Вот еще R3trans.log
4 ETW000 R3trans version 6.24 (release 741 - 16.05.14 - 20:14:06). 4 ETW000 unicode enabled version 4 ETW000 =============================================== 4 ETW000 4 ETW000 date&time : 18.07.2014 - 01:09:57 4 ETW000 control file: <no ctrlfile> 4 ETW000 R3trans was called as follows: R3trans -x 4 ETW000 trace at level 2 opened for a given file pointer 4 ETW000 [ dev trc,00000] Fri Jul 18 01:09:57 2014 50 0.000050 4 ETW000 [ dev trc,00000] db_con_init called 15 0.000065 4 ETW000 [ dev trc,00000] set_use_ext_con_info(): ssfs will be used to get connect information 4 ETW000 19 0.000084 4 ETW000 [ dev trc,00000] determine_block_commit: no con_hdl found as blocked for con_name = R/3 4 ETW000 13 0.000097 4 ETW000 [ dev trc,00000] create_con (con_name=R/3) 10 0.000107 4 ETW000 [ dev trc,00000] Loading DB library '/usr/sap/NRS/SYS/exe/run/dboraslib.so' ... 24 0.000131 4 ETW000 [ dev trc,00000] DlLoadLib() success: dlopen("/usr/sap/NRS/SYS/exe/run/dboraslib.so"), hdl 0, count 1, addr 478d7f0 4 ETW000 5787 0.005918 4 ETW000 [ dev trc,00000] Library '/usr/sap/NRS/SYS/exe/run/dboraslib.so' loaded 11 0.005929 4 ETW000 [ dev trc,00000] function DbSlExpFuns loaded from library /usr/sap/NRS/SYS/exe/run/dboraslib.so 4 ETW000 14 0.005943 4 ETW000 [ dev trc,00000] Version of '/usr/sap/NRS/SYS/exe/run/dboraslib.so' is "741.10", patchlevel (0.37) 4 ETW000 76 0.006019 4 ETW000 [ dev trc,00000] function dsql_db_init loaded from library /usr/sap/NRS/SYS/exe/run/dboraslib.so 4 ETW000 13 0.006032 4 ETW000 [ dev trc,00000] function dbdd_exp_funs loaded from library /usr/sap/NRS/SYS/exe/run/dboraslib.so 4 ETW000 31 0.006063 4 ETW000 [ dev trc,00000] function sapic_get_instant_client_version loaded from library /usr/sap/NRS/SYS/exe/run/dboraslib.so 4 ETW000 15 0.006078 4 ETW000 [ dev trc,00000] function sapic_get_instant_client_flavor loaded from library /usr/sap/NRS/SYS/exe/run/dboraslib.so 4 ETW000 13 0.006091 4 ETW000 [ dev trc,00000] function sapic_get_patchset_version loaded from library /usr/sap/NRS/SYS/exe/run/dboraslib.so 4 ETW000 14 0.006105 4 ETW000 [ dev trc,00000] function sapic_get_ls_inventory loaded from library /usr/sap/NRS/SYS/exe/run/dboraslib.so 4 ETW000 13 0.006118 4 ETW000 [ dev trc,00000] -->DbSlControl(con=-1,cmd=47=DBSL_CMD_IMP_FUNS_SET) -> changed=30, tagset=1 4 ETW000 20 0.006138 4 ETW000 [ dev trc,00000] -->DbSlControl(con=-1,cmd=39=DBSL_CMD_SET_SINGLETASK) 13 0.006151 4 ETW000 [ dev trc,00000] -->DbSlControl(con=-1,cmd=10=DBSL_CMD_DBCA_PTR_GET) 13 0.006164 4 ETW000 [ dev trc,00000] New connection 0 created 8 0.006172 4 ETW000 [ dev trc,00000] 0: name = R/3, con_id = -000000001, state = DISCONNECTED, tx = NO , bc = NO , oc = 000, hc = NO , perm = YES, reco = NO , info = NO , timeout = 000, con_max = 255, con_opt = 255, occ = NO , prog = 4 ETW000 32 0.006204 4 ETW000 [ dev trc,00000] -->DbSlControl(con=-1,cmd=10=DBSL_CMD_DBCA_PTR_GET) 12 0.006216 4 ETW000 [ dev trc,00000] db_con_connect (con_name=R/3) 11 0.006227 4 ETW000 [ dev trc,00000] determine_block_commit: no con_hdl found as blocked for con_name = R/3 4 ETW000 10 0.006237 4 ETW000 [ dev trc,00000] find_con_by_name found the following connection: 7 0.006244 4 ETW000 [ dev trc,00000] 0: name = R/3, con_id = 000000000, state = DISCONNECTED, tx = NO , bc = NO , oc = 000, hc = NO , perm = YES, reco = NO , info = NO , timeout = 000, con_max = 255, con_opt = 255, occ = NO , prog = 4 ETW000 16 0.006260 4 ETW000 [ dev trc,00000] read_con_info_ssfs(): reading connect info for connection R/3 10 0.006270 4 ETW000 [ dev trc,00000] -->DbSlControl(con=-1,cmd=74=DBSL_CMD_CON_INFO_EXT_SUPPORT) -> rc=0=DBSL_ERR_OK, con_vers=0 4 ETW000 19 0.006289 4 ETW000 [ dev trc,00000] read_con_info_ssfs(): DBSL supports extended connect protocol 11 0.006300 4 ETW000 ==> connect info for default DB will be read from ssfs 4 ETW000 [ dev trc,00000] read_con_info_ssfs(): profile parameter auth/shadow_upgrade is not set ==> connect info for shadow upgrade will not be read with an extra upgrade key set 4 ETW000 18 0.006318 4 ETW000 [ dev trc,00000] read_con_info_ssfs(): register callback ssfs_dbi_trace and max level 2 4 ETW000 11 0.006329 4 ETW000 [ dev trc,00000] RSecSSFs: Entering function "RSecSSFsGetRecord" [/bas/741_REL/src/krn/rsec/rsecssfs.c 1143] 4 ETW000 32 0.006361 4 ETW000 [ dev trc,00000] RSecSSFs: Data file "/usr/sap/NRS/SYS/global/security/rsecssfs/data/SSFS_NRS.DAT" opened for read [/bas/741_REL/src/krn/rsec/rsecssfs.c 4244] 4 ETW000 21979 0.028340 4 ETW000 [ dev trc,00000] RSecSSFs: SSFS-1430: File "/usr/sap/NRS/SYS/global/security/rsecssfs/key/SSFS_NRS.KEY" cannot be opened in mode "rb": No such file or directory (errno = 2); at this location, this is not considered an error [/bas/741_REL/src/krn/rsec/rsecssfs.c 1458] 4 ETW000 91 0.028431 4 ETW000 [ dev trc,00000] RSecSSFs: Key file "/usr/sap/NRS/SYS/global/security/rsecssfs/key/SSFS_NRS.KEY" not found, using default key [/bas/741_REL/src/krn/rsec/rsecssfs.c 2283] 4 ETW000 55 0.028486 4 ETW000 [ dev trc,00000] RSecSSFs: Exiting function "RSecSSFsGetRecord" with return code 0 (message: <No message available>) [/bas/741_REL/src/krn/rsec/rsecssfs.c 1224] 4 ETW000 411 0.028897 4 ETW000 [ dev trc,00000] read_ssfs_record(): DB_CONNECT/DEFAULT_DB_USER read successfully from ssfs 4 ETW000 31 0.028928 4 ETW000 [ dev trc,00000] read_con_info_ssfs(): deregister callback ssfs_dbi_trace 33 0.028961 4 ETW000 [ dev trc,00000] read_con_info_ssfs(): register callback ssfs_dbi_trace and max level 2 4 ETW000 26 0.028987 4 ETW000 [ dev trc,00000] RSecSSFs: Entering function "RSecSSFsGetRecord" [/bas/741_REL/src/krn/rsec/rsecssfs.c 1143] 4 ETW000 36 0.029023 4 ETW000 [ dev trc,00000] RSecSSFs: Data file "/usr/sap/NRS/SYS/global/security/rsecssfs/data/SSFS_NRS.DAT" opened for read [/bas/741_REL/src/krn/rsec/rsecssfs.c 4244] 4 ETW000 122 0.029145 4 ETW000 [ dev trc,00000] RSecSSFs: SSFS-1430: File "/usr/sap/NRS/SYS/global/security/rsecssfs/key/SSFS_NRS.KEY" cannot be opened in mode "rb": No such file or directory (errno = 2); at this location, this is not considered an error [/bas/741_REL/src/krn/rsec/rsecssfs.c 1458] 4 ETW000 63 0.029208 4 ETW000 [ dev trc,00000] RSecSSFs: Key file "/usr/sap/NRS/SYS/global/security/rsecssfs/key/SSFS_NRS.KEY" not found, using default key [/bas/741_REL/src/krn/rsec/rsecssfs.c 2283] 4 ETW000 36 0.029244 4 ETW000 [ dev trc,00000] RSecSSFs: Exiting function "RSecSSFsGetRecord" with return code 0 (message: <No message available>) [/bas/741_REL/src/krn/rsec/rsecssfs.c 1224] 4 ETW000 350 0.029594 4 ETW000 [ dev trc,00000] read_ssfs_record(): DB_CONNECT/DEFAULT_DB_PASSWORD read successfully from ssfs 4 ETW000 29 0.029623 4 ETW000 [ dev trc,00000] read_con_info_ssfs(): deregister callback ssfs_dbi_trace 19 0.029642 4 ETW000 [ dev trc,00000] read_con_info_ssfs(): register callback ssfs_dbi_trace and max level 2 4 ETW000 25 0.029667 4 ETW000 [ dev trc,00000] RSecSSFs: Entering function "RSecSSFsGetRecord" [/bas/741_REL/src/krn/rsec/rsecssfs.c 1143] 4 ETW000 35 0.029702 4 ETW000 [ dev trc,00000] RSecSSFs: Data file "/usr/sap/NRS/SYS/global/security/rsecssfs/data/SSFS_NRS.DAT" opened for read [/bas/741_REL/src/krn/rsec/rsecssfs.c 4244] 4 ETW000 122 0.029824 4 ETW000 [ dev trc,00000] RSecSSFs: SSFS-1430: File "/usr/sap/NRS/SYS/global/security/rsecssfs/key/SSFS_NRS.KEY" cannot be opened in mode "rb": No such file or directory (errno = 2); at this location, this is not considered an error [/bas/741_REL/src/krn/rsec/rsecssfs.c 1458] 4 ETW000 63 0.029887 4 ETW000 [ dev trc,00000] RSecSSFs: Key file "/usr/sap/NRS/SYS/global/security/rsecssfs/key/SSFS_NRS.KEY" not found, using default key [/bas/741_REL/src/krn/rsec/rsecssfs.c 2283] 4 ETW000 36 0.029923 4 ETW000 [ dev trc,00000] RSecSSFs: SSFS-4215: Data file "/usr/sap/NRS/SYS/global/security/rsecssfs/data/SSFS_NRS.DAT" exists, but does not contain the requested entry [/bas/741_REL/src/krn/rsec/rsecssfs.c 4274] 4 ETW000 64 0.029987 4 ETW000 [ dev trc,00000] RSecSSFs: SSFS-4218: Record with key "DB_CONNECT/DEFAULT_DB_CON_ENV" not found in secure storage [/bas/741_REL/src/krn/rsec/rsecssfs.c 4284] 4 ETW000 56 0.030043 4 ETW000 [ dev trc,00000] RSecSSFs: Exiting function "RSecSSFsGetRecord" with return code 1 (message: SSFS-4218: Record with key "DB_CONNECT/DEFAULT_DB_CON_ENV" not found in secure storage <-- SSFS-4215: Data file "/usr/sap/NRS/SYS/global/security/rsecssfs/data/SSFS_NRS.DAT" exists, but does not contain the requested entry) [/bas/741_REL/src/krn/rsec/rsecssfs.c 1224] 4 ETW000 74 0.030117 4 ETW000 [ dev trc,00000] read_ssfs_record(): not found is accepted, RSecSSFsGetRecord(DB_CONNECT/DEFAULT_DB_CON_ENV)=1 : SSFS-4218: Record with key "DB_CONNECT/DEFAULT_DB_CON_ENV" not found in secure storage <-- SSFS-4215: Data file "/usr/sap/NRS/SYS/global/security/rsecssfs/data/SSFS_NRS.DAT" exists, but does not contain the requested entry 4 ETW000 38 0.030155 4 ETW000 [ dev trc,00000] read_con_info_ssfs(): deregister callback ssfs_dbi_trace 18 0.030173 4 ETW000 [ dev trc,00000] -->DbSlConnect(vers=0, type=0, env='[default env]', usr='SAPSR3', kernel dbsl='741') 4 ETW000 102 0.030275 4 ETW000 [ dev trc,00000] Register application info. 365 0.030640 4 ETW000 [ dev trc,00000] Oracle client version: 11.2.0.3.0, V1, default build, (dbsl 741 300514, UNICODE[2]) 4 ETW000 97 0.030737 4 ETW000 [ dev trc,00000] Installed Oracle client patches: 47 0.030784 4 ETW000 [ dev trc,00000] # Patch 13508485 : Created on 21 Dec 2011, 13:23:38 hrs PST8PDT 4 ETW000 39 0.030823 4 ETW000 [ dev trc,00000] # Patch Description: Created on 3 Jan 2012, 02:50:27 hrs PST8PDT 42 0.030865 4 ETW000 [ dev trc,00000] # Patch 11742262 : Created on 7 Mar 2012, 12:22:41 hrs CET 53 0.030918 4 ETW000 [ dev trc,00000] Default connection: tnsname ='NRS' 35 0.030953 4 ETW000 [ dev trc,00000] -->oci_initialize(con=0, char='UTF16', nchar='AL16UTF16', nls=-1),uc_ln=2 4 ETW000 47 0.031000 4 ETW000 [ dev trc,00000] (-) OCIEnvCreate(mode=16384=OCI_UTF16) returned 0 (for default NLS handle) 4 ETW000 5515 0.036515 4 ETW000 [ dev trc,00000] OCIHandleAlloc(OCI_HTYPE_ERROR, con=0, ErrHp=485c3b8) 29 0.036544 4 ETW000 [ dev trc,00000] OCIHandleAlloc(OCI_HTYPE_ERROR, con=0, ErrBt=485d648) 18 0.036562 4 ETW000 [ dev trc,00000] NLS env. settings: lang=41004D00450052004900430041004E00 61 0.036623 4 ETW000 [ dev trc,00000] terr=41004D0045005200490043004100 17 0.036640 4 ETW000 [ dev trc,00000] char=55005400460031003600 13 0.036653 4 ETW000 [ dev trc,00000] Client NLS setting (by OCINlsGetInfo(con=0)): 'AMERICAN_AMERICA.UTF16' 4 ETW000 17 0.036670 4 ETW000 [ dev trc,00000] charset='UTF16', ncharset='AL16UTF16', UNI_ASC=FALSE 10 0.036680 4 ETW000 [ dev trc,00000] Connecting as SAPSR3/<pwd>@NRS on connection 0 (nls 0) ... (dbsl 741 300514, UNICODE[2]) 4 ETW000 30 0.036710 4 ETW000 [ dev trc,00000] OCIHandleAlloc(OCI_HTYPE_SVCCTX, con=0, svchp=485d568) 16 0.036726 4 ETW000 [ dev trc,00000] Allocating server context handle 14 0.036740 4 ETW000 [ dev trc,00000] Attaching to database server NRS (con=0, svchp=485d568, srvhp=4860890) 4 ETW000 36 0.036776 4 ETW000 [ dev trc,00000] Assigning server context 4860890 to service context 485d568 20353 0.057129 4 ETW000 [ dev trc,00000] OCIHandleAlloc(OCI_HTYPE_SESSION, con=0, usrhp=488f0f0) 77 0.057206 4 ETW000 [ dev trc,00000] Assigning username to user session: con=0, usrhp=488f0f0 34 0.057240 4 ETW000 [ dev trc,00000] Assigning password to user session: con=0, usrhp=488f0f0 41 0.057281 4 ETW000 [ dev trc,00000] Starting user session: OCISessionBegin(con=0, usr='SAPSR3', svc=485d568, srv=4860890, usr=488f0f0) 4 ETW000 276 0.057557 4 ETW000 [ dev trc,00000] Assigning user session usrhp=488f0f0 to service context svchp=485d568 4 ETW000 12150 0.069707 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected 98 0.069805 4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=39,stp=4871e28) 37 0.069842 4 ETW000 [ dev trc,00000] SELECT SID FROM V$MYSTAT WHERE ROWNUM<2 4 ETW000 40 0.069882 4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_INT , l= 4, con=0, stp=4871e28, pv=7fff99684af8, in=7fff99684afe,rl=0000NULL,rc=0000NULL) 4 ETW000 131 0.070013 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected, new transaction 79 0.070092 4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#1: con=0,stp=4871e28,itr=1,off=0,bat=0) 35 0.070127 4 ETW000 [ dev trc,00000] before OCIStmtExecute(svchp=485d568, errhp=485c3b8): [dur. 0,000s] 31 0.070158 4 ETW000 [ dev trc,00000] after OCIStmtExecute(rpc=0): [dur. 0,001s] 1079 0.071237 4 ETW000 [ dev trc,00000] <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,001s] 49 0.071286 4 ETW000 [ dev trc,00000] Now 'SAPSR3/<pwd>@NRS' is connected: con=0, nls=0, session=1249, time='2014-07-18 01:09:57' 4 ETW000 122 0.071408 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected 54 0.071462 4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=33,stp=4871e28) 30 0.071492 4 ETW000 [ dev trc,00000] ALTER SESSION SET NLS_SORT=BINARY 4 ETW000 35 0.071527 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected, new transaction 64 0.071591 4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#2: con=0,stp=4871e28,itr=1,off=0,bat=0) 33 0.071624 4 ETW000 [ dev trc,00000] before OCIStmtExecute(svchp=485d568, errhp=485c3b8): [dur. 0,000s] 30 0.071654 4 ETW000 [ dev trc,00000] after OCIStmtExecute(rpc=0): [dur. 0,001s] 642 0.072296 4 ETW000 [ dev trc,00000] <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,001s] 55 0.072351 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected 78 0.072429 4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=110,stp=4871e28) 32 0.072461 4 ETW000 [ dev trc,00000] SELECT UPPER(INSTANCE_NAME),HOST_NAME,VERSION,TO_CHAR(STARTUP_TIME,'MON DD, YYYY, HH24:MI:SS') FROM V$INSTANCE 4 ETW000 35 0.072496 4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_STR , l= 66, con=0, stp=4871e28, pv=7f81606182e8, in=7fff99684afe,rl=0000NULL,rc=0000NULL) 4 ETW000 81 0.072577 4 ETW000 [ dev trc,00000] - oci_define ( 1: SQLT_STR , l=130, con=0, stp=4871e28, pv=7f8160618530, in=7fff99684afe,rl=0000NULL,rc=0000NULL) 4 ETW000 50 0.072627 4 ETW000 [ dev trc,00000] - oci_define ( 2: SQLT_STR , l= 66, con=0, stp=4871e28, pv=7f81606182a6, in=7fff99684afe,rl=0000NULL,rc=0000NULL) 4 ETW000 58 0.072685 4 ETW000 [ dev trc,00000] - oci_define ( 3: SQLT_STR , l= 62, con=0, stp=4871e28, pv=7fff99684ac0, in=7fff99684afe,rl=0000NULL,rc=0000NULL) 4 ETW000 46 0.072731 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected, new transaction 51 0.072782 4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#3: con=0,stp=4871e28,itr=1,off=0,bat=0) 33 0.072815 4 ETW000 [ dev trc,00000] before OCIStmtExecute(svchp=485d568, errhp=485c3b8): [dur. 0,000s] 30 0.072845 4 ETW000 [ dev trc,00000] after OCIStmtExecute(rpc=0): [dur. 0,001s] 737 0.073582 4 ETW000 [ dev trc,00000] <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,001s] 41 0.073623 4 ETW000 [ dev trc,00000] DB instance NRS is running on srvtest with ORACLE version 11.2.0.4.0 since JUL 18, 2014, 00:26:01. 4 ETW000 48 0.073671 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected 69 0.073740 4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=74,stp=4871e28) 32 0.073772 4 ETW000 [ dev trc,00000] SELECT SUBSTR(NAME,1,3), TO_CHAR(CREATED,'YYYYMMDDHHMMSS') FROM V$DATABASE 4 ETW000 35 0.073807 4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_CHR , l= 6, con=0, stp=4871e28, pv=7fff99684900, in=7fff99684afe,rl=0000NULL,rc=0000NULL) 4 ETW000 89 0.073896 4 ETW000 [ dev trc,00000] - oci_define ( 1: SQLT_STR , l= 30, con=0, stp=4871e28, pv=7fff99684ae0, in=7fff99684afe,rl=0000NULL,rc=0000NULL) 4 ETW000 50 0.073946 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected, new transaction 53 0.073999 4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#4: con=0,stp=4871e28,itr=1,off=0,bat=0) 33 0.074032 4 ETW000 [ dev trc,00000] before OCIStmtExecute(svchp=485d568, errhp=485c3b8): [dur. 0,000s] 30 0.074062 4 ETW000 [ dev trc,00000] after OCIStmtExecute(rpc=0): [dur. 0,012s] 11838 0.085900 4 ETW000 [ dev trc,00000] <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,012s] 47 0.085947 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected 88 0.086035 4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=172,stp=4871e28) 33 0.086068 4 ETW000 [ dev trc,00000] SELECT VALUE FROM V$NLS_PARAMETERS WHERE PARAMETER IN ('NLS_LANGUAGE','NLS_TERRITORY','NLS_CHARACTERSET','NLS_NCHAR_CHARAC 4 ETW000 36 0.086104 4 ETW000 [ dev trc,00000] TERSET','NLS_LENGTH_SEMANTICS') ORDER BY PARAMETER 4 ETW000 34 0.086138 4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_STR , l=202, con=0, stp=4871e28, pv=7fff99684c10, in=7fff99685ac0,rl=0000NULL,rc=0000NULL) 4 ETW000 84 0.086222 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected, new transaction 56 0.086278 4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#5: con=0,stp=4871e28,itr=5,off=0,bat=0) 69 0.086347 4 ETW000 [ dev trc,00000] before OCIStmtExecute(svchp=485d568, errhp=485c3b8): [dur. 0,000s] 38 0.086385 4 ETW000 [ dev trc,00000] after OCIStmtExecute(rpc=0): [dur. 0,001s] 773 0.087158 4 ETW000 [ dev trc,00000] <--oci_execute_stmt(rc=0, iters-errors = 5-0) [dur. 0,001s] 45 0.087203 4 ETW000 [ dev trc,00000] con=0, V$NLS_PARAMETERS: NLS_LANG=AMERICAN_AMERICA.UTF8, NLS_NCHAR=UTF8 4 ETW000 51 0.087254 4 ETW000 [ dev trc,00000] V$NLS_PARAMETERS: NLS_LENGTH_SEMANTICS='BYTE' 30 0.087284 4 ETW000 [ dev trc,00000] Nls CharacterSet NationalCharSet EnvHp ErrHp ErrBt 4 ETW000 61 0.087345 4 ETW000 [ dev trc,00000] 0 UTF16 AL16UTF16 484fc80 485c3b8 485d648 4 ETW000 50 0.087395 4 ETW000 [ dev trc,00000] SELECT STATUS,OBJECT_TYPE FROM USER_OBJECTS WHERE OBJECT_NAME='IOV' 26 0.087421 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected 61 0.087482 4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=67,stp=4871e28) 30 0.087512 4 ETW000 [ dev trc,00000] SELECT STATUS,OBJECT_TYPE FROM USER_OBJECTS WHERE OBJECT_NAME='IOV' 4 ETW000 35 0.087547 4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_STR , l= 20, con=0, stp=4871e28, pv=7fff99685ac0, in=7fff99685aee,rl=0000NULL,rc=0000NULL) 4 ETW000 76 0.087623 4 ETW000 [ dev trc,00000] - oci_define ( 1: SQLT_STR , l= 44, con=0, stp=4871e28, pv=7fff996859e0, in=7fff99685ae0,rl=0000NULL,rc=0000NULL) 4 ETW000 49 0.087672 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected, new transaction 53 0.087725 4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#6: con=0,stp=4871e28,itr=1,off=0,bat=0) 39 0.087764 4 ETW000 [ dev trc,00000] before OCIStmtExecute(svchp=485d568, errhp=485c3b8): [dur. 0,000s] 42 0.087806 4 ETW000 [ dev trc,00000] after OCIStmtExecute(rpc=0): [dur. 0,001s] 994 0.088800 4 ETW000 [ dev trc,00000] <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,001s] 47 0.088847 4 ETW000 [ dev trc,00000] SELECT SUBSTR(TEXT,140,10) FROM USER_SOURCE WHERE NAME='IOV' 38 0.088885 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected 62 0.088947 4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=60,stp=4871e28) 30 0.088977 4 ETW000 [ dev trc,00000] SELECT SUBSTR(TEXT,140,10) FROM USER_SOURCE WHERE NAME='IOV' 4 ETW000 35 0.089012 4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_STR , l= 42, con=0, stp=4871e28, pv=7fff996859a0, in=7fff99685aee,rl=0000NULL,rc=0000NULL) 4 ETW000 78 0.089090 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected, new transaction 55 0.089145 4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#7: con=0,stp=4871e28,itr=1,off=0,bat=0) 32 0.089177 4 ETW000 [ dev trc,00000] before OCIStmtExecute(svchp=485d568, errhp=485c3b8): [dur. 0,000s] 31 0.089208 4 ETW000 [ dev trc,00000] after OCIStmtExecute(rpc=0): [dur. 0,001s] 801 0.090009 4 ETW000 [ dev trc,00000] <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,001s] 47 0.090056 4 ETW000 [ dev trc,00000] FUNCTION IOV exists and is VALID (orc=0). 39 0.090095 4 ETW000 [ dev trc,00000] SELECT STATUS,OBJECT_TYPE FROM USER_OBJECTS WHERE OBJECT_NAME='RTRIM2' 4 ETW000 42 0.090137 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected 61 0.090198 4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=70,stp=4871e28) 31 0.090229 4 ETW000 [ dev trc,00000] SELECT STATUS,OBJECT_TYPE FROM USER_OBJECTS WHERE OBJECT_NAME='RTRIM2' 4 ETW000 35 0.090264 4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_STR , l= 20, con=0, stp=4871e28, pv=7fff99684ad0, in=7fff99684afe,rl=0000NULL,rc=0000NULL) 4 ETW000 94 0.090358 4 ETW000 [ dev trc,00000] - oci_define ( 1: SQLT_STR , l= 44, con=0, stp=4871e28, pv=7fff99684aa0, in=7fff99684afc,rl=0000NULL,rc=0000NULL) 4 ETW000 51 0.090409 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected, new transaction 53 0.090462 4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#8: con=0,stp=4871e28,itr=1,off=0,bat=0) 33 0.090495 4 ETW000 [ dev trc,00000] before OCIStmtExecute(svchp=485d568, errhp=485c3b8): [dur. 0,000s] 30 0.090525 4 ETW000 [ dev trc,00000] after OCIStmtExecute(rpc=0): [dur. 0,001s] 691 0.091216 4 ETW000 [ dev trc,00000] <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,001s] 45 0.091261 4 ETW000 [ dev trc,00000] FUNCTION RTRIM2 exists and is VALID (orc=0). 40 0.091301 4 ETW000 [ dev trc,00000] SELECT STATUS,OBJECT_TYPE FROM USER_OBJECTS WHERE OBJECT_NAME='CONCAT3' 4 ETW000 62 0.091363 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected 64 0.091427 4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=71,stp=4871e28) 30 0.091457 4 ETW000 [ dev trc,00000] SELECT STATUS,OBJECT_TYPE FROM USER_OBJECTS WHERE OBJECT_NAME='CONCAT3' 4 ETW000 35 0.091492 4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_STR , l= 20, con=0, stp=4871e28, pv=7fff99684ad0, in=7fff99684afe,rl=0000NULL,rc=0000NULL) 4 ETW000 76 0.091568 4 ETW000 [ dev trc,00000] - oci_define ( 1: SQLT_STR , l= 44, con=0, stp=4871e28, pv=7fff99684aa0, in=7fff99684afc,rl=0000NULL,rc=0000NULL) 4 ETW000 50 0.091618 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 not connected, new transaction 53 0.091671 4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#9: con=0,stp=4871e28,itr=1,off=0,bat=0) 32 0.091703 4 ETW000 [ dev trc,00000] before OCIStmtExecute(svchp=485d568, errhp=485c3b8): [dur. 0,000s] 31 0.091734 4 ETW000 [ dev trc,00000] after OCIStmtExecute(rpc=0): [dur. 0,001s] 711 0.092445 4 ETW000 [ dev trc,00000] <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,001s] 47 0.092492 4 ETW000 [ dev trc,00000] FUNCTION CONCAT3 exists and is VALID (orc=0). 44 0.092536 4 ETW000 [ dev trc,00000] DbSlConnect(con=0) -> orc=0, 0=DBSL_ERR_OK 28 0.092564 4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=21=DBSL_CMD_DBHOST_NAME_GET) 27 0.092591 4 ETW000 [ dev trc,00000] Connection 0 opened (DBSL handle 0) 28 0.092619 4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=7=DBSL_CMD_DBNAME_GET) 34 0.092653 4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=63=DBSL_CMD_DBSID_GET) 36 0.092689 4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=21=DBSL_CMD_DBHOST_NAME_GET) 30 0.092719 4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=11=DBSL_CMD_USERID_GET) -> USERID='SAPSR3' 29 0.092748 4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=22=DBSL_CMD_OWNERID_GET) -> OWNERID='SAPSR3' 4 ETW000 34 0.092782 4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=13=DBSL_CMD_VENDOR_NAME_GET) 25 0.092807 4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=24=DBSL_CMD_DBVERSION_GET) 26 0.092833 4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=51=DBSL_CMD_NLS_CHARACTERSET_GET) 25 0.092858 4 ETW000 [ dev trc,00000] -->DbSlPrepare(DBSL_SELECT, con=0, ssp=7fff99685f70, dap=7fff99685ed0), tok=7fff99685f90, stid=0000NULL 4 ETW000 62 0.092920 4 ETW000 [ dev trc,00000] build_stmt() -> OK 53 0.092973 4 ETW000 [ dev trc,00000] AppInf(210)->1; mod='DBSL: con=0, no ABAP',act='0',usr='DBSL: con=0, no client_id',ta='',mp='' 4 ETW000 133 0.093106 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 connected 47 0.093153 4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=26,stp=4871e28); AI=DBSL: con=0, no ABAP.0.DBSL: con=0, no client_id.DBSL: con=0, no client_info 4 ETW000 54 0.093207 4 ETW000 [ dev trc,00000] SELECT VERSION FROM SVERS 4 ETW000 34 0.093241 4 ETW000 [ dev trc,00000] stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK 48 0.093289 4 ETW000 [ dev trc,00000] DbSlPrepare(lit=0, lob=0, fae=0, col=0, mrk=0,sch=47bde60, scp=47c72f0, tab='SVERS') -> 0=DBSL_ERR_OK 4 ETW000 62 0.093351 4 ETW000 [ dev trc,00000] -->DbSlRead(con=0, ssp=7fff99685f70, dap=7fff99685ed0), sch=47bde60, stid=0000NULL, tok=7fff99685f90, prepared=1 4 ETW000 56 0.093407 4 ETW000 [ dev trc,00000] -->DbSlRead(con=0, ssp=7fff99685f70, dap=7fff99685ed0), sch=47bde60, scp=47c72f0, tab='SVERS' 4 ETW000 38 0.093445 4 ETW000 [ dev trc,00000] stmt=SELECT VERSION FROM SVERS 4 ETW000 37 0.093482 4 ETW000 [ dev trc,00000] 7fff99685f70->id_p=(nil) 26 0.093508 4 ETW000 [ dev trc,00000] Out 00: DBSL_DATA_SHORT_CHAR (len=144, max=144, dec=0) 34 0.093542 4 ETW000 [ dev trc,00000] bind_type_and_length(): 0 input variables, col=0 33 0.093575 4 ETW000 [ dev trc,00000] bind_type_and_length(): 1 output variables 26 0.093601 4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=144, max=144, dec=0 30 0.093631 4 ETW000 [ dev trc,00000] bind_ind_and_values(OUT,con=0,arr=890,col=1,rc=0,rl=0,flt=0,int=0,sh=0,uc=72) 4 ETW000 64 0.093695 4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_CHR , l=144, con=0, stp=4871e28, pv=48bf214, in=48beb20,rl=0000NULL,rc=0000NULL) 4 ETW000 44 0.093739 4 ETW000 [ dev trc,00000] -->exec_fetch(bulk=0, sch=47bde60, dap=7fff99685ed0, DBSL_DIR_READ) 45 0.093784 4 ETW000 [ dev trc,00000] -->stmt_fetch(sch=47bde60, odp=47c7380, DBSL_DIR_READ) 27 0.093811 4 ETW000 [ dev trc,00000] AppInf(5)->1; mod='',act='',usr='DBSL: con=0, no client_id',ta='',mp='' 4 ETW000 51 0.093862 4 ETW000 [ dev trc,00000] time 2014-07-18 01:09:57, con=0 connected, new transaction 50 0.093912 4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#10: con=0,stp=4871e28,itr=1,off=0,bat=0); AI='..DBSL: con=0, no client_id.' 4 ETW000 43 0.093955 4 ETW000 [ dev trc,00000] before OCIStmtExecute(svchp=485d568, errhp=485c3b8): [dur. 0,000s] 30 0.093985 4 ETW000 [ dev trc,00000] after OCIStmtExecute(rpc=1): [dur. 0,001s] 763 0.094748 4 ETW000 [ dev trc,00000] <--oci_execute_stmt(rc=0, rows processed 1, iters-errors = 1-0) [dur. 0,001s] 4 ETW000 57 0.094805 4 ETW000 [ dev trc,00000] stmt_fetch() -> orc=0, 0=DBSL_ERR_OK 38 0.094843 4 ETW000 [ dev trc,00000] DbSlRead() --> 0=DBSL_ERR_OK 41 0.094884 4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=43=DBSL_CMD_SAPRELEASE_SET) 27 0.094911 4 ETW000 [ dev trc,00000] DbSlControl(DBSL_CMD_SAPRELEASE_SET,abap='740') 24 0.094935 4 ETW000 Connected to database. 4 ETW000 [ dev trc,00000] Disconnecting from ALL connections: 35 0.094970 4 ETW000 [ dev trc,00000] Disconnecting from connection 0 ... 42 0.095012 4 ETW000 [ dev trc,00000] Rolling back transaction 48 0.095060 4 ETW000 [ dev trc,00000] Closing user session (con=0, svc=485d568, usr=488f0f0) 489 0.095549 4 ETW000 [ dev trc,00000] Deallocating user session handle 488f0f0 for con=0 1042 0.096591 4 ETW000 [ dev trc,00000] server_detach(con=0,stale=0,srvhp=4860890) 58 0.096649 4 ETW000 [ dev trc,00000] Server handle (con=0,svchp=485d568,srvhp=4860890) detached 234 0.096883 4 ETW000 [ dev trc,00000] Free server handle srvhp=4860890 of con=0 35 0.096918 4 ETW000 [ dev trc,00000] Deallocating service context handle 485d568 for con=0 35 0.096953 4 ETW000 [ dev trc,00000] Disconnected (con=0) from ORACLE. 25 0.096978 4 ETW000 [ dev trc,00000] Disconnected from connection 0 23 0.097001 4 ETW000 [ dev trc,00000] statistics db_con_commit (com_total=0, com_tx=0) 24 0.097025 4 ETW000 [ dev trc,00000] statistics db_con_rollback (roll_total=0, roll_tx=0) 23 0.097048 4 ETW000 Disconnected from database. 4 ETW000 End of Transport (0000). 4 ETW000 date&time: 18.07.2014 - 01:09:57
|
|