Solved: SUM cannot connect to oracle, SAP runs already wit...

Hello together,

we wanted upgrade ECC 6.0 to EHP 6 on Oracle 11.2.0.4 / Linux.

SAP running on ssfs authentication.

SAP System starts with ssfs in dev_w7 trace:

B ==> connect info for default DB will be read from ssfs

Getting from SUM SP12 Dumps with this errors:

4 ETW000 TRACE-INFO: 27: [ dev trc,00000] Logon as OPS$-user to get

SAPSR3's password 12 0.269337

4 ETW000 TRACE-INFO: 28: [ dev trc,00000] Connecting as /@PSB on

connection 0 (nls 0) ... (dbsl 721 231014, non-unicode)

4 ETW000 TRACE-INFO: 34: [ dev trc,00000] OCIHandleAlloc(con=0):

New session handle usr=x17b5850, rc=0) 57 0.519098

4 ETW000 TRACE-INFO: 35: [ dev trc,00000]

OCISessionBegin(OCI_DEFAULT) failed with -1=OCI_ERROR

8687 0.527785

4 ETW000 TRACE-INFO: 36: [ dev trc,00000]

OCISessionBegin(OCI_DEFAULT) failed with SQL error 1017:

22 0.527807

4 ETW000 TRACE-INFO: 37: [ dev trc,00000] ORA-01017: invalid

username/password; logon denied

sidadm env variables:

RSEC_SSFS_DATAPATH=/usr/sap/PSB/SYS/global/security/rsecssfs/data

RSEC_SSFS_KEYPATH=/usr/sap/PSB/SYS/global/security/rsecssfs/key

rsdb_ssfs_connestyle=1

oraadm env variables:

RSEC_SSFS_DATAPATH=/usr/sap/PSB/SYS/global/security/rsecssfs/data

RSEC_SSFS_KEYPATH=/usr/sap/PSB/SYS/global/security/rsecssfs/key

rsdb_ssfs_connestyle=1

tp, r3trans, kernel and db lib are the newest from marketplace.

Thanks for your help !

SAP Managed Tags:
SAP enhancement package for SAP ERP

You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.

Comment

Accepted Solutions (1)

One more suspect here is env variable


rsdb_ssfs_connestyle=1

Instead of above try to use rsdb_ssfs_connect=1 & check again by re execution of phase.

Hope this will resolve your issue.

Good luck !!

You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.

Comment

Hello,

thanks for your help. This was a copy/paste error:

rsdb_ssfs_connect = 1 is set in every profile

R3trans -d and -X works fine !

---------------------------------------------------

trc file: "dev_w0", trc level: 1, release: "721"

---------------------------------------------------

* ACTIVE TRACE LEVEL 1

* ACTIVE TRACE COMPONENTS all, MJ

M sysno 01

M sid PSB

M systemid 390 (AMD/Intel x86_64 with Linux)

M relno 7210

M patchlevel 0

M patchno 402

M intno 20020600

M make single threaded, ASCII, 64 bit, optimized

M profile /usr/sap/PSB/SYS/profile/PSB_DVEBMGS01_prodsb

M pid 17101

M Tue Mar 24 11:35:15 2015

M kernel runs with dp version 139(ext=121) (@(#) DPLIB-INT-VERSION-139)

M length of sys_adm_ext is 380 bytes

M ThStart: taskhandler started

M ThTHPInit: thp initialized

M ThInit: initializing DIA work process W0

M ***LOG Q01=> ThInit, WPStart (Workp. 0 1 17101) [thxxhead.c 1350]

M Tue Mar 24 11:35:19 2015

M ThInit: running on host prodsb

M calling db_connect ...

B Loading DB library '/usr/sap/PSB/DVEBMGS01/exe/dboraslib.so' ...

B Library '/usr/sap/PSB/DVEBMGS01/exe/dboraslib.so' loaded

B Version of '/usr/sap/PSB/DVEBMGS01/exe/dboraslib.so' is "721.02", patchlevel (0.419)

B con_info_ext_support(): DBSL supports extended connect protocol

B ==> connect info for default DB will be read from ssfs

C dbs/ora/stmt_cache_size = 250

C Register application info.

C Oracle client version: 11.2.0.4.0, V2, default build, (dbsl 721 030315, non-u nicode)

C Installed Oracle client patches:

C # Patch 12985200 : Created on 2 Jul 2014, 09:45:20 hrs PST8PDT

C # Patch 11742262 : Created on 6 Nov 2013, 15:22:08 hrs CET

C Client NLS setting (by OCINlsGetInfo(con=0)): 'AMERICAN_AMERICA.WE8DEC'

C Connecting as SAPSR3/<pwd>@PSB on connection 0 (nls 0) ... (dbsl 721 030315, non-unicode)

C OCIHandleAlloc(con=0): Service svc=x58bf2d8 created, rc=0

C Tue Mar 24 11:35:20 2015

C OCIServerAttach(con=0, svc=x58bf2d8): New server hdl. srv=x58c06b0 attached t o 'PSB'

C OCISessionBegin(con=0, svc=x58bf2d8, srv=x58c06b0='PSB'): start session usr=x 58f03b0='SAPSR3', rc=0

C Now 'SAPSR3/<pwd>@PSB' is connected: con=0, nls=0, session=10, time='2015-03- 24 11:35:20'

C DB instance PSB is running on prodsb with ORACLE version 11.2.0.4.0 since MAR 11, 2015, 15:14:48.

C con=0, V$NLS_PARAMETERS: NLS_LANG=AMERICAN_AMERICA.WE8DEC, NLS_NCHAR=UTF8

C # CharacterSet NCharSet envhp errhp er2hp bathp

C 0 WE8DEC AL16UTF16 x58b1be0 x58bd238 x58be2f8 x58bf3b8

B Connection 0 opened (DBSL handle 0)

C DbSlControl(DBSL_CMD_SAPRELEASE_SET,abap='700')

M ThInit: db_connect o.k.

M ICT: exclude compression: *.zip,*.rar,*.arj,*.z,*.gz,*.tar,*.lzh,*.cab,*.hqx, *.ace,*.jar,*.ear,*.war,*.jpg,*.pdf,*.gzip,*.uue,*.bz2,*.iso,*.sda,*.sar,*.gif,* .png,*.swc,*.swf

M vmcj/sgc_options: switch on template cleanup before cloning

M vmcj/sgc_options: switch off delayed session cleanup during shared gc

M ThVmcInitWaitForVm: th_maxWaitForVmTime=30

M ThVmcInitMaxErrCount: th_max_error_count=5

I Tue Mar 24 11:35:22 2015

I MtxInit: 0 0 0

M SHM_PRES_BUF (addr: 0x7f052baf9000, size: 20000000)

M SHM_ROLL_AREA (addr: 0x7effe684d000, size: 268435456)

M SHM_PAGING_AREA (addr: 0x7effd684d000, size: 268435456)

M SHM_ROLL_ADM (addr: 0x7f052ce0d000, size: 11090264)

M SHM_PAGING_ADM (addr: 0x7effd652c000, size: 3277856)

M ThCreateNoBuffer allocated 344144 bytes for 1000 entries at 0x7ef fb9799000

M ThCreateNoBuffer index size: 3000 elems

M ThCreateVBAdm allocated 17120 bytes (50 server) at 0x7f053fac3 000

X EmInit: MmSetImplementation( 2 ).

X MM global diagnostic options set: 0

X <ES> client 0 initializing ....

X Using implementation std

X Linux: Kernel supports shared memory disclaiming

X Linux: using madvise(<pointer>, <size>, 9).

X Linux: disclaiming for shared memory enabled

X ES initialized.

X mm.dump: set maximum dump mem to 192 MB

X mm.dump: set global maximum dump mem to 192 MB

X EsRegisterEmCheck: Register EmGetEsHandles at 0x1e93b90

I *** INFO SHM 42 in POOL 40 13938 KB estimated 9392 KB real ( -4545 KB -33 %)

B db_con_shm_ini: WP_ID = 0, WP_CNT = 26, CON_ID = -1

B dbtbxbuf: Buffer TABL (addr: 0x7effb1427100, size: 100000000, end: 0x7effb73 85200)

B dbtbxbuf: Buffer TABLP (addr: 0x7effae353100, size: 51200000, end: 0x7effb142 7100)

B dbsync[db_syinit]: successfully attached to shared memory, sync_adm_p = 0x7ef fbfb96000

B dbsync[db_syinit]: Buffer synchronisation started with

B sync_concept = SEQ_NR

B sendon = 1

B bufreftime = 120

B max_gap_wait_time = 60

B ddlog_del_time = 60

B last_counter = -2147470991

B oldest_gap = (2147483647,19700101000000)

B time_of_last_sync = 20150324113521

B MySysId = 'prodsb 01'

B dbexpbuf[EXP_SHB]: buffer EIBUF installed with

B semkey = 35

B shmkey = 54

B wp_n = 26

B sclass = 0

B block_length = 256

B max_objects = 15000

B max_obj_size = 24421120

B pref_obj_size = 0

B est_large_obj_size = 512000

B free_vec_lg = 2001

B hash_vec_size = 30011

B buffer_l = 102400000

B max_blocks = 381583

B free_blocks = 381583

B mutex_n = 30011

B max_mtx_wait_time = 17000

B recovery_delay = 500000

B tracing = 0

B force_checks = 0

B protect_shm = 0

B dbexpbuf[EXP_SHM]: buffer ESM installed with

B semkey = 56

B shmkey = 65

B wp_n = 26

B sclass = 0

B block_length = 256

B max_objects = 2000

B max_obj_size = 891776

B pref_obj_size = 0

B est_large_obj_size = 8192

B free_vec_lg = 33

B hash_vec_size = 4001

B buffer_l = 4194304

B max_blocks = 13937

B free_blocks = 13937

B mutex_n = 4001

B max_mtx_wait_time = 17000

B recovery_delay = 500000

B tracing = 0

B force_checks = 0

B protect_shm = 0

B dbexpbuf[EXP_CUA]: buffer CUA installed with

B semkey = 30

B shmkey = 47

B wp_n = 26

B sclass = 10

B block_length = 256

B max_objects = 10000

B max_obj_size = 4338368

B pref_obj_size = 0

B est_large_obj_size = 49152

B free_vec_lg = 193

B hash_vec_size = 20011

B buffer_l = 20480000

B max_blocks = 67790

B free_blocks = 67790

B mutex_n = 20011

B max_mtx_wait_time = 17000

B recovery_delay = 500000

B tracing = 0

B force_checks = 0

B protect_shm = 0

B dbexpbuf[EXP_OTR]: buffer OTR installed with

B semkey = 55

B shmkey = 64

B wp_n = 26

B sclass = 13

B block_length = 128

B max_objects = 2000

B max_obj_size = 891616

B pref_obj_size = 0

B est_large_obj_size = 10240

B free_vec_lg = 81

B hash_vec_size = 4001

B buffer_l = 4194304

B max_blocks = 27869

B free_blocks = 27869

B mutex_n = 4001

B max_mtx_wait_time = 17000

B recovery_delay = 500000

B tracing = 0

B force_checks = 0

B protect_shm = 0

B NTAB: version is VERS_B, UNICODELG=1, SAP_UC_LN=1

I MPI: dynamic quotas disabled.

I MPI init: pipes=4000 buffers=1279 reserved=383 quota=10%

M Semaphore recovery: keep semaphore data.

M logoff_check: set cancel flag during logoff.

M PfInitMemory: version = 1

M PfInitMemory: stat/recex/memory_check = 0

M PfInitMemory: stat/rfcrec = 5, distinct = 0, depth = 5

M CCMS: SemInMgt: Semaphore Management initialized by AlAttachShm_Doublestack.

M CCMS: SemInit: Semaphore 38 initialized by AlAttachShm_Doublestack.

G Tue Mar 24 11:35:23 2015

G RelWritePermissionForShm( pLocation = 120, pEnforce = 0 )

G GetWritePermissionForShm( pLocation = 99, pEnforce = 1 )

G RelWritePermissionForShm( pLocation = 100, pEnforce = 1 )

S *** init spool environment

S TSPEVJOB updates outside critical section: event_update_nocsec = 1

S initialize debug system

T Stack direction is downwards.

T debug control: prepare exclude for printer trace

T new memory block 0x5990fa0

S spool kernel/ddic check: Ok

S using table TSP02FX for frontend printing

S 1 spool work process(es) found

S frontend print via spool service enabled

S printer list size is 150

S printer type list size is 50

S queue size (profile) = 300

S hostspool list size = 3000

S option list size is 30

I *** INFO SHM 49 in POOL 40 2704 KB estimated 1326 KB real ( -1377 KB -51 %)

S found processing queue enabled

S found spool memory service RSPO-RCLOCKS at 0x7effc0f22060

S doing lock recovery

S setting server cache root

S found spool memory service RSPO-SERVERCACHE at 0x7effc0f228c8

S using messages for server info

S size of spec char cache entry: 165024 bytes (timeout 100 sec)

S size of open spool request entry: 1376 bytes

S immediate print option for implicitely closed spool requests is disabled

A Tue Mar 24 11:35:24 2015

A ***GENER* Trace switched on ***

A ---PXA-------------------------------------------

A PXA INITIALIZATION

A PXA: Locked PXA-Semaphore.

A PXA: max_map_count = 1000000: ok

A System page size: 4kb, total admin_size: 55000kb, dir_size: 54300kb.

A Attached to PXA (address 0x7eff6e1f5000, size 900000K, 1 fragments of 845000K )

A PXA allocated (address 0x7eff6e1f5000, size 900000K)

A abap/pxa = shared protect gen_remote

A PXA: checking structure sizes: 888|216|8

A PXA INITIALIZATION FINISHED

A ---PXA-------------------------------------------

A ATRA: pfclock execution time = 0

A abap/force_local_update_task=0

A ABAP ShmAdm attached (addr=0x7f00420f4000 leng=20955136 end=0x7f00434f0000)

A >> Shm MMADM area (addr=0x7f0042501cd8 leng=256960 end=0x7f0042540898)

A >> Shm MMDAT area (addr=0x7f0042541000 leng=16445440 end=0x7f00434f0000)

A RFC Destination> destination prodsb_PSB_01 host prodsb system PSB systnr 1 (p rodsb_PSB_01)

A RFC Options> H=prodsb,S=01,d=1,

A RFC FRFC> fallback activ but this is not a central instance.

A RFC rfc/signon_error_log = -1

A RFC rfc/dump_connection_info = 0

A RFC rfc/dump_client_info = 0

A RFC rfc/cp_convert/ignore_error = 1

A RFC rfc/cp_convert/conversion_char = 23

A RFC rfc/wan_compress/threshold = 251

A RFC rfc/recorder_pcs not set, use defaule value: 1

A RFC rfc/delta_trc_level not set, use default value: 0

A RFC rfc/no_uuid_check not set, use default value: 0

H HTTP> Parameter icf/ssocookie_mandatory set to 0

B dbtran INFO (init_connection '<DEFAULT>' [ORACLE:721.02]):

B max_blocking_factor = 5, min_blocking_factor = 5,

B max_in_blocking_factor = 5, min_in_blocking_factor = 5,

B max_union_blocking_factor = 5, min_union_blocking_factor = 5,

B prefer_union_all = 0, prefer_join = 0,

B prefer_fix_blocking = 0, prefer_in_itab_opt = 1,

B convert AVG = 0, alias table FUPD = 0,

B escape_as_literal = 1, ignore_maxmarkercnt = 0,

B select * =0x0f, character encoding =SBCS / <none> :-,

B use_hints = abap->1, dbif->0x1, upto->18446744073709551615

M ThrCreateShObjects allocated 53736 bytes at 0x7f053f906000

Y dyWpInit

Y ztta/dynpro_ara 800000

Y ztta/cua_ara 250000

Y ztta/diag_ara 250000

N SsfSapSecin: getenv(SECUDIR)=="/usr/sap/PSB/DVEBMGS01/sec"

N =================================================

N === SSF INITIALIZATION:

N ===...SSF Security Toolkit name SAPSECULIB .

N ===...SSF library is /usr/sap/PSB/DVEBMGS01/exe/libsapcrypto.so .

N ===...SSF default hash algorithm is SHA1 .

N ===...SSF default symmetric encryption algorithm is DES-CBC .

N Tue Mar 24 11:35:25 2015

N ===...SECUDIR="/usr/sap/PSB/DVEBMGS01/sec"

N ===...loading of Security Toolkit successfully completed.

N === CommonCryptoLib (SAPCRYPTOLIB) Version 8.4.34 pl40 (Feb 9 2015) MT-saf e

N =================================================

N MskiInitLogonTicketCacheHandle: Logon Ticket cache pointer retrieved from sha red memory.

N MskiInitLogonTicketCacheHandle: Workprocess runs with Logon Ticket cache.

M JrfcVmcRegister in process-driver OK

M JrfcVmcRegisterNativesDriver o.k.

W =================================================

W === ipl_Init() called

W ITS Plugin: Path dw_gui

W ITS Plugin: Description ITS Plugin - ITS rendering DLL

W ITS Plugin: sizeof(SAP_UC) 1

W ITS Plugin: Release: 721, [7210.0.402.20020600]

W ITS Plugin: Int.version, [34]

W ITS Plugin: Feature set: [32]

W ===... Calling itsp_Init in external dll ===>

W === ipl_Init() returns 0, ITSPE_OK: OK

W =================================================

N SignInit: Security Session Management cannot be used (ABAP parts are missing, note 1477428)

N SignInit: Not attempted to load Kerberos Library (ABAP parts missing, note 17 98979)

N VSI: WP init in ABAP VM completed with rc=0

E EnqId_Initialize: local EnqId initialization o.k.

M Set restart flag on 1073741824 bytes os heap

Could you share trans.log as well.

Thanks,

Hi,

Can you verify the SSFS by below commands:

rsecssfx list

This should show the summary.

Cross verify all the steps as per sap note:

1639578 - SSFS as password storage for primary database connect

Regards, Prem

Note are already implemented:

XXX:psbadm 65> rsecssfx list

|---------------------------------------------------------------------------------|

| Record Key | Status | Timestamp of last Update |

|---------------------------------------------------------------------------------|

| DB_CONNECT/DEFAULT_DB_PASSWORD | Encrypted | 2015-03-13 11:51:15 UTC |

| DB_CONNECT/DEFAULT_DB_USER | Plaintext | 2015-03-13 11:51:38 UTC |

|---------------------------------------------------------------------------------|

Summary

-------

Active Records : 2 (Encrypted : 1, Plain : 1, Wrong Key : 0, Error : 0)

Outdated Records : 9 (occupied space can be released by the "compact" command)

Datafile Location : /usr/sap/PSB/SYS/global/security/rsecssfs/data/SSFS_PSB.DAT (when existing)

Keyfile Location : /usr/sap/PSB/SYS/global/security/rsecssfs/key/SSFS_PSB.KEY (when existing)

trans.log

4 ETW000 R3trans version 6.24 (release 721 - 25.02.15 - 20:15:02).

4 ETW000 ===============================================

4 ETW000

4 ETW000 date&time : 24.03.2015 - 12:19:23

4 ETW000 control file: <no ctrlfile>

4 ETW000 R3trans was called as follows: R3trans -d

4 ETW000 trace at level 2 opened for a given file pointer

4 ETW000 [ dev trc,00000] Tue Mar 24 12:19:23 2015 145 0.000145

4 ETW000 [ dev trc,00000] db_con_init called 24 0.000169

4 ETW000 [ dev trc,00000] set_use_ext_con_info(): ssfs will be used to get connect information

4 ETW000 38 0.000207

4 ETW000 [ dev trc,00000] determine_block_commit: no con_hdl found as blocked for con_name = R/3

4 ETW000 18 0.000225

4 ETW000 [ dev trc,00000] create_con (con_name=R/3) 13 0.000238

4 ETW000 [ dev trc,00000] Loading DB library '/usr/sap/PSB/SYS/exe/run/dboraslib.so' ... 36 0.000274

4 ETW000 [ dev trc,00000] DlLoadLib() success: dlopen("/usr/sap/PSB/SYS/exe/run/dboraslib.so"), hdl 0

4 ETW000 16602 0.016876

4 ETW000 [ dev trc,00000] Library '/usr/sap/PSB/SYS/exe/run/dboraslib.so' loaded 20 0.016896

4 ETW000 [ dev trc,00000] function DbSlExpFuns loaded from library /usr/sap/PSB/SYS/exe/run/dboraslib.so

4 ETW000 26 0.016922

4 ETW000 [ dev trc,00000] Version of '/usr/sap/PSB/SYS/exe/run/dboraslib.so' is "721.02", patchlevel (0.419)

4 ETW000 125 0.017047

4 ETW000 [ dev trc,00000] function dsql_db_init loaded from library /usr/sap/PSB/SYS/exe/run/dboraslib.so

4 ETW000 18 0.017065

4 ETW000 [ dev trc,00000] function dbdd_exp_funs loaded from library /usr/sap/PSB/SYS/exe/run/dboraslib.so

4 ETW000 37 0.017102

4 ETW000 [ dev trc,00000] function sapic_get_instant_client_version loaded from library /usr/sap/PSB/SYS/exe/run/dboraslib.so

4 ETW000 21 0.017123

4 ETW000 [ dev trc,00000] function sapic_get_instant_client_flavor loaded from library /usr/sap/PSB/SYS/exe/run/dboraslib.so

4 ETW000 16 0.017139

4 ETW000 [ dev trc,00000] function sapic_get_patchset_version loaded from library /usr/sap/PSB/SYS/exe/run/dboraslib.so

4 ETW000 16 0.017155

4 ETW000 [ dev trc,00000] function sapic_get_ls_inventory loaded from library /usr/sap/PSB/SYS/exe/run/dboraslib.so

4 ETW000 15 0.017170

4 ETW000 [ dev trc,00000] -->DbSlControl(con=-1,cmd=47=DBSL_CMD_IMP_FUNS_SET) -> changed=30, tagset=1

4 ETW000 32 0.017202

4 ETW000 [ dev trc,00000] -->DbSlControl(con=-1,cmd=39=DBSL_CMD_SET_SINGLETASK) 11 0.017213

4 ETW000 [ dev trc,00000] -->DbSlControl(con=-1,cmd=10=DBSL_CMD_DBCA_PTR_GET) 18 0.017231

4 ETW000 [ dev trc,00000] New connection 0 created 10 0.017241

4 ETW000 [ dev trc,00000] 00: name=R/3, con_id=-000000001, state=DISCONNECTED, tx=NO , bc=NO , hc=NO , perm=YES, reco=NO , info=NO ,

4 ETW000 timeout=000, con_max=255, con_opt=255, occ=NO , prog= 49 0.017290

4 ETW000 [ dev trc,00000] -->DbSlControl(con=-1,cmd=10=DBSL_CMD_DBCA_PTR_GET) 22 0.017312

4 ETW000 [ dev trc,00000] db_con_connect (con_name=R/3) 11 0.017323

4 ETW000 [ dev trc,00000] determine_block_commit: no con_hdl found as blocked for con_name = R/3

4 ETW000 14 0.017337

4 ETW000 [ dev trc,00000] find_con_by_name found the following connection: 12 0.017349

4 ETW000 [ dev trc,00000] 00: name=R/3, con_id=000000000, state=DISCONNECTED, tx=NO , bc=NO , hc=NO , perm=YES, reco=NO , info=NO ,

4 ETW000 timeout=000, con_max=255, con_opt=255, occ=NO , prog= 18 0.017367

4 ETW000 [ dev trc,00000] read_con_info_ssfs(): reading connect info for connection R/3 11 0.017378

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 22 0.017400

4 ETW000 [ dev trc,00000] con_info_ext_support(): DBSL supports extended connect protocol 13 0.017413

4 ETW000 ==> connect info for default DB will be read from ssfs

4 ETW000 [ dev trc,00000] con_info_ext_support(): auth/shadow_upgrade = undefined 15 0.017428

4 ETW000 ==> Using default key set to get connect info from ssfs

4 ETW000 [ dev trc,00000] read_ssfs_record(): register callback ssfs_dbi_trace and max level 2

4 ETW000 17 0.017445

4 ETW000 [ dev trc,00000] RSecSSFs: Entering function "RSecSSFsGetRecord" [rsecssfs.c 872] 38 0.017483

4 ETW000 [ dev trc,00000] RSecSSFs: Configuration data read from environment parameters [rsecssfs.c 4635]

4 ETW000 25659 0.043142

4 ETW000 [ dev trc,00000] RSecSSFs: Data file "/usr/sap/PSB/SYS/global/security/rsecssfs/data/SSFS_PSB.DAT" opened for read [rsecssfs.c 2761]

4 ETW000 104 0.043246

4 ETW000 [ dev trc,00000] RSecSSFs: File "/usr/sap/PSB/SYS/global/security/rsecssfs/key/SSFS_PSB.KEY" cannot be opened in mode "rb": No such file or directory (errno = 2); at this location, this is not considered an error [rsecssfs.c 1188]

4 ETW000 65 0.043311

4 ETW000 [ dev trc,00000] RSecSSFs: Key file "/usr/sap/PSB/SYS/global/security/rsecssfs/key/SSFS_PSB.KEY" not found, using default key [rsecssfs.c 1635]

4 ETW000 18 0.043329

4 ETW000 [ dev trc,00000] RSecSSFs: Exiting function "RSecSSFsGetRecord" with return code 0 (message: <No message available>) [rsecssfs.c 940]

4 ETW000 438 0.043767

4 ETW000 [ dev trc,00000] read_ssfs_record(): DB_CONNECT/DEFAULT_DB_USER read successfully from ssfs

4 ETW000 17 0.043784

4 ETW000 [ dev trc,00000] read_ssfs_record(): deregister callback ssfs_dbi_trace 10 0.043794

4 ETW000 [ dev trc,00000] read_ssfs_record(): register callback ssfs_dbi_trace and max level 2

4 ETW000 12 0.043806

4 ETW000 [ dev trc,00000] RSecSSFs: Entering function "RSecSSFsGetRecord" [rsecssfs.c 872] 36 0.043842

4 ETW000 [ dev trc,00000] RSecSSFs: Configuration data read from environment parameters [rsecssfs.c 4635]

4 ETW000 39 0.043881

4 ETW000 [ dev trc,00000] RSecSSFs: Data file "/usr/sap/PSB/SYS/global/security/rsecssfs/data/SSFS_PSB.DAT" opened for read [rsecssfs.c 2761]

4 ETW000 48 0.043929

4 ETW000 36 0.043965

4 ETW000 [ dev trc,00000] RSecSSFs: Key file "/usr/sap/PSB/SYS/global/security/rsecssfs/key/SSFS_PSB.KEY" not found, using default key [rsecssfs.c 1635]

4 ETW000 17 0.043982

4 ETW000 [ dev trc,00000] RSecSSFs: Exiting function "RSecSSFsGetRecord" with return code 0 (message: <No message available>) [rsecssfs.c 940]

4 ETW000 310 0.044292

4 ETW000 [ dev trc,00000] read_ssfs_record(): DB_CONNECT/DEFAULT_DB_PASSWORD read successfully from ssfs

4 ETW000 15 0.044307

4 ETW000 [ dev trc,00000] read_ssfs_record(): deregister callback ssfs_dbi_trace 9 0.044316

4 ETW000 [ dev trc,00000] read_ssfs_record(): register callback ssfs_dbi_trace and max level 2

4 ETW000 13 0.044329

4 ETW000 [ dev trc,00000] RSecSSFs: Entering function "RSecSSFsGetRecord" [rsecssfs.c 872] 13 0.044342

4 ETW000 [ dev trc,00000] RSecSSFs: Configuration data read from environment parameters [rsecssfs.c 4635]

4 ETW000 36 0.044378

4 ETW000 [ dev trc,00000] RSecSSFs: Data file "/usr/sap/PSB/SYS/global/security/rsecssfs/data/SSFS_PSB.DAT" opened for read [rsecssfs.c 2761]

4 ETW000 45 0.044423

4 ETW000 34 0.044457

4 ETW000 [ dev trc,00000] RSecSSFs: Key file "/usr/sap/PSB/SYS/global/security/rsecssfs/key/SSFS_PSB.KEY" not found, using default key [rsecssfs.c 1635]

4 ETW000 18 0.044475

4 ETW000 [ dev trc,00000] RSecSSFs: Record with key "DB_CONNECT/DEFAULT_DB_CON_ENV" not found in secure storage [rsecssfs.c 2783]

4 ETW000 46 0.044521

4 ETW000 [ dev trc,00000] RSecSSFs: Exiting function "RSecSSFsGetRecord" with return code 1 (message: Record with key "DB_CONNECT/DEFAULT_DB_CON_ENV" not found in secure storage) [rsecssfs.c 940]

4 ETW000 46 0.044567

4 ETW000 [ dev trc,00000] read_ssfs_record(): not found is accepted, RSecSSFsGetRecord(DB_CONNECT/DEFAULT_DB_CON_ENV)=1 : Record with key "DB_CONNECT/DEFAULT_DB_CON_ENV" not found in secure storage

4 ETW000 34 0.044601

4 ETW000 [ dev trc,00000] read_ssfs_record(): deregister callback ssfs_dbi_trace 11 0.044612

4 ETW000 [ dev trc,00000] -->DbSlConnect(vers=0, type=0, env='[default env]', usr='SAPSR3', kernel dbsl='721')

4 ETW000 97 0.044709

4 ETW000 [ dev trc,00000] dbs/ora/stmt_cache_size = 250 27 0.044736

4 ETW000 [ dev trc,00000] Register application info. 319 0.045055

4 ETW000 [ dev trc,00000] Oracle client version: 11.2.0.4.0, V2, default build, (dbsl 721 030315, non-unicode)

4 ETW000 90 0.045145

4 ETW000 [ dev trc,00000] Installed Oracle client patches: 25 0.045170

4 ETW000 [ dev trc,00000] # Patch 12985200 : Created on 2 Jul 2014, 09:45:20 hrs PST8PDT

4 ETW000 16 0.045186

4 ETW000 [ dev trc,00000] # Patch 11742262 : Created on 6 Nov 2013, 15:22:08 hrs CET 14 0.045200

4 ETW000 [ dev trc,00000] Default connection: tnsname ='PSB' 16 0.045216

4 ETW000 [ dev trc,00000] -->oci_initialize(con=0, char='WE8DEC', nchr='AL16UTF16', nls=0),uc_ln=1

4 ETW000 26 0.045242

4 ETW000 [ dev trc,00000] OCIEnvCreate(mode=0=OCI_DEFAULT) -> rc=0, env=x177f340 (for default NLS hdl)

4 ETW000 7514 0.052756

4 ETW000 [ dev trc,00000] # CharacterSet NCharSet envhp errhp er2hp bathp

4 ETW000 71 0.052827

4 ETW000 [ dev trc,00000] 0 WE8DEC AL16UTF16 x177f340 x178a8f8 x178b978 x178c9f8

4 ETW000 21 0.052848

4 ETW000 [ dev trc,00000] NLS env. settings: lang=414D45524943414E 57 0.052905

4 ETW000 [ dev trc,00000] terr=414D4552494341 16 0.052921

4 ETW000 [ dev trc,00000] char=574538444543 12 0.052933

4 ETW000 [ dev trc,00000] Client NLS setting (by OCINlsGetInfo(con=0)): 'AMERICAN_AMERICA.WE8DEC'

4 ETW000 16 0.052949

4 ETW000 [ dev trc,00000] charset='WE8DEC', nchrset='AL16UTF16', UNI_ASC=FALSE 11 0.052960

4 ETW000 [ dev trc,00000] Connecting as SAPSR3/<pwd>@PSB on connection 0 (nls 0) ... (dbsl 721 030315, non-unicode)

4 ETW000 31 0.052991

4 ETW000 [ dev trc,00000] OCIHandleAlloc(con=0): Service svc=x178c918 created, rc=0 27 0.053018

4 ETW000 [ dev trc,00000] OCIHandleAlloc(con=0,svc=x178c918): New server hdl. srv=x178e250 created, rc=0

4 ETW000 48 0.053066

4 ETW000 [ dev trc,00000] OCIServerAttach(con=0, svc=x178c918): New server hdl. srv=x178e250 attached to 'PSB'

4 ETW000 33436 0.086502

4 ETW000 [ dev trc,00000] OCIAttrSet(con=0, 'PSB'): Assign srv=x178e250 to service svc=x178c918

4 ETW000 48 0.086550

4 ETW000 [ dev trc,00000] OCIHandleAlloc(con=0): New session handle usr=x17be1b0, rc=0) 59 0.086609

4 ETW000 [ dev trc,00000] OCIAttrSet(con=0): Assign user 'SAPSR3' to session hdl. usr=x17be1b0

4 ETW000 21 0.086630

4 ETW000 [ dev trc,00000] OCIAttrSet(con=0): Assign password to session hdl. usr=x17be1b0 19 0.086649

4 ETW000 [ dev trc,00000] OCISessionBegin(con=0, svc=x178c918, srv=x178e250='PSB'): start session usr=x17be1b0='SAPSR3', rc=0

4 ETW000 15825 0.102474

4 ETW000 [ dev trc,00000] OCIAttrSet(con=0): Assign session usr=x17be1b0='SAPSR3' to service svc=x178c918

4 ETW000 21 0.102495

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected 88 0.102583

4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=39,stp=x17a0898) 19 0.102602

4 ETW000 [ dev trc,00000] SELECT SID FROM V$MYSTAT WHERE ROWNUM<2

4 ETW000 17 0.102619

4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_INT , l= 4, con=0, stp=x17a0898, pv=x7fffd10b2e38, in=x7fffd10b2e3e,rl=NULL,rc=NULL)

4 ETW000 98 0.102717

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 64 0.102781

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#1: con=0,stp=x17a0898,itr=1,off=0,bat=0) 16 0.102797

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 14 0.102811

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=0): [dur. 0,001s] 964 0.103775

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, iters-errors = 1-0) [dur. 0,001s] 25 0.103800

4 ETW000 [ dev trc,00000] Now 'SAPSR3/<pwd>@PSB' is connected: con=0, nls=0, session=144, time='2015-03-24 12:19:23'

4 ETW000 94 0.103894

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected 30 0.103924

4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=33,stp=x17a0898) 14 0.103938

4 ETW000 [ dev trc,00000] ALTER SESSION SET NLS_SORT=BINARY

4 ETW000 17 0.103955

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 29 0.103984

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#2: con=0,stp=x17a0898,itr=1,off=0,bat=0) 14 0.103998

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 14 0.104012

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=0): [dur. 0,000s] 403 0.104415

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, iters-errors = 1-0) [dur. 0,000s] 24 0.104439

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected 58 0.104497

4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=110,stp=x17a0898) 16 0.104513

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 49 0.104562

4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_STR , l= 33, con=0, stp=x17a0898, pv=x7f8a92ddb251, in=x7fffd10b2e4e,rl=NULL,rc=NULL)

4 ETW000 38 0.104600

4 ETW000 [ dev trc,00000] - oci_define ( 1: SQLT_STR , l= 65, con=0, stp=x17a0898, pv=x7f8a92ddb375, in=x7fffd10b2e4e,rl=NULL,rc=NULL)

4 ETW000 27 0.104627

4 ETW000 [ dev trc,00000] - oci_define ( 2: SQLT_STR , l= 33, con=0, stp=x17a0898, pv=x7f8a92ddb230, in=x7fffd10b2e4e,rl=NULL,rc=NULL)

4 ETW000 26 0.104653

4 ETW000 [ dev trc,00000] - oci_define ( 3: SQLT_STR , l= 31, con=0, stp=x17a0898, pv=x7fffd10b2e20, in=x7fffd10b2e4e,rl=NULL,rc=NULL)

4 ETW000 23 0.104676

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 24 0.104700

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#3: con=0,stp=x17a0898,itr=1,off=0,bat=0) 14 0.104714

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 14 0.104728

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=0): [dur. 0,001s] 487 0.105215

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, iters-errors = 1-0) [dur. 0,001s] 25 0.105240

4 ETW000 [ dev trc,00000] DB instance PSB is running on prodsb with ORACLE version 11.2.0.4.0 since MAR 11, 2015, 15:14:48.

4 ETW000 31 0.105271

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected 34 0.105305

4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=74,stp=x17a0898) 14 0.105319

4 ETW000 [ dev trc,00000] SELECT SUBSTR(NAME,1,3), TO_CHAR(CREATED,'YYYYMMDDHHMMSS') FROM V$DATABASE

4 ETW000 16 0.105335

4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_CHR , l= 3, con=0, stp=x17a0898, pv=x7fffd10b2d80, in=x7fffd10b2e4e,rl=NULL,rc=NULL)

4 ETW000 35 0.105370

4 ETW000 [ dev trc,00000] - oci_define ( 1: SQLT_STR , l= 15, con=0, stp=x17a0898, pv=x7fffd10b2e30, in=x7fffd10b2e4e,rl=NULL,rc=NULL)

4 ETW000 35 0.105405

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 26 0.105431

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#4: con=0,stp=x17a0898,itr=1,off=0,bat=0) 31 0.105462

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 14 0.105476

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=0): [dur. 0,013s] 13395 0.118871

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, iters-errors = 1-0) [dur. 0,013s] 27 0.118898

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected 62 0.118960

4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=172,stp=x17a0898) 18 0.118978

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 42 0.119020

4 ETW000 [ dev trc,00000] TERSET','NLS_LENGTH_SEMANTICS') ORDER BY PARAMETER

4 ETW000 16 0.119036

4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_STR , l=101, con=0, stp=x17a0898, pv=x7fffd10b2f40, in=x7fffd10b36a0,rl=NULL,rc=NULL)

4 ETW000 38 0.119074

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 77 0.119151

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#5: con=0,stp=x17a0898,itr=5,off=0,bat=0) 19 0.119170

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 13 0.119183

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=0): [dur. 0,001s] 840 0.120023

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, iters-errors = 5-0) [dur. 0,001s] 26 0.120049

4 ETW000 [ dev trc,00000] con=0, V$NLS_PARAMETERS: NLS_LANG=AMERICAN_AMERICA.WE8DEC, NLS_NCHAR=UTF8

4 ETW000 43 0.120092

4 ETW000 [ dev trc,00000] V$NLS_PARAMETERS: NLS_LENGTH_SEMANTICS='BYTE' 15 0.120107

4 ETW000 [ dev trc,00000] # CharacterSet NCharSet envhp errhp er2hp bathp

4 ETW000 19 0.120126

4 ETW000 [ dev trc,00000] 0 WE8DEC AL16UTF16 x177f340 x178a8f8 x178b978 x178c9f8

4 ETW000 19 0.120145

4 ETW000 [ dev trc,00000] DbSlConnect(con=0) -> orc=0, rc=0=DBSL_ERR_OK 13 0.120158

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=21=DBSL_CMD_DBHOST_NAME_GET) 15 0.120173

4 ETW000 [ dev trc,00000] Connection 0 opened (DBSL handle 0) 11 0.120184

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=7=DBSL_CMD_DBNAME_GET) 42 0.120226

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=63=DBSL_CMD_DBSID_GET) 22 0.120248

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=21=DBSL_CMD_DBHOST_NAME_GET) 18 0.120266

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=11=DBSL_CMD_USERID_GET) -> USERID='SAPSR3' 16 0.120282

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=22=DBSL_CMD_OWNERID_GET) -> OWNERID='SAPSR3'

4 ETW000 17 0.120299

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=13=DBSL_CMD_VENDOR_NAME_GET) 11 0.120310

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=24=DBSL_CMD_DBVERSION_GET) 12 0.120322

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=51=DBSL_CMD_NLS_CHARACTERSET_GET) 11 0.120333

4 ETW000 [ dev trc,00000] -->DbSlPrepare(DBSL_SELECT, con=0, ssp=x7fffd10b39c0, dap=x7fffd10b3920), tok=x7fffd10b39e0, stid=NULL

4 ETW000 71 0.120404

4 ETW000 [ dev trc,00000] stmt.len=26, length(stmt.str)=26 42 0.120446

4 ETW000 [ dev trc,00000] .str=SELECT VERSION FROM SVERS

4 ETW000 37 0.120483

4 ETW000 [ dev trc,00000] build_stmt(): stmt.len = 26 16 0.120499

4 ETW000 [ dev trc,00000] build_stmt() -> OK 11 0.120510

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 118 0.120628

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected 21 0.120649

4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=26,stp=x17a0898); AI=DBSL: con=0, no ABAP.0.DBSL: con=0, no client_id.DBSL: con=0, no client_info

4 ETW000 19 0.120668

4 ETW000 [ dev trc,00000] SELECT VERSION FROM SVERS

4 ETW000 15 0.120683

4 ETW000 [ dev trc,00000] stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK 27 0.120710

4 ETW000 [ dev trc,00000] DbSlPrepare(lit=0, lob=0, fae=0, col=0, upd=0, mrk=0,sch=x1702710, scp=x1709c60, tab='SVERS') -> 0=DBSL_ERR_OK

4 ETW000 23 0.120733

4 ETW000 [ dev trc,00000] -->DbSlRead(con=0, ssp=NULL, dap=x1702710), sch=x1702710, stid=NULL, tok=x7fffd10b39e0, prepared=1

4 ETW000 47 0.120780

4 ETW000 [ dev trc,00000] -->DbSlRead(con=0, ssp=NULL, dap=x1702710), sch=x1702710, scp=x1709c60, tab='SVERS'

4 ETW000 19 0.120799

4 ETW000 [ dev trc,00000] stmt=SELECT VERSION FROM SVERS

4 ETW000 29 0.120828

4 ETW000 [ dev trc,00000] x7fffd10b39c0->id=NULL 13 0.120841

4 ETW000 [ dev trc,00000] Out 00: DBSL_DATA_SHORT_CHAR (len=72, max=72, dec=0) 16 0.120857

4 ETW000 [ dev trc,00000] bind_type_and_length(): 0 input variables, col=0 21 0.120878

4 ETW000 [ dev trc,00000] bind_type_and_length(): 1 output variables 14 0.120892

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=72, max=72, dec=0 12 0.120904

4 ETW000 [ dev trc,00000] bind_ind_and_values(OUT,con=0,arr=878,col=1,rc=0,rl=0,flt=0,int=0,sh=0,uc=72)

4 ETW000 38 0.120942

4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_CHR , l= 72, con=0, stp=x17a0898, pv=x17f6d0c, in=x17f6630,rl=NULL,rc=NULL)

4 ETW000 20 0.120962

4 ETW000 [ dev trc,00000] -->exec_fetch(con=0, bulk=0, sch=x1702710, dap=x7fffd10b3920, DBSL_DIR_READ)

4 ETW000 49 0.121011

4 ETW000 [ dev trc,00000] -->stmt_fetch(con=0, sch=x1702710, odp=x1709cf0, DBSL_DIR_READ) 14 0.121025

4 ETW000 [ dev trc,00000] AppInf(5)->1; mod='',act='',usr='DBSL: con=0, no client_id',ta='',mp=''

4 ETW000 38 0.121063

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 25 0.121088

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#6: con=0,stp=x17a0898,itr=1,off=0,bat=0); AI='..DBSL: con=0, no client_id.'

4 ETW000 19 0.121107

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 13 0.121120

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=1): [dur. 0,001s] 867 0.121987

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, rows processed 1, iters-errors = 1-0) [dur. 0,001s]

4 ETW000 30 0.122017

4 ETW000 [ dev trc,00000] stmt_fetch() -> orc=0, 0=DBSL_ERR_OK 12 0.122029

4 ETW000 [ dev trc,00000] sccb_stmt_deactivate(sch=x1702710) 33 0.122062

4 ETW000 [ dev trc,00000] DbSlRead() --> 0=DBSL_ERR_OK 13 0.122075

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=43=DBSL_CMD_SAPRELEASE_SET) 13 0.122088

4 ETW000 [ dev trc,00000] DbSlControl(DBSL_CMD_SAPRELEASE_SET,abap='700') 11 0.122099

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=41=DBSL_CMD_RELINFO_GET) 32 0.122131

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=14=DBSL_CMD_VERSION_GET) 12 0.122143

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=50=DBSL_CMD_GET_PATCH_INFO) 11 0.122154

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=52=DBSL_CMD_GET_DBLIB_VERSION) 50 0.122204

4 ETW000 [ dev trc,00000] -> 'OCI_112, 11.2.0.4.0, V2, default build' 13 0.122217

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=20=DBSL_CMD_DBFEATURES_PTR_GET) 171 0.122388

4 ETW000 [ dev trc,00000] -->DbSlPrepare(DBSL_SELECT, con=0, ssp=x7fffd10ae840, dap=x7fffd10ae720), tok=x7fffd10ae860, stid=NULL

4 ETW000 73 0.122461

4 ETW000 [ dev trc,00000] stmt.len=62, length(stmt.str)=62 25 0.122486

4 ETW000 [ dev trc,00000] .str=SELECT COMPCNT, UNICODELG FROM "DDNTT" WHERE TABNAME = 'SVERS'

4 ETW000 17 0.122503

4 ETW000 [ dev trc,00000] build_stmt(): stmt.len = 62 11 0.122514

4 ETW000 [ dev trc,00000] build_stmt() -> OK 9 0.122523

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 64 0.122587

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected 19 0.122606

4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=62,stp=x179f840); AI=DBSL: con=0, no ABAP.0.DBSL: con=0, no client_id.DBSL: con=0, no client_info

4 ETW000 18 0.122624

4 ETW000 [ dev trc,00000] SELECT COMPCNT, UNICODELG FROM "DDNTT" WHERE TABNAME = 'SVERS'

4 ETW000 15 0.122639

4 ETW000 [ dev trc,00000] stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK 43 0.122682

4 ETW000 [ dev trc,00000] DbSlPrepare(lit=0, lob=0, fae=0, col=0, upd=0, mrk=0,sch=x1702788, scp=x1709d80, tab='DDNTT') -> 0=DBSL_ERR_OK

4 ETW000 37 0.122719

4 ETW000 [ dev trc,00000] -->DbSlBegRead(con=0, ssp=NULL, dap=x1702788), sch=x1702788, stid=NULL, tok=x7fffd10ae860, prepared=1

4 ETW000 32 0.122751

4 ETW000 [ dev trc,00000] -->DbSlBegRead(#0: con=0, ssp=NULL, dap=x1702788), In=0, Out=2, sch=x1702788, scp=x1709d80, tab='DDNTT'

4 ETW000 27 0.122778

4 ETW000 [ dev trc,00000] stmt.len = 62 12 0.122790

4 ETW000 [ dev trc,00000] stmt=SELECT COMPCNT, UNICODELG FROM "DDNTT" WHERE TABNAME = 'SVERS'

4 ETW000 15 0.122805

4 ETW000 [ dev trc,00000] x7fffd10ae840->id=NULL 12 0.122817

4 ETW000 [ dev trc,00000] Out 00: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 11 0.122828

4 ETW000 [ dev trc,00000] Out 01: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.122838

4 ETW000 [ dev trc,00000] bind_type_and_length(): 0 input variables, col=0 10 0.122848

4 ETW000 [ dev trc,00000] bind_type_and_length(): 2 output variables 10 0.122858

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 10 0.122868

4 ETW000 [ dev trc,00000] 1: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 10 0.122878

4 ETW000 [ dev trc,00000] bind_ind_and_values(OUT,con=0,arr=5416,col=2,rc=0,rl=0,flt=0,int=2,sh=0,uc=0)

4 ETW000 20 0.122898

4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_INT , l= 4, con=0, stp=x179f840, pv=x17f6630, in=x1800f70,rl=NULL,rc=NULL)

4 ETW000 19 0.122917

4 ETW000 [ dev trc,00000] - oci_define ( 1: SQLT_INT , l= 4, con=0, stp=x179f840, pv=x17fbad0, in=x18039c0,rl=NULL,rc=NULL)

4 ETW000 27 0.122944

4 ETW000 [ dev trc,00000] DbSlBegRead(#0) -> 0=DBSL_ERR_OK 15 0.122959

4 ETW000 [ dev trc,00000] -->DbSlExeRead(#1: con=0, ssp=x7fffd10ae840, dap=x7fffd10ae720) 16 0.122975

4 ETW000 [ dev trc,00000] -->exec_fetch(con=0, bulk=0, sch=x1702788, dap=x7fffd10ae720, DBSL_SEQ_READ)

4 ETW000 18 0.122993

4 ETW000 [ dev trc,00000] -->stmt_fetch(con=0, sch=x1702788, odp=x1709e10, DBSL_SEQ_READ) 12 0.123005

4 ETW000 [ dev trc,00000] AppInf(5)->1; mod='',act='',usr='DBSL: con=0, no client_id',ta='',mp=''

4 ETW000 20 0.123025

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 19 0.123044

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#7: con=0,stp=x179f840,itr=1,off=0,bat=0); AI='..DBSL: con=0, no client_id.'

4 ETW000 18 0.123062

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 13 0.123075

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=1): [dur. 0,001s] 673 0.123748

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, rows processed 1, iters-errors = 1-0) [dur. 0,001s]

4 ETW000 29 0.123777

4 ETW000 [ dev trc,00000] stmt_fetch() -> orc=0, 0=DBSL_ERR_OK 13 0.123790

4 ETW000 [ dev trc,00000] DbSlExeRead(#1,con=0) -> 0=DBSL_ERR_OK, dbcount=1, lob_pw=0 13 0.123803

4 ETW000 [ dev trc,00000] -->DbSlEndRead(#1: con=0, ssp=x7fffd10ae840, dap=x7fffd10ae720, sch=x1702788) -> 0=DBSL_ERR_OK

4 ETW000 23 0.123826

4 ETW000 [ dev trc,00000] sccb_stmt_deactivate(sch=x1702788) 11 0.123837

4 ETW000 [ dev trc,00000] NTAB: version is VERS_B, UNICODELG=1, SAP_UC_LN=1 17 0.123854

4 ETW000 [ dev trc,00000] NTAB: standalone processing 54 0.123908

4 ETW000 [ dev trc,00000] NTAB: ntprofile(), read profile 18 0.123926

4 ETW000 [ dev trc,00000] NTAB: rsdb/ntab/entrycount 1000. 9 0.123935

4 ETW000 [ dev trc,00000] NTAB: rsdb/ntab/ftabsize 500. 9 0.123944

4 ETW000 [ dev trc,00000] NTAB: rsdb/ntab/irbdsize 100. 7 0.123951

4 ETW000 [ dev trc,00000] NTAB: rsdb/ntab/sntabsize 100. 8 0.123959

4 ETW000 [ dev trc,00000] NTAB: compute_hash_card: 2003. 14 0.123973

4 ETW000 [ dev trc,00000] NTAB: maxcnt 1000. 11 0.123984

4 ETW000 [ dev trc,00000] NTAB: hfactor 2003. 8 0.123992

4 ETW000 [ dev trc,00000] NTAB: mem_protocol_size 104 8 0.124000

4 ETW000 [ dev trc,00000] NTAB: hdr_backpack_offset 0 7 0.124007

4 ETW000 [ dev trc,00000] NTAB: hdr_backpack_size 0 8 0.124015

4 ETW000 [ dev trc,00000] NTAB: FTAB: header_size 88. 8 0.124023

4 ETW000 [ dev trc,00000] NTAB: FTAB: item_size 64. 7 0.124030

4 ETW000 [ dev trc,00000] NTAB: FTAB: item_cnt 1000. 8 0.124038

4 ETW000 [ dev trc,00000] NTAB: FTAB: unit_size 4 8 0.124046

4 ETW000 [ dev trc,00000] NTAB: FTAB: unit_cnt 128000. 8 0.124054

4 ETW000 [ dev trc,00000] NTAB: FTAB: data_size 512000. 8 0.124062

4 ETW000 [ dev trc,00000] NTAB: IREC: header_size 88. 8 0.124070

4 ETW000 [ dev trc,00000] NTAB: IREC: item_size 64. 8 0.124078

4 ETW000 [ dev trc,00000] NTAB: IREC: item_cnt 250. 7 0.124085

4 ETW000 [ dev trc,00000] NTAB: IREC: unit_size 8 8 0.124093

4 ETW000 [ dev trc,00000] NTAB: IREC: unit_cnt 12800. 8 0.124101

4 ETW000 [ dev trc,00000] NTAB: IREC: data_size 102400. 8 0.124109

4 ETW000 [ dev trc,00000] NTAB: STAB: header_size 88. 8 0.124117

4 ETW000 [ dev trc,00000] NTAB: STAB: item_size 64. 28 0.124145

4 ETW000 [ dev trc,00000] NTAB: STAB: item_cnt 250. 10 0.124155

4 ETW000 [ dev trc,00000] NTAB: STAB: unit_size 4 8 0.124163

4 ETW000 [ dev trc,00000] NTAB: STAB: unit_cnt 25600. 7 0.124170

4 ETW000 [ dev trc,00000] NTAB: STAB: data_size 102400. 8 0.124178

4 ETW000 [ dev trc,00000] NTAB: TTAB: header_size 192. 8 0.124186

4 ETW000 [ dev trc,00000] NTAB: TTAB: item_size 40. 8 0.124194

4 ETW000 [ dev trc,00000] NTAB: TTAB: item_cnt 1000. 8 0.124202

4 ETW000 [ dev trc,00000] NTAB: TTAB: unit_size 152 8 0.124210

4 ETW000 [ dev trc,00000] NTAB: TTAB: unit_cnt 1000. 7 0.124217

4 ETW000 [ dev trc,00000] NTAB: TTAB: data_size 152000. 8 0.124225

4 ETW000 [ dev trc,00000] NTAB: FTAB: hh_p 17b1980, hh_len 88 606 0.124831

4 ETW000 [ dev trc,00000] NTAB: FTAB: aa_p 1806d60, aa_len 16024 17 0.124848

4 ETW000 [ dev trc,00000] NTAB: FTAB: ia_p 180ac00, ia_len 64000 8 0.124856

4 ETW000 [ dev trc,00000] NTAB: FTAB: dat_p 7f8a93fdf010, dat_len 512000 9 0.124865

4 ETW000 [ dev trc,00000] NTAB: IREC: hh_p 17b19e0, hh_len 88 8 0.124873

4 ETW000 [ dev trc,00000] NTAB: IREC: aa_p 181a610, aa_len 16024 8 0.124881

4 ETW000 [ dev trc,00000] NTAB: IREC: ia_p 181e4b0, ia_len 16000 8 0.124889

4 ETW000 [ dev trc,00000] NTAB: IREC: dat_p 1822340, dat_len 102400 8 0.124897

4 ETW000 [ dev trc,00000] NTAB: STAB: hh_p 183b350, hh_len 88 8 0.124905

4 ETW000 [ dev trc,00000] NTAB: STAB: aa_p 183b3b0, aa_len 16024 8 0.124913

4 ETW000 [ dev trc,00000] NTAB: STAB: ia_p 183f250, ia_len 16000 8 0.124921

4 ETW000 [ dev trc,00000] NTAB: STAB: dat_p 18430e0, dat_len 102400 8 0.124929

4 ETW000 [ dev trc,00000] NTAB: TTAB: hh_p 185c0f0, hh_len 192 8 0.124937

4 ETW000 [ dev trc,00000] NTAB: TTAB: aa_p 185c1c0, aa_len 16024 8 0.124945

4 ETW000 [ dev trc,00000] NTAB: TTAB: ia_p 1860060, ia_len 40000 8 0.124953

4 ETW000 [ dev trc,00000] NTAB: TTAB: dat_p 7f8a93fb9010, dat_len 152000 8 0.124961

4 ETW000 [ dev trc,00000] NTAB: ntab_mem_protocol 185c0f0, ntab_mp_p 185c0f0, ntab_proc_id 0 16 0.124977

4 ETW000 [ dev trc,00000] NTAB: FTAB: hh_p 17b1980, ha_list 1806d60, hi_list 180ac00, buffer 7f8a93fdf010

4 ETW000 104 0.125081

4 ETW000 [ dev trc,00000] NTAB: IREC: hh_p 17b19e0, ha_list 181a610, hi_list 181e4b0, buffer 1822340

4 ETW000 14 0.125095

4 ETW000 [ dev trc,00000] NTAB: STAB: hh_p 183b350, ha_list 183b3b0, hi_list 183f250, buffer 18430e0

4 ETW000 13 0.125108

4 ETW000 [ dev trc,00000] NTAB: TTAB: hh_p 185c158, ha_list 185c1c0, hi_list 1860060, buffer 7f8a93fb9010

4 ETW000 40 0.125148

4 ETW000 [ dev trc,00000] NTAB: mem_handler: alloc for 500 elems, task 0, art 0 43 0.125191

4 ETW000 [ dev trc,00000] NTAB: mem_handler: alloc for 500 elems, task 0, art 1 33 0.125224

4 ETW000 [ dev trc,00000] NTAB: mem_handler: alloc for 500 elems, task 0, art 2 26 0.125250

4 ETW000 [ dev trc,00000] NTAB: mem_handler: alloc for 500 elems, task 0, art 3 21 0.125271

4 ETW000 [ dev trc,00000] CHECK_STMTID(x1692580): no cache (con=0,sch=NULL) 43 0.125314

4 ETW000 [ dev trc,00000] -->DbSlBegRead(#0: con=0, ssp=x1692580, dap=NULL), sch=NULL, state=0

4 ETW000 18 0.125332

4 ETW000 [ dev trc,00000] Wrong statement ID or statement not prepared. 10 0.125342

4 ETW000 [ dev trc,00000] x1693d80->id=x1692580: STID='10.DDNTF .0000001042.20150228002218'

4 ETW000 19 0.125361

4 ETW000 [ dev trc,00000] DbSlBegRead(#0) -> 13=DBSL_ERR_STMTID 10 0.125371

4 ETW000 [ dev trc,00000] -->DbSlPrepare(DBSL_SELECT, con=0, ssp=x1693d80, dap=x16936e0), tok=x1693440, stid=x1692580

4 ETW000 19 0.125390

4 ETW000 [ dev trc,00000] stmt.len=100, length(stmt.str)=100 26 0.125416

4 ETW000 [ dev trc,00000] .str=SELECT TABNAME, BLOCKNR, FIELDSLG, FIELDS FROM "DDNTF" WHERE TABNAME = :A0 ORDER BY TABNAME, BLOCKNR

4 ETW000 16 0.125432

4 ETW000 [ dev trc,00000] build_stmt(): stmt.len = 100 23 0.125455

4 ETW000 [ dev trc,00000] build_stmt() -> OK 11 0.125466

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 67 0.125533

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected 20 0.125553

4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=100,stp=x179e7c0); AI=DBSL: con=0, no ABAP.0.DBSL: con=0, no client_id.DBSL: con=0, no client_info

4 ETW000 17 0.125570

4 ETW000 [ dev trc,00000] SELECT TABNAME, BLOCKNR, FIELDSLG, FIELDS FROM "DDNTF" WHERE TABNAME = :A0 ORDER BY TABNAME, BLOCKNR

4 ETW000 15 0.125585

4 ETW000 [ dev trc,00000] stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK 36 0.125621

4 ETW000 [ dev trc,00000] DbSlPrepare(lit=0, lob=0, fae=0, col=1, upd=0, mrk=1,sch=x1702800, scp=x1709ea0, tab='DDNTF') -> 0=DBSL_ERR_OK

4 ETW000 23 0.125644

4 ETW000 [ dev trc,00000] -->DbSlBegRead(con=0, ssp=x1692580, dap=x1702800), sch=x1702800, stid=x1692580, tok=x1693440, prepared=1

4 ETW000 22 0.125666

4 ETW000 [ dev trc,00000] -->DbSlBegRead(#0: con=0, ssp=x1692580, dap=x1702800), In=1, Out=4, sch=x1702800, scp=x1709ea0, tab='DDNTF'

4 ETW000 24 0.125690

4 ETW000 [ dev trc,00000] stmt.len = 100 32 0.125722

4 ETW000 [ dev trc,00000] stmt=SELECT TABNAME, BLOCKNR, FIELDSLG, FIELDS FROM "DDNTF" WHERE TABNAME = :A0 ORDER BY TABNAME, BLOCKNR

4 ETW000 15 0.125737

4 ETW000 [ dev trc,00000] x1693d80->id=x1692580: STID='10.DDNTF .0000001042.20150228002218'

4 ETW000 19 0.125756

4 ETW000 [ dev trc,00000] In 00: DBSL_DATA_SHORT_CHAR (len=30, max=30, dec=0) 12 0.125768

4 ETW000 [ dev trc,00000] Out 00: DBSL_DATA_SHORT_CHAR (len=30, max=30, dec=0) 10 0.125778

4 ETW000 [ dev trc,00000] Out 01: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 11 0.125789

4 ETW000 [ dev trc,00000] Out 02: DBSL_DATA_INTEGER_4 (len=4, max=4, dec=0) 9 0.125798

4 ETW000 [ dev trc,00000] Out 03: DBSL_DATA_LONG_RAW (len=32768, max=32768, dec=0) 11 0.125809

4 ETW000 [ dev trc,00000] bind_type_and_length(): 1 input variables, col=1 10 0.125819

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=30, max=30, dec=0 11 0.125830

4 ETW000 [ dev trc,00000] bind_ind_and_values(IN,con=0,arr=1911,col=1,rc=0,rl=1,flt=0,int=0,sh=0,uc=30)

4 ETW000 20 0.125850

4 ETW000 [ dev trc,00000] - oci_bind ( 0: SQLT_AFC , l= 30, con=0, stp=x179e7c0, pv=x17f840c, in=x17f6630,rl=x17f751e,rc=NULL)

4 ETW000 26 0.125876

4 ETW000 [ dev trc,00000] bind_type_and_length(): 4 output variables 56 0.125932

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=30, max=30, dec=0 14 0.125946

4 ETW000 [ dev trc,00000] 1: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 11 0.125957

4 ETW000 [ dev trc,00000] 2: DBSL_DATA_INTEGER_4 , len=4, max=4, dec=0 10 0.125967

4 ETW000 [ dev trc,00000] 3: DBSL_DATA_LONG_RAW , len=32768, max=32768, dec=0 11 0.125978

4 ETW000 [ dev trc,00000] bind_ind_and_values(OUT,con=0,arr=1,col=4,rc=0,rl=1,flt=0,int=2,sh=0,uc=30)

4 ETW000 35 0.126013

4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_CHR , l= 30, con=0, stp=x179e7c0, pv=x1886792, in=x1886788,rl=NULL,rc=NULL)

4 ETW000 20 0.126033

4 ETW000 [ dev trc,00000] - oci_define ( 1: SQLT_INT , l= 4, con=0, stp=x179e7c0, pv=x1886780, in=x188678a,rl=NULL,rc=NULL)

4 ETW000 29 0.126062

4 ETW000 [ dev trc,00000] - oci_define ( 2: SQLT_INT , l= 4, con=0, stp=x179e7c0, pv=x1886784, in=x188678c,rl=NULL,rc=NULL)

4 ETW000 21 0.126083

4 ETW000 [ dev trc,00000] - oci_define ( 3: SQLT_LBI , l=32770, con=0, stp=x179e7c0, pv=x18867b0, in=x188678e,rl=x1886790,rc=NULL)

4 ETW000 24 0.126107

4 ETW000 [ dev trc,00000] DbSlBegRead(#0) -> 0=DBSL_ERR_OK 299 0.126406

4 ETW000 [ dev trc,00000] -->DbSlExeRead(#1: con=0, ssp=x1693d80, dap=x16936e0) 27 0.126433

4 ETW000 [ dev trc,00000] -->exec_fetch(con=0, bulk=0, sch=x1702800, dap=x16936e0, DBSL_SEQ_READ)

4 ETW000 36 0.126469

4 ETW000 [ dev trc,00000] -->stmt_fetch(con=0, sch=x1702800, odp=x1709f30, DBSL_SEQ_READ) 13 0.126482

4 ETW000 [ dev trc,00000] AppInf(5)->1; mod='',act='',usr='DBSL: con=0, no client_id',ta='',mp=''

4 ETW000 24 0.126506

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 24 0.126530

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#8: con=0,stp=x179e7c0,itr=1,off=0,bat=0); AI='..DBSL: con=0, no client_id.'

4 ETW000 18 0.126548

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 13 0.126561

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=1): [dur. 0,002s] 1928 0.128489

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, rows processed 1, iters-errors = 1-0) [dur. 0,002s]

4 ETW000 33 0.128522

4 ETW000 [ dev trc,00000] stmt_fetch() -> orc=0, 0=DBSL_ERR_OK 12 0.128534

4 ETW000 [ dev trc,00000] DbSlExeRead(#1,con=0) -> 0=DBSL_ERR_OK, dbcount=1, lob_pw=0 62 0.128596

4 ETW000 [ dev trc,00000] -->DbSlEndRead(#1: con=0, ssp=x1693d80, dap=x16936e0, sch=x1702800) -> 0=DBSL_ERR_OK

4 ETW000 25 0.128621

4 ETW000 [ dev trc,00000] sccb_stmt_deactivate(sch=x1702800) 12 0.128633

4 ETW000 [ dev trc,00000] CHECK_STMTID(x1693de0): no cache (con=0,sch=NULL) 74 0.128707

4 ETW000 [ dev trc,00000] -->DbSlRead(con=0, ssp=x1693de0, dap=NULL), sch=NULL, scp=NULL, state=0

4 ETW000 19 0.128726

4 ETW000 [ dev trc,00000] Wrong statement ID or statement not prepared. 9 0.128735

4 ETW000 [ dev trc,00000] x1693000->id=x1693de0: STID='10.DDNTT .0000011992.20150228002209'

4 ETW000 20 0.128755

4 ETW000 [ dev trc,00000] DbSlRead() --> 13=DBSL_ERR_STMTID 10 0.128765

4 ETW000 [ dev trc,00000] -->DbSlPrepare(DBSL_SELECT, con=0, ssp=x1693000, dap=x1691d40), tok=x1692fa0, stid=x1693de0

4 ETW000 19 0.128784

4 ETW000 [ dev trc,00000] stmt.len=244, length(stmt.str)=244 30 0.128814

4 ETW000 [ dev trc,00000] .str=SELECT VERSION, UUID, CRTIMESTMP, ABTIMESTMP, DYTIMESTMP, FLDCNT, TABLENGTH, KEYCNT, KEYLENGTH, CLIENTPOS, TABTYPE, TABFOR

4 ETW000 16 0.128830

4 ETW000 [ dev trc,00000] M, REFNAME, HFLAG, BUFSTATE, BUFPARM, ALIGN, POINTERLG, UNICODELG, COMPCNT, LEAFCNT FROM "DDNTT" WHERE TABNAME = :A0

4 ETW000 15 0.128845

4 ETW000 [ dev trc,00000] build_stmt(): stmt.len = 244 13 0.128858

4 ETW000 [ dev trc,00000] build_stmt() -> OK 10 0.128868

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 87 0.128955

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected 22 0.128977

4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=244,stp=x179c6e8); AI=DBSL: con=0, no ABAP.0.DBSL: con=0, no client_id.DBSL: con=0, no client_info

4 ETW000 19 0.128996

4 ETW000 [ dev trc,00000] SELECT VERSION, UUID, CRTIMESTMP, ABTIMESTMP, DYTIMESTMP, FLDCNT, TABLENGTH, KEYCNT, KEYLENGTH, CLIENTPOS, TABTYPE, TABF

4 ETW000 14 0.129010

4 ETW000 [ dev trc,00000] ORM, REFNAME, HFLAG, BUFSTATE, BUFPARM, ALIGN, POINTERLG, UNICODELG, COMPCNT, LEAFCNT FROM "DDNTT" WHERE TABNAME = :A0

4 ETW000 14 0.129024

4 ETW000 [ dev trc,00000] stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK 32 0.129056

4 ETW000 [ dev trc,00000] DbSlPrepare(lit=0, lob=0, fae=0, col=1, upd=0, mrk=1,sch=x1702878, scp=x1709fc0, tab='DDNTT') -> 0=DBSL_ERR_OK

4 ETW000 21 0.129077

4 ETW000 [ dev trc,00000] -->DbSlRead(con=0, ssp=x1693de0, dap=x1702878), sch=x1702878, stid=x1693de0, tok=x1692fa0, prepared=1

4 ETW000 22 0.129099

4 ETW000 [ dev trc,00000] -->DbSlRead(con=0, ssp=x1693de0, dap=x1702878), sch=x1702878, scp=x1709fc0, tab='DDNTT'

4 ETW000 17 0.129116

4 ETW000 [ dev trc,00000] stmt=SELECT VERSION, UUID, CRTIMESTMP, ABTIMESTMP, DYTIMESTMP, FLDCNT, TABLENGTH, KEYCNT, KEYLENGTH, CLIENTPOS, TABTYPE, TABF

4 ETW000 17 0.129133

4 ETW000 [ dev trc,00000] ORM, REFNAME, HFLAG, BUFSTATE, BUFPARM, ALIGN, POINTERLG, UNICODELG, COMPCNT, LEAFCNT FROM "DDNTT" WHERE TABNAME = :A0

4 ETW000 15 0.129148

4 ETW000 [ dev trc,00000] x1693000->id=x1693de0: STID='10.DDNTT .0000011992.20150228002209'

4 ETW000 19 0.129167

4 ETW000 [ dev trc,00000] In 00: DBSL_DATA_SHORT_CHAR (len=30, max=30, dec=0) 11 0.129178

4 ETW000 [ dev trc,00000] Out 00: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 11 0.129189

4 ETW000 [ dev trc,00000] Out 01: DBSL_DATA_SHORT_RAW (len=16, max=16, dec=0) 10 0.129199

4 ETW000 [ dev trc,00000] Out 02: DBSL_DATA_SHORT_CHAR (len=14, max=14, dec=0) 10 0.129209

4 ETW000 [ dev trc,00000] Out 03: DBSL_DATA_SHORT_CHAR (len=14, max=14, dec=0) 10 0.129219

4 ETW000 [ dev trc,00000] Out 04: DBSL_DATA_SHORT_CHAR (len=14, max=14, dec=0) 10 0.129229

4 ETW000 [ dev trc,00000] Out 05: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.129239

4 ETW000 [ dev trc,00000] Out 06: DBSL_DATA_INTEGER_4 (len=4, max=4, dec=0) 10 0.129249

4 ETW000 [ dev trc,00000] Out 07: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.129259

4 ETW000 [ dev trc,00000] Out 08: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.129269

4 ETW000 [ dev trc,00000] Out 09: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.129279

4 ETW000 [ dev trc,00000] Out 10: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 27 0.129306

4 ETW000 [ dev trc,00000] Out 11: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 11 0.129317

4 ETW000 [ dev trc,00000] Out 12: DBSL_DATA_SHORT_CHAR (len=30, max=30, dec=0) 10 0.129327

4 ETW000 [ dev trc,00000] Out 13: DBSL_DATA_SHORT_RAW (len=6, max=6, dec=0) 10 0.129337

4 ETW000 [ dev trc,00000] Out 14: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 10 0.129347

4 ETW000 [ dev trc,00000] Out 15: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.129357

4 ETW000 [ dev trc,00000] Out 16: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.129367

4 ETW000 [ dev trc,00000] Out 17: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.129377

4 ETW000 [ dev trc,00000] Out 18: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 9 0.129386

4 ETW000 [ dev trc,00000] Out 19: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.129396

4 ETW000 [ dev trc,00000] Out 20: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 9 0.129405

4 ETW000 [ dev trc,00000] bind_type_and_length(): 1 input variables, col=1 11 0.129416

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=30, max=30, dec=0 10 0.129426

4 ETW000 [ dev trc,00000] bind_ind_and_values(IN,con=0,arr=1911,col=1,rc=0,rl=1,flt=0,int=0,sh=0,uc=30)

4 ETW000 52 0.129478

4 ETW000 [ dev trc,00000] - oci_bind ( 0: SQLT_AFC , l= 30, con=0, stp=x179c6e8, pv=x188855c, in=x1886780,rl=x188766e,rc=NULL)

4 ETW000 20 0.129498

4 ETW000 [ dev trc,00000] bind_type_and_length(): 21 output variables 28 0.129526

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 13 0.129539

4 ETW000 [ dev trc,00000] 1: DBSL_DATA_SHORT_RAW , len=16, max=16, dec=0 11 0.129550

4 ETW000 [ dev trc,00000] 2: DBSL_DATA_SHORT_CHAR , len=14, max=14, dec=0 10 0.129560

4 ETW000 [ dev trc,00000] 3: DBSL_DATA_SHORT_CHAR , len=14, max=14, dec=0 9 0.129569

4 ETW000 [ dev trc,00000] 4: DBSL_DATA_SHORT_CHAR , len=14, max=14, dec=0 10 0.129579

4 ETW000 [ dev trc,00000] 5: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 10 0.129589

4 ETW000 [ dev trc,00000] 6: DBSL_DATA_INTEGER_4 , len=4, max=4, dec=0 9 0.129598

4 ETW000 [ dev trc,00000] 7: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 10 0.129608

4 ETW000 [ dev trc,00000] 8: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 10 0.129618

4 ETW000 [ dev trc,00000] 9: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 10 0.129628

4 ETW000 [ dev trc,00000] 10: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 9 0.129637

4 ETW000 [ dev trc,00000] 11: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 10 0.129647

4 ETW000 [ dev trc,00000] 12: DBSL_DATA_SHORT_CHAR , len=30, max=30, dec=0 10 0.129657

4 ETW000 [ dev trc,00000] 13: DBSL_DATA_SHORT_RAW , len=6, max=6, dec=0 9 0.129666

4 ETW000 [ dev trc,00000] 14: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 10 0.129676

4 ETW000 [ dev trc,00000] 15: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 9 0.129685

4 ETW000 [ dev trc,00000] 16: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 26 0.129711

4 ETW000 [ dev trc,00000] 17: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 10 0.129721

4 ETW000 [ dev trc,00000] 18: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 10 0.129731

4 ETW000 [ dev trc,00000] 19: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 9 0.129740

4 ETW000 [ dev trc,00000] 20: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 10 0.129750

4 ETW000 [ dev trc,00000] bind_ind_and_values(OUT,con=0,arr=345,col=21,rc=0,rl=2,flt=0,int=11,sh=0,uc=76)

4 ETW000 20 0.129770

4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_CHR , l= 1, con=0, stp=x179c6e8, pv=x17fdf7a, in=x17fa17c,rl=NULL,rc=NULL)

4 ETW000 19 0.129789

4 ETW000 [ dev trc,00000] - oci_define ( 1: SQLT_BIN , l= 16, con=0, stp=x179c6e8, pv=x18045e6, in=x17fa42e,rl=x17fda16,rc=NULL)

4 ETW000 30 0.129819

4 ETW000 [ dev trc,00000] - oci_define ( 2: SQLT_CHR , l= 14, con=0, stp=x179c6e8, pv=x17fe0d3, in=x17fa6e0,rl=NULL,rc=NULL)

4 ETW000 23 0.129842

4 ETW000 [ dev trc,00000] - oci_define ( 3: SQLT_CHR , l= 14, con=0, stp=x179c6e8, pv=x17ff3b1, in=x17fa992,rl=NULL,rc=NULL)

4 ETW000 23 0.129865

4 ETW000 [ dev trc,00000] - oci_define ( 4: SQLT_CHR , l= 14, con=0, stp=x179c6e8, pv=x180068f, in=x17fac44,rl=NULL,rc=NULL)

4 ETW000 21 0.129886

4 ETW000 [ dev trc,00000] - oci_define ( 5: SQLT_INT , l= 4, con=0, stp=x179c6e8, pv=x17f6630, in=x17faef6,rl=NULL,rc=NULL)

4 ETW000 20 0.129906

4 ETW000 [ dev trc,00000] - oci_define ( 6: SQLT_INT , l= 4, con=0, stp=x179c6e8, pv=x17f6b94, in=x17fb1a8,rl=NULL,rc=NULL)

4 ETW000 21 0.129927

4 ETW000 [ dev trc,00000] - oci_define ( 7: SQLT_INT , l= 4, con=0, stp=x179c6e8, pv=x17f70f8, in=x17fb45a,rl=NULL,rc=NULL)

4 ETW000 21 0.129948

4 ETW000 [ dev trc,00000] - oci_define ( 8: SQLT_INT , l= 4, con=0, stp=x179c6e8, pv=x17f765c, in=x17fb70c,rl=NULL,rc=NULL)

4 ETW000 20 0.129968

4 ETW000 [ dev trc,00000] - oci_define ( 9: SQLT_INT , l= 4, con=0, stp=x179c6e8, pv=x17f7bc0, in=x17fb9be,rl=NULL,rc=NULL)

4 ETW000 20 0.129988

4 ETW000 [ dev trc,00000] - oci_define (10: SQLT_CHR , l= 1, con=0, stp=x179c6e8, pv=x180196d, in=x17fbc70,rl=NULL,rc=NULL)

4 ETW000 21 0.130009

4 ETW000 [ dev trc,00000] - oci_define (11: SQLT_CHR , l= 1, con=0, stp=x179c6e8, pv=x1801ac6, in=x17fbf22,rl=NULL,rc=NULL)

4 ETW000 32 0.130041

4 ETW000 [ dev trc,00000] - oci_define (12: SQLT_CHR , l= 30, con=0, stp=x179c6e8, pv=x1801c1f, in=x17fc1d4,rl=NULL,rc=NULL)

4 ETW000 22 0.130063

4 ETW000 [ dev trc,00000] - oci_define (13: SQLT_BIN , l= 6, con=0, stp=x179c6e8, pv=x1805b76, in=x17fc486,rl=x17fdcc8,rc=NULL)

4 ETW000 40 0.130103

4 ETW000 [ dev trc,00000] - oci_define (14: SQLT_CHR , l= 1, con=0, stp=x179c6e8, pv=x180448d, in=x17fc738,rl=NULL,rc=NULL)

4 ETW000 20 0.130123

4 ETW000 [ dev trc,00000] - oci_define (15: SQLT_INT , l= 4, con=0, stp=x179c6e8, pv=x17f8124, in=x17fc9ea,rl=NULL,rc=NULL)

4 ETW000 21 0.130144

4 ETW000 [ dev trc,00000] - oci_define (16: SQLT_INT , l= 4, con=0, stp=x179c6e8, pv=x17f8688, in=x17fcc9c,rl=NULL,rc=NULL)

4 ETW000 20 0.130164

4 ETW000 [ dev trc,00000] - oci_define (17: SQLT_INT , l= 4, con=0, stp=x179c6e8, pv=x17f8bec, in=x17fcf4e,rl=NULL,rc=NULL)

4 ETW000 20 0.130184

4 ETW000 [ dev trc,00000] - oci_define (18: SQLT_INT , l= 4, con=0, stp=x179c6e8, pv=x17f9150, in=x17fd200,rl=NULL,rc=NULL)

4 ETW000 20 0.130204

4 ETW000 [ dev trc,00000] - oci_define (19: SQLT_INT , l= 4, con=0, stp=x179c6e8, pv=x17f96b4, in=x17fd4b2,rl=NULL,rc=NULL)

4 ETW000 20 0.130224

4 ETW000 [ dev trc,00000] - oci_define (20: SQLT_INT , l= 4, con=0, stp=x179c6e8, pv=x17f9c18, in=x17fd764,rl=NULL,rc=NULL)

4 ETW000 50 0.130274

4 ETW000 [ dev trc,00000] -->exec_fetch(con=0, bulk=0, sch=x1702878, dap=x1691d40, DBSL_DIR_READ)

4 ETW000 23 0.130297

4 ETW000 [ dev trc,00000] -->stmt_fetch(con=0, sch=x1702878, odp=x170a050, DBSL_DIR_READ) 12 0.130309

4 ETW000 [ dev trc,00000] AppInf(5)->1; mod='',act='',usr='DBSL: con=0, no client_id',ta='',mp=''

4 ETW000 22 0.130331

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 22 0.130353

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#9: con=0,stp=x179c6e8,itr=1,off=0,bat=0); AI='..DBSL: con=0, no client_id.'

4 ETW000 19 0.130372

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 12 0.130384

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=1): [dur. 0,001s] 884 0.131268

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, rows processed 1, iters-errors = 1-0) [dur. 0,001s]

4 ETW000 31 0.131299

4 ETW000 [ dev trc,00000] stmt_fetch() -> orc=0, 0=DBSL_ERR_OK 12 0.131311

4 ETW000 [ dev trc,00000] sccb_stmt_deactivate(sch=x1702878) 17 0.131328

4 ETW000 [ dev trc,00000] DbSlRead() --> 0=DBSL_ERR_OK 12 0.131340

4 ETW000 [ dev trc,00000] { db_rtab( fcode = 'RT_READ_ONLY', tname = 'TADIR' ) {twdbcall.c:880}

4 ETW000 50 0.131390

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=12=DBSL_CMD_VENDOR_ID_GET) 49 0.131439

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=20=DBSL_CMD_DBFEATURES_PTR_GET) 37 0.131476

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=2=DBSL_CMD_DBSTATS_PTR_GET) 12 0.131488

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=10=DBSL_CMD_DBCA_PTR_GET) 10 0.131498

4 ETW000 [ dev trc,00000] CHECK_STMTID(x12e0330): no cache (con=0,sch=NULL) 141 0.131639

4 ETW000 [ dev trc,00000] -->DbSlRead(con=0, ssp=x12e0330, dap=NULL), sch=NULL, scp=NULL, state=0

4 ETW000 22 0.131661

4 ETW000 [ dev trc,00000] Wrong statement ID or statement not prepared. 10 0.131671

4 ETW000 [ dev trc,00000] x12e1060->id=x12e0330: STID='03.TADIR .1073741825.20060105115716'

4 ETW000 19 0.131690

4 ETW000 [ dev trc,00000] DbSlRead() --> 13=DBSL_ERR_STMTID 10 0.131700

4 ETW000 [ dev trc,00000] -->DbSlPrepare(DBSL_SELECT, con=0, ssp=x12e1060, dap=x12e0378), tok=x12e1080, stid=x12e0330

4 ETW000 31 0.131731

4 ETW000 [ dev trc,00000] stmt.len=75, length(stmt.str)=75 36 0.131767

4 ETW000 [ dev trc,00000] .str=SELECT * FROM "TADIR" WHERE "PGMID"=:A0 AND "OBJECT"=:A1 AND "OBJ_NAME"=:A2

4 ETW000 17 0.131784

4 ETW000 [ dev trc,00000] build_stmt(): stmt.len = 75 12 0.131796

4 ETW000 [ dev trc,00000] build_stmt() -> OK 9 0.131805

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 72 0.131877

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected 20 0.131897

4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=75,stp=x18c8c18); AI=DBSL: con=0, no ABAP.0.DBSL: con=0, no client_id.DBSL: con=0, no client_info

4 ETW000 18 0.131915

4 ETW000 [ dev trc,00000] SELECT * FROM "TADIR" WHERE "PGMID"=:A0 AND "OBJECT"=:A1 AND "OBJ_NAME"=:A2

4 ETW000 15 0.131930

4 ETW000 [ dev trc,00000] stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK 30 0.131960

4 ETW000 [ dev trc,00000] DbSlPrepare(lit=0, lob=0, fae=0, col=3, upd=0, mrk=3,sch=x17028f0, scp=x170a0e0, tab='TADIR') -> 0=DBSL_ERR_OK

4 ETW000 22 0.131982

4 ETW000 [ dev trc,00000] -->DbSlRead(con=0, ssp=x12e0330, dap=x17028f0), sch=x17028f0, stid=x12e0330, tok=x12e1080, prepared=1

4 ETW000 22 0.132004

4 ETW000 [ dev trc,00000] -->DbSlRead(con=0, ssp=x12e0330, dap=x17028f0), sch=x17028f0, scp=x170a0e0, tab='TADIR'

4 ETW000 16 0.132020

4 ETW000 [ dev trc,00000] stmt=SELECT * FROM "TADIR" WHERE "PGMID"=:A0 AND "OBJECT"=:A1 AND "OBJ_NAME"=:A2

4 ETW000 16 0.132036

4 ETW000 [ dev trc,00000] x12e1060->id=x12e0330: STID='03.TADIR .1073741825.20060105115716'

4 ETW000 41 0.132077

4 ETW000 [ dev trc,00000] In 00: DBSL_DATA_SHORT_CHAR (len=4, max=4, dec=0) 12 0.132089

4 ETW000 [ dev trc,00000] In 01: DBSL_DATA_SHORT_CHAR (len=4, max=4, dec=0) 11 0.132100

4 ETW000 [ dev trc,00000] In 02: DBSL_DATA_SHORT_CHAR (len=40, max=40, dec=0) 11 0.132111

4 ETW000 [ dev trc,00000] Out 00: DBSL_DATA_SHORT_CHAR (len=4, max=4, dec=0) 10 0.132121

4 ETW000 [ dev trc,00000] Out 01: DBSL_DATA_SHORT_CHAR (len=4, max=4, dec=0) 10 0.132131

4 ETW000 [ dev trc,00000] Out 02: DBSL_DATA_SHORT_CHAR (len=40, max=40, dec=0) 10 0.132141

4 ETW000 [ dev trc,00000] Out 03: DBSL_DATA_SHORT_CHAR (len=10, max=10, dec=0) 10 0.132151

4 ETW000 [ dev trc,00000] Out 04: DBSL_DATA_SHORT_CHAR (len=10, max=10, dec=0) 10 0.132161

4 ETW000 [ dev trc,00000] Out 05: DBSL_DATA_SHORT_CHAR (len=12, max=12, dec=0) 10 0.132171

4 ETW000 [ dev trc,00000] Out 06: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 10 0.132181

4 ETW000 [ dev trc,00000] Out 07: DBSL_DATA_SHORT_CHAR (len=30, max=30, dec=0) 10 0.132191

4 ETW000 [ dev trc,00000] Out 08: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 11 0.132202

4 ETW000 [ dev trc,00000] Out 09: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 10 0.132212

4 ETW000 [ dev trc,00000] Out 10: DBSL_DATA_SHORT_CHAR (len=8, max=8, dec=0) 10 0.132222

4 ETW000 [ dev trc,00000] Out 11: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 9 0.132231

4 ETW000 [ dev trc,00000] Out 12: DBSL_DATA_SHORT_CHAR (len=20, max=20, dec=0) 11 0.132242

4 ETW000 [ dev trc,00000] Out 13: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 10 0.132252

4 ETW000 [ dev trc,00000] Out 14: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 10 0.132262

4 ETW000 [ dev trc,00000] Out 15: DBSL_DATA_SHORT_CHAR (len=30, max=30, dec=0) 10 0.132272

4 ETW000 [ dev trc,00000] Out 16: DBSL_DATA_SHORT_CHAR (len=10, max=10, dec=0) 10 0.132282

4 ETW000 [ dev trc,00000] Out 17: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 10 0.132292

4 ETW000 [ dev trc,00000] Out 18: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 10 0.132302

4 ETW000 [ dev trc,00000] bind_type_and_length(): 3 input variables, col=3 10 0.132312

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=4, max=4, dec=0 12 0.132324

4 ETW000 [ dev trc,00000] 1: DBSL_DATA_SHORT_CHAR , len=4, max=4, dec=0 10 0.132334

4 ETW000 [ dev trc,00000] 2: DBSL_DATA_SHORT_CHAR , len=40, max=40, dec=0 10 0.132344

4 ETW000 [ dev trc,00000] bind_ind_and_values(IN,con=0,arr=1083,col=3,rc=0,rl=3,flt=0,int=0,sh=0,uc=48)

4 ETW000 20 0.132364

4 ETW000 [ dev trc,00000] - oci_bind ( 0: SQLT_AFC , l= 4, con=0, stp=x18c8c18, pv=x17f98f4, in=x17f6630,rl=x17f7f92,rc=NULL)

4 ETW000 20 0.132384

4 ETW000 [ dev trc,00000] - oci_bind ( 1: SQLT_AFC , l= 4, con=0, stp=x18c8c18, pv=x17fa9e0, in=x17f6ea6,rl=x17f8808,rc=NULL)

4 ETW000 24 0.132408

4 ETW000 [ dev trc,00000] - oci_bind ( 2: SQLT_AFC , l= 40, con=0, stp=x18c8c18, pv=x17fbacc, in=x17f771c,rl=x17f907e,rc=NULL)

4 ETW000 37 0.132445

4 ETW000 [ dev trc,00000] bind_type_and_length(): 19 output variables 14 0.132459

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=4, max=4, dec=0 13 0.132472

4 ETW000 [ dev trc,00000] 1: DBSL_DATA_SHORT_CHAR , len=4, max=4, dec=0 10 0.132482

4 ETW000 [ dev trc,00000] 2: DBSL_DATA_SHORT_CHAR , len=40, max=40, dec=0 11 0.132493

4 ETW000 [ dev trc,00000] 3: DBSL_DATA_SHORT_CHAR , len=10, max=10, dec=0 10 0.132503

4 ETW000 [ dev trc,00000] 4: DBSL_DATA_SHORT_CHAR , len=10, max=10, dec=0 10 0.132513

4 ETW000 [ dev trc,00000] 5: DBSL_DATA_SHORT_CHAR , len=12, max=12, dec=0 9 0.132522

4 ETW000 [ dev trc,00000] 6: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 10 0.132532

4 ETW000 [ dev trc,00000] 7: DBSL_DATA_SHORT_CHAR , len=30, max=30, dec=0 10 0.132542

4 ETW000 [ dev trc,00000] 8: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 10 0.132552

4 ETW000 [ dev trc,00000] 9: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 9 0.132561

4 ETW000 [ dev trc,00000] 10: DBSL_DATA_SHORT_CHAR , len=8, max=8, dec=0 10 0.132571

4 ETW000 [ dev trc,00000] 11: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 9 0.132580

4 ETW000 [ dev trc,00000] 12: DBSL_DATA_SHORT_CHAR , len=20, max=20, dec=0 10 0.132590

4 ETW000 [ dev trc,00000] 13: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 10 0.132600

4 ETW000 [ dev trc,00000] 14: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 9 0.132609

4 ETW000 [ dev trc,00000] 15: DBSL_DATA_SHORT_CHAR , len=30, max=30, dec=0 10 0.132619

4 ETW000 [ dev trc,00000] 16: DBSL_DATA_SHORT_CHAR , len=10, max=10, dec=0 10 0.132629

4 ETW000 [ dev trc,00000] 17: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 10 0.132639

4 ETW000 [ dev trc,00000] 18: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 9 0.132648

4 ETW000 [ dev trc,00000] bind_ind_and_values(OUT,con=0,arr=290,col=19,rc=0,rl=0,flt=0,int=0,sh=0,uc=186)

4 ETW000 26 0.132674

4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_CHR , l= 4, con=0, stp=x18c8c18, pv=x188928c, in=x1886780,rl=NULL,rc=NULL)

4 ETW000 20 0.132694

4 ETW000 [ dev trc,00000] - oci_define ( 1: SQLT_CHR , l= 4, con=0, stp=x18c8c18, pv=x1889714, in=x18869c4,rl=NULL,rc=NULL)

4 ETW000 37 0.132731

4 ETW000 [ dev trc,00000] - oci_define ( 2: SQLT_CHR , l= 40, con=0, stp=x18c8c18, pv=x1889b9c, in=x1886c08,rl=NULL,rc=NULL)

4 ETW000 22 0.132753

4 ETW000 [ dev trc,00000] - oci_define ( 3: SQLT_CHR , l= 10, con=0, stp=x18c8c18, pv=x188c8ec, in=x1886e4c,rl=NULL,rc=NULL)

4 ETW000 24 0.132777

4 ETW000 [ dev trc,00000] - oci_define ( 4: SQLT_CHR , l= 10, con=0, stp=x18c8c18, pv=x188d440, in=x1887090,rl=NULL,rc=NULL)

4 ETW000 35 0.132812

4 ETW000 [ dev trc,00000] - oci_define ( 5: SQLT_CHR , l= 12, con=0, stp=x18c8c18, pv=x188df94, in=x18872d4,rl=NULL,rc=NULL)

4 ETW000 24 0.132836

4 ETW000 [ dev trc,00000] - oci_define ( 6: SQLT_CHR , l= 1, con=0, stp=x18c8c18, pv=x188ed2c, in=x1887518,rl=NULL,rc=NULL)

4 ETW000 21 0.132857

4 ETW000 [ dev trc,00000] - oci_define ( 7: SQLT_CHR , l= 30, con=0, stp=x18c8c18, pv=x188ee4e, in=x188775c,rl=NULL,rc=NULL)

4 ETW000 21 0.132878

4 ETW000 [ dev trc,00000] - oci_define ( 8: SQLT_CHR , l= 1, con=0, stp=x18c8c18, pv=x189104a, in=x18879a0,rl=NULL,rc=NULL)

4 ETW000 20 0.132898

4 ETW000 [ dev trc,00000] - oci_define ( 9: SQLT_CHR , l= 1, con=0, stp=x18c8c18, pv=x189116c, in=x1887be4,rl=NULL,rc=NULL)

4 ETW000 21 0.132919

4 ETW000 [ dev trc,00000] - oci_define (10: SQLT_CHR , l= 8, con=0, stp=x18c8c18, pv=x189128e, in=x1887e28,rl=NULL,rc=NULL)

4 ETW000 21 0.132940

4 ETW000 [ dev trc,00000] - oci_define (11: SQLT_CHR , l= 1, con=0, stp=x18c8c18, pv=x1891b9e, in=x188806c,rl=NULL,rc=NULL)

4 ETW000 31 0.132971

4 ETW000 [ dev trc,00000] - oci_define (12: SQLT_CHR , l= 20, con=0, stp=x18c8c18, pv=x1891cc0, in=x18882b0,rl=NULL,rc=NULL)

4 ETW000 21 0.132992

4 ETW000 [ dev trc,00000] - oci_define (13: SQLT_CHR , l= 1, con=0, stp=x18c8c18, pv=x1893368, in=x18884f4,rl=NULL,rc=NULL)

4 ETW000 21 0.133013

4 ETW000 [ dev trc,00000] - oci_define (14: SQLT_CHR , l= 1, con=0, stp=x18c8c18, pv=x189348a, in=x1888738,rl=NULL,rc=NULL)

4 ETW000 21 0.133034

4 ETW000 [ dev trc,00000] - oci_define (15: SQLT_CHR , l= 30, con=0, stp=x18c8c18, pv=x18935ac, in=x188897c,rl=NULL,rc=NULL)

4 ETW000 20 0.133054

4 ETW000 [ dev trc,00000] - oci_define (16: SQLT_CHR , l= 10, con=0, stp=x18c8c18, pv=x18957a8, in=x1888bc0,rl=NULL,rc=NULL)

4 ETW000 20 0.133074

4 ETW000 [ dev trc,00000] - oci_define (17: SQLT_CHR , l= 1, con=0, stp=x18c8c18, pv=x18962fc, in=x1888e04,rl=NULL,rc=NULL)

4 ETW000 21 0.133095

4 ETW000 [ dev trc,00000] - oci_define (18: SQLT_CHR , l= 1, con=0, stp=x18c8c18, pv=x189641e, in=x1889048,rl=NULL,rc=NULL)

4 ETW000 20 0.133115

4 ETW000 [ dev trc,00000] -->exec_fetch(con=0, bulk=0, sch=x17028f0, dap=x12e0378, DBSL_DIR_READ)

4 ETW000 21 0.133136

4 ETW000 [ dev trc,00000] -->stmt_fetch(con=0, sch=x17028f0, odp=x170a170, DBSL_DIR_READ) 12 0.133148

4 ETW000 [ dev trc,00000] AppInf(5)->1; mod='',act='',usr='DBSL: con=0, no client_id',ta='',mp=''

4 ETW000 35 0.133183

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 24 0.133207

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#10: con=0,stp=x18c8c18,itr=1,off=0,bat=0); AI='..DBSL: con=0, no client_id.'

4 ETW000 18 0.133225

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 13 0.133238

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=1): [dur. 0,001s] 817 0.134055

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, rows processed 1, iters-errors = 1-0) [dur. 0,001s]

4 ETW000 30 0.134085

4 ETW000 [ dev trc,00000] stmt_fetch() -> orc=0, 0=DBSL_ERR_OK 12 0.134097

4 ETW000 [ dev trc,00000] sccb_stmt_deactivate(sch=x17028f0) 16 0.134113

4 ETW000 [ dev trc,00000] DbSlRead() --> 0=DBSL_ERR_OK 12 0.134125

4 ETW000 [ dev trc,00000] } db_rtab( fcode = 'RT_READ_ONLY', retcode = 0 ) 18 0.134143

4 ETW000 Connected to DBMS = ORACLE --- dbs_ora_tnsname = 'PSB' --- SYSTEM = 'PSB'.

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=13=DBSL_CMD_VENDOR_NAME_GET) 86 0.134229

4 ETW000 [ dev trc,00000] { db_rtab( fcode = 'RT_INSERT', tname = 'PATCHHIST' ) {saprel.c:1496}

4 ETW000 149 0.134378

4 ETW000 [ dev trc,00000] -->DbSlRead(con=0, ssp=x1693de0, dap=NULL), sch=x1702878, stid=x1693de0, tok=x1692fa0, prepared=2

4 ETW000 29 0.134407

4 ETW000 [ dev trc,00000] -->DbSlRead(con=0, ssp=x1693de0, dap=NULL), sch=x1702878, scp=x1709fc0, tab='DDNTT'

4 ETW000 17 0.134424

4 ETW000 [ dev trc,00000] stmt=SELECT VERSION, UUID, CRTIMESTMP, ABTIMESTMP, DYTIMESTMP, FLDCNT, TABLENGTH, KEYCNT, KEYLENGTH, CLIENTPOS, TABTYPE, TABF

4 ETW000 19 0.134443

4 ETW000 [ dev trc,00000] ORM, REFNAME, HFLAG, BUFSTATE, BUFPARM, ALIGN, POINTERLG, UNICODELG, COMPCNT, LEAFCNT FROM "DDNTT" WHERE TABNAME = :A0

4 ETW000 15 0.134458

4 ETW000 [ dev trc,00000] x1693000->id=x1693de0: STID='10.DDNTT .0000011992.20150228002209'

4 ETW000 18 0.134476

4 ETW000 [ dev trc,00000] In 00: DBSL_DATA_SHORT_CHAR (len=30, max=30, dec=0) 12 0.134488

4 ETW000 [ dev trc,00000] Out 00: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 11 0.134499

4 ETW000 [ dev trc,00000] Out 01: DBSL_DATA_SHORT_RAW (len=16, max=16, dec=0) 11 0.134510

4 ETW000 [ dev trc,00000] Out 02: DBSL_DATA_SHORT_CHAR (len=14, max=14, dec=0) 10 0.134520

4 ETW000 [ dev trc,00000] Out 03: DBSL_DATA_SHORT_CHAR (len=14, max=14, dec=0) 10 0.134530

4 ETW000 [ dev trc,00000] Out 04: DBSL_DATA_SHORT_CHAR (len=14, max=14, dec=0) 10 0.134540

4 ETW000 [ dev trc,00000] Out 05: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 9 0.134549

4 ETW000 [ dev trc,00000] Out 06: DBSL_DATA_INTEGER_4 (len=4, max=4, dec=0) 10 0.134559

4 ETW000 [ dev trc,00000] Out 07: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 30 0.134589

4 ETW000 [ dev trc,00000] Out 08: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 11 0.134600

4 ETW000 [ dev trc,00000] Out 09: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.134610

4 ETW000 [ dev trc,00000] Out 10: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 10 0.134620

4 ETW000 [ dev trc,00000] Out 11: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 10 0.134630

4 ETW000 [ dev trc,00000] Out 12: DBSL_DATA_SHORT_CHAR (len=30, max=30, dec=0) 11 0.134641

4 ETW000 [ dev trc,00000] Out 13: DBSL_DATA_SHORT_RAW (len=6, max=6, dec=0) 10 0.134651

4 ETW000 [ dev trc,00000] Out 14: DBSL_DATA_SHORT_CHAR (len=1, max=1, dec=0) 10 0.134661

4 ETW000 [ dev trc,00000] Out 15: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.134671

4 ETW000 [ dev trc,00000] Out 16: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.134681

4 ETW000 [ dev trc,00000] Out 17: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.134691

4 ETW000 [ dev trc,00000] Out 18: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.134701

4 ETW000 [ dev trc,00000] Out 19: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.134711

4 ETW000 [ dev trc,00000] Out 20: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.134721

4 ETW000 [ dev trc,00000] bind_type_and_length(): 1 input variables, col=1 11 0.134732

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=30, max=30, dec=0 12 0.134744

4 ETW000 [ dev trc,00000] bind_type_and_length(): 21 output variables 13 0.134757

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 11 0.134768

4 ETW000 [ dev trc,00000] 1: DBSL_DATA_SHORT_RAW , len=16, max=16, dec=0 10 0.134778

4 ETW000 [ dev trc,00000] 2: DBSL_DATA_SHORT_CHAR , len=14, max=14, dec=0 11 0.134789

4 ETW000 [ dev trc,00000] 3: DBSL_DATA_SHORT_CHAR , len=14, max=14, dec=0 10 0.134799

4 ETW000 [ dev trc,00000] 4: DBSL_DATA_SHORT_CHAR , len=14, max=14, dec=0 9 0.134808

4 ETW000 [ dev trc,00000] 5: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 11 0.134819

4 ETW000 [ dev trc,00000] 6: DBSL_DATA_INTEGER_4 , len=4, max=4, dec=0 10 0.134829

4 ETW000 [ dev trc,00000] 7: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 9 0.134838

4 ETW000 [ dev trc,00000] 8: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 10 0.134848

4 ETW000 [ dev trc,00000] 9: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 9 0.134857

4 ETW000 [ dev trc,00000] 10: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 10 0.134867

4 ETW000 [ dev trc,00000] 11: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 9 0.134876

4 ETW000 [ dev trc,00000] 12: DBSL_DATA_SHORT_CHAR , len=30, max=30, dec=0 10 0.134886

4 ETW000 [ dev trc,00000] 13: DBSL_DATA_SHORT_RAW , len=6, max=6, dec=0 9 0.134895

4 ETW000 [ dev trc,00000] 14: DBSL_DATA_SHORT_CHAR , len=1, max=1, dec=0 10 0.134905

4 ETW000 [ dev trc,00000] 15: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 10 0.134915

4 ETW000 [ dev trc,00000] 16: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 9 0.134924

4 ETW000 [ dev trc,00000] 17: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 9 0.134933

4 ETW000 [ dev trc,00000] 18: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 25 0.134958

4 ETW000 [ dev trc,00000] 19: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 11 0.134969

4 ETW000 [ dev trc,00000] 20: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 10 0.134979

4 ETW000 [ dev trc,00000] -->exec_fetch(con=0, bulk=0, sch=x1702878, dap=x1691d40, DBSL_DIR_READ)

4 ETW000 20 0.134999

4 ETW000 [ dev trc,00000] -->stmt_fetch(con=0, sch=x1702878, odp=x170a050, DBSL_DIR_READ) 12 0.135011

4 ETW000 [ dev trc,00000] AppInf(5)->1; mod='',act='',usr='DBSL: con=0, no client_id',ta='',mp=''

4 ETW000 23 0.135034

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 24 0.135058

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#11: con=0,stp=x179c6e8,itr=1,off=0,bat=0); AI='..DBSL: con=0, no client_id.'

4 ETW000 18 0.135076

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 72 0.135148

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=1): [dur. 0,000s] 403 0.135551

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, rows processed 1, iters-errors = 1-0) [dur. 0,001s]

4 ETW000 27 0.135578

4 ETW000 [ dev trc,00000] stmt_fetch() -> orc=0, 0=DBSL_ERR_OK 12 0.135590

4 ETW000 [ dev trc,00000] sccb_stmt_deactivate(sch=x1702878) 17 0.135607

4 ETW000 [ dev trc,00000] DbSlRead() --> 0=DBSL_ERR_OK 12 0.135619

4 ETW000 [ dev trc,00000] -->DbSlBegRead(con=0, ssp=x1692580, dap=NULL), sch=x1702800, stid=x1692580, tok=x1693440, prepared=2

4 ETW000 30 0.135649

4 ETW000 [ dev trc,00000] -->DbSlBegRead(#0: con=0, ssp=x1692580, dap=NULL), In=1, Out=4, sch=x1702800, scp=x1709ea0, tab='DDNTF'

4 ETW000 29 0.135678

4 ETW000 [ dev trc,00000] stmt.len = 100 13 0.135691

4 ETW000 [ dev trc,00000] stmt=SELECT TABNAME, BLOCKNR, FIELDSLG, FIELDS FROM "DDNTF" WHERE TABNAME = :A0 ORDER BY TABNAME, BLOCKNR

4 ETW000 15 0.135706

4 ETW000 [ dev trc,00000] x1693d80->id=x1692580: STID='10.DDNTF .0000001042.20150228002218'

4 ETW000 19 0.135725

4 ETW000 [ dev trc,00000] In 00: DBSL_DATA_SHORT_CHAR (len=30, max=30, dec=0) 12 0.135737

4 ETW000 [ dev trc,00000] Out 00: DBSL_DATA_SHORT_CHAR (len=30, max=30, dec=0) 10 0.135747

4 ETW000 [ dev trc,00000] Out 01: DBSL_DATA_INTEGER_2 (len=2, max=2, dec=0) 10 0.135757

4 ETW000 [ dev trc,00000] Out 02: DBSL_DATA_INTEGER_4 (len=4, max=4, dec=0) 10 0.135767

4 ETW000 [ dev trc,00000] Out 03: DBSL_DATA_LONG_RAW (len=32768, max=32768, dec=0) 10 0.135777

4 ETW000 [ dev trc,00000] bind_type_and_length(): 1 input variables, col=1 10 0.135787

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=30, max=30, dec=0 11 0.135798

4 ETW000 [ dev trc,00000] bind_type_and_length(): 4 output variables 53 0.135851

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=30, max=30, dec=0 12 0.135863

4 ETW000 [ dev trc,00000] 1: DBSL_DATA_INTEGER_2 , len=2, max=2, dec=0 10 0.135873

4 ETW000 [ dev trc,00000] 2: DBSL_DATA_INTEGER_4 , len=4, max=4, dec=0 10 0.135883

4 ETW000 [ dev trc,00000] 3: DBSL_DATA_LONG_RAW , len=32768, max=32768, dec=0 9 0.135892

4 ETW000 [ dev trc,00000] DbSlBegRead(#0) -> 0=DBSL_ERR_OK 11 0.135903

4 ETW000 [ dev trc,00000] -->DbSlExeRead(#1: con=0, ssp=x1693d80, dap=x16936e0) 15 0.135918

4 ETW000 [ dev trc,00000] -->exec_fetch(con=0, bulk=0, sch=x1702800, dap=x16936e0, DBSL_SEQ_READ)

4 ETW000 17 0.135935

4 ETW000 [ dev trc,00000] -->stmt_fetch(con=0, sch=x1702800, odp=x1709f30, DBSL_SEQ_READ) 11 0.135946

4 ETW000 [ dev trc,00000] AppInf(5)->1; mod='',act='',usr='DBSL: con=0, no client_id',ta='',mp=''

4 ETW000 23 0.135969

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 21 0.135990

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#12: con=0,stp=x179e7c0,itr=1,off=0,bat=0); AI='..DBSL: con=0, no client_id.'

4 ETW000 18 0.136008

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 13 0.136021

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=1): [dur. 0,001s] 628 0.136649

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, rows processed 1, iters-errors = 1-0) [dur. 0,001s]

4 ETW000 29 0.136678

4 ETW000 [ dev trc,00000] stmt_fetch() -> orc=0, 0=DBSL_ERR_OK 12 0.136690

4 ETW000 [ dev trc,00000] DbSlExeRead(#1,con=0) -> 0=DBSL_ERR_OK, dbcount=1, lob_pw=0 17 0.136707

4 ETW000 [ dev trc,00000] -->DbSlEndRead(#1: con=0, ssp=x1693d80, dap=x16936e0, sch=x1702800) -> 0=DBSL_ERR_OK

4 ETW000 22 0.136729

4 ETW000 [ dev trc,00000] sccb_stmt_deactivate(sch=x1702800) 11 0.136740

4 ETW000 [ dev trc,00000] CHECK_STMTID(x12e0330): no cache (con=0,sch=NULL) 33 0.136773

4 ETW000 [ dev trc,00000] DbSlModify(DBSL_INSERT, con=0, ssp=x12e1060, dap=x12e0330), sch=NULL, state=0

4 ETW000 24 0.136797

4 ETW000 [ dev trc,00000] Wrong statement ID or statement not prepared. 10 0.136807

4 ETW000 [ dev trc,00000] x12e1060->id=x12e0330: STID='03.PATCHHIST .0268435456.20011119135405'

4 ETW000 13 0.136820

4 ETW000 [ dev trc,00000] DbSlModify(con=0) -> 13=DBSL_ERR_STMTID 15 0.136835

4 ETW000 [ dev trc,00000] -->DbSlPrepare(DBSL_INSERT, con=0, ssp=x12e1060, dap=x12e0378), tok=x12e1080, stid=x12e0330

4 ETW000 22 0.136857

4 ETW000 [ dev trc,00000] stmt.len=63, length(stmt.str)=63 38 0.136895

4 ETW000 [ dev trc,00000] .str=INSERT INTO "PATCHHIST" VALUES(:A0,:A1,:A2,:A3,:A4,:A5,:A6,:A7)

4 ETW000 37 0.136932

4 ETW000 [ dev trc,00000] build_stmt(): stmt.len = 63 12 0.136944

4 ETW000 [ dev trc,00000] build_stmt() -> OK 10 0.136954

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 76 0.137030

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected 19 0.137049

4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=63,stp=x18cf0f8); AI=DBSL: con=0, no ABAP.0.DBSL: con=0, no client_id.DBSL: con=0, no client_info

4 ETW000 18 0.137067

4 ETW000 [ dev trc,00000] INSERT INTO "PATCHHIST" VALUES(:A0,:A1,:A2,:A3,:A4,:A5,:A6,:A7)

4 ETW000 14 0.137081

4 ETW000 [ dev trc,00000] stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK 45 0.137126

4 ETW000 [ dev trc,00000] DbSlPrepare(lit=0, lob=0, fae=0, col=8, upd=0, mrk=8,sch=x1702968, scp=x170a200, tab='PATCHHIST') -> 0=DBSL_ERR_OK

4 ETW000 24 0.137150

4 ETW000 [ dev trc,00000] -->DbSlModify(DBSL_INSERT, con=0, ssp=x12e1060, dap=x12e0378, sch=x1702968), tab='PATCHHIST'

4 ETW000 21 0.137171

4 ETW000 [ dev trc,00000] stmt=INSERT INTO "PATCHHIST" VALUES(:A0,:A1,:A2,:A3,:A4,:A5,:A6,:A7)

4 ETW000 16 0.137187

4 ETW000 [ dev trc,00000] x12e1060->id=x12e0330: STID='03.PATCHHIST .0268435456.20011119135405'

4 ETW000 19 0.137206

4 ETW000 [ dev trc,00000] In 00: DBSL_DATA_SHORT_CHAR (len=20, max=20, dec=0) 11 0.137217

4 ETW000 [ dev trc,00000] In 01: DBSL_DATA_SHORT_CHAR (len=10, max=10, dec=0) 10 0.137227

4 ETW000 [ dev trc,00000] In 02: DBSL_DATA_SHORT_CHAR (len=22, max=22, dec=0) 10 0.137237

4 ETW000 [ dev trc,00000] In 03: DBSL_DATA_SHORT_CHAR (len=10, max=10, dec=0) 9 0.137246

4 ETW000 [ dev trc,00000] In 04: DBSL_DATA_SHORT_CHAR (len=3, max=3, dec=0) 10 0.137256

4 ETW000 [ dev trc,00000] In 05: DBSL_DATA_SHORT_CHAR (len=14, max=14, dec=0) 10 0.137266

4 ETW000 [ dev trc,00000] In 06: DBSL_DATA_NUMC (len=10, max=10, dec=0) 10 0.137276

4 ETW000 [ dev trc,00000] In 07: DBSL_DATA_NUMC (len=10, max=10, dec=0) 9 0.137285

4 ETW000 [ dev trc,00000] bind_type_and_length(): 8 input variables, col=8 10 0.137295

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=20, max=20, dec=0 11 0.137306

4 ETW000 [ dev trc,00000] 1: DBSL_DATA_SHORT_CHAR , len=10, max=10, dec=0 10 0.137316

4 ETW000 [ dev trc,00000] 2: DBSL_DATA_SHORT_CHAR , len=22, max=22, dec=0 10 0.137326

4 ETW000 [ dev trc,00000] 3: DBSL_DATA_SHORT_CHAR , len=10, max=10, dec=0 9 0.137335

4 ETW000 [ dev trc,00000] 4: DBSL_DATA_SHORT_CHAR , len=3, max=3, dec=0 27 0.137362

4 ETW000 [ dev trc,00000] 5: DBSL_DATA_SHORT_CHAR , len=14, max=14, dec=0 11 0.137373

4 ETW000 [ dev trc,00000] 6: DBSL_DATA_NUMC , len=10, max=10, dec=0 11 0.137384

4 ETW000 [ dev trc,00000] 7: DBSL_DATA_NUMC , len=10, max=10, dec=0 10 0.137394

4 ETW000 [ dev trc,00000] bind_ind_and_values(IN,con=0,arr=496,col=8,rc=0,rl=8,flt=0,int=0,sh=0,uc=99)

4 ETW000 25 0.137419

4 ETW000 [ dev trc,00000] - oci_bind ( 0: SQLT_AFC , l= 20, con=0, stp=x18cf0f8, pv=x188a580, in=x1886780,rl=x1888680,rc=NULL)

4 ETW000 35 0.137454

4 ETW000 [ dev trc,00000] - oci_bind ( 1: SQLT_AFC , l= 10, con=0, stp=x18cf0f8, pv=x188cc40, in=x1886b60,rl=x1888a60,rc=NULL)

4 ETW000 28 0.137482

4 ETW000 [ dev trc,00000] - oci_bind ( 2: SQLT_AFC , l= 22, con=0, stp=x18cf0f8, pv=x188dfa0, in=x1886f40,rl=x1888e40,rc=NULL)

4 ETW000 20 0.137502

4 ETW000 [ dev trc,00000] - oci_bind ( 3: SQLT_AFC , l= 10, con=0, stp=x18cf0f8, pv=x1890a40, in=x1887320,rl=x1889220,rc=NULL)

4 ETW000 21 0.137523

4 ETW000 [ dev trc,00000] - oci_bind ( 4: SQLT_AFC , l= 3, con=0, stp=x18cf0f8, pv=x1891da0, in=x1887700,rl=x1889600,rc=NULL)

4 ETW000 21 0.137544

4 ETW000 [ dev trc,00000] - oci_bind ( 5: SQLT_AFC , l= 14, con=0, stp=x18cf0f8, pv=x1892370, in=x1887ae0,rl=x18899e0,rc=NULL)

4 ETW000 20 0.137564

4 ETW000 [ dev trc,00000] - oci_bind ( 6: SQLT_AFC , l= 10, con=0, stp=x18cf0f8, pv=x1893e90, in=x1887ec0,rl=x1889dc0,rc=NULL)

4 ETW000 21 0.137585

4 ETW000 [ dev trc,00000] - oci_bind ( 7: SQLT_AFC , l= 10, con=0, stp=x18cf0f8, pv=x18951f0, in=x18882a0,rl=x188a1a0,rc=NULL)

4 ETW000 20 0.137605

4 ETW000 [ dev trc,00000] -->exec_modify(): bulk=0, input_cnt=8, lit_cnt=0, fae_cnt=0 18 0.137623

4 ETW000 [ dev trc,00000] stmt_execute?: row_max=1, _xcnt=0, _i=1, _pcnt=0, _upto=4294967295, _total=0

4 ETW000 34 0.137657

4 ETW000 [ dev trc,00000] AppInf(5)->1; mod='',act='',usr='DBSL: con=0, no client_id',ta='',mp=''

4 ETW000 26 0.137683

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 22 0.137705

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#13: con=0,stp=x18cf0f8,itr=1,off=0,bat=0); AI='..DBSL: con=0, no client_id.'

4 ETW000 18 0.137723

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 13 0.137736

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=1): [dur. 0,001s] 1166 0.138902

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, rows processed 1, iters-errors = 1-0) [dur. 0,001s]

4 ETW000 48 0.138950

4 ETW000 [ dev trc,00000] IN array size xcnt=1, IN->row_total=1 19 0.138969

4 ETW000 [ dev trc,00000] orpc=1, DbCa.dbcount=1, DbSt.counter.dbrecords=1 11 0.138980

4 ETW000 [ dev trc,00000] stmt_execute() -> orc=0 (orc1=0), rc=0=DBSL_ERR_OK 12 0.138992

4 ETW000 [ dev trc,00000] <--exec_modify() -> 0=DBSL_ERR_OK, supply=999 11 0.139003

4 ETW000 [ dev trc,00000] sccb_stmt_deactivate(sch=x1702968) 13 0.139016

4 ETW000 [ dev trc,00000] DbSlModify(con=0) -> 0=DBSL_ERR_OK 12 0.139028

4 ETW000 [ dev trc,00000] } db_rtab( fcode = 'RT_INSERT', retcode = 0 ) 11 0.139039

4 ETW000 [ dev trc,00000] { dsql_open (con_da=(0,R/3),#binds=0,#input=0, 113 0.139152

4 ETW000 name=UNKNOWN, stmtid=NULL,

4 ETW000 stmt="SELECT EXECUTABLE,SAPRELEASE,HOSTNAME,PLATFORM,DBVENDOR,TIMESTAMP,PATCHNO,DBSLPATCHN FROM ...")

4 ETW000 [ dev trc,00000] vv Ds_prep_open(head_p=0x7fffd10b3250, icnt=0) 34 0.139186

4 ETW000 [ dev trc,00000] cursor_new(): cid=0 -> SAP_O_K 12 0.139198

4 ETW000 [ dev trc,00000] vv cursor_open(cid=0, head_p=0x7fffd10b3250, icnt=0, re=0) 21 0.139219

4 ETW000 [ dev trc,00000] -->DbSlPrepare(DBSL_SELECT, con=0, ssp=x7f8a92de1bc8, dap=x7f8a92de1b30), tok=x7f8a92de1ba8, stid=NULL

4 ETW000 21 0.139240

4 ETW000 [ dev trc,00000] stmt.len=303, length(stmt.str)=303 29 0.139269

4 ETW000 [ dev trc,00000] .str=SELECT EXECUTABLE,SAPRELEASE,HOSTNAME,PLATFORM,DBVENDOR,TIMESTAMP,PATCHNO,DBSLPATCHN FROM PATCHHIST WHERE EXECUTABLE = 'R3tr

4 ETW000 16 0.139285

4 ETW000 [ dev trc,00000] ans' AND TIMESTAMP = (SELECT MAX(TIMESTAMP) FROM PATCHHIST WHERE EXECUTABLE = 'R3trans' AND SAPRELEASE = '721' AND HOSTNAME

4 ETW000 14 0.139299

4 ETW000 [ dev trc,00000] = 'prodsb' AND PLATFORM = 'Linux' AND DBVENDOR = 'ORA')

4 ETW000 14 0.139313

4 ETW000 [ dev trc,00000] build_stmt(): stmt.len = 303 14 0.139327

4 ETW000 [ dev trc,00000] build_stmt() -> OK 9 0.139336

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 71 0.139407

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected 20 0.139427

4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=303,stp=x18d2278); AI=DBSL: con=0, no ABAP.0.DBSL: con=0, no client_id.DBSL: con=0, no client_info

4 ETW000 32 0.139459

4 ETW000 [ dev trc,00000] SELECT EXECUTABLE,SAPRELEASE,HOSTNAME,PLATFORM,DBVENDOR,TIMESTAMP,PATCHNO,DBSLPATCHN FROM PATCHHIST WHERE EXECUTABLE = 'R3

4 ETW000 15 0.139474

4 ETW000 [ dev trc,00000] trans' AND TIMESTAMP = (SELECT MAX(TIMESTAMP) FROM PATCHHIST WHERE EXECUTABLE = 'R3trans' AND SAPRELEASE = '721' AND HOSTN

4 ETW000 31 0.139505

4 ETW000 [ dev trc,00000] AME = 'prodsb' AND PLATFORM = 'Linux' AND DBVENDOR = 'ORA')

4 ETW000 16 0.139521

4 ETW000 [ dev trc,00000] stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK 33 0.139554

4 ETW000 [ dev trc,00000] DbSlPrepare(lit=0, lob=0, fae=0, col=0, upd=0, mrk=0,sch=x17029e0, scp=x170a320, tab=' ') -> 0=DBSL_ERR_OK

4 ETW000 22 0.139576

4 ETW000 [ dev trc,00000] -->DbSlBegRead(con=0, ssp=NULL, dap=x17029e0), sch=x17029e0, stid=NULL, tok=x7f8a92de1ba8, prepared=1

4 ETW000 22 0.139598

4 ETW000 [ dev trc,00000] -->DbSlBegRead(#0: con=0, ssp=NULL, dap=x17029e0), In=0, Out=0, sch=x17029e0, scp=x170a320, tab=' '

4 ETW000 27 0.139625

4 ETW000 [ dev trc,00000] stmt.len = 303 13 0.139638

4 ETW000 [ dev trc,00000] stmt=SELECT EXECUTABLE,SAPRELEASE,HOSTNAME,PLATFORM,DBVENDOR,TIMESTAMP,PATCHNO,DBSLPATCHN FROM PATCHHIST WHERE EXECUTABLE = 'R3

4 ETW000 15 0.139653

4 ETW000 [ dev trc,00000] trans' AND TIMESTAMP = (SELECT MAX(TIMESTAMP) FROM PATCHHIST WHERE EXECUTABLE = 'R3trans' AND SAPRELEASE = '721' AND HOSTN

4 ETW000 15 0.139668

4 ETW000 [ dev trc,00000] AME = 'prodsb' AND PLATFORM = 'Linux' AND DBVENDOR = 'ORA')

4 ETW000 15 0.139683

4 ETW000 [ dev trc,00000] x7f8a92de1bc8->id=NULL 11 0.139694

4 ETW000 [ dev trc,00000] bind_type_and_length(): 0 input variables, col=0 12 0.139706

4 ETW000 [ dev trc,00000] DbSlBegRead(#0) -> 0=DBSL_ERR_OK 10 0.139716

4 ETW000 [ dev trc,00000] ^^ cursor_open(cid=0) -> OK 10 0.139726

4 ETW000 [ dev trc,00000] ^^ Ds_prep_open(cid=0) -> rc=0 10 0.139736

4 ETW000 [ dev trc,00000] } dsql_open()=0, *cu_id_p=0 9 0.139745

4 ETW000 [ dev trc,00000] { dsql_fetch (con_da=(0,R/3),cu_id=0,#output=8) 17 0.139762

4 ETW000 [ dev trc,00000] vv Ds_fetch(head_p=0x7fffd10b3250, cid=0, #out=8, rows=1) 13 0.139775

4 ETW000 [ dev trc,00000] -->DbSlExeRead(#1: con=0, ssp=x7f8a92de1bc8, dap=x7f8a92de1b30) 26 0.139801

4 ETW000 [ dev trc,00000] bind_type_and_length(): 8 output variables 12 0.139813

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=20, max=20, dec=0 11 0.139824

4 ETW000 [ dev trc,00000] 1: DBSL_DATA_SHORT_CHAR , len=10, max=10, dec=0 10 0.139834

4 ETW000 [ dev trc,00000] 2: DBSL_DATA_SHORT_CHAR , len=22, max=22, dec=0 9 0.139843

4 ETW000 [ dev trc,00000] 3: DBSL_DATA_SHORT_CHAR , len=10, max=10, dec=0 10 0.139853

4 ETW000 [ dev trc,00000] 4: DBSL_DATA_SHORT_CHAR , len=3, max=3, dec=0 10 0.139863

4 ETW000 [ dev trc,00000] 5: DBSL_DATA_SHORT_CHAR , len=14, max=14, dec=0 27 0.139890

4 ETW000 [ dev trc,00000] 6: DBSL_DATA_SHORT_CHAR , len=10, max=10, dec=0 10 0.139900

4 ETW000 [ dev trc,00000] 7: DBSL_DATA_SHORT_CHAR , len=10, max=10, dec=0 10 0.139910

4 ETW000 [ dev trc,00000] bind_ind_and_values(OUT,con=0,arr=565,col=8,rc=0,rl=0,flt=0,int=0,sh=0,uc=99)

4 ETW000 27 0.139937

4 ETW000 [ dev trc,00000] - oci_define ( 0: SQLT_CHR , l= 20, con=0, stp=x18d2278, pv=x1888ad0, in=x1886780,rl=NULL,rc=NULL)

4 ETW000 20 0.139957

4 ETW000 [ dev trc,00000] - oci_define ( 1: SQLT_CHR , l= 10, con=0, stp=x18d2278, pv=x188b6f4, in=x1886bea,rl=NULL,rc=NULL)

4 ETW000 30 0.139987

4 ETW000 [ dev trc,00000] - oci_define ( 2: SQLT_CHR , l= 22, con=0, stp=x18d2278, pv=x188cd06, in=x1887054,rl=NULL,rc=NULL)

4 ETW000 22 0.140009

4 ETW000 [ dev trc,00000] - oci_define ( 3: SQLT_CHR , l= 10, con=0, stp=x18d2278, pv=x188fd94, in=x18874be,rl=NULL,rc=NULL)

4 ETW000 23 0.140032

4 ETW000 [ dev trc,00000] - oci_define ( 4: SQLT_CHR , l= 3, con=0, stp=x18d2278, pv=x18913a6, in=x1887928,rl=NULL,rc=NULL)

4 ETW000 31 0.140063

4 ETW000 [ dev trc,00000] - oci_define ( 5: SQLT_CHR , l= 14, con=0, stp=x18d2278, pv=x1891a45, in=x1887d92,rl=NULL,rc=NULL)

4 ETW000 22 0.140085

4 ETW000 [ dev trc,00000] - oci_define ( 6: SQLT_CHR , l= 10, con=0, stp=x18d2278, pv=x189392b, in=x18881fc,rl=NULL,rc=NULL)

4 ETW000 22 0.140107

4 ETW000 [ dev trc,00000] - oci_define ( 7: SQLT_CHR , l= 10, con=0, stp=x18d2278, pv=x1894f3d, in=x1888666,rl=NULL,rc=NULL)

4 ETW000 21 0.140128

4 ETW000 [ dev trc,00000] -->exec_fetch(con=0, bulk=0, sch=x17029e0, dap=x7f8a92de1b30, DBSL_SEQ_READ)

4 ETW000 21 0.140149

4 ETW000 [ dev trc,00000] -->stmt_fetch(con=0, sch=x17029e0, odp=x170a3b0, DBSL_SEQ_READ) 13 0.140162

4 ETW000 [ dev trc,00000] AppInf(5)->1; mod='',act='',usr='DBSL: con=0, no client_id',ta='',mp=''

4 ETW000 21 0.140183

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 21 0.140204

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#14: con=0,stp=x18d2278,itr=565,off=0,bat=0); AI='..DBSL: con=0, no client_id.'

4 ETW000 18 0.140222

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 13 0.140235

4 ETW000 [ dev trc,00000] check2: OCIStmtExecute() completed, rc=100=OCI_NO_DATA, no further data

4 ETW000 678 0.140913

4 ETW000 [ dev trc,00000] -> rc=1403=OCI_ERR_NOT_FOUND 12 0.140925

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=1): [dur. 0,001s] 15 0.140940

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=1403, rows processed 1, iters-errors = 565-0) [dur. 0,001s]

4 ETW000 36 0.140976

4 ETW000 [ dev trc,00000] stmt_fetch() -> orc=1403, 0=DBSL_ERR_OK 12 0.140988

4 ETW000 [ dev trc,00000] DbSlExeRead(#1,con=0) -> 0=DBSL_ERR_OK, dbcount=1, lob_pw=0 15 0.141003

4 ETW000 [ dev trc,00000] head_p->sqlcode=1403, ->rec_cnt=1, ->mod_cnt=1 11 0.141014

4 ETW000 [ dev trc,00000] ^^ Ds_fetch() -> rc=0=DS_SAP_O_K 10 0.141024

4 ETW000 [ dev trc,00000] } dsql_fetch()=0, rec_cnt=1, mod_cnt=1 10 0.141034

4 ETW000 [ dev trc,00000] { dsql_close (con_da=(0,R/3),cu_id=0) 9 0.141043

4 ETW000 [ dev trc,00000] vv Ds_close(cid=0) 11 0.141054

4 ETW000 [ dev trc,00000] vv cursor_close(cid=0) 11 0.141065

4 ETW000 [ dev trc,00000] -->DbSlEndRead(#1: con=0, ssp=x7f8a92de1bc8, dap=x7f8a92de1b30, sch=x17029e0) -> 0=DBSL_ERR_OK

4 ETW000 20 0.141085

4 ETW000 [ dev trc,00000] sccb_stmt_deactivate(sch=x17029e0) 11 0.141096

4 ETW000 [ dev trc,00000] ^^ cursor_close() 10 0.141106

4 ETW000 [ dev trc,00000] ^^ Ds_close() -> SAP_O_K 10 0.141116

4 ETW000 [ dev trc,00000] } dsql_close()=0 8 0.141124

4 ETW000 [ dev trc,00000] { db_rtab( fcode = 'RT_INSERT', tname = 'PATCHHIST' ) {saprel.c:1600}

4 ETW000 25 0.141149

4 ETW000 [ dev trc,00000] -->DbSlModify(DBSL_INSERT, con=0, ssp=x12e1060, dap=x12e0378, sch=x1702968), tab='PATCHHIST'

4 ETW000 28 0.141177

4 ETW000 [ dev trc,00000] stmt=INSERT INTO "PATCHHIST" VALUES(:A0,:A1,:A2,:A3,:A4,:A5,:A6,:A7)

4 ETW000 17 0.141194

4 ETW000 [ dev trc,00000] x12e1060->id=x12e0330: STID='03.PATCHHIST .0268435456.20011119135405'

4 ETW000 18 0.141212

4 ETW000 [ dev trc,00000] In 00: DBSL_DATA_SHORT_CHAR (len=20, max=20, dec=0) 12 0.141224

4 ETW000 [ dev trc,00000] In 01: DBSL_DATA_SHORT_CHAR (len=10, max=10, dec=0) 10 0.141234

4 ETW000 [ dev trc,00000] In 02: DBSL_DATA_SHORT_CHAR (len=22, max=22, dec=0) 10 0.141244

4 ETW000 [ dev trc,00000] In 03: DBSL_DATA_SHORT_CHAR (len=10, max=10, dec=0) 9 0.141253

4 ETW000 [ dev trc,00000] In 04: DBSL_DATA_SHORT_CHAR (len=3, max=3, dec=0) 10 0.141263

4 ETW000 [ dev trc,00000] In 05: DBSL_DATA_SHORT_CHAR (len=14, max=14, dec=0) 10 0.141273

4 ETW000 [ dev trc,00000] In 06: DBSL_DATA_NUMC (len=10, max=10, dec=0) 10 0.141283

4 ETW000 [ dev trc,00000] In 07: DBSL_DATA_NUMC (len=10, max=10, dec=0) 9 0.141292

4 ETW000 [ dev trc,00000] bind_type_and_length(): 8 input variables, col=8 10 0.141302

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=20, max=20, dec=0 11 0.141313

4 ETW000 [ dev trc,00000] 1: DBSL_DATA_SHORT_CHAR , len=10, max=10, dec=0 29 0.141342

4 ETW000 [ dev trc,00000] 2: DBSL_DATA_SHORT_CHAR , len=22, max=22, dec=0 12 0.141354

4 ETW000 [ dev trc,00000] 3: DBSL_DATA_SHORT_CHAR , len=10, max=10, dec=0 9 0.141363

4 ETW000 [ dev trc,00000] 4: DBSL_DATA_SHORT_CHAR , len=3, max=3, dec=0 10 0.141373

4 ETW000 [ dev trc,00000] 5: DBSL_DATA_SHORT_CHAR , len=14, max=14, dec=0 10 0.141383

4 ETW000 [ dev trc,00000] 6: DBSL_DATA_NUMC , len=10, max=10, dec=0 9 0.141392

4 ETW000 [ dev trc,00000] 7: DBSL_DATA_NUMC , len=10, max=10, dec=0 10 0.141402

4 ETW000 [ dev trc,00000] -->exec_modify(): bulk=0, input_cnt=8, lit_cnt=0, fae_cnt=0 13 0.141415

4 ETW000 [ dev trc,00000] stmt_execute?: row_max=1, _xcnt=0, _i=1, _pcnt=0, _upto=4294967295, _total=0

4 ETW000 17 0.141432

4 ETW000 [ dev trc,00000] AppInf(5)->1; mod='',act='',usr='DBSL: con=0, no client_id',ta='',mp=''

4 ETW000 23 0.141455

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 24 0.141479

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#15: con=0,stp=x18cf0f8,itr=1,off=0,bat=0); AI='..DBSL: con=0, no client_id.'

4 ETW000 19 0.141498

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 13 0.141511

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=1): [dur. 0,000s] 287 0.141798

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, rows processed 1, iters-errors = 1-0) [dur. 0,000s]

4 ETW000 27 0.141825

4 ETW000 [ dev trc,00000] IN array size xcnt=1, IN->row_total=1 11 0.141836

4 ETW000 [ dev trc,00000] orpc=1, DbCa.dbcount=1, DbSt.counter.dbrecords=1 11 0.141847

4 ETW000 [ dev trc,00000] stmt_execute() -> orc=0 (orc1=0), rc=0=DBSL_ERR_OK 10 0.141857

4 ETW000 [ dev trc,00000] <--exec_modify() -> 0=DBSL_ERR_OK, supply=999 10 0.141867

4 ETW000 [ dev trc,00000] sccb_stmt_deactivate(sch=x1702968) 12 0.141879

4 ETW000 [ dev trc,00000] DbSlModify(con=0) -> 0=DBSL_ERR_OK 12 0.141891

4 ETW000 [ dev trc,00000] } db_rtab( fcode = 'RT_INSERT', retcode = 0 ) 10 0.141901

4 ETW000 [ dev trc,00000] { db_rtab( fcode = 'RT_DELETE', tname = 'PATCHHIST' ) {saprel.c:1608}

4 ETW000 15 0.141916

4 ETW000 [ dev trc,00000] CHECK_STMTID(x12e0330): no cache (con=0,sch=NULL) 18 0.141934

4 ETW000 [ dev trc,00000] DbSlModify(DBSL_DELETE, con=0, ssp=x12e1060, dap=x12e0330), sch=NULL, state=0

4 ETW000 22 0.141956

4 ETW000 [ dev trc,00000] Wrong statement ID or statement not prepared. 9 0.141965

4 ETW000 [ dev trc,00000] x12e1060->id=x12e0330: STID='03.PATCHHIST .0805306369.20011119135405'

4 ETW000 14 0.141979

4 ETW000 [ dev trc,00000] DbSlModify(con=0) -> 13=DBSL_ERR_STMTID 14 0.141993

4 ETW000 [ dev trc,00000] -->DbSlPrepare(DBSL_DELETE, con=0, ssp=x12e1060, dap=x12e0378), tok=x12e1080, stid=x12e0330

4 ETW000 41 0.142034

4 ETW000 [ dev trc,00000] stmt.len=144, length(stmt.str)=144 39 0.142073

4 ETW000 [ dev trc,00000] .str=DELETE FROM "PATCHHIST" WHERE "EXECUTABLE"=:A0 AND "SAPRELEASE"=:A1 AND "HOSTNAME"=:A2 AND "PLATFORM"=:A3 AND "DBVENDOR"=:A4

4 ETW000 16 0.142089

4 ETW000 [ dev trc,00000] AND "TIMESTAMP"=:A5

4 ETW000 16 0.142105

4 ETW000 [ dev trc,00000] build_stmt(): stmt.len = 144 12 0.142117

4 ETW000 [ dev trc,00000] build_stmt() -> OK 9 0.142126

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 74 0.142200

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected 20 0.142220

4 ETW000 [ dev trc,00000] -->oci_prepare_stmt(con=0,len=144,stp=x18d6308); AI=DBSL: con=0, no ABAP.0.DBSL: con=0, no client_id.DBSL: con=0, no client_info

4 ETW000 18 0.142238

4 ETW000 [ dev trc,00000] DELETE FROM "PATCHHIST" WHERE "EXECUTABLE"=:A0 AND "SAPRELEASE"=:A1 AND "HOSTNAME"=:A2 AND "PLATFORM"=:A3 AND "DBVENDOR"=:

4 ETW000 14 0.142252

4 ETW000 [ dev trc,00000] A4 AND "TIMESTAMP"=:A5

4 ETW000 15 0.142267

4 ETW000 [ dev trc,00000] stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK 63 0.142330

4 ETW000 [ dev trc,00000] DbSlPrepare(lit=0, lob=0, fae=0, col=6, upd=0, mrk=6,sch=x1702a58, scp=x170a440, tab='PATCHHIST') -> 0=DBSL_ERR_OK

4 ETW000 26 0.142356

4 ETW000 [ dev trc,00000] -->DbSlModify(DBSL_DELETE, con=0, ssp=x12e1060, dap=x12e0378, sch=x1702a58), tab='PATCHHIST'

4 ETW000 22 0.142378

4 ETW000 [ dev trc,00000] stmt=DELETE FROM "PATCHHIST" WHERE "EXECUTABLE"=:A0 AND "SAPRELEASE"=:A1 AND "HOSTNAME"=:A2 AND "PLATFORM"=:A3 AND "DBVENDOR"=:

4 ETW000 16 0.142394

4 ETW000 [ dev trc,00000] A4 AND "TIMESTAMP"=:A5

4 ETW000 14 0.142408

4 ETW000 [ dev trc,00000] x12e1060->id=x12e0330: STID='03.PATCHHIST .0805306369.20011119135405'

4 ETW000 18 0.142426

4 ETW000 [ dev trc,00000] In 00: DBSL_DATA_SHORT_CHAR (len=20, max=20, dec=0) 21 0.142447

4 ETW000 [ dev trc,00000] In 01: DBSL_DATA_SHORT_CHAR (len=10, max=10, dec=0) 12 0.142459

4 ETW000 [ dev trc,00000] In 02: DBSL_DATA_SHORT_CHAR (len=22, max=22, dec=0) 29 0.142488

4 ETW000 [ dev trc,00000] In 03: DBSL_DATA_SHORT_CHAR (len=10, max=10, dec=0) 11 0.142499

4 ETW000 [ dev trc,00000] In 04: DBSL_DATA_SHORT_CHAR (len=3, max=3, dec=0) 10 0.142509

4 ETW000 [ dev trc,00000] In 05: DBSL_DATA_SHORT_CHAR (len=14, max=14, dec=0) 11 0.142520

4 ETW000 [ dev trc,00000] bind_type_and_length(): 6 input variables, col=6 11 0.142531

4 ETW000 [ dev trc,00000] 0: DBSL_DATA_SHORT_CHAR , len=20, max=20, dec=0 11 0.142542

4 ETW000 [ dev trc,00000] 1: DBSL_DATA_SHORT_CHAR , len=10, max=10, dec=0 10 0.142552

4 ETW000 [ dev trc,00000] 2: DBSL_DATA_SHORT_CHAR , len=22, max=22, dec=0 10 0.142562

4 ETW000 [ dev trc,00000] 3: DBSL_DATA_SHORT_CHAR , len=10, max=10, dec=0 10 0.142572

4 ETW000 [ dev trc,00000] 4: DBSL_DATA_SHORT_CHAR , len=3, max=3, dec=0 9 0.142581

4 ETW000 [ dev trc,00000] 5: DBSL_DATA_SHORT_CHAR , len=14, max=14, dec=0 10 0.142591

4 ETW000 [ dev trc,00000] bind_ind_and_values(IN,con=0,arr=631,col=6,rc=0,rl=6,flt=0,int=0,sh=0,uc=79)

4 ETW000 26 0.142617

4 ETW000 [ dev trc,00000] - oci_bind ( 0: SQLT_AFC , l= 20, con=0, stp=x18d6308, pv=x188a2a8, in=x1886780,rl=x1888514,rc=NULL)

4 ETW000 20 0.142637

4 ETW000 [ dev trc,00000] - oci_bind ( 1: SQLT_AFC , l= 10, con=0, stp=x18d6308, pv=x188d3f4, in=x1886c6e,rl=x1888a02,rc=NULL)

4 ETW000 25 0.142662

4 ETW000 [ dev trc,00000] - oci_bind ( 2: SQLT_AFC , l= 22, con=0, stp=x18d6308, pv=x188ec9a, in=x188715c,rl=x1888ef0,rc=NULL)

4 ETW000 21 0.142683

4 ETW000 [ dev trc,00000] - oci_bind ( 3: SQLT_AFC , l= 10, con=0, stp=x18d6308, pv=x18922d4, in=x188764a,rl=x18893de,rc=NULL)

4 ETW000 20 0.142703

4 ETW000 [ dev trc,00000] - oci_bind ( 4: SQLT_AFC , l= 3, con=0, stp=x18d6308, pv=x1893b7a, in=x1887b38,rl=x18898cc,rc=NULL)

4 ETW000 20 0.142723

4 ETW000 [ dev trc,00000] - oci_bind ( 5: SQLT_AFC , l= 14, con=0, stp=x18d6308, pv=x18942df, in=x1888026,rl=x1889dba,rc=NULL)

4 ETW000 20 0.142743

4 ETW000 [ dev trc,00000] -->exec_modify(): bulk=0, input_cnt=6, lit_cnt=0, fae_cnt=0 14 0.142757

4 ETW000 [ dev trc,00000] stmt_execute?: row_max=1, _xcnt=0, _i=1, _pcnt=0, _upto=4294967295, _total=0

4 ETW000 18 0.142775

4 ETW000 [ dev trc,00000] AppInf(5)->1; mod='',act='',usr='DBSL: con=0, no client_id',ta='',mp=''

4 ETW000 21 0.142796

4 ETW000 [ dev trc,00000] time 2015-03-24 12:19:23, con=0 connected, new transaction 22 0.142818

4 ETW000 [ dev trc,00000] -->oci_execute_stmt(#16: con=0,stp=x18d6308,itr=1,off=0,bat=0); AI='..DBSL: con=0, no client_id.'

4 ETW000 18 0.142836

4 ETW000 [ dev trc,00000] -->OCIStmtExecute(con=0, svc=x178c918, err=x178a8f8): [dur. 0,000s] 13 0.142849

4 ETW000 [ dev trc,00000] OCIStmtExecute(rpc=1): [dur. 0,001s] 718 0.143567

4 ETW000 [ dev trc,00000] <--oci_execute_stmt(orc=0, rows processed 1, iters-errors = 1-0) [dur. 0,001s]

4 ETW000 29 0.143596

4 ETW000 [ dev trc,00000] IN array size xcnt=1, IN->row_total=1 11 0.143607

4 ETW000 [ dev trc,00000] orpc=1, DbCa.dbcount=1, DbSt.counter.dbrecords=1 10 0.143617

4 ETW000 [ dev trc,00000] stmt_execute() -> orc=0 (orc1=0), rc=0=DBSL_ERR_OK 11 0.143628

4 ETW000 [ dev trc,00000] <--exec_modify() -> 0=DBSL_ERR_OK, supply=999 10 0.143638

4 ETW000 [ dev trc,00000] sccb_stmt_deactivate(sch=x1702a58) 12 0.143650

4 ETW000 [ dev trc,00000] DbSlModify(con=0) -> 0=DBSL_ERR_OK 12 0.143662

4 ETW000 [ dev trc,00000] } db_rtab( fcode = 'RT_DELETE', retcode = 0 ) 11 0.143673

4 ETW690 COMMIT "0" "0"

4 ETW000 [ dev trc,00000] db_con_commit (con_da={R/3,0,0},th_commit=1,tx=1,hold_cursor=0) 36 0.143709

4 ETW000 [ dev trc,00000] all LL freed, no memory used for LL storage 28 0.143737

4 ETW000 [ dev trc,00000] -->DbSlCommit(con=0,FORCE,DROP), 16 stmts executed, 0/0 open cur 34 0.143771

4 ETW000 [ dev trc,00000] all LL freed, no memory used for LL storage 17 0.143788

4 ETW000 [ dev trc,00000] -->oci_commit(con=0), time: 2015-03-24 12:19:23 20 0.143808

4 ETW000 [ dev trc,00000] OCITransCommit(svc=x178c918, err=x178a8f8, OCI_DEFAULT) 11 0.143819

4 ETW000 [ dev trc,00000] <--oci_commit(), orc=0, time: 2015-03-24 12:19:23 1326 0.145145

4 ETW000 [ dev trc,00000] -->DbSlControl(con=0,cmd=12=DBSL_CMD_VENDOR_ID_GET) 94 0.145239

4 ETW000 trace to file pointer closed

4 ETW000 GetDBMigrateCodePagesLangs setting any locale.

4 ETW000 GetDBMigrateCodePagesLangs uses TCP0D, TCPDB, TCP0C.

4 ETW000 locale is set to "LC_CTYPE=de_DE;LC_NUMERIC=C;LC_TIME=de_DE;LC_COLLATE=de_DE;LC_MONETARY=de_DE;LC_MESSAGES=de_DE;LC_PAPER=de_DE;LC_NAME=de_DE;LC_ADDRESS=de_DE;LC_TELEPHONE=de_DE;LC_MEASUREMENT=de_DE;LC_IDENTIFICATION=de_DE"

4 ETW000 trace at level 1 opened for a given file pointer

4 ETW000

4 ETW000 ================== STEP 1 =====================

4 ETW000 date&time : 24.03.2015 - 12:19:23

4 ETW000 function : CONNECT

4 ETW000 buffersync : YES

4 ETW000 clients : default

4 ETW000 commit : 100000

4 ETW000 table cache : dynamic

4 ETW000

4 ETW000 [ dev trc,00000] Disconnecting from ALL connections: 222 0.000222

4 ETW000 [ dev trc,00000] dbcon[db_con_disconnect_all]: disconnecting from connection 0 ... 17 0.000239

4 ETW000 [ dev trc,00000] Disconnecting con=0 22 0.000261

4 ETW000 [ dev trc,00000] OCISessionEnd(con=0, svc=x178c918, srv=x178e250='PSB'): Close session usr=x17be1b0, rc=0

4 ETW000 1713 0.001974

4 ETW000 [ dev trc,00000] OCIServerDetach(stale1 con=0, svc=x178c918, srv=x178e250='PSB') successfully detached

4 ETW000 1955 0.003929

4 ETW000 [ dev trc,00000] OCIHandleFree(con=0, svc=x178c918): Server handle srv=x178e250 freed

4 ETW000 22 0.003951

4 ETW000 [ dev trc,00000] OCIHandleFree(con=0): Service hdl. svc=x178c918 freed. 7 0.003958

4 ETW000 [ dev trc,00000] dbcon[db_con_disconnect_all]: disconnected from connection 0 32 0.003990

4 ETW000 [ dev trc,00000] statistics db_con_commit (com_total=1, com_tx=1) 5 0.003995

4 ETW000 [ dev trc,00000] statistics db_con_rollback (roll_total=0, roll_tx=0) 4 0.003999

4 ETW000 Disconnected from database.

4 ETW000 End of Transport (0000).

4 ETW000 date&time: 24.03.2015 - 12:19:23

Hi,

It is seems that your oracle client is old. Can you check that ? It must be 11.

Regards, Prem

Oracle Client is: Oracle client version: 11.2.0.4.0, V2, default build, (dbsl 721 030315, non-u nicode)

Check also /oracle/client is up to date.

Hi Dieter ,

Please execute the following as <sid>adm and share the result

sapcontrol -nr <instance Number> -function GetEnvironment

Thanks ,

Manu

Output is:

24.03.2015 14:08:17

GetEnvironment

lines

LOGNAME=psbadm

HOME=/home/psbadm

SHELL=/bin/csh

TERM=vt100

PATH=/oracle/PSB/11264/bin:/home/psbadm/bin:/usr/local/bin:/bin:/usr/bin:/usr/bin/X11:/usr/X11R6/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin:/usr/sap/PSB/SYS/exe/nuc/linuxx86_64:/usr/sap/PSB/SYS/exe/run:/home/psbadm:.

HOSTTYPE=x86_64

VENDOR=suse

OSTYPE=linux

MACHTYPE=x86_64-suse-linux

SHLVL=1

PWD=/home/psbadm

USER=psbadm

GROUP=sapsys

HOST=prodsb

CSHEDIT=emacs

MAIL=/var/spool/mail/psbadm

CPU=x86_64

HOSTNAME=hostxx.

INPUTRC=/etc/inputrc

LESS=-M -I

LESSOPEN=lessopen.sh %s

LESSCLOSE=lessclose.sh %s %s

LESS_ADVANCED_PREPROCESSOR=no

LESSKEY=/etc/lesskey.bin

PAGER=less

MORE=-sl

MINICOM=-c on

MANPATH=/usr/local/man:/usr/share/man

INFODIR=/usr/local/info:/usr/share/info:/usr/info

INFOPATH=/usr/local/info:/usr/share/info:/usr/info

XKEYSYMDB=/usr/share/X11/XKeysymDB

XNLSPATH=/usr/share/X11/nls

COLORTERM=1

CVS_RSH=ssh

XCURSOR_THEME=DMZ

QT_HOME_DIR=/usr/share/desktop-data

LANG=en_US.UTF-8

FROM_HEADER=

NNTPSERVER=news

WINDOWMANAGER=/usr/bin/gnome

PYTHONSTARTUP=/etc/pythonstart

XDG_DATA_DIRS=/usr/local/share:/usr/share:/etc/opt/kde3/share:/opt/kde3/share:/usr/share/gnome/help

XDG_CONFIG_DIRS=/etc/xdg

G_BROKEN_FILENAMES=1

G_FILENAME_ENCODING=@locale,UTF-8,ISO-8859-1,CP1252

ENV=/etc/bash.bashrc

CSHRCREAD=true

LS_COLORS=no=00:fi=00:di=01;34:ln=00;36:pi=40;33:so=01;35:do=01;35:bd=40;33;01:cd=40;33;01:or=41;33;01:ex=00;32:*.cmd=00;32:*.exe=01;32:*.com=01;32:*.bat=01;32:*.btm=01;32:*.dll=01;32:*.tar=00;31:*.tbz=00;31:*.tgz=00;31:*.rpm=00;31:*.deb=00;31:*.arj=00;31:*.taz=00;31:*.lzh=00;31:*.lzma=00;31:*.zip=00;31:*.zoo=00;31:*.z=00;31:*.Z=00;31:*.gz=00;31:*.bz2=00;31:*.tb2=00;31:*.tz2=00;31:*.tbz2=00;31:*.avi=01;35:*.bmp=01;35:*.fli=01;35:*.gif=01;35:*.jpg=01;35:*.jpeg=01;35:*.mng=01;35:*.mov=01;35:*.mpg=01;35:*.pcx=01;35:*.pbm=01;35:*.pgm=01;35:*.png=01;35:*.ppm=01;35:*.tga=01;35:*.tif=01;35:*.xbm=01;35:*.xpm=01;35:*.dl=01;35:*.gl=01;35:*.wmv=01;35:*.aiff=00;32:*.au=00;32:*.mid=00;32:*.mp3=00;32:*.ogg=00;32:*.voc=00;32:*.wav=00;32:

LS_OPTIONS=-N --color=tty -T 0

RSEC_SSFS_DATAPATH=/usr/sap/PSB/SYS/global/security/rsecssfs/data

RSEC_SSFS_KEYPATH=/usr/sap/PSB/SYS/global/security/rsecssfs/key

rsdb_ssfs_connect=1

SAPSYSTEMNAME=PSB

DIR_LIBRARY=/usr/sap/PSB/SYS/exe/run

LD_LIBRARY_PATH=/usr/sap/PSB/DVEBMGS01/exe:/usr/sap/PSB/SYS/exe/run:/usr/sap/PSB/SYS/exe/nuc/linuxx86_64:/oracle/client/11x_64/instantclient

SAPEXE=/usr/sap/PSB/SYS/exe/run

THREAD=NOPS

DB_SID=PSB

dbms_type=ORA

dbs_ora_tnsname=PSB

dbs_ora_schema=SAPSR3

ORACLE_SID=PSB

ORACLE_BASE=/oracle

TNS_ADMIN=/usr/sap/PSB/SYS/profile/oracle

ORACLE_HOME=/oracle/PSB/11264

NLS_LANG=AMERICAN_AMERICA.WE8DEC

SAPDATA_HOME=/oracle/PSB

Why is the hostname with a point ?

HOSTNAME=hostxx.

Hi,

Provide me screenshot of of directory

/oracle/client/11x_<wordsize>/instantclient_<release>

Regards.Prem

Hi Prem ,

Believe the client is in 11 , From his earlier logs

B con_info_ext_support(): DBSL supports extended connect protocol

B ==> connect info for default DB will be read from ssfs

C dbs/ora/stmt_cache_size = 250

C Register application info.

C Oracle client version: 11.2.0.4.0, V2, default build, (dbsl 721 030315, non-u nicode)

C Installed Oracle client patches:

C # Patch 12985200 : Created on 2 Jul 2014, 09:45:20 hrs PST8PDT

C # Patch 11742262 : Created on 6 Nov 2013, 15:22:08 hrs CET

C Client NLS setting (by OCINlsGetInfo(con=0)): 'AMERICAN_AMERICA.WE8DEC'

C Connecting as SAPSR3/<pwd>@PSB on connection 0 (nls 0) ... (dbsl 721 030315, non-unicode)

C OCIHandleAlloc(con=0): Service svc=x58bf2d8 created, rc=0

Thanks ,

Manu

Answers (5)

Hallo Dieter,

I've created a document regarding to this issue. Please have a look.

And related SAP Note:

1904826 - Upgrade error "Connect via SAPUSER not supported for kernel >= 740"

I hope it helps.

Regards,

Serhat

You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.

Comment

Thanks for the response, I make the Upgrade to EHP 6 so I use OPS$. But have noticed in my knowledge base. Thanks a lot.

Dear Dieter,

I think the below two parameter are still present in your spfile<SID>.ora file

1. remote_os_authent = true

2. os_authent_prefix = 'OPS$'

If it exist , then remove the parameter and take a restart of database.

With Regards

Ashutosh Chaturvedi

You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.

Comment

Hello,

yes set these Parameter back. Now I am on EHP6 in the Preprocessing Phase and have approved the step who has last time produced an error.

Thanks for all.

Regards

Hi Dieter,

As i requested earlier for output of R3trans -d i.e required trans.log,as seems an issue with SSFS connection.

In addition i would suggest you to upgrade DBSL libraries with the updated one at SMP & check again.

Thanks,

You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.

Comment

OPS$ User is deleted and take a repeat im SUM - no luck !

DBSL libraries a new from the 17th of march 2015.

Hi Dieter ,

Not sure on this but try the following Notes and check whether the password entered in SUM is causing the issue

2067086 - ORA-01017 during SAP Upgrade

1904239 - SUM options to change parameters entered in INITPUT and INITSUBST phases

Thanks ,

Manu

Hi,

thanks for your help.

I am not in the SHD Phase only in Extraction Phase.

brconnect -u // -c -f check => all is ok

Oracle Clietn

hostxx:psbadm 62> pwd

/oracle/client/11x_64/instantclient_11204

hostxx:psbadm 63> ls

adrci genezi libclntsh.so.10.1 libnnz10.so libociei.so ojdbc5.jar SAPIC_README

classes12.jar libclntsh.so libclntsh.so.11.1 libnnz11.so ojdbc14.jar ojdbc6.jar wrc

Hi Dieter,

Could you check with SCN thread

Hope this would help you.

Thanks,

Set

rsecssfx put DB_CONNECT/DEFAULT_DB_CON_ENV ORA

But I read it is only for HANA required ?

prodsb:psbadm 61> rsecssfx list

|---------------------------------------------------------------------------------|

| Record Key | Status | Timestamp of last Update |

|---------------------------------------------------------------------------------|

| DB_CONNECT/DEFAULT_DB_CON_ENV | Encrypted | 2015-03-25 07:38:49 UTC |

| DB_CONNECT/DEFAULT_DB_PASSWORD | Encrypted | 2015-03-25 07:30:25 UTC |

| DB_CONNECT/DEFAULT_DB_USER | Plaintext | 2015-03-25 07:30:23 UTC |

|---------------------------------------------------------------------------------|

Hi,


Set rsecssfx put DB_CONNECT/DEFAULT_DB_CON_ENV ORA

Unfortunately this would not work,as this is only for HANA .I suggest you to kindly unset the parameter DB_CONNECT/DEFAULT_DB_CON_ENV ORA .(As we'rnt using this parameter in previous).

Here i would suggest you to try to reset database connection password once by following again SAP Note 1622837 - Secure connection of AS ABAP to Oracle via SSFS

& 1639578 - SSFS as password storage for primary database connect

Addition to it please raise an SAP OSS in parallel.

Regards,

Thanks for your request. I have many times reset the passwort via sqlplus, rsecssfx and brconnect.

Have already opened a OSS ticket.

Find out, that in /oracle/PSB/sapdata1/SUM/abap/control/dbs/ORA/DBENV.CSH and SH Skript. I insert the ssfs Parameter, delete SUM and restart. No Luck !

Hi Dieter,

what is the phase that this error is taking place?

Please attach file SAPupConsole.log to this thread.

Regards,

Tomas Black

Hi Tomas,

after the promt about the stack.xml file.

NOW I have reset the installation and start SAP with OPS$ because of the customer wanted EHP 6.

Hope this is definitely.

SAP Ticket ist already 1 week open - think they have no solution !!!

Thanks all for your help.

Hi Dieter,


after the promt about the stack.xml file.

Could you share the snap shot for the phase ?

Thanks,

Hi Diteter,

Is the issue resolved or any update on same.

Also as mentioned by Gaurav & Manu The issue is with SSFS. And below are my observations:-

In the 1st message log we can see that issue is with user id/password this may have came up as the password you have changed is not update in SSFS:-

4 ETW000 TRACE-INFO: 27: [

dev trc,00000] Logon as OPS$-user to get

SAPSR3's password	12 0.269337
4 ETW000 TRACE-INFO: 37: [	dev trc,00000]	ORA-01017: invalid

username/password; logon denied

Also from Trans.log files one can see that the






4 ETW000  [ 
dev trc,00000]  RSecSSFs: File "/usr/sap/PSB/SYS/global/security/rsecssfs/key/SSFS_PSB.KEY" cannot be opened in mode "rb": No such file or directory (errno = 2); at this location, this is not considered an error [rsecssfs.c 1188]


4 ETW000  [ 
dev trc,00000]  RSecSSFs: Key file "/usr/sap/PSB/SYS/global/security/rsecssfs/key/SSFS_PSB.KEY" not found, using default key [rsecssfs.c 1635]


4 ETW000  [ 
dev trc,00000]  RSecSSFs: File "/usr/sap/PSB/SYS/global/security/rsecssfs/key/SSFS_PSB.KEY" cannot be opened in mode "rb": No such file or directory (errno = 2); at this location, this is not considered an error [rsecssfs.c 1188]

So can you verify the above mentioned file exist /usr/sap/PSB/SYS/global/security/rsecssfs/key/SSFS_PSB.KEY" & /usr/sap/PSB/SYS/global/security/rsecssfs/data/SSFS_PSB.DAT.

Also would recommend you to fix the SSFS by deletion and reconfiguring the SSFS files and parameters. Do not change password too frequently otherwise you may loose a track of the things.

Let us know the update.

Regards,

Ram

I cannot belive, that SAP starts fine with ssfs and SUM not. Well done, customer wanted to have EHP6 so I am using OPS$. From SAP I get no reaction, so I think there is a problem too. Maybe in the next SUM it is fixed. Thanks for all !

Hi Dieter,

what's the incident number?

Regards,

Tomas

Hi Dieter ,

Please check whether you still have the OPS$ sidam.sapuser table , If you have that please drop the table and try once again

Thanks,

Manu

You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.

Comment

Hi Dieter,


4 ETW000 TRACE-INFO: 27:  [     dev trc,00000]  Logon as OPS$-user to get
SAPSR3's password                                        12  0.269337

Here still SAP is using OPS$ mechanism to connect with database,could you share complete log file form dev_w0 as well as trans.log by execution of R3trans -d.

In addition i would suggest you to refer SCN doc at

to verify steps at your end.

Regards,

You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.

Comment

Ask a Question

Top Q&A Solution Author

User

Count

103

SUM cannot connect to oracle, SAP runs already with ssfs !?

Accepted Solutions (1)

Accepted Solutions (1)

1639578 - SSFS as password storage for primary database connect

Answers (5)

Answers (5)

Re: Can I add a column to the MAT0M search help?

Re: How create a plugin session timeout with a cou...

Third Party with Subcontracting PREQ from Schedule...

Is it possible to group all open items into a sing...

Re: How to set BOM when splitting material codes f...

4 ETW000 [	dev trc,00000] RSecSSFs: File "/usr/sap/PSB/SYS/global/security/rsecssfs/key/SSFS_PSB.KEY" cannot be opened in mode "rb": No such file or directory (errno = 2); at this location, this is not considered an error [rsecssfs.c 1188]
4 ETW000 [	dev trc,00000] RSecSSFs: Key file "/usr/sap/PSB/SYS/global/security/rsecssfs/key/SSFS_PSB.KEY" not found, using default key [rsecssfs.c 1635]
4 ETW000 [	dev trc,00000] RSecSSFs: File "/usr/sap/PSB/SYS/global/security/rsecssfs/key/SSFS_PSB.KEY" cannot be opened in mode "rb": No such file or directory (errno = 2); at this location, this is not considered an error [rsecssfs.c 1188]