Skip to Content
0

Disp+work.exe Stopped

May 16, 2017 at 03:55 AM

808

avatar image

Hello Dear Gurus,

Oracle DB and SAP ECC are up and running on Oracle Linux. There is no network problem but after starting disp+work.exe stopped. Please help me.


DEV_DISP log =

---------------------------------------------------
trc file: "dev_disp.new", trc level: 1, release: "742"
---------------------------------------------------
sysno 10
sid QE1
systemid 390 (AMD/Intel x86_64 with Linux)
relno 7420
patchlevel 0
patchno 28
intno 20020600
make multithreaded, Unicode, 64 bit, optimized
profile /usr/sap/QE1/SYS/profile/QE1_DVEBMGS10_svrqas01
pid 32008


Mon May 15 06:30:18 2017
kernel runs with dp version 219000(ext=117000) (@(#) DPLIB-INT-VERSION-219000-UC)
length of sys_adm_ext is 500 bytes
***LOG Q00=> DpSapEnvInit, DPStart (10 32008) [dpInit.c 597]
shared lib "dw_xml.so" version 28 successfully loaded
shared lib "dw_xtc.so" version 28 successfully loaded
shared lib "dw_stl.so" version 28 successfully loaded
shared lib "dw_gui.so" version 28 successfully loaded
shared lib "dw_rndrt.so" version 28 successfully loaded
shared lib "dw_abp.so" version 28 successfully loaded
rdisp/softcancel_sequence : -> 0,5,-5
use internal message server connection to port 3900
rdisp/shutdown/disable_login : 0
rdisp/snapshot(CREATE): DP_CS_RESOURCES_EXHAUSTED
rdisp/snapshot(PERIOD):300 sec
rdisp/snapshot(LINES):10000 lines
DpCommonParamInit: rdisp/core_file_size = default --> no change

Mon May 15 06:30:22 2017
*** WARNING => DpNetCheck: NiAddrToHost(1.0.0.0) took 4 seconds
***LOG GZZ=> 1 possible network problems detected - check tracefile and adjust the DNS settings [dpxxtool2.c 5079]
MtxInit: 30000 0 0
DpIPCInit2: write dp-profile-values into sys_adm_ext
RqQInit: use events to trigger worker
DpIPCInit2: start server >svrqas01_QE1_10 <
DpShMCreate: alloate/attach shared memory (mode=CREATE)
DpShMCreate: sizeof(wp_adm) 33120 (1104)
DpShMCreate: sizeof(tm_adm) 13011936 (64736)
DpShMCreate: sizeof(ca_adm) 432000 (72)
DpCommTableSize: max/headSize/ftSize/tableSize=1000/8/3656056/3861112
DpShMCreate: sizeof(comm_adm) 3861112 (3648)
DpSlockTableSize: max/headSize/ftSize/fiSize/tableSize=0/0/0/0/0
DpShMCreate: sizeof(slock_adm) 0 (296)
DpFileTableSize: max/headSize/ftSize/tableSize=0/0/0/0
DpShMCreate: sizeof(file_adm) 0 (80)
DpSockTableSize: max/headSize/ftSize/tableSize=1000/8/1024056/1024064
DpShMCreate: sizeof(sock_adm) 1024064 (1016)
DpShMCreate: sizeof(vmc_adm) 0 (3208)
DpShMCreate: sizeof(wall_adm) (ft=40056/fi=67448/hd=64/rec=192)
DpShMCreate: sizeof(amc_rec_adm) (ft=169656/fi=101848/hd=56/rec=416)
DpShMCreate: sizeof(websocket_adm) (ft=28056/hd=64/rec=272)
DpShMCreate: sizeof(gw_adm) 56
DpShMCreate: sizeof(j2ee_adm) 3928
DpShMCreate: SHM_DP_ADM_KEY (addr: 7f6956613000, size: 18879744
DpShMCreate: allocated sys_adm at 7f6956613200
DpShMCreate: allocated wp_adm_list at 7f69566250e8
DpShMCreate: allocated wp_adm at 7f6956625408
DpShMCreate: allocated tm_adm_list at 7f695662d768
DpShMCreate: allocated tm_adm at 7f695662d9a8
DpShMCreate: allocated ca_adm at 7f6957296788
DpShMCreate: allocated comm_adm at 7f6957300108
DpShMCreate: system runs without slock table
DpShMCreate: allocated sock_adm at 7f69576aed80
DpShMCreate: allocated vmc_adm_list at 7f69577a8fc0
DpShMCreate: system runs without VMC
DpShMCreate: allocated gw_adm at 7f69577a9260
DpShMCreate: allocated j2ee_adm at 7f69577a9498
DpShMCreate: allocated ca_info at 7f69577aa5f0
DpShMCreate: allocated wall_adm (ft) at 7f69577aa830

Mon May 15 06:30:22 2017
DpShMCreate: allocated wall_adm (fi) at 7f69577b46a8
DpShMCreate: allocated wall_adm (head) at 7f69577c5020
DpShMCreate: allocated amc_rec_adm (ft) at 7f69577c5260
DpShMCreate: allocated amc_rec_adm (fi) at 7f69577eeb18
DpShMCreate: allocated amc_rec_adm (head) at 7f6957807af0
DpShMCreate: allocated websocket_adm (ft) at 7f6957807d28
DpShMCreate: allocated websocket_adm (head) at 7f695780ecc0
DpShMCreate: initialized 21 eyes
DpSysAdmIntInit: initialize sys_adm
DpSysAdmIntInit: created queue 0 (DispatcherQueue)
DpSysAdmIntInit: created queue 1 (GatewayQueue)
DpSysAdmIntInit: created queue 2 (IcmanQueue)
DpSysAdmIntInit: created queue 3 (StartServiceQueue)
DpSysAdmIntInit: created queue 4 (DpMonQueue)
Scheduler info
--------------
WP info
#dia = 15
#btc = 0
#standby = 0
#max = 30
General Scheduler info
preemptionInfo.isActive = true
preemptionInfo.timeslice = 500
preemptionInfo.checkLoad = true
Prio Class High
maxRuntime[RQ_Q_PRIO_HIGH] = 600 sec
maxRuntimeHalf[RQ_Q_PRIO_HIGH] = 300 sec
Prio Class Normal
maxRuntime[RQ_Q_PRIO_NORMAL] = 3600 sec
maxRuntimeHalf[RQ_Q_PRIO_NORMAL] = 1800 sec
maxTicketsForPrio[RQ_Q_PRIO_NORMAL] = 12
withPrioTickets[RQ_Q_PRIO_NORMAL] = true
Prio Class Low
maxRuntime[RQ_Q_PRIO_LOW] = infinite
maxRuntimeHalf[RQ_Q_PRIO_LOW] = infinite
maxTicketsForPrio[RQ_Q_PRIO_LOW] = 12
withPrioTickets[RQ_Q_PRIO_LOW] = true
Running requests[RQ_Q_PRIO_NORMAL] = 0
Running requests[RQ_Q_PRIO_LOW] = 0
Mon May 15 06:30:22 2017

DpCommAttachTable: attached comm table (header=7f6957300108/ft=7f6957300110/fi=7f695767ca88)
DpSockAttachTable: attached sock table (header=7f69576aed80/ft=7f69576aed88)
MBUF state OFF
DpCommInitTable: init table for 1000 entries
DpSockInitTable: init table for 1000 entries
EM: Initializing PROC storage: quota=0 use_stdheap=0
EmInit: MmSetImplementation( 2 ).
MM global diagnostic options set: 0
<ES> client 30 initializing ....
<ES> EsILock: use Semphore 33 for locking
<ES> block size is 4096 kByte.
<ES> Info: em/initial_size_MB( 9831MB) not multiple of em/blocksize_KB( 4096KB)
<ES> Info: em/initial_size_MB rounded up to 9832MB
<ES> Info: disclaim threshold = 0 MB
<ES> Info: disclaim coasting/alloc = 300 s
<ES> Info: disclaim coasting/free = 0 s
<ES> Info: blockdisclaimsize_KB = 0 KB
Using implementation std
<ES> Info: use mapped file
EsStdUnamFileMapInit: ES Segment = 0x7f66e1b4f000 - 0x7f694834f000
EsStdInit: Extended Memory 9832 MB allocated
Linux: Kernel supports shared memory disclaiming
Linux: using madvise(<pointer>, <size>, 9).
Linux: disclaiming for shared memory enabled
<ES> 2457 blocks reserved for free list.
ES initialized.
mm.dump: set maximum dump mem to 96 MB
rdisp/calculateLoadAverage : 1
***LOG Q0K=> DpMsAttach, mscon ( svrqas01) [dpMessageSer 1655]
DpStartStopMsg: send start message (myname is >svrqas01_QE1_10 <)
DpStartStopMsg: start msg sent to message server o.k.
MBUF state LOADING
MPI: dynamic quotas disabled.
MPI init: pipes=4000 buffers=6395 reserved=1918 quota=10%
DpAsCreate: forked gwrd (pid 32043)
DpIcmCreate: forked ICM (pid 32044)
DpWpDynCreate: created new work process W0-32045
DpWpDynCreate: created new work process W1-32046
DpWpDynCreate: created new work process W2-32047
DpWpDynCreate: created new work process W3-32048

Mon May 15 06:30:22 2017
DpWpDynCreate: created new work process W4-32049
DpWpDynCreate: created new work process W5-32050
DpWpDynCreate: created new work process W6-32051
DpWpDynCreate: created new work process W7-32052
DpWpDynCreate: created new work process W8-32053
DpWpDynCreate: created new work process W9-32054
DpWpDynCreate: created new work process W10-32055
DpWpDynCreate: created new work process W11-32056
DpWpDynCreate: created new work process W12-32057
DpWpDynCreate: created new work process W13-32058
DpWpDynCreate: created new work process W14-32059
DpWpDynCreate: created new work process W15-32060
DpWpDynCreate: created new work process W16-32061
DpWpDynCreate: created new work process W17-32062
DpWpDynCreate: created new work process W18-32063
DpWpDynCreate: created new work process W19-32064
DpWpDynCreate: created new work process W20-32065
DpWpDynCreate: created new work process W21-32068
DpWpDynCreate: created new work process W22-32069
DpWpDynCreate: created new work process W23-32070
DpWpDynCreate: created new work process W24-32071
CGROUPS: changing prio of pid 32008 to medium
CGROUPS: disabled
**START Linux Memory Parameter Check
virtual memory: hard-limit = UNLIMITED
virtual memory: soft-limit = UNLIMITED
core size: hard-limit = UNLIMITED
core size: soft-limit = 0 MB
data segment size: hard-limit = UNLIMITED
data segment size: soft-limit = UNLIMITED
stack size: hard-limit = 10 MB
stack size: soft-limit = 8 MB
max open files: hard-limit = 65536
max open files: soft-limit = 65536
Page Size: 4 KB
kernel.shmmax = 65536 MB
kernel.shmall = 16777216 MB
**END Linux Memory Parameter Check
Linux scheduler "SCHED_OTHER" used with prio 0

Mon May 15 06:30:23 2017
CCMS: SemInMgt: Semaphore Management initialized by AlAttachShm_Doublestack.
CCMS: SemInit: Semaphore 38 initialized by AlAttachShm_Doublestack.
CCMS: start to initalize 3.X shared alert area (first segment).
DpCheckPreemptionTicker: created thread for DpPremptionTicker
DpMBufHwIdSet: set Hardware-ID
***LOG Q1C=> DpMBufHwIdSet [dpxxmbuf.c 1179]
MBUF state ACTIVE
DpMBufTypeMod: MBUF component UP (event=MBUF_DPEVT_UP)
DpMsgProcess: 1 server in MBUF
DpMsCheckServices()
DpMsgProcess: MBUF state is MBUF_ACTIVE
DpMBufReset: state = MBUF_PREPARED

Mon May 15 06:30:38 2017
MBUF state ACTIVE
DpMBufTypeMod: MBUF component UP (event=MBUF_DPEVT_UP)
DpMsgProcess: 1 server in MBUF
DpMsCheckServices()
DpMBufTypeMod: MBUF server state ACTIVE (event=MBUF_DPEVT_DSTATE)
DpModState: change server state from STARTING to ACTIVE
DpMsInfo: MOD for server svrqas01_QE1_10

Mon May 15 06:31:44 2017
***
*** DpRqNoWpHandle: SHUTDOWN request from W3 received (reason=DP_SHUTDOWN_LARGE_TIME_DIFF) ***
***

********** SERVER SNAPSHOT 1 (Reason: Shutdown) - begin **********

Server svrqas01_QE1_10

Force W3 in state WP_HOLD to dump stack
Force W16 in state WP_RUN to dump stack
Force W17 in state WP_RUN to dump stack
Force W19 in state WP_RUN to dump stack
Force W20 in state WP_RUN to dump stack

Scheduler info
--------------
WP info
DpNumberOfDiaWps: dia_wps 15, standby_wps 0
#dia = 15
#btc = 7
#standby = 0
#max = 30
General Scheduler info
preemptionInfo.isActive = true
preemptionInfo.timeslice = 500
preemptionInfo.checkLoad = true
Prio Class High
maxRuntime[RQ_Q_PRIO_HIGH] = 600 sec
maxRuntimeHalf[RQ_Q_PRIO_HIGH] = 300 sec
Prio Class Normal
maxRuntime[RQ_Q_PRIO_NORMAL] = 3600 sec
maxRuntimeHalf[RQ_Q_PRIO_NORMAL] = 1800 sec
maxTicketsForPrio[RQ_Q_PRIO_NORMAL] = 12
withPrioTickets[RQ_Q_PRIO_NORMAL] = true
Prio Class Low
maxRuntime[RQ_Q_PRIO_LOW] = infinite
maxRuntimeHalf[RQ_Q_PRIO_LOW] = infinite
maxTicketsForPrio[RQ_Q_PRIO_LOW] = 12
withPrioTickets[RQ_Q_PRIO_LOW] = true
Actual tickets in use
actTicketsInUseForPrio[RQ_Q_PRIO_NORMAL] = 12
actTicketsInUseForPrio[RQ_Q_PRIO_LOW] = 12
Running requests[RQ_Q_PRIO_NORMAL] = 0
Running requests[RQ_Q_PRIO_LOW] = 0

Queue Statistics Mon May 15 06:31:44 2017
------------------------------------------------------------

Number of lost wakeup datagrams: 0

Max. number of queue elements : 14000

DIA : 0 (peak 4, writeCount 86, readCount 86)
UPD : 0 (peak 1, writeCount 4, readCount 4)
ENQ : 0 (peak 0, writeCount 0, readCount 0)
BTC : 0 (peak 2, writeCount 35, readCount 35)
SPO : 0 (peak 1, writeCount 6, readCount 6)
UP2 : 0 (peak 1, writeCount 2, readCount 2)
DISP: 0 (peak 2, writeCount 56, readCount 56)
GW : 0 (peak 1, writeCount 1, readCount 1)
ICM : 0 (peak 1, writeCount 4, readCount 4)
LWP : 0 (peak 24, writeCount 47, readCount 47)

Session queue dump (high priority, 0 elements, peak 3):
Session queue dump (normal priority, 0 elements, peak 2):
Session queue dump (low priority, 0 elements, peak 0):



Infos about some special queues:

Queue <StartServiceQueue> in slot 3 (port=0) has no requests

Workprocess Table (long) Mon May 15 06:31:44 2017
------------------------------------------------------------

Current snapshot id: 1
Number of preemptions : 0

|No |Pid |Type|State |Cause|Err|Prio|Sess-Key |Sess-Type|Locked|Sem|Time |Program |Cli|User |Action |Action-Info |
|---+------+----+-------+-----+---+----+----------------+---------+------+---+-----+----------------------------------------+---+------------+--------------------+--------------------|
| 3|32048 |DIA |WP_HOLD|PRIV | |high|T22_U76_M0 |INTERNAL | | | 2| |000|SAPSYS | | |
| 16|32061 |BTC |WP_RUN | | |low |T1_U85_M0 |BATCH | | | 1| |000|SAPSYS |READDIR |BTCJOBEPP |
| 17|32062 |BTC |WP_RUN | | |low |T18_U84_M0 |BATCH | | | 1| |000|SAPSYS |COMMIT | |
| 19|32064 |BTC |WP_RUN | | |low |T6_U80_M0 |BATCH | | | 1| |000|SAPSYS |COMMIT | |
| 20|32065 |BTC |WP_RUN | | |low |T9_U86_M0 |BATCH | | | 1|<BATCH> |000|SAPSYS | | |

Found 5 active workprocesses

Session Table Mon May 15 06:31:44 2017
------------------------------------------------------------

|Logon-Type |Sess-Key |Cli|User |Terminal |Time |WP |Program |Prio|Tasks|Application-Info |Tcode |ES-Mem(KB)|
|------------+----------------+---+------------+--------------------+--------+---+----------------------------------------+----+-----+--------------------------------------------------+----------+----------|
|BATCH |T1_U85_M0 |000|SAPSYS | |06:31:43|16 |SAPMSSY2 |low | | | |4139 |
|BATCH |T6_U80_M0 |000|SAPSYS | |06:31:43|19 |RSBTCRTE |low | | | |12331 |
|BATCH |T9_U86_M0 |000|SAPSYS | |06:31:43|20 |SAPMSSY2 |low | | | |4138 |
|BATCH |T18_U84_M0 |000|SAPSYS | |06:31:43|17 |RSBTCRTE |low | | | |8235 |
|INTERNAL |T22_U76_M0 |000|SAPSYS | |06:31:42|3 |SAPMSSY2 |high| | | |4139 |

Found 5 logons with 5 sessions


Mon May 15 06:31:44 2017
CA Blocks
0 WORKER 32062
2 WORKER 32064
3 WORKER 32061
4 WORKER 32065
4 ca_blk slots of 6000 in use, 0 currently unowned (in request queues)

********** SERVER SNAPSHOT 1 (Reason: Shutdown) - end **********


Mon May 15 06:31:54 2017
DpTriggerSapSnapshot: start /usr/sap/QE1/DVEBMGS10/exe/sapcontrol
DpTriggerSapSnapshot: sapcontrol runs with pid 600
***LOG Q41=> DpDumpInternalTables, () [dpxxdisp.c 3299]
DpHalt: shutdown server >svrqas01_QE1_10 < (normal)
DpMBufTypeMod: MBUF server state SHUTDOWN (event=MBUF_DPEVT_DSTATE)
DpModState: change server state from ACTIVE to SHUTDOWN
DpHalt: stop work processes

Mon May 15 06:31:55 2017
DpHdlSoftCancel: cancel request for T22_U76_M0 received from DISP (reason=DP_SOFTCANCEL_NO_REASON)
DpHdlSoftCancel: cancel request for T7_U87_M0 received from DISP (reason=DP_SOFTCANCEL_NO_REASON)
DpHdlSoftCancel: cancel request for T1_U85_M0 received from DISP (reason=DP_SOFTCANCEL_NO_REASON)
DpHdlSoftCancel: cancel request for T18_U84_M0 received from DISP (reason=DP_SOFTCANCEL_NO_REASON)
DpHdlSoftCancel: cancel request for T6_U80_M0 received from DISP (reason=DP_SOFTCANCEL_NO_REASON)
DpWpMutexLocked: W19 inside critical section (mtx ?)
DpHdlSoftCancelForActiveProgram: wp 19 inside critical section, reschedule softcancel (level 0)

Mon May 15 06:32:55 2017
DpHalt: stop gateway
DpHalt: stop icman
DpHalt: terminate gui connections
DpHalt: wait for end of work processes
DpHalt: waiting for termination of work processes ...

Mon May 15 06:32:56 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:32:57 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:32:59 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:00 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:01 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:02 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:03 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:04 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:05 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:06 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:07 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:08 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:09 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:10 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:11 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:12 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:13 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:14 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:15 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:16 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:17 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:18 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:19 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:20 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:21 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:22 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:23 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:24 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:25 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:26 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:27 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:28 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:29 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:30 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:31 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:32 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:33 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:34 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:35 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:36 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:37 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:38 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:39 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:40 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:41 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:42 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:43 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:44 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:45 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:46 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:47 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:48 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:49 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:50 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:51 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:52 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:53 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:54 2017
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:55 2017
*** ERROR => DpHalt: W19 (pid 32064) still alive ... [dpInit.c 3257]
DpHalt: waiting for termination of work processes ...

Mon May 15 06:33:56 2017
DpHalt: wait for end of gateway
DpHalt: wait for end of icman
DpStartStopMsg: send stop message (myname is >svrqas01_QE1_10 <)
DpStartStopMsg: stop msg sent to message server o.k.

Mon May 15 06:33:57 2017
DpHalt: sync with message server o.k.
DpHalt: detach from message server
***LOG Q0M=> DpMsDetach, ms_detach () [dpMessageSer 2069]
MBUF state OFF
DpMBufTypeMod: MBUF component DOWN (event=MBUF_DPEVT_DOWN)
DpHalt: ignore SIGCHLD from now on
SigISetIgnoreAction : SIG_IGN for signal SIGCHLD
DpHalt: cleanup EM
DpHalt: cleanup event management
DpHalt: cleanup shared memory/semaphores
***LOG Q05=> DpHalt, DpHalt ( 32008) [dpInit.c 3594]
DpHalt: *** shutdown completed - server stopped ***

DEV_W0 log =


---------------------------------------------------
trc file: "dev_w0", trc level: 1, release: "742"
---------------------------------------------------
*
* ACTIVE TRACE LEVEL 1
* ACTIVE TRACE COMPONENTS all, MJ
*
M sysno 10
M sid QE1
M systemid 390 (AMD/Intel x86_64 with Linux)
M relno 7420
M patchlevel 0
M patchno 28
M intno 20020600
M make multithreaded, Unicode, 64 bit, optimized
M profile /usr/sap/QE1/SYS/profile/QE1_DVEBMGS10_svrqas01
M pid 22780
M
M
M Fri May 12 13:57:23 2017
M kernel runs with dp version 219000(ext=117000) (@(#) DPLIB-INT-VERSION-219000-UC)
M length of sys_adm_ext is 500 bytes
M ThStart: taskhandler started
M ThInit: initializing DIA work process W0
M ThStopHeapLockChecker: stop heap lock checker
M ***LOG Q01=> ThInit, WPStart (Workp. 0 1 22780) [thxxhead.c 1026]
M
M Fri May 12 13:57:32 2017
M ThInit: running on host svrqas01
I MtxInit: 0 0 0
M calling db_connect ...
B Loading DB library '/usr/sap/QE1/DVEBMGS10/exe/dboraslib.so' ...
B Library '/usr/sap/QE1/DVEBMGS10/exe/dboraslib.so' loaded
B Version of '/usr/sap/QE1/DVEBMGS10/exe/dboraslib.so' is "742.06", patchlevel (0.25)
B read_con_info_ssfs(): DBSL supports extended connect protocol
B ==> connect info for default DB will be read from ssfs
C Register application info.
C Oracle client version: 11.2.0.3.0, V2, default build, (dbsl 742 231014, UNICODE[2])
C Installed Oracle client patches:
C # Patch 14489591 : Created on 19 Jan 2013, 20:08:26 hrs PST8PDT
C # Patch 14042380 : Created on 23 Dec 2013, 22:24:52 hrs PST8PDT
C # Patch description: Created on 7 Jan 2014, 02:20:21 hrs PST8PDT
C # Patch 13508485 : Created on 21 Dec 2011, 13:23:38 hrs PST8PDT
C # Patch 11742262 : Created on 7 Mar 2012, 12:22:41 hrs CET
C Client NLS setting (by OCINlsGetInfo(con=0)): 'AMERICAN_AMERICA.UTF16'
C Connecting as SAPSR3/<pwd>@QE1 on connection 0 (nls 0) ... (dbsl 742 231014, UNICODE[2])
C OCIServerAttach(con=0, svc=7fc46e07cf18) srv=7fc46e07f520 attached to 'QE1'
C OCISessionBegin(con=0, svc=7fc46e07cf18, srv=7fc46e07f520='QE1'): start session of usr=7fc46e08e1c0='SAPSR3', rc=0
C Now 'SAPSR3/<pwd>@QE1' is connected: con=0, nls=0, session=152, time='2017-05-12 13:57:32'
C DB instance QE1 is running on svrqasdb with ORACLE version 11.2.0.3.0 since MAY 12, 2017, 13:15:56.
C con=0, V$NLS_PARAMETERS: NLS_LANG=AMERICAN_AMERICA.UTF8, NLS_NCHAR=UTF8
C Nls CharacterSet NationalCharSet env err bat
C 0 UTF16 AL16UTF16 7fc46e06f070 7fc46e07ae18 7fc46e07cff8
B Connection 0 opened (DBSL handle 0)
C DbSlControl(DBSL_CMD_SAPRELEASE_SET,abap='740')
M ThDbConnect: db_connect o.k.
X
X Fri May 12 13:57:38 2017
X EmInit: MmSetImplementation( 2 ).
X MM global diagnostic options set: 0
X <ES> client 0 initializing ....
X Using implementation std
X <ES> Info: use mapped file
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 96 MB
I *** INFO SHM 44 in POOL 40 57593 KB estimated 46559 KB real ( -11034 KB -20 %)
I *** INFO SHM 45 in POOL 40 37459 KB estimated 26425 KB real ( -11034 KB -30 %)
B db_con_shm_ini: WP_ID = 0, WP_CNT = 30, CON_ID = -1
B Start CursorInit
B TBI initializing semaphore lock manager ...
B dbtbxbuf: Buffer TBI64 (addr: 7fc1c3bec0e8, size: 1247308812, end: 7fc20e172cf4)
B DBI: init TBI BUFFER (data): start=7fc2062e5000 length=1209239040 end=7fc24e41d600
B dbprotocol: table logging switched off for all clients
B DbDmlCursor::maxItabInvalidationThreshold = 20
B DB FDA shm initialized: ptr=7fc1c3a1b0f0 total_size_wp=1048576lu used_size_wp=1048576
B dbsync[db_syinit]: successfully attached to shared memory, sync_adm_p = 7fc1dee52000
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 = -2147127411
B oldest_gap = (2147483647,19700101000000)
B time_of_last_sync = 20170512135736
B MySysId = 'svrqas01 10'
B dbexpbuf[EXP_SHB]: successfully attached to shared memory
B dbexpbuf[EXP_SHB]: buffer installed with the following properties
B semKey = 35
B shmKey = 54
B wpCnt = 30
B blockSize = 512
B maxObjects = 35953
B maxObjectSize = 33433728
B freeListVectorSize = 489
B hashVectorSize = 71909
B bufferSize = 147262464
B maxBlocks = 261201
B freeBlocksCnt = 261201
B mutexVectorSize = 71911, ADMIN_MUTEX = 71909, INVAL_MUTEX = 71910
B tracing = 0
B forceChecks = 0
B protectShm = 0
B dbexpbuf[EXP_SHM]: successfully attached to shared memory
B dbexpbuf[EXP_SHM]: buffer installed with the following properties
B semKey = 56
B shmKey = 65
B wpCnt = 30
B blockSize = 512
B maxObjects = 2000
B maxObjectSize = 859264
B freeListVectorSize = 17
B hashVectorSize = 4001
B bufferSize = 4194304
B maxBlocks = 6713
B freeBlocksCnt = 6713
B mutexVectorSize = 4003, ADMIN_MUTEX = 4001, INVAL_MUTEX = 4002
B tracing = 0
B forceChecks = 0
B protectShm = 0
B dbexpbuf[EXP_CUA]: successfully attached to shared memory
B dbexpbuf[EXP_CUA]: buffer installed with the following properties
B semKey = 30
B shmKey = 47
B wpCnt = 30
B blockSize = 512
B maxObjects = 2000
B maxObjectSize = 577536
B freeListVectorSize = 587
B hashVectorSize = 4001
B bufferSize = 3072000
B maxBlocks = 4512
B freeBlocksCnt = 4512
B mutexVectorSize = 4003, ADMIN_MUTEX = 4001, INVAL_MUTEX = 4002
B tracing = 0
B forceChecks = 0
B protectShm = 0
B dbexpbuf[EXP_OTR]: successfully attached to shared memory
B dbexpbuf[EXP_OTR]: buffer installed with the following properties
B semKey = 55
B shmKey = 64
B wpCnt = 30
B blockSize = 256
B maxObjects = 2000
B maxObjectSize = 859200
B freeListVectorSize = 33
B hashVectorSize = 4001
B bufferSize = 4194304
B maxBlocks = 13425
B freeBlocksCnt = 13425
B mutexVectorSize = 4003, ADMIN_MUTEX = 4001, INVAL_MUTEX = 4002
B tracing = 0
B forceChecks = 0
B protectShm = 0
B NTAB: Structure of NTAB on DB is VERS_B, unicodelg of executable is 2, unicodelg of SVERS in nametab is 2
M SHM_PRES_BUF (addr: 7fc47cb79000, size: 4400000)
I *** INFO SHM 48 in POOL 40 695 KB estimated 535 KB real ( -160 KB -24 %)
M ThCreateNoBuffer allocated 548152 bytes for 1000 entries at 7fc1df14b000
M ThCreateNoBuffer index size: 3000 elems
M ThCreateVBAdm allocated 33376 bytes (50 server) at 7fc48ff62000
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
G RelWritePermissionForShm( pLocation = 120, pEnforce = 0 )
G GetWritePermissionForShm( pLocation = 99, pEnforce = 1 )
G RelWritePermissionForShm( pLocation = 100, pEnforce = 1 )
S *** init spool environment
S
S Fri May 12 13:57:38 2017
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 7fc46e108b20
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 2898 KB estimated 1632 KB real ( -1266 KB -44 %)
S found processing queue enabled
S found spool memory service RSPO-RCLOCKS at 7fc1df1d2070
S doing lock recovery
S setting server cache root
S found spool memory service RSPO-SERVERCACHE at 7fc1df1d2938
S using messages for server info
S size of spec char cache entry: 297032 bytes (timeout 100 sec)
S size of open spool request entry: 2512 bytes
S immediate print option for implicitely closed spool requests is disabled
M ThrCreateShObjects allocated 62368 bytes at 7fc47ca2c000
I MPI: dynamic quotas disabled.
I MPI init: pipes=4000 buffers=6395 reserved=1918 quota=10%
M CCMS: SemInMgt: Semaphore Management initialized by AlAttachShm_Doublestack.
M CCMS: SemInit: Semaphore 38 initialized by AlAttachShm_Doublestack.
A PXA: max_map_count = 1000000: ok
A ***GENER* Trace switched on ***
A
A ---PXA-------------------------------------------
A PXA INITIALIZATION
A PXA: Locked PXA-Semaphore.
A System page size: 4kb, total admin_size: 119168kb, dir_size: 38656kb.
A Attached to PXA (address 7fc152592000, size 1511424K, 3 fragments of 464088K )
A abap/pxa = shared protect gen_remote
A PXA: checking structure sizes: 760|272|8
A PXA INITIALIZATION FINISHED
A ---PXA-------------------------------------------
A
A
A Fri May 12 13:57:38 2017
A ATRA: pfclock execution time = 0
A abap/force_local_update_task=0
A ABAP ShmAdm attached (addr=7fc24ecbe000 leng=206553088 end=7fc25b1ba000)
A >> Shm MMADM area (addr=7fc251b3f108 leng=2427520 end=7fc251d8fb88)
A >> Shm MMDAT area (addr=7fc251d90000 leng=155361280 end=7fc25b1ba000)
A RFC Destination> destination svrqas01_QE1_10 host svrqas01 system QE1 systnr 10 (svrqas01_QE1_10)
A RFC Options> H=svrqas01,S=10,d=2,
B *-- dbmetadata DbVendorMetaData --------------*
B Connection : R/3[0]
B DB vendor : ORACLE,742.06
B DB vendor : 4
B DBSL version : 742.06
B DBSL features
B maxstmtsize : 1048576
B maxmarkercnt : 65535
B maxincnt : 1000
B maxlongsize : 32768
B maxhistlongsize : 32768
B minhistlongsize : 32768
B maxmarkersize : 8
B autorpad : 0
B stringspadded : 0
B blk1obj1mod : 1
B haverownum : 1
B havepermanentstmts : 0
B fupdlockperm : 1
B fupdorder : 1
B preferunionall : 0
B prefer_join : 0
B prefer_join_with_fda : 0
B preferinitabopt : 1
B useinputsize : 0
B preferfixblocking : 0
B maxblockingfactor : 5
B minblockingfactor : 5
B maxinblockingfactor : 5
B mininblockingfactor : 5
B maxunionblockingfactor : 5
B minunionblockingfactor : 5
B prefer_asterisk : 15
B
B Fri May 12 13:57:38 2017
B deferred_lob_writing : 0
B prefer_count_big : 0
B supports_fda_prot : 0
B integer_operation_cast : 1
B modulo_operator : 0
B smallint_cast : 0
B integer_division_mode : 2
B FAE controls
B supports_fda_prot : 0
B prefer_in_itab_opt : 1
B prefer_union_all : 0
B prefer_join : 0
B prefer_join_with_fda : 0
B prefer_fix_blocking : 0
B max_blocking_factor : 5
B min_blocking_factor : 5
B max_in_blocking_factor : 5
B min_in_blocking_factor : 5
B max_union_blocking_factor : 5
B min_union_blocking_factor : 5
B DB feature mode
B views_parameters_unnamed: 0
B views_with_parameters : 1
B external_views : 0
B TABLE_KEYCNT_MAX1 : 1
B TABLE_KEYLEN_MAX1 : 1
B TABLE_LEN_MAX1 : 1
B Hint settings
B ABAP hints enabled : 1
B DBI hints enabled : 1
B DBI hints enforced : 0
B upto limit : -1
B Misc settings
B DB buffer size: 130000
B Float Cast: {null}
B Count Text: COUNT(
B Count All Text: COUNT(*)
B Reserved characters: {null}
B UPTO handling: 0
B *------------- DbVendorMetaData --------------*
B
B Fri May 12 13:57:38 2017
B dbrda: Redirect database access is disabled via rsdb/rda profile parameter setting.
A
A Fri May 12 13:57:39 2017
A RFC FRFC> fallback ist not active. Do nothing.
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: 2
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:742.06]):
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,
B select * =0x0f, character encoding = STD / <none>:-,
B use_hints = abap->1, dbif->0x1, upto->18446744073709551615
Y dyWpInit
Y ztta/dynpro_ara 800000
Y ztta/cua_ara 500000
Y ztta/diag_ara 250000
N MskiInitLogonTicketCacheHandle: Logon Ticket cache pointer retrieved from shared memory.
N MskiInitLogonTicketCacheHandle: Workprocess runs with Logon Ticket cache.
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) 2
W ITS Plugin: Release: 742, [7420.0.28.20020600]
W ITS Plugin: Int.version, [34]
W ITS Plugin: Feature set: [34]
W ===... Calling itsp_Init in external dll ===>
W === ipl_Init() returns 0, ITSPE_OK: OK
W =================================================
N VSI: WP init in ABAP VM completed with rc=0
N SsfSapSecin: getenv(SECUDIR)=="/usr/sap/QE1/DVEBMGS10/sec"
N
N =================================================
N === SSF INITIALIZATION:
N ===...SSF Security Toolkit name SAPSECULIB .
N ===...SSF library is /usr/sap/QE1/DVEBMGS10/exe/libsapcrypto.so .
N ===...SSF default hash algorithm is SHA1 .
N ===...SSF default symmetric encryption algorithm is AES128-CBC .
N ===...SECUDIR="/usr/sap/QE1/DVEBMGS10/sec"
N ===...loading of Security Toolkit successfully completed.
N === CommonCryptoLib (SAPCRYPTOLIB) Version 8.4.32 pl40 (Nov 14 2014) MT-safe
N
N Fri May 12 13:57:39 2017
N =================================================
N SignInit: successfully obtained handle for Security Context cache
N SPNegoInit: SPNego disabled ("spnego/enable" not set to 1)
M JrfcVmcRegisterNativesDriver o.k.
M CGROUPS: ThSetProcessPriority workerType=1
M CGROUPS: changing prio of pid 22780 to medium
M CGROUPS: disabled
E EnqId_Initialize: local EnqId initialization o.k.
M ThrtAmcInit: use DB table AMC_RECEIVER for AMC dispatching
M
M Fri May 12 13:58:53 2017
M in_ThErrHandle: 1
M ThIErrHandle: new stat of W0 is WP_SHUTDOWN
M ThIErrHandle: I'm during shutdown
M PfRejectStatistic: clear statistic record
M PfClearAllRec: clear statistic area
M PfClearAllRec: statRecordAction = STAT_RECORD_ACTION_REJECT
M ThIErrHandle: entering ThSetStatError
M PfSetError: clear statistic record
M PfClearAllRec: clear statistic area
M PfClearAllRec: statRecordAction = STAT_RECORD_ACTION_REJECT
M ThWpSetCurrentSession: set WP's current session to NO SESSION (rq_cnt 0, last wp -1, last rq_id 0)
M ThResetActRequestQueue: Reset queue in slot 42 (T23_U84_M0)
M ThRqReleaseQueueSelectHandle: release selectable handle of queue 42 (T23_U84_M0) from [thRequest.c:856]
M RqQQueueReleaseSelectableHandle: Queue <T23_U84_M0> in slot 42 does not have a selectable handle
M RqQQueueReleaseSelectableHandle: Queue <T23_U84_M0> in slot 42 released selectable hdl -1 (port=0) W-1
M RqQQueueRelease: Return queue <T23_U84_M0> in slot 42
C -->DbSlControl(con=0,cmd=57=DBSL_CMD_SQLBREAK)
C -->oci_break(con=0,Acon=-1,cb=0000NULL): cancel of current SQL
C sc_p=7fc46e03d010,no=6,idc_p=(nil),con=0,act=0,slen=21,smax=256,#vars=0,stmt=7a95680,table=IACFL
C Dumping stmt. cache (DBSL private attributes):
C sch=7fc46e03d010, scp=7fc46e046840, ups_sch=0000NULL, stp=7a962c8, r_c=0
C prep=2, dbds=0, lit_cnt=0, lob_cnt=0, fae_cnt=0, xop=1, dbcount=36
C IN : col_cnt=0, row_max=1, row_xcnt=0, row_pcnt=0, row_i=140733193388032, row_total=0,
C row_upto=0, row_size=0, vda_max=0, bound=0, itp=0000NULL, vda_arr=0000NULL
C lob_anz=0, lob_max=0, lob_pw=0, lobarr=0000NULL, rows_ret=0
C OUT: col_cnt=5, row_max=792, row_xcnt=0, row_pcnt=0, row_i=140466905415680, row_total=36,
C row_upto=0, row_size=154, vda_max=32, bound=1, itp=0000NULL, vda_arr=7a96a00
C lob_anz=0, lob_max=0, lob_pw=0, lobarr=0000NULL, rows_ret=0
C SELECT * FROM "IACFL";
C No OCI call running -> OCIBreak() not called
C <--oci_break() -> Aorc=-24200
C <--DbSlControl(con=0,cmd=57=DBSL_CMD_SQLBREAK), rc=1=DBSL_ERR_ACCESS
B db_sqlbreak() = 1
M ThCallDbBreak: no sql statement active
M ThIErrHandle: action is STOP_WP, skip rollback
M ThTriggerExecShutDown: shutdown server
M ThCallHooks: call hooks for event BEFORE_SHUTDOWN
M PfStatIndInit: Initializing Index-Record
M PfWriteIntoFile: copied shared buf (13615 bytes) to local buf
M PfWriteIntoFile: write 13615 bytes into stat-file
M Fri May 12 13:58:53 2017
M PfWriteIntoFile: writing Index
M min. start :1494597458/697013
M min. end :1494597458/827411
M max. end :1494597524/174813
M wpid :16
M tasktypes :821950
M max. resp :22625361
M max. cpu :11610000
M max.db :0
M no. of recs :55
M no. of bytes :13615
M PfWriteIntoFile: updated fileindex for file stat with endtime 1494597524 (12.05.2017 13:58:44)
M PfWriteIntoFile: updated fileindex
M PfStatIndInit: Initializing Index-Record
M PfWriteIntoFile: wrote buffer to file
M ThIErrHandle: do not call ThrCoreInfo (no_core_info=0, in_dynp_env=0)
M
M ***
M *** work process W0 died => ThRqWaitFor: shutdown
M call ThrShutDown (1)...
B Disconnecting from ALL connections:
B Wp Hdl ConName ConId ConState TX BC OC HC PRM RCT INF TIM MAX OPT Date Time DBUser DBHost Program
B 000 000 R/3 000000000 INACTIVE NO NO 000 NO YES NO NO 000 255 255 20170512 135732 SAPSR3 svrqasdb
C Disconnecting con=0
C OCISessionEnd(con=0, svc=7fc46e07cf18, srv=7fc46e07f520='QE1'): Close session usr=7fc46e08e1c0, rc=0
C OCIServerDetach(stale(1) con=0, svc=7fc46e07cf18): Server srv=7fc46e07f520='QE1' detached
B Disconnected from connection 0
B statistics db_con_commit (com_total=2, com_tx=0)
B statistics db_con_rollback (roll_total=0, roll_tx=0)
M ***LOG Q02=> wp_halt, WPStop (Workp. 0 22780) [dpuxtool.c 318]

TRANS.LOG =

4 ETW000 R3trans version 6.24 (release 742 - 18.11.14 - 20:14:09).

4 ETW000 unicode enabled version

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

4 ETW000

4 ETW000 date&time: 13.05.2017 - 00:38:06

4 ETW000 control file: <no ctrlfile>

4 ETW000 R3trans was called as follows: R3trans -d

4 ETW000trace at level 2 opened for a given file pointer

4 ETW000[dev trc,00000]Sat May 13 00:38:06 20171230.000123

4 ETW000[dev trc,00000]db_con_init called270.000150

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

4 ETW000540.000204

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

4 ETW000280.000232

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

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

4 ETW000[dev trc,00000]DlLoadLib() success: dlopen("/usr/sap/QE1/SYS/exe/run/dboraslib.so"), hdl 0, count 1, addr 2d214d0

4 ETW000102530.010549

4 ETW000[dev trc,00000]Library '/usr/sap/QE1/SYS/exe/run/dboraslib.so' loaded280.010577

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

4 ETW000290.010606

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

4 ETW0001280.010734

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

4 ETW000270.010761

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

4 ETW000570.010818

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

4 ETW000290.010847

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

4 ETW000290.010876

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

4 ETW000270.010903

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

4 ETW000270.010930

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

4 ETW000440.010974

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

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

4 ETW000[dev trc,00000]New connection 0 created180.011046

4 ETW000[dev trc,00000]0: name = R/3, con_id = -000000001, state = DISCONNECTED, tx = NO , bc = NO , oc = 000, hc = NO , perm = YES, reco = NO , info = NO , timeout = 000, con_max = 255, con_opt = 255, occ = NO , prog =

4 ETW000560.011102

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

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

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

4 ETW000220.011171

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

4 ETW000[dev trc,00000]0: name = R/3, con_id = 000000000, state = DISCONNECTED, tx = NO , bc = NO , oc = 000, hc = NO , perm = YES, reco = NO , info = NO , timeout = 000, con_max = 255, con_opt = 255, occ = NO , prog =

4 ETW000320.011218

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

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 ETW000400.011279

4 ETW000[dev trc,00000]read_con_info_ssfs(): DBSL supports extended connect protocol230.011302

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

4 ETW000[dev trc,00000]read_con_info_ssfs(): profile parameter auth/shadow_upgrade is not set ==> connect info for shadow upgrade will not be read with an extra upgrade key set

4 ETW000310.011333

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

4 ETW000220.011355

4 ETW000[dev trc,00000]RSecSSFs: Entering function "RSecSSFsGetRecord" [/bas/742_REL/src/krn/rsec/rsecssfs.c 1437]

4 ETW0001230.011478

4 ETW000[dev trc,00000]RSecSSFs: Data file "/usr/sap/QE1/SYS/global/security/rsecssfs/data/SSFS_QE1.DAT" opened for read [/bas/742_REL/src/krn/rsec/rsecssfs.c 4919]

4 ETW000226580.034136

4 ETW000[dev trc,00000]RSecSSFs: Key file is type 2 with obfuscation (no LPS) [/bas/742_REL/src/krn/rsec/rsecssfs.c 3094]

4 ETW000950.034231

4 ETW000[dev trc,00000]RSecSSFs: Exiting function "RSecSSFsGetRecord" with return code 0 (message: <No message available>) [/bas/742_REL/src/krn/rsec/rsecssfs.c 1526]

4 ETW0005040.034735

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

4 ETW000300.034765

4 ETW000[dev trc,00000]read_con_info_ssfs(): deregister callback ssfs_dbi_trace180.034783

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

4 ETW000220.034805

4 ETW000[dev trc,00000]RSecSSFs: Entering function "RSecSSFsGetRecord" [/bas/742_REL/src/krn/rsec/rsecssfs.c 1437]

4 ETW000440.034849

4 ETW000[dev trc,00000]RSecSSFs: Data file "/usr/sap/QE1/SYS/global/security/rsecssfs/data/SSFS_QE1.DAT" opened for read [/bas/742_REL/src/krn/rsec/rsecssfs.c 4919]

4 ETW000860.034935

4 ETW000[dev trc,00000]RSecSSFs: Key file is type 2 with obfuscation (no LPS) [/bas/742_REL/src/krn/rsec/rsecssfs.c 3094]

4 ETW000590.034994

4 ETW000[dev trc,00000]RSecSSFs: Exiting function "RSecSSFsGetRecord" with return code 0 (message: <No message available>) [/bas/742_REL/src/krn/rsec/rsecssfs.c 1526]

4 ETW0003010.035295

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

4 ETW000240.035319

4 ETW000[dev trc,00000]read_con_info_ssfs(): deregister callback ssfs_dbi_trace170.035336

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

4 ETW000210.035357

4 ETW000[dev trc,00000]RSecSSFs: Entering function "RSecSSFsGetRecord" [/bas/742_REL/src/krn/rsec/rsecssfs.c 1437]

4 ETW000840.035441

4 ETW000[dev trc,00000]RSecSSFs: Data file "/usr/sap/QE1/SYS/global/security/rsecssfs/data/SSFS_QE1.DAT" opened for read [/bas/742_REL/src/krn/rsec/rsecssfs.c 4919]

4 ETW000720.035513

4 ETW000[dev trc,00000]RSecSSFs: Key file is type 2 with obfuscation (no LPS) [/bas/742_REL/src/krn/rsec/rsecssfs.c 3094]

4 ETW000580.035571

4 ETW000[dev trc,00000]RSecSSFs: SSFS-4215: Data file "/usr/sap/QE1/SYS/global/security/rsecssfs/data/SSFS_QE1.DAT" exists, but does not contain the requested entry [/bas/742_REL/src/krn/rsec/rsecssfs.c 4949]

4 ETW0001530.035724

4 ETW000 [dev trc,00000]RSecSSFs: SSFS-4218: Record with key "DB_CONNECT/DEFAULT_DB_CON_ENV" not found in secure storage [/bas/742_REL/src/krn/rsec/rsecssfs.c 4959]

4 ETW000380.035762

4 ETW000[dev trc,00000]RSecSSFs: Exiting function "RSecSSFsGetRecord" with return code 1 (message: SSFS-4218: Record with key "DB_CONNECT/DEFAULT_DB_CON_ENV" not found in secure storage <-- SSFS-4215: Data file "/usr/sap/QE1/SYS/global/security/rsecssfs/data/SSFS_QE1.DAT" exists, but does not contain the requested entry) [/bas/742_REL/src/krn/rsec/rsecssfs.c 1526]

4 ETW00052 0.035814

4 ETW000[dev trc,00000]read_ssfs_record(): not found is accepted, RSecSSFsGetRecord(DB_CONNECT/DEFAULT_DB_CON_ENV)=1 : SSFS-4218: Record with key "DB_CONNECT/DEFAULT_DB_CON_ENV" not found in secure storage <-- SSFS-4215: Data file "/usr/sap/QE1/SYS/global/security/rsecssfs/data/SSFS_QE1.DAT" exists, but does not contain the requested entry

4 ETW000290.035843

4 ETW000[dev trc,00000]read_con_info_ssfs(): deregister callback ssfs_dbi_trace170.035860

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

4 ETW0001160.035976

4 ETW000[dev trc,00000]Substitution of aliases T_nn (n=0...9) in SQL hints enabled.570.036033

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

4 ETW000[dev trc,00000]Oracle client version: 11.2.0.3.0, V2, default build, (dbsl 742 231014, UNICODE[2])

4 ETW0001020.036637

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

4 ETW000[dev trc,00000]# Patch14489591: Created on 19 Jan 2013, 20:08:26 hrs PST8PDT

4 ETW000320.036710

4 ETW000[dev trc,00000]# Patch14042380: Created on 23 Dec 2013, 22:24:52 hrs PST8PDT

4 ETW000370.036747

4 ETW000[dev trc,00000]# Patch description: Created on7 Jan 2014, 02:20:21 hrs PST8PDT400.036787

4 ETW000[dev trc,00000]# Patch13508485: Created on 21 Dec 2011, 13:23:38 hrs PST8PDT

4 ETW0003510.037138

4 ETW000[dev trc,00000]# Patch11742262: Created on7 Mar 2012, 12:22:41 hrs CET290.037167

4 ETW000[dev trc,00000]Default connection: tnsname ='QE1'250.037192

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

4 ETW000380.037230

4 ETW000[dev trc,00000](-) OCIEnvCreate(mode=16384=OCI_UTF16) -> rc=0, env=2df7120 (for default NLS hdl)

4 ETW00086770.045907

4 ETW000[dev trc,00000]OCIHandleAlloc(OCI_HTYPE_ERROR, con=0, env=2df7120) -> err=2e02008, er2=2e03088, bat=2e04108

4 ETW000930.046000

4 ETW000[dev trc,00000]NLS env. settings: lang=41004D00450052004900430041004E001270.046127

4 ETW000[dev trc,00000]terr=41004D0045005200490043004100380.046165

4 ETW000[dev trc,00000]char=55005400460031003600300.046195

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

4 ETW000320.046227

4 ETW000[dev trc,00000]charset='UTF16', ncharset='AL16UTF16', UNI_ASC=FALSE220.046249

4 ETW000[dev trc,00000]Connecting as SAPSR3/<pwd>@QE1 on connection 0 (nls 0) ... (dbsl 742 231014, UNICODE[2])

4 ETW000490.046298

4 ETW000[ dev trc,00000]OCIHandleAlloc(con=0): New service handle svc=2e04028, rc=0480.046346

4 ETW000[dev trc,00000]OCIHandleAlloc(con=0,svc=2e04028): New server hdl. srv=2e070d0, rc=0

4 ETW0001380.046484

4 ETW000[dev trc,00000]OCIServerAttach(con=0, svc=2e04028) srv=2e070d0 attached to 'QE1'249790.071463

4 ETW000[dev trc,00000]OCIAttrSet(con=0, 'QE1'): Assign srv=2e070d0 to service svc=2e04028410.071504

4 ETW000[dev trc,00000]OCIHandleAlloc(con=0): New session handle usr=2e3dc10, rc=0)2500.071754

4 ETW000[dev trc,00000]OCIAttrSet(con=0): Assign user 'SAPSR3' to session handle usr=2e3dc10

4 ETW000560.071810

4 ETW000[dev trc,00000]OCIAttrSet(con=0): Assign password to session handle usr=2e3dc10410.071851

4 ETW000[dev trc,00000]OCISessionBegin(con=0, svc=2e04028, srv=2e070d0='QE1'): start session of usr=2e3dc10='SAPSR3', rc=0

4 ETW000109050.082756

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

4 ETW000430.082799

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected920.082891

4 ETW000[dev trc,00000]-->oci_prepare_stmt(con=0,len=39,stp=2e18758)320.082923

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

4 ETW000400.082963

4 ETW000[dev trc,00000]-oci_define( 0: SQLT_INT , l=4, con=0, stp=2e18758, pv=7fff89772998, in=7fff8977299e,rl=0000NULL,rc=0000NULL)

4 ETW0001310.083094

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction830.083177

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

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]270.083234

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

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

4 ETW000[dev trc,00000]Now 'SAPSR3/<pwd>@QE1' is connected: con=0, nls=0, session=12, time='2017-05-13 00:38:06'

4 ETW000930.084539

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected580.084597

4 ETW000[dev trc,00000]-->oci_prepare_stmt(con=0,len=33,stp=2e18758)270.084624

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

4 ETW000290.084653

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction690.084722

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

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]260.084778

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

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

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected810.085682

4 ETW000[dev trc,00000]-->oci_prepare_stmt(con=0,len=110,stp=2e18758)380.085720

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 ETW000280.085748

4 ETW000[dev trc,00000]-oci_define( 0: SQLT_STR , l= 66, con=0, stp=2e18758, pv=7f7590dda9aa, in=7fff8977299e,rl=0000NULL,rc=0000NULL)

4 ETW000910.085839

4 ETW000[dev trc,00000]-oci_define( 1: SQLT_STR , l=130, con=0, stp=2e18758, pv=7f7590ddabf2, in=7fff8977299e,rl=0000NULL,rc=0000NULL)

4 ETW000450.085884

4 ETW000[dev trc,00000]-oci_define( 2: SQLT_STR , l= 66, con=0, stp=2e18758, pv=7f7590dda968, in=7fff8977299e,rl=0000NULL,rc=0000NULL)

4 ETW000450.085929

4 ETW000[dev trc,00000]-oci_define( 3: SQLT_STR , l= 62, con=0, stp=2e18758, pv=7fff89772960, in=7fff8977299e,rl=0000NULL,rc=0000NULL)

4 ETW000390.085968

4 ETW000 [dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction460.086014

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

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]270.086075

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

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

4 ETW000[dev trc,00000]DB instance QE1 is running on svrqasdb with ORACLE version 11.2.0.3.0 since MAY 12, 2017, 13:15:56.

4 ETW000440.087025

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected600.087085

4 ETW000[dev trc,00000]-->oci_prepare_stmt(con=0,len=74,stp=2e18758)270.087112

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

4 ETW000280.087140

4 ETW000[dev trc,00000]-oci_define( 0: SQLT_CHR , l=6, con=0, stp=2e18758, pv=7fff897727a0, in=7fff8977299e,rl=0000NULL,rc=0000NULL)

4 ETW000880.087228

4 ETW000[dev trc,00000]-oci_define( 1: SQLT_STR , l= 30, con=0, stp=2e18758, pv=7fff89772980, in=7fff8977299e,rl=0000NULL,rc=0000NULL)

4 ETW000450.087273

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction480.087321

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

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]600.087409

4 ETW000[dev trc,00000]OCIStmtExecute(rpc=0): [dur. 0,005s]45470.091956

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

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected930.092087

4 ETW000[dev trc,00000]-->oci_prepare_stmt(con=0,len=172,stp=2e18758)290.092116

4 ETW000[dev trc,00000]SELECT VALUE FROM V$NLS_PARAMETERS WHERE PARAMETER IN ('NLS_LANGUAGE','NLS_TERRITORY','NLS_CHARACTERSET','NLS_NCHAR_CHARAC

4 ETW000290.092145

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

4 ETW000400.092185

4 ETW000[dev trc,00000]-oci_define( 0: SQLT_STR , l=202, con=0, stp=2e18758, pv=7fff89772ab0, in=7fff897739b0,rl=0000NULL,rc=0000NULL)

4 ETW000770.092262

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction500.092312

4 ETW000[dev trc,00000]-->oci_execute_stmt(#5: con=0,stp=2e18758,itr=5,off=0,bat=0)280.092340

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]560.092396

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

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

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

4 ETW000450.093306

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

4 ETW000[dev trc,00000]Nls CharacterSetNationalCharSetenverrbat

4 ETW000720.093410

4 ETW000[dev trc,00000]0 UTF16AL16UTF162df71202e020082e04108

4 ETW000370.093447

4 ETW000[dev trc,00000]SELECT STATUS,OBJECT_TYPE FROM USER_OBJECTS WHERE OBJECT_NAME='IOV'270.093474

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected630.093537

4 ETW000[dev trc,00000]-->oci_prepare_stmt(con=0,len=67,stp=2e18758)390.093576

4 ETW000[dev trc,00000]SELECT STATUS,OBJECT_TYPE FROM USER_OBJECTS WHERE OBJECT_NAME='IOV'

4 ETW000290.093605

4 ETW000[dev trc,00000]-oci_define( 0: SQLT_STR , l= 20, con=0, stp=2e18758, pv=7fff89772970, in=7fff8977299e,rl=0000NULL,rc=0000NULL)

4 ETW000700.093675

4 ETW000[dev trc,00000]-oci_define( 1: SQLT_STR , l= 44, con=0, stp=2e18758, pv=7fff89772910, in=7fff8977299c,rl=0000NULL,rc=0000NULL)

4 ETW000430.093718

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction470.093765

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

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]260.093818

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

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

4 ETW000[dev trc,00000]SELECT SUBSTR(TEXT,140,10) FROM USER_SOURCE WHERE NAME='IOV'340.094831

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected540.094885

4 ETW000[dev trc,00000]-->oci_prepare_stmt(con=0,len=60,stp=2e18758)430.094928

4 ETW000[dev trc,00000]SELECT SUBSTR(TEXT,140,10) FROM USER_SOURCE WHERE NAME='IOV'

4 ETW000280.094956

4 ETW000[dev trc,00000]-oci_define( 0: SQLT_STR , l= 42, con=0, stp=2e18758, pv=7fff89772940, in=7fff8977299e,rl=0000NULL,rc=0000NULL)

4 ETW000680.095024

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction490.095073

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

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]250.095125

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

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

4 ETW000[dev trc,00000]FUNCTION IOV exists and is VALID (orc=0).330.095973

4 ETW000[dev trc,00000]SELECT STATUS,OBJECT_TYPE FROM USER_OBJECTS WHERE OBJECT_NAME='RTRIM2'

4 ETW000280.096001

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected530.096054

4 ETW000[dev trc,00000]-->oci_prepare_stmt(con=0,len=70,stp=2e18758)250.096079

4 ETW000[dev trc,00000]SELECT STATUS,OBJECT_TYPE FROM USER_OBJECTS WHERE OBJECT_NAME='RTRIM2'

4 ETW000270.096106

4 ETW000[dev trc,00000]-oci_define( 0: SQLT_STR , l= 20, con=0, stp=2e18758, pv=7fff897739b0, in=7fff897739de,rl=0000NULL,rc=0000NULL)

4 ETW000650.096171

4 ETW000[dev trc,00000]-oci_define( 1: SQLT_STR , l= 44, con=0, stp=2e18758, pv=7fff897738d0, in=7fff897739d0,rl=0000NULL,rc=0000NULL)

4 ETW000420.096213

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction460.096259

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

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]250.096311

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

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

4 ETW000[dev trc,00000]FUNCTION RTRIM2 exists and is VALID (orc=0).340.097308

4 ETW000[dev trc,00000]SELECT STATUS,OBJECT_TYPE FROM USER_OBJECTS WHERE OBJECT_NAME='CONCAT3'

4 ETW000340.097342

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected870.097429

4 ETW000[dev trc,00000]-->oci_prepare_stmt(con=0,len=71,stp=2e18758)300.097459

4 ETW000[dev trc,00000]SELECT STATUS,OBJECT_TYPE FROM USER_OBJECTS WHERE OBJECT_NAME='CONCAT3'

4 ETW000270.097486

4 ETW000[dev trc,00000]-oci_define( 0: SQLT_STR , l= 20, con=0, stp=2e18758, pv=7fff89772970, in=7fff8977299e,rl=0000NULL,rc=0000NULL)

4 ETW000820.097568

4 ETW000[dev trc,00000]-oci_define( 1: SQLT_STR , l= 44, con=0, stp=2e18758, pv=7fff89772940, in=7fff8977299c,rl=0000NULL,rc=0000NULL)

4 ETW000420.097610

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction470.097657

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

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]250.097709

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

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

4 ETW000[dev trc,00000]FUNCTION CONCAT3 exists and is VALID (orc=0).330.098496

4 ETW000[dev trc,00000]DbSlConnect(con=0) -> orc=0, rc=0=DBSL_ERR_OK240.098520

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

4 ETW000[dev trc,00000]-->DbSlControl(con=0,cmd=86=DBSL_CMD_SCHEMA_GET) -> SCHEMA='SAPSR3'290.098572

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

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

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

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

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

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

4 ETW000290.098743

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

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

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

4 ETW000[dev trc,00000]-->DbSlPrepare(DBSL_SELECT, con=0, ssp=7fff89773e60, dap=7fff89773dc0), tok=7fff89773e80, stid=0000NULL

4 ETW000510.098858

4 ETW000[dev trc,00000]build_stmt() -> OK500.098908

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 ETW0001270.099035

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected410.099076

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

4 ETW000330.099109

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

4 ETW000290.099138

4 ETW000[dev trc,00000]stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK560.099194

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

4 ETW000400.099234

4 ETW000[dev trc,00000]-->DbSlRead(con=0, ssp=7fff89773e60, dap=7fff89773dc0), sch=2d51ee0, stid=0000NULL, tok=7fff89773e80, prepared=1

4 ETW000450.099279

4 ETW000[dev trc,00000]-->DbSlRead(con=0, ssp=7fff89773e60, dap=7fff89773dc0), sch=2d51ee0, scp=2d5b370, tab='SVERS'

4 ETW000320.099311

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

4 ETW000330.099344

4 ETW000[dev trc,00000]7fff89773e60->id_p=(nil)560.099400

4 ETW000[dev trc,00000]Out00: DBSL_DATA_SHORT_CHAR(len=144, max=144, dec=0)350.099435

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

4 ETW000[dev trc,00000]bind_type_and_length(): 1 output variables260.099490

4 ETW000[dev trc,00000]0: DBSL_DATA_SHORT_CHAR, len=144, max=144, dec=0230.099513

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

4 ETW000600.099573

4 ETW000[dev trc,00000]-oci_define( 0: SQLT_CHR , l=144, con=0, stp=2e18758, pv=2e6d914, in=2e6d220,rl=0000NULL,rc=0000NULL)

4 ETW000370.099610

4 ETW000[dev trc,00000]-->exec_fetch(con=0, bulk=0, sch=2d51ee0, dap=7fff89773dc0, DBSL_DIR_READ)

4 ETW000500.099660

4 ETW000[dev trc,00000]-->stmt_fetch(con=0, sch=2d51ee0, odp=2d5b400, DBSL_DIR_READ)230.099683

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

4 ETW000460.099729

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction440.099773

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

4 ETW000360.099809

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]260.099835

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

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

4 ETW000450.100602

4 ETW000[dev trc,00000]stmt_fetch() -> orc=0, 0=DBSL_ERR_OK230.100625

4 ETW000[dev trc,00000]DbSlRead() --> 0=DBSL_ERR_OK360.100661

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

4 ETW000[dev trc,00000]DbSlControl(DBSL_CMD_SAPRELEASE_SET,abap='740')200.100705

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

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

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

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

4 ETW000[dev trc,00000]-> 'OCI_112, 11.2.0.3.0, V2, default build'230.100849

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

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

4 ETW000460.101028

4 ETW000[dev trc,00000]-->DbSlPrepare(DBSL_SELECT, con=0, ssp=7fff89769d80, dap=7fff89769c70), tok=7fff89769da0, stid=0000NULL

4 ETW000350.101063

4 ETW000[dev trc,00000]build_stmt() -> OK310.101094

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 ETW0001090.101203

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected400.101243

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

4 ETW000330.101276

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

4 ETW000280.101304

4 ETW000[dev trc,00000]stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK860.101390

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

4 ETW000450.101435

4 ETW000[dev trc,00000]db_con_test_and_open: 1 open cursors (delta=1)180.101453

4 ETW000[dev trc,00000]db_con_check_dirty: 1 open cursors, tx = NO , bc = NO230.101476

4 ETW000[dev trc,00000]db_con_check_dirty: db_con_dirty = YES160.101492

4 ETW000[dev trc,00000]-->DbSlBegRead(con=0, ssp=7fff89769d80, dap=7fff89769c70), sch=2d51f78, stid=0000NULL, tok=7fff89769da0, prepared=1

4 ETW000460.101538

4 ETW000[dev trc,00000]-->DbSlBegRead(#0: con=0, ssp=7fff89769d80, dap=7fff89769c70), In=0, Out=2, sch=2d51f78, scp=2d5b490, tab='DDNTT'

4 ETW000500.101588

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

4 ETW000320.101620

4 ETW000[dev trc,00000]7fff89769d80->id_p=(nil)230.101643

4 ETW000[dev trc,00000]Out00: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)250.101668

4 ETW000[dev trc,00000]Out01: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)220.101690

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

4 ETW000[dev trc,00000]bind_type_and_length(): 2 output variables200.101744

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

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

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

4 ETW000370.101826

4 ETW000[dev trc,00000]-oci_define( 0: SQLT_INT , l=4, con=0, stp=2e16680, pv=2e6d220, in=2e824a8,rl=0000NULL,rc=0000NULL)

4 ETW000360.101862

4 ETW000[dev trc,00000]-oci_define( 1: SQLT_INT , l=4, con=0, stp=2e16680, pv=2e77b64, in=2e8794a,rl=0000NULL,rc=0000NULL)

4 ETW000440.101906

4 ETW000[dev trc,00000]DbSlBegRead(#0) -> 0=DBSL_ERR_OK250.101931

4 ETW000[dev trc,00000]-->DbSlExeRead(con=0, ssp=7fff89769d80, dap=7fff89769c70280.101959

4 ETW000[dev trc,00000]-->DbSlExeRead(#1: con=0, ssp=7fff89769d80, dap=7fff89769c70)250.101984

4 ETW000[dev trc,00000]-->exec_fetch(con=0, bulk=0, sch=2d51f78, dap=7fff89769c70, DBSL_SEQ_READ)

4 ETW000290.102013

4 ETW000[dev trc,00000]-->stmt_fetch(con=0, sch=2d51f78, odp=2d5b520, DBSL_SEQ_READ)220.102035

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

4 ETW000450.102080

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction420.102122

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

4 ETW000350.102157

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]260.102183

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

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

4 ETW000440.102995

4 ETW000[dev trc,00000]stmt_fetch() -> orc=0, 0=DBSL_ERR_OK220.103017

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

4 ETW000[dev trc,00000]db_con_test_and_open: 0 open cursors (delta=-1)190.103061

4 ETW000[dev trc,00000]db_con_check_dirty: db_con_dirty = NO 150.103076

4 ETW000[dev trc,00000]-->DbSlEndRead(#1: con=0, ssp=7fff89769d80, dap=7fff89769c70, sch=2d51f78) -> 0=DBSL_ERR_OK

4 ETW000380.103114

4 ETW000[dev trc,00000]NTAB: Structure of NTAB on DB is VERS_B, unicodelg of executable is 2, unicodelg of SVERS in nametab is 2

4 ETW000310.103145

4 ETW000[dev trc,00000]NTAB: standalone processing500.103195

4 ETW000[dev trc,00000]NTAB: ntprofile(), read profile360.103231

4 ETW000[dev trc,00000]NTAB: rsdb/ntab/entrycount 1000.170.103248

4 ETW000[dev trc,00000]NTAB: rsdb/ntab/ftabsize 500.150.103263

4 ETW000[dev trc,00000]NTAB: rsdb/ntab/irbdsize 100.230.103286

4 ETW000[dev trc,00000]NTAB: rsdb/ntab/sntabsize 100.150.103301

4 ETW000[dev trc,00000]NTAB: compute_hash_card: 2003.180.103319

4 ETW000[dev trc,00000]NTAB: maxcnt 1000.200.103339

4 ETW000[dev trc,00000]NTAB: hfactor 2003.150.103354

4 ETW000[dev trc,00000]NTAB: mem_protocol_size 104460.103400

4 ETW000[dev trc,00000]NTAB: hdr_backpack_offset 0180.103418

4 ETW000[dev trc,00000]NTAB: hdr_backpack_size 0150.103433

4 ETW000[dev trc,00000]NTAB: FTAB: header_size 88.160.103449

4 ETW000[dev trc,00000]NTAB: FTAB: item_size 64.150.103464

4 ETW000[dev trc,00000]NTAB: FTAB: item_cnt 1000.150.103479

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

4 ETW000[dev trc,00000]NTAB: FTAB: unit_cnt 128000.150.103509

4 ETW000[dev trc,00000]NTAB: FTAB: data_size 512000.160.103525

4 ETW000[dev trc,00000]NTAB: IREC: header_size 88.150.103540

4 ETW000[dev trc,00000]NTAB: IREC: item_size 64.150.103555

4 ETW000[dev trc,00000]NTAB: IREC: item_cnt 250.150.103570

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

4 ETW000[dev trc,00000]NTAB: IREC: unit_cnt 12800.150.103599

4 ETW000[dev trc,00000]NTAB: IREC: data_size 102400.150.103614

4 ETW000[dev trc,00000]NTAB: STAB: header_size 88.150.103629

4 ETW000[dev trc,00000]NTAB: STAB: item_size 64.140.103643

4 ETW000[dev trc,00000]NTAB: STAB: item_cnt 250.150.103658

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

4 ETW000[dev trc,00000]NTAB: STAB: unit_cnt 25600.150.103687

4 ETW000[dev trc,00000]NTAB: STAB: data_size 102400.150.103702

4 ETW000[dev trc,00000]NTAB: TTAB: header_size 192.150.103717

4 ETW000[dev trc,00000]NTAB: TTAB: item_size 40.140.103731

4 ETW000[dev trc,00000]NTAB: TTAB: item_cnt 1000.150.103746

4 ETW000[dev trc,00000]NTAB: TTAB: unit_size 256150.103761

4 ETW000[dev trc,00000]NTAB: TTAB: unit_cnt 1000.140.103775

4 ETW000[dev trc,00000]NTAB: TTAB: data_size 256000.250.103800

4 ETW000[dev trc,00000]NTAB: FTAB: hh_p 2e12af0, hh_len 883210.104121

4 ETW000[dev trc,00000]NTAB: FTAB: aa_p 2e8d840, aa_len 16024190.104140

4 ETW000[dev trc,00000]NTAB: FTAB: ia_p 2e916e0, ia_len 64000170.104157

4 ETW000[dev trc,00000]NTAB: FTAB: dat_p 7f758854d010, dat_len 512000170.104174

4 ETW000[dev trc,00000]NTAB: IREC: hh_p 2e12b50, hh_len 88160.104190

4 ETW000[dev trc,00000]NTAB: IREC: aa_p 2ea10f0, aa_len 16024150.104205

4 ETW000[dev trc,00000]NTAB: IREC: ia_p 2ea4f90, ia_len 16000160.104221

4 ETW000[dev trc,00000]NTAB: IREC: dat_p 2ea8e20, dat_len 102400160.104237

4 ETW000[dev trc,00000]NTAB: STAB: hh_p 2e12bb0, hh_len 88220.104259

4 ETW000[dev trc,00000]NTAB: STAB: aa_p 2ec1e30, aa_len 16024160.104275

4 ETW000[dev trc,00000]NTAB: STAB: ia_p 2ec5cd0, ia_len 16000160.104291

4 ETW000[dev trc,00000]NTAB: STAB: dat_p 2ec9b60, dat_len 102400160.104307

4 ETW000[dev trc,00000]NTAB: TTAB: hh_p 2e10720, hh_len 192160.104323

4 ETW000 [dev trc,00000]NTAB: TTAB: aa_p 2ee2b70, aa_len 16024160.104339

4 ETW000[dev trc,00000]NTAB: TTAB: ia_p 2ee6a10, ia_len 40000150.104354

4 ETW000[dev trc,00000]NTAB: TTAB: dat_p 7f758850e010, dat_len 256000430.104397

4 ETW000[dev trc,00000]NTAB: ntab_mem_protocol 2e10720, ntab_mp_p 2e10720, ntab_proc_id 0230.104420

4 ETW000[dev trc,00000]NTAB: FTAB: hh_p 2e12af0, ha_list 2e8d840, hi_list 2e916e0, buffer 7f758854d010

4 ETW000740.104494

4 ETW000[dev trc,00000]NTAB: IREC: hh_p 2e12b50, ha_list 2ea10f0, hi_list 2ea4f90, buffer 2ea8e20

4 ETW000250.104519

4 ETW000[dev trc,00000]NTAB: STAB: hh_p 2e12bb0, ha_list 2ec1e30, hi_list 2ec5cd0, buffer 2ec9b60

4 ETW000230.104542

4 ETW000[dev trc,00000]NTAB: TTAB: hh_p 2e10788, ha_list 2ee2b70, hi_list 2ee6a10, buffer 7f758850e010

4 ETW000230.104565

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

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

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

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

4 ETW000[dev trc,00000]db_con_test_and_open: 1 open cursors (delta=1)430.104734

4 ETW000[dev trc,00000]db_con_check_dirty: 1 open cursors, tx = NO , bc = NO410.104775

4 ETW000[dev trc,00000]db_con_check_dirty: db_con_dirty = YES150.104790

4 ETW000[dev trc,00000]CHECK_STMTID(17bc7e0): no cache (0,sch=(nil))270.104817

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

4 ETW000390.104856

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

4 ETW000[dev trc,00000]17bc7a0->id_p=17bc7e0: STID='10.DDNTF.1045.20141121204845'

4 ETW000340.104909

4 ETW000[dev trc,00000]DbSlBegRead(#0) -> 13=DBSL_ERR_STMTID210.104930

4 ETW000[dev trc,00000]db_con_add_open_cursors called for:160.104946

4 ETW000[dev trc,00000]0: name = R/3, con_id = 000000000, state = ACTIVE, tx = NO , bc = NO , oc = 000, hc = NO , perm = YES, reco = NO , info = NO , timeout = 000, con_max = 255, con_opt = 255, occ = NO , prog =

4 ETW000330.104979

4 ETW000[dev trc,00000]db_con_add_open_cursors: 0 open cursors (delta=-1)170.104996

4 ETW000[dev trc,00000]-->DbSlPrepare(DBSL_SELECT, con=0, ssp=17bc7a0, dap=17bca20), tok=17bc8e0, stid=17bc7e0

4 ETW000330.105029

4 ETW000[dev trc,00000]build_stmt() -> OK360.105065

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 ETW0001110.105176

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected410.105217

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

4 ETW000410.105258

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

4 ETW000280.105286

4 ETW000[dev trc,00000]stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK680.105354

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

4 ETW000750.105429

4 ETW000[dev trc,00000]db_con_test_and_open: 1 open cursors (delta=1)190.105448

4 ETW000[dev trc,00000]db_con_check_dirty: 1 open cursors, tx = NO , bc = NO170.105465

4 ETW000[dev trc,00000]db_con_check_dirty: db_con_dirty = YES140.105479

4 ETW000[dev trc,00000]-->DbSlBegRead(con=0, ssp=17bc7a0, dap=17bca20), sch=2d52010, stid=17bc7e0, tok=17bc8e0, prepared=1

4 ETW000370.105516

4 ETW000[dev trc,00000]-->DbSlBegRead(#0: con=0, ssp=17bc7a0, dap=17bca20), In=1, Out=4, sch=2d52010, scp=2d5b5b0, tab='DDNTF'

4 ETW000500.105566

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

4 ETW000320.105598

4 ETW000[dev trc,00000]17bc7a0->id_p=17bc7e0: STID='10.DDNTF.1045.20141121204845'

4 ETW000430.105641

4 ETW000[dev trc,00000]In00: DBSL_DATA_SHORT_CHAR(len=60, max=60, dec=0)250.105666

4 ETW000[dev trc,00000]Out00: DBSL_DATA_SHORT_CHAR(len=60, max=60, dec=0)220.105688

4 ETW000[dev trc,00000]Out01: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)230.105711

4 ETW000[dev trc,00000]Out02: DBSL_DATA_INTEGER_4(len=4, max=4, dec=0)220.105733

4 ETW000[dev trc,00000]Out03: DBSL_DATA_LONG_RAW(len=32768, max=32768, dec=0)220.105755

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

4 ETW000[dev trc,00000]0: DBSL_DATA_SHORT_CHAR, len=60, max=60, dec=0230.105800

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

4 ETW000370.105837

4 ETW000[dev trc,00000]-oci_bind( 0: SQLT_AFC , l= 60, con=0, stp=2e145d0, pv=2e6f1dc, in=2e6d220,rl=2e6e1fe,rc=0000NULL)

4 ETW000420.105879

4 ETW000[dev trc,00000]bind_type_and_length(): 4 output variables810.105960

4 ETW000[dev trc,00000]0: DBSL_DATA_SHORT_CHAR, len=60, max=60, dec=0280.105988

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

4 ETW000[dev trc,00000]2: DBSL_DATA_INTEGER_4, len=4, max=4, dec=0210.106031

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

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

4 ETW000490.106102

4 ETW000[dev trc,00000]-oci_define( 0: SQLT_CHR , l= 60, con=0, stp=2e145d0, pv=2f0d1d6, in=2f0d1b8,rl=0000NULL,rc=0000NULL)

4 ETW000360.106138

4 ETW000[dev trc,00000]-oci_define( 1: SQLT_INT , l=4, con=0, stp=2e145d0, pv=2f0d1a0, in=2f0d1be,rl=0000NULL,rc=0000NULL)

4 ETW000440.106182

4 ETW000[dev trc,00000]-oci_define( 2: SQLT_INT , l=4, con=0, stp=2e145d0, pv=2f0d1ac, in=2f0d1c4,rl=0000NULL,rc=0000NULL)

4 ETW000450.106227

4 ETW000[dev trc,00000]-oci_define( 3: SQLT_LBI , l=32770, con=0, stp=2e145d0, pv=2f0d28a, in=2f0d1ca,rl=2f0d1d0,rc=0000NULL)

4 ETW000400.106267

4 ETW000[dev trc,00000]DbSlBegRead(#0) -> 0=DBSL_ERR_OK2150.106482

4 ETW000[dev trc,00000]-->DbSlExeRead(con=0, ssp=17bc7a0, dap=17bca20330.106515

4 ETW000[dev trc,00000]-->DbSlExeRead(#1: con=0, ssp=17bc7a0, dap=17bca20)240.106539

4 ETW000[dev trc,00000]-->exec_fetch(con=0, bulk=0, sch=2d52010, dap=17bca20, DBSL_SEQ_READ)

4 ETW000290.106568

4 ETW000[dev trc,00000]-->stmt_fetch(con=0, sch=2d52010, odp=2d5b640, DBSL_SEQ_READ)230.106591

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

4 ETW000570.106648

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction450.106693

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

4 ETW000360.106729

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]260.106755

4 ETW000[dev trc,00000]OCIStmtExecute() completed, rc=100=OCI_NO_DATA, no further data13930.108148

4 ETW000[dev trc,00000]-> rc=1403=OCI_ERR_NOT_FOUND41 0.108189

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

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

4 ETW000320.108250

4 ETW000[dev trc,00000]stmt_fetch() -> orc=1403, 0=DBSL_ERR_OK220.108272

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

4 ETW000[dev trc,00000]db_con_test_and_open: 0 open cursors (delta=-1)220.108357

4 ETW000[dev trc,00000]db_con_check_dirty: db_con_dirty = NO500.108407

4 ETW000[dev trc,00000]-->DbSlEndRead(#1: con=0, ssp=17bc7a0, dap=17bca20, sch=2d52010) -> 0=DBSL_ERR_OK

4 ETW000340.108441

4 ETW000[dev trc,00000]CHECK_STMTID(17baf40): no cache (0,sch=(nil))1010.108542

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

4 ETW000330.108575

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

4 ETW000[dev trc,00000]17baf00->id_p=17baf40: STID='10.DDNTT.11619.20141121204813'

4 ETW000330.108627

4 ETW000[dev trc,00000]DbSlRead() --> 13=DBSL_ERR_STMTID210.108648

4 ETW000[dev trc,00000]-->DbSlPrepare(DBSL_SELECT, con=0, ssp=17baf00, dap=17bb140), tok=17bb040, stid=17baf40

4 ETW000330.108681

4 ETW000[dev trc,00000]build_stmt() -> OK440.108725

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 ETW0001190.108844

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected410.108885

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

4 ETW000330.108918

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

4 ETW000300.108948

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

4 ETW000430.108991

4 ETW000[dev trc,00000]stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK870.109078

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

4 ETW000400.109118

4 ETW000[dev trc,00000]-->DbSlRead(con=0, ssp=17baf00, dap=17bb140), sch=2d520a8, stid=17baf40, tok=17bb040, prepared=1

4 ETW000450.109163

4 ETW000[dev trc,00000]-->DbSlRead(con=0, ssp=17baf00, dap=17bb140), sch=2d520a8, scp=2d5b6d0, tab='DDNTT'

4 ETW000310.109194

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

4 ETW000330.109227

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

4 ETW000270.109254

4 ETW000[dev trc,00000]17baf00->id_p=17baf40: STID='10.DDNTT.11619.20141121204813'

4 ETW000320.109286

4 ETW000[dev trc,00000]In00: DBSL_DATA_SHORT_CHAR(len=60, max=60, dec=0)240.109310

4 ETW000[dev trc,00000]Out00: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)220.109332

4 ETW000[dev trc,00000]Out01: DBSL_DATA_SHORT_RAW(len=16, max=16, dec=0)220.109354

4 ETW000[dev trc,00000]Out02: DBSL_DATA_SHORT_CHAR(len=28, max=28, dec=0)540.109408

4 ETW000[dev trc,00000]Out03: DBSL_DATA_SHORT_CHAR(len=28, max=28, dec=0)250.109433

4 ETW000[dev trc,00000]Out04: DBSL_DATA_SHORT_CHAR(len=28, max=28, dec=0)220.109455

4 ETW000[dev trc,00000]Out05: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)220.109477

4 ETW000[dev trc,00000]Out06: DBSL_DATA_INTEGER_4(len=4, max=4, dec=0)220.109499

4 ETW000[dev trc,00000]Out07: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)220.109521

4 ETW000[dev trc,00000]Out08: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)210.109542

4 ETW000[dev trc,00000]Out09: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)220.109564

4 ETW000[dev trc,00000]Out10: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)220.109586

4 ETW000[dev trc,00000]Out11: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)210.109607

4 ETW000[dev trc,00000]Out12: DBSL_DATA_SHORT_CHAR(len=60, max=60, dec=0)220.109629

4 ETW000[dev trc,00000]Out13: DBSL_DATA_SHORT_RAW(len=6, max=6, dec=0)210.109650

4 ETW000[dev trc,00000]Out14: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)210.109671

4 ETW000[dev trc,00000]Out15: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)220.109693

4 ETW000[dev trc,00000]Out16: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)210.109714

4 ETW000[dev trc,00000]Out17: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)220.109736

4 ETW000[dev trc,00000]Out18: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)320.109768

4 ETW000[dev trc,00000]Out19: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)230.109791

4 ETW000[dev trc,00000]Out20: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)210.109812

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

4 ETW000[dev trc,00000]0: DBSL_DATA_SHORT_CHAR, len=60, max=60, dec=0230.109856

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

4 ETW000360.109892

4 ETW000[dev trc,00000]-oci_bind( 0: SQLT_AFC , l= 60, con=0, stp=2f45a18, pv=2f0f15c, in=2f0d1a0,rl=2f0e17e,rc=0000NULL)

4 ETW000370.109929

4 ETW000[dev trc,00000]bind_type_and_length(): 21 output variables460.109975

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

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

4 ETW000[dev trc,00000]2: DBSL_DATA_SHORT_CHAR, len=28, max=28, dec=0220.110045

4 ETW000[dev trc,00000]3: DBSL_DATA_SHORT_CHAR, len=28, max=28, dec=0210.110066

4 ETW000[dev trc,00000]4: DBSL_DATA_SHORT_CHAR, len=28, max=28, dec=0210.110087

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

4 ETW000[dev trc,00000]6: DBSL_DATA_INTEGER_4, len=4, max=4, dec=0230.110137

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

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

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

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

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

4 ETW000[dev trc,00000]12: DBSL_DATA_SHORT_CHAR, len=60, max=60, dec=0210.110263

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

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

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

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

4 ETW000[dev trc,00000]17: DBSL_DATA_INTEGER_2, len=2, max=2, dec=046 0.110393

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

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

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

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

4 ETW000430.110507

4 ETW000[dev trc,00000]-oci_define( 0: SQLT_CHR , l=2, con=0, stp=2f45a18, pv=2e77f18, in=2e726b0,rl=0000NULL,rc=0000NULL)

4 ETW000450.110552

4 ETW000[dev trc,00000]-oci_define( 1: SQLT_LBI , l= 16, con=0, stp=2f45a18, pv=2e8a338, in=2e72a88,rl=2e77768,rc=0000NULL)

4 ETW000460.110598

4 ETW000[dev trc,00000]-oci_define( 2: SQLT_CHR , l= 28, con=0, stp=2f45a18, pv=2e782f0, in=2e72e60,rl=0000NULL,rc=0000NULL)

4 ETW000390.110637

4 ETW000[dev trc,00000]-oci_define( 3: SQLT_CHR , l= 28, con=0, stp=2f45a18, pv=2e7b8c0, in=2e73238,rl=0000NULL,rc=0000NULL)

4 ETW000390.110676

4 ETW000[dev trc,00000]-oci_define( 4: SQLT_CHR , l= 28, con=0, stp=2f45a18, pv=2e7ee90, in=2e73610,rl=0000NULL,rc=0000NULL)

4 ETW000370.110713

4 ETW000[dev trc,00000]-oci_define( 5: SQLT_INT , l=4, con=0, stp=2f45a18, pv=2e6d220, in=2e739e8,rl=0000NULL,rc=0000NULL)

4 ETW000350.110748

4 ETW000[dev trc,00000]-oci_define( 6: SQLT_INT , l=4, con=0, stp=2f45a18, pv=2e6d9d0, in=2e73dc0,rl=0000NULL,rc=0000NULL)

4 ETW000370.110785

4 ETW000[dev trc,00000]-oci_define( 7: SQLT_INT , l=4, con=0, stp=2f45a18, pv=2e6e180, in=2e74198,rl=0000NULL,rc=0000NULL)

4 ETW000350.110820

4 ETW000[dev trc,00000]-oci_define( 8: SQLT_INT , l=4, con=0, stp=2f45a18, pv=2e6e930, in=2e74570,rl=0000NULL,rc=0000NULL)

4 ETW000360.110856

4 ETW000[dev trc,00000]-oci_define( 9: SQLT_INT , l=4, con=0, stp=2f45a18, pv=2e6f0e0, in=2e74948,rl=0000NULL,rc=0000NULL)

4 ETW000360.110892

4 ETW000[dev trc,00000]-oci_define(10: SQLT_CHR , l=2, con=0, stp=2f45a18, pv=2e82460, in=2e74d20,rl=0000NULL,rc=0000NULL)

4 ETW000350.110927

4 ETW000[dev trc,00000]-oci_define(11: SQLT_CHR , l=2, con=0, stp=2f45a18, pv=2e82838, in=2e750f8,rl=0000NULL,rc=0000NULL)

4 ETW000360.110963

4 ETW000[dev trc,00000]-oci_define(12: SQLT_CHR , l= 60, con=0, stp=2f45a18, pv=2e82c10, in=2e754d0,rl=0000NULL,rc=0000NULL)

4 ETW000470.111010

4 ETW000[dev trc,00000]-oci_define(13: SQLT_LBI , l=6, con=0, stp=2f45a18, pv=2e8c1f8, in=2e758a8,rl=2e77b40,rc=0000NULL)

4 ETW000400.111050

4 ETW000[dev trc,00000]-oci_define(14: SQLT_CHR , l=2, con=0, stp=2f45a18, pv=2e89f60, in=2e75c80,rl=0000NULL,rc=0000NULL)

4 ETW000420.111092

4 ETW000[dev trc,00000]-oci_define(15: SQLT_INT , l=4, con=0, stp=2f45a18, pv=2e6f890, in=2e76058,rl=0000NULL,rc=0000NULL)

4 ETW000370.111129

4 ETW000[dev trc,00000]-oci_define(16: SQLT_INT , l=4, con=0, stp=2f45a18, pv=2e70040, in=2e76430,rl=0000NULL,rc=0000NULL)

4 ETW000440.111173

4 ETW000[dev trc,00000]-oci_define(17: SQLT_INT , l=4, con=0, stp=2f45a18, pv=2e707f0, in=2e76808,rl=0000NULL,rc=0000NULL)

4 ETW000370.111210

4 ETW000[dev trc,00000]-oci_define(18: SQLT_INT , l=4, con=0, stp=2f45a18, pv=2e70fa0, in=2e76be0,rl=0000NULL,rc=0000NULL)

4 ETW000360.111246

4 ETW000[dev trc,00000]-oci_define(19: SQLT_INT , l=4, con=0, stp=2f45a18, pv=2e71750, in=2e76fb8,rl=0000NULL,rc=0000NULL)

4 ETW000350.111281

4 ETW000[dev trc,00000]-oci_define(20: SQLT_INT , l=4, con=0, stp=2f45a18, pv=2e71f00, in=2e77390,rl=0000NULL,rc=0000NULL)

4 ETW000360.111317

4 ETW000[dev trc,00000]-->exec_fetch(con=0, bulk=0, sch=2d520a8, dap=17bb140, DBSL_DIR_READ)

4 ETW000820.111399

4 ETW000[dev trc,00000]-->stmt_fetch(con=0, sch=2d520a8, odp=2d5b760, DBSL_DIR_READ)260.111425

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

4 ETW000470.111472

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction450.111517

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

4 ETW000350.111552

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]260.111578

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

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

4 ETW000460.112664

4 ETW000[dev trc,00000]stmt_fetch() -> orc=0, 0=DBSL_ERR_OK230.112687

4 ETW000[dev trc,00000]DbSlRead() --> 0=DBSL_ERR_OK250.112712

4 ETW000[dev trc,00000]{ db_rtab( fcode = 'RT_READ_ONLY', tname = 'TADIR' ) {/bas/742_REL/src/cts/R3trans/twdbcall.c:869}

4 ETW000540.112766

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

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

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

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

4 ETW000[dev trc,00000]CHECK_STMTID(17cc990): no cache (0,sch=(nil))1150.113006

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

4 ETW000430.113049

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

4 ETW000[dev trc,00000]17cc920->id_p=17cc990: STID=' 3.TADIR.1073741825.20141020131655'

4 ETW000450.113113

4 ETW000[dev trc,00000]DbSlRead() --> 13=DBSL_ERR_STMTID210.113134

4 ETW000[dev trc,00000]-->DbSlPrepare(DBSL_SELECT, con=0, ssp=17cc920, dap=17cca10), tok=17cc940, stid=17cc990

4 ETW000490.113183

4 ETW000[dev trc,00000]build_stmt() -> OK430.113226

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 ETW0001130.113339

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected740.113413

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

4 ETW000390.113452

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

4 ETW000280.113480

4 ETW000[dev trc,00000]stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK710.113551

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

4 ETW000400.113591

4 ETW000[dev trc,00000]-->DbSlRead(con=0, ssp=17cc920, dap=17cca10), sch=2d52140, stid=17cc990, tok=17cc940, prepared=1

4 ETW000370.113628

4 ETW000[dev trc,00000]-->DbSlRead(con=0, ssp=17cc920, dap=17cca10), sch=2d52140, scp=2d5b7f0, tab='TADIR'

4 ETW000310.113659

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

4 ETW000300.113689

4 ETW000[dev trc,00000]17cc920->id_p=17cc990: STID=' 3.TADIR.1073741825.20141020131655'

4 ETW000330.113722

4 ETW000[dev trc,00000]In00: DBSL_DATA_SHORT_CHAR(len=8, max=8, dec=0)230.113745

4 ETW000[dev trc,00000]In01: DBSL_DATA_SHORT_CHAR(len=8, max=8, dec=0)230.113768

4 ETW000[dev trc,00000]In02: DBSL_DATA_SHORT_CHAR(len=80, max=80, dec=0)220.113790

4 ETW000[dev trc,00000]Out00: DBSL_DATA_SHORT_CHAR(len=8, max=8, dec=0)220.113812

4 ETW000[dev trc,00000]Out01: DBSL_DATA_SHORT_CHAR(len=8, max=8, dec=0)210.113833

4 ETW000[dev trc,00000]Out02: DBSL_DATA_SHORT_CHAR(len=80, max=80, dec=0)210.113854

4 ETW000[dev trc,00000]Out03: DBSL_DATA_SHORT_CHAR(len=20, max=20, dec=0)220.113876

4 ETW000[dev trc,00000]Out04: DBSL_DATA_SHORT_CHAR(len=20, max=20, dec=0)210.113897

4 ETW000[dev trc,00000]Out05: DBSL_DATA_SHORT_CHAR(len=24, max=24, dec=0)210.113918

4 ETW000[dev trc,00000]Out06: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)330.113951

4 ETW000[dev trc,00000]Out07: DBSL_DATA_SHORT_CHAR(len=60, max=60, dec=0)220.113973

4 ETW000[dev trc,00000]Out08: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)220.113995

4 ETW000[dev trc,00000]Out09: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)270.114022

4 ETW000[dev trc,00000]Out10: DBSL_DATA_SHORT_CHAR(len=16, max=16, dec=0)230.114045

4 ETW000[dev trc,00000] Out11: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)220.114067

4 ETW000[dev trc,00000]Out12: DBSL_DATA_SHORT_CHAR(len=40, max=40, dec=0)210.114088

4 ETW000[dev trc,00000]Out13: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)220.114110

4 ETW000[dev trc,00000]Out14: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)210.114131

4 ETW000[dev trc,00000]Out15: DBSL_DATA_SHORT_CHAR(len=60, max=60, dec=0)210.114152

4 ETW000[dev trc,00000]Out16: DBSL_DATA_SHORT_CHAR(len=20, max=20, dec=0)220.114174

4 ETW000[dev trc,00000]Out17: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)210.114195

4 ETW000[dev trc,00000]Out18: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)220.114217

4 ETW000[dev trc,00000]Out19: DBSL_DATA_NUMC(len=16, max=16, dec=0)220.114239

4 ETW000[dev trc,00000]Out20: DBSL_DATA_NUMC(len=16, max=16, dec=0)210.114260

4 ETW000[dev trc,00000]Out21: DBSL_DATA_SHORT_CHAR(len=60, max=60, dec=0)220.114282

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

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

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

4 ETW000[dev trc,00000]2: DBSL_DATA_SHORT_CHAR, len=80, max=80, dec=0480.114395

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

4 ETW000520.114447

4 ETW000[dev trc,00000]-oci_bind( 0: SQLT_AFC , l=8, con=0, stp=2f546c8, pv=2e70a84, in=2e6d220,rl=2e6ee52,rc=0000NULL)

4 ETW000360.114483

4 ETW000[dev trc,00000]-oci_bind( 1: SQLT_AFC , l=8, con=0, stp=2f546c8, pv=2e7301c, in=2e6db86,rl=2e6f7b8,rc=0000NULL)

4 ETW000530.114536

4 ETW000[dev trc,00000]-oci_bind( 2: SQLT_AFC , l= 80, con=0, stp=2f546c8, pv=2e755b4, in=2e6e4ec,rl=2e7011e,rc=0000NULL)

4 ETW000430.114579

4 ETW000[dev trc,00000]bind_type_and_length(): 22 output variables300.114609

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

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

4 ETW000[dev trc,00000]2: DBSL_DATA_SHORT_CHAR, len=80, max=80, dec=0210.114676

4 ETW000[dev trc,00000]3: DBSL_DATA_SHORT_CHAR, len=20, max=20, dec=0220.114698

4 ETW000[dev trc,00000]4: DBSL_DATA_SHORT_CHAR, len=20, max=20, dec=0210.114719

4 ETW000[dev trc,00000]5: DBSL_DATA_SHORT_CHAR, len=24, max=24, dec=0360.114755

4 ETW000[dev trc,00000]6: DBSL_DATA_SHORT_CHAR, len=2, max=2, dec=0210.114776

4 ETW000[dev trc,00000]7: DBSL_DATA_SHORT_CHAR, len=60, max=60, dec=0210.114797

4 ETW000[ dev trc,00000]8: DBSL_DATA_SHORT_CHAR, len=2, max=2, dec=0210.114818

4 ETW000[dev trc,00000]9: DBSL_DATA_SHORT_CHAR, len=2, max=2, dec=0210.114839

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

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

4 ETW000[dev trc,00000]12: DBSL_DATA_SHORT_CHAR, len=40, max=40, dec=0210.114902

4 ETW000[dev trc,00000]13: DBSL_DATA_SHORT_CHAR, len=2, max=2, dec=0220.114924

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

4 ETW000[dev trc,00000]15: DBSL_DATA_SHORT_CHAR, len=60, max=60, dec=0210.114966

4 ETW000[dev trc,00000]16: DBSL_DATA_SHORT_CHAR, len=20, max=20, dec=0270.114993

4 ETW000[dev trc,00000]17: DBSL_DATA_SHORT_CHAR, len=2, max=2, dec=0220.115015

4 ETW000[dev trc,00000]18: DBSL_DATA_SHORT_CHAR, len=2, max=2, dec=0210.115036

4 ETW000[dev trc,00000]19: DBSL_DATA_NUMC, len=16, max=16, dec=0220.115058

4 ETW000[dev trc,00000]20: DBSL_DATA_NUMC, len=16, max=16, dec=0210.115079

4 ETW000[dev trc,00000]21: DBSL_DATA_SHORT_CHAR, len=60, max=60, dec=0220.115101

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

4 ETW000370.115138

4 ETW000[dev trc,00000]-oci_define( 0: SQLT_CHR , l=8, con=0, stp=2f546c8, pv=2f0fd74, in=2f0d1a0,rl=0000NULL,rc=0000NULL)

4 ETW000350.115173

4 ETW000[dev trc,00000]-oci_define( 1: SQLT_CHR , l=8, con=0, stp=2f546c8, pv=2f1056c, in=2f0d39e,rl=0000NULL,rc=0000NULL)

4 ETW000440.115217

4 ETW000[dev trc,00000]-oci_define( 2: SQLT_CHR , l= 80, con=0, stp=2f546c8, pv=2f10d64, in=2f0d59c,rl=0000NULL,rc=0000NULL)

4 ETW000370.115254

4 ETW000[dev trc,00000]-oci_define( 3: SQLT_CHR , l= 20, con=0, stp=2f546c8, pv=2f15d14, in=2f0d79a,rl=0000NULL,rc=0000NULL)

4 ETW000400.115294

4 ETW000[dev trc,00000]-oci_define( 4: SQLT_CHR , l= 20, con=0, stp=2f546c8, pv=2f17100, in=2f0d998,rl=0000NULL,rc=0000NULL)

4 ETW000360.115330

4 ETW000[dev trc,00000]-oci_define( 5: SQLT_CHR , l= 24, con=0, stp=2f546c8, pv=2f184ec, in=2f0db96,rl=0000NULL,rc=0000NULL)

4 ETW000650.115395

4 ETW000[dev trc,00000]-oci_define( 6: SQLT_CHR , l=2, con=0, stp=2f546c8, pv=2f19cd4, in=2f0dd94,rl=0000NULL,rc=0000NULL)

4 ETW000410.115436

4 ETW000[dev trc,00000]-oci_define( 7: SQLT_CHR , l= 60, con=0, stp=2f546c8, pv=2f19ed2, in=2f0df92,rl=0000NULL,rc=0000NULL)

4 ETW000460.115482

4 ETW000[dev trc,00000]-oci_define( 8: SQLT_CHR , l=2, con=0, stp=2f546c8, pv=2f1da96, in=2f0e190,rl=0000NULL,rc=0000NULL)

4 ETW000380.115520

4 ETW000[dev trc,00000]-oci_define( 9: SQLT_CHR , l=2, con=0, stp=2f546c8, pv=2f1dc94, in=2f0e38e,rl=0000NULL,rc=0000NULL)

4 ETW000370.115557

4 ETW000[dev trc,00000]-oci_define(10: SQLT_CHR , l= 16, con=0, stp=2f546c8, pv=2f1de92, in=2f0e58c,rl=0000NULL,rc=0000NULL)

4 ETW000480.115605

4 ETW000[dev trc,00000]-oci_define(11: SQLT_CHR , l=2, con=0, stp=2f546c8, pv=2f1ee82, in=2f0e78a,rl=0000NULL,rc=0000NULL)

4 ETW000370.115642

4 ETW000[dev trc,00000]-oci_define(12: SQLT_CHR , l= 40, con=0, stp=2f546c8, pv=2f1f080, in=2f0e988,rl=0000NULL,rc=0000NULL)

4 ETW0002230.115865

4 ETW000[dev trc,00000]-oci_define(13: SQLT_CHR , l=2, con=0, stp=2f546c8, pv=2f21858, in=2f0eb86,rl=0000NULL,rc=0000NULL)

4 ETW000 430.115908

4 ETW000[dev trc,00000]-oci_define(14: SQLT_CHR , l=2, con=0, stp=2f546c8, pv=2f21a56, in=2f0ed84,rl=0000NULL,rc=0000NULL)

4 ETW000360.115944

4 ETW000[dev trc,00000]-oci_define(15: SQLT_CHR , l= 60, con=0, stp=2f546c8, pv=2f21c54, in=2f0ef82,rl=0000NULL,rc=0000NULL)

4 ETW000410.115985

4 ETW000[dev trc,00000]-oci_define(16: SQLT_CHR , l= 20, con=0, stp=2f546c8, pv=2f25818, in=2f0f180,rl=0000NULL,rc=0000NULL)

4 ETW000370.116022

4 ETW000[dev trc,00000]-oci_define(17: SQLT_CHR , l=2, con=0, stp=2f546c8, pv=2f26c04, in=2f0f37e,rl=0000NULL,rc=0000NULL)

4 ETW000360.116058

4 ETW000[dev trc,00000]-oci_define(18: SQLT_CHR , l=2, con=0, stp=2f546c8, pv=2f26e02, in=2f0f57c,rl=0000NULL,rc=0000NULL)

4 ETW000360.116094

4 ETW000[dev trc,00000]-oci_define(19: SQLT_CHR , l= 16, con=0, stp=2f546c8, pv=2f27000, in=2f0f77a,rl=0000NULL,rc=0000NULL)

4 ETW000490.116143

4 ETW000[dev trc,00000]-oci_define(20: SQLT_CHR , l= 16, con=0, stp=2f546c8, pv=2f27ff0, in=2f0f978,rl=0000NULL,rc=0000NULL)

4 ETW000370.116180

4 ETW000[dev trc,00000]-oci_define(21: SQLT_CHR , l= 60, con=0, stp=2f546c8, pv=2f28fe0, in=2f0fb76,rl=0000NULL,rc=0000NULL)

4 ETW000360.116216

4 ETW000[dev trc,00000]-->exec_fetch(con=0, bulk=0, sch=2d52140, dap=17cca10, DBSL_DIR_READ)

4 ETW000330.116249

4 ETW000[dev trc,00000]-->stmt_fetch(con=0, sch=2d52140, odp=2d5b880, DBSL_DIR_READ)230.116272

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

4 ETW000570.116329

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction740.116403

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

4 ETW000400.116443

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]270.116470

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

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

4 ETW000460.117467

4 ETW000[dev trc,00000]stmt_fetch() -> orc=0, 0=DBSL_ERR_OK220.117489

4 ETW000[dev trc,00000]DbSlRead() --> 0=DBSL_ERR_OK310.117520

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

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

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

4 ETW000[dev trc,00000]{ db_rtab( fcode = 'RT_INSERT', tname = 'PATCHHIST' ) {/bas/742_REL/src/flat/saprel.c:1470}

4 ETW000670.117715

4 ETW000[dev trc,00000]-->DbSlRead(con=0, ssp=17baf00, dap=17bb140), sch=2d520a8, stid=17baf40, tok=17bb040, prepared=2

4 ETW000420.117757

4 ETW000[dev trc,00000]-->DbSlRead(con=0, ssp=17baf00, dap=17bb140), sch=2d520a8, scp=2d5b6d0, tab='DDNTT'

4 ETW000310.117788

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

4 ETW000410.117829

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

4 ETW000280.117857

4 ETW000[dev trc,00000]17baf00->id_p=17baf40: STID='10.DDNTT.11619.20141121204813'

4 ETW000340.117891

4 ETW000[dev trc,00000]In00: DBSL_DATA_SHORT_CHAR(len=60, max=60, dec=0)270.117918

4 ETW000[dev trc,00000]Out00: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)240.117942

4 ETW000[dev trc,00000]Out01: DBSL_DATA_SHORT_RAW(len=16, max=16, dec=0)230.117965

4 ETW000[dev trc,00000]Out02: DBSL_DATA_SHORT_CHAR(len=28, max=28, dec=0)220.117987

4 ETW000[dev trc,00000]Out03: DBSL_DATA_SHORT_CHAR(len=28, max=28, dec=0)210.118008

4 ETW000[dev trc,00000]Out04: DBSL_DATA_SHORT_CHAR(len=28, max=28, dec=0)210.118029

4 ETW000[dev trc,00000]Out05: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)220.118051

4 ETW000[dev trc,00000]Out06: DBSL_DATA_INTEGER_4(len=4, max=4, dec=0)220.118073

4 ETW000[dev trc,00000]Out07: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)330.118106

4 ETW000[dev trc,00000]Out08: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)220.118128

4 ETW000[dev trc,00000]Out09: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)210.118149

4 ETW000[dev trc,00000]Out10: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)220.118171

4 ETW000[dev trc,00000]Out11: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)220.118193

4 ETW000[dev trc,00000]Out12: DBSL_DATA_SHORT_CHAR(len=60, max=60, dec=0)210.118214

4 ETW000[dev trc,00000]Out13: DBSL_DATA_SHORT_RAW(len=6, max=6, dec=0)220.118236

4 ETW000[dev trc,00000]Out14: DBSL_DATA_SHORT_CHAR(len=2, max=2, dec=0)210.118257

4 ETW000[dev trc,00000]Out15: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)210.118278

4 ETW000[dev trc,00000]Out16: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)220.118300

4 ETW000[dev trc,00000]Out17: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)210.118321

4 ETW000[dev trc,00000]Out18: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)220.118343

4 ETW000[dev trc,00000]Out19: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)500.118393

4 ETW000[dev trc,00000]Out20: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)290.118422

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

4 ETW000[dev trc,00000] 0: DBSL_DATA_SHORT_CHAR, len=60, max=60, dec=0230.118466

4 ETW000[dev trc,00000]bind_type_and_length(): 21 output variables230.118489

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

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

4 ETW000[dev trc,00000]2: DBSL_DATA_SHORT_CHAR, len=28, max=28, dec=0210.118554

4 ETW000[dev trc,00000]3: DBSL_DATA_SHORT_CHAR, len=28, max=28, dec=0210.118575

4 ETW000[dev trc,00000]4: DBSL_DATA_SHORT_CHAR, len=28, max=28, dec=0210.118596

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

4 ETW000[dev trc,00000]6: DBSL_DATA_INTEGER_4, len=4, max=4, dec=0210.118638

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

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

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

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

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

4 ETW000[dev trc,00000]12: DBSL_DATA_SHORT_CHAR, len=60, max=60, dec=0210.118765

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

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

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

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

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

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

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

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

4 ETW000[dev trc,00000]-->exec_fetch(con=0, bulk=0, sch=2d520a8, dap=17bb140, DBSL_DIR_READ)

4 ETW000320.118982

4 ETW000[dev trc,00000]-->stmt_fetch(con=0, sch=2d520a8, odp=2d5b760, DBSL_DIR_READ)220.119004

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

4 ETW000500.119054

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction490.119103

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

4 ETW000360.119139

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]260.119165

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

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

4 ETW000440.119767

4 ETW000[dev trc,00000]stmt_fetch() -> orc=0, 0=DBSL_ERR_OK220.119789

4 ETW000[dev trc,00000]DbSlRead() --> 0=DBSL_ERR_OK250.119814

4 ETW000[dev trc,00000]db_con_test_and_open: 1 open cursors (delta=1)250.119839

4 ETW000[dev trc,00000]db_con_check_dirty: 1 open cursors, tx = NO , bc = NO180.119857

4 ETW000[dev trc,00000]db_con_check_dirty: db_con_dirty = YES210.119878

4 ETW000[dev trc,00000]-->DbSlBegRead(con=0, ssp=17bc7a0, dap=17bca20), sch=2d52010, stid=17bc7e0, tok=17bc8e0, prepared=2

4 ETW000380.119916

4 ETW000[dev trc,00000]-->DbSlBegRead(#0: con=0, ssp=17bc7a0, dap=17bca20), In=1, Out=4, sch=2d52010, scp=2d5b5b0, tab='DDNTF'

4 ETW000540.119970

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

4 ETW000330.120003

4 ETW000[dev trc,00000]17bc7a0->id_p=17bc7e0: STID='10.DDNTF.1045.20141121204845'

4 ETW000330.120036

4 ETW000[dev trc,00000]In00: DBSL_DATA_SHORT_CHAR(len=60, max=60, dec=0)240.120060

4 ETW000[dev trc,00000]Out00: DBSL_DATA_SHORT_CHAR(len=60, max=60, dec=0)220.120082

4 ETW000[dev trc,00000]Out01: DBSL_DATA_INTEGER_2(len=2, max=2, dec=0)220.120104

4 ETW000[dev trc,00000]Out02: DBSL_DATA_INTEGER_4(len=4, max=4, dec=0)210.120125

4 ETW000[dev trc,00000]Out03: DBSL_DATA_LONG_RAW(len=32768, max=32768, dec=0)230.120148

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

4 ETW000[dev trc,00000]0: DBSL_DATA_SHORT_CHAR, len=60, max=60, dec=0230.120204

4 ETW000[dev trc,00000]bind_type_and_length(): 4 output variables230.120227

4 ETW000[dev trc,00000]0: DBSL_DATA_SHORT_CHAR, len=60, max=60, dec=0220.120249

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

4 ETW000[dev trc,00000]2: DBSL_DATA_INTEGER_4, len=4, max=4, dec=0210.120292

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

4 ETW000[dev trc,00000]DbSlBegRead(#0) -> 0=DBSL_ERR_OK210.120335

4 ETW000[dev trc,00000]-->DbSlExeRead(con=0, ssp=17bc7a0, dap=17bca20230.120358

4 ETW000[dev trc,00000]-->DbSlExeRead(#1: con=0, ssp=17bc7a0, dap=17bca20)600.120418

4 ETW000[dev trc,00000]-->exec_fetch(con=0, bulk=0, sch=2d52010, dap=17bca20, DBSL_SEQ_READ)

4 ETW000300.120448

4 ETW000[dev trc,00000]-->stmt_fetch(con=0, sch=2d52010, odp=2d5b640, DBSL_SEQ_READ)220.120470

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

4 ETW000480.120518

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction44 0.120562

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

4 ETW000360.120598

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]250.120623

4 ETW000[dev trc,00000]OCIStmtExecute() completed, rc=100=OCI_NO_DATA, no further data5560.121179

4 ETW000[dev trc,00000]-> rc=1403=OCI_ERR_NOT_FOUND310.121210

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

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

4 ETW000320.121268

4 ETW000[dev trc,00000]stmt_fetch() -> orc=1403, 0=DBSL_ERR_OK230.121291

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

4 ETW000[dev trc,00000]db_con_test_and_open: 0 open cursors (delta=-1)190.121340

4 ETW000[dev trc,00000]db_con_check_dirty: db_con_dirty = NO160.121356

4 ETW000[dev trc,00000]-->DbSlEndRead(#1: con=0, ssp=17bc7a0, dap=17bca20, sch=2d52010) -> 0=DBSL_ERR_OK

4 ETW000680.121424

4 ETW000[dev trc,00000]db_con_check_dirty: 0 open cursors, tx = YES, bc = NO330.121457

4 ETW000[dev trc,00000]db_con_check_dirty: db_con_dirty = YES160.121473

4 ETW000[dev trc,00000]CHECK_STMTID(17cc990): no cache (0,sch=(nil))290.121502

4 ETW000[dev trc,00000]-->DbSlModify(DBSL_INSERT, con=0, ssp=17cc920, dap=17cca10), sch=0000NULL, state=0

4 ETW000330.121535

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

4 ETW000[dev trc,00000]17cc920->id_p=17cc990: STID=' 3.PATCHHIST. 268435456.20141020135211'

4 ETW000330.121607

4 ETW000[dev trc,00000]DbSlModify(con=0) -> 13=DBSL_ERR_STMTID220.121629

4 ETW000[dev trc,00000]-->DbSlPrepare(DBSL_INSERT, con=0, ssp=17cc920, dap=17cca10), tok=17cc940, stid=17cc990

4 ETW000350.121664

4 ETW000[dev trc,00000]build_stmt() -> OK490.121713

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 ETW0001220.121835

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected420.121877

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

4 ETW000340.121911

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

4 ETW000280.121939

4 ETW000[dev trc,00000]stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK750.122014

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

4 ETW000400.122054

4 ETW000[dev trc,00000]db_con_check_dirty: 0 open cursors, tx = YES, bc = NO190.122073

4 ETW000[dev trc,00000]db_con_check_dirty: db_con_dirty = YES150.122088

4 ETW000[dev trc,00000]-->DbSlModify(DBSL_INSERT, con=0, ssp=17cc920, dap=17cca10, sch=2d521d8), tab='PATCHHIST'

4 ETW000330.122121

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

4 ETW000320.122153

4 ETW000[dev trc,00000]17cc920->id_p=17cc990: STID=' 3.PATCHHIST. 268435456.20141020135211'

4 ETW000320.122185

4 ETW000[dev trc,00000]In00: DBSL_DATA_SHORT_CHAR(len=40, max=40, dec=0)240.122209

4 ETW000[dev trc,00000]In01: DBSL_DATA_SHORT_CHAR(len=20, max=20, dec=0)210.122230

4 ETW000[dev trc,00000]In02: DBSL_DATA_SHORT_CHAR(len=44, max=44, dec=0)220.122252

4 ETW000[dev trc,00000]In03: DBSL_DATA_SHORT_CHAR(len=20, max=20, dec=0)210.122273

4 ETW000[dev trc,00000]In04: DBSL_DATA_SHORT_CHAR(len=6, max=6, dec=0)220.122295

4 ETW000[dev trc,00000]In05: DBSL_DATA_SHORT_CHAR(len=28, max=28, dec=0)210.122316

4 ETW000[dev trc,00000]In06: DBSL_DATA_NUMC(len=20, max=20, dec=0)220.122338

4 ETW000[dev trc,00000]In07: DBSL_DATA_NUMC(len=20, max=20, dec=0)210.122359

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

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

4 ETW000[dev trc,00000]1: DBSL_DATA_SHORT_CHAR, len=20, max=20, dec=0220.122474

4 ETW000[dev trc,00000]2: DBSL_DATA_SHORT_CHAR, len=44, max=44, dec=0220.122496

4 ETW000[dev trc,00000]3: DBSL_DATA_SHORT_CHAR, len=20, max=20, dec=0210.122517

4 ETW000[dev trc,00000]4: DBSL_DATA_SHORT_CHAR, len=6, max=6, dec=0210.122538

4 ETW000[dev trc,00000]5: DBSL_DATA_SHORT_CHAR, len=28, max=28, dec=0210.122559

4 ETW000[dev trc,00000]6: DBSL_DATA_NUMC, len=20, max=20, dec=0220.122581

4 ETW000[dev trc,00000]7: DBSL_DATA_NUMC, len=20, max=20, dec=0210.122602

4 ETW000[dev trc,00000]bind_ind_and_values(IN,con=0,arr=565,col=8,rc=0,rl=8,flt=0,int=0,sh=0,uc=99)

4 ETW000370.122639

4 ETW000[dev trc,00000]-oci_bind( 0: SQLT_AFC , l= 40, con=0, stp=2f5cd98, pv=2f11840, in=2f0d1a0,rl=2f0f4f0,rc=0000NULL)

4 ETW000370.122676

4 ETW000[dev trc,00000]-oci_bind( 1: SQLT_AFC , l= 20, con=0, stp=2f5cd98, pv=2f17088, in=2f0d60a,rl=2f0f95a,rc=0000NULL)

4 ETW000530.122729

4 ETW000[dev trc,00000]-oci_bind( 2: SQLT_AFC , l= 44, con=0, stp=2f5cd98, pv=2f19cac, in=2f0da74,rl=2f0fdc4,rc=0000NULL)

4 ETW000430.122772

4 ETW000[dev trc,00000]-oci_bind( 3: SQLT_AFC , l= 20, con=0, stp=2f5cd98, pv=2f1fdc8, in=2f0dede,rl=2f1022e,rc=0000NULL)

4 ETW000490.122821

4 ETW000[dev trc,00000]-oci_bind( 4: SQLT_AFC , l=6, con=0, stp=2f5cd98, pv=2f229ec, in=2f0e348,rl=2f10698,rc=0000NULL)

4 ETW000440.122865

4 ETW000[dev trc,00000]-oci_bind( 5: SQLT_AFC , l= 28, con=0, stp=2f5cd98, pv=2f2372a, in=2f0e7b2,rl=2f10b02,rc=0000NULL)

4 ETW000420.122907

4 ETW000[dev trc,00000]-oci_bind( 6: SQLT_AFC , l= 20, con=0, stp=2f5cd98, pv=2f274f6, in=2f0ec1c,rl=2f10f6c,rc=0000NULL)

4 ETW000420.122949

4 ETW000[dev trc,00000]-oci_bind( 7: SQLT_AFC , l= 20, con=0, stp=2f5cd98, pv=2f2a11a, in=2f0f086,rl=2f113d6,rc=0000NULL)

4 ETW000420.122991

4 ETW000[dev trc,00000]-->exec_modify(): bulk=0, input_cnt=8, lit_cnt=0, fae_cnt=0300.123021

4 ETW000[dev trc,00000]stmt_execute?: row_max=1, _xcnt=0, _i=1, _pcnt=0, _upto=4294967295, _total=0

4 ETW000530.123074

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

4 ETW000520.123126

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction450.123171

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

4 ETW000470.123218

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]260.123244

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

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

4 ETW000440.124483

4 ETW000[dev trc,00000]IN array size xcnt=1, IN->row_total=12170.124700

4 ETW000[ dev trc,00000]orpc=1, DbCa.dbcount=1, DbSt.counter.dbrecords=1230.124723

4 ETW000[dev trc,00000]stmt_execute() -> orc=0 (orc1=0), rc=0=DBSL_ERR_OK240.124747

4 ETW000[dev trc,00000]<--exec_modify() -> 0=DBSL_ERR_OK, supply=999280.124775

4 ETW000[dev trc,00000]DbSlModify(con=0) -> 0=DBSL_ERR_OK220.124797

4 ETW000[dev trc,00000]} db_rtab( fcode = 'RT_INSERT', retcode = 0 )190.124816

4 ETW000[dev trc,00000]{ dsql_open (con_da=(0,R/3),#binds=0,#input=0,580.124874

4 ETW000name=UNKNOWN, stmtid=NULL,

4 ETW000stmt="SELECT EXECUTABLE,SAPRELEASE,HOSTNAME,PLATFORM,DBVENDOR,TIMESTAMP,PATCHNO,DBSLPATCHN FROM...")

4 ETW000[dev trc,00000]db_con_test_and_open: 1 open cursors (delta=1)340.124908

4 ETW000[dev trc,00000]db_con_check_dirty: 1 open cursors, tx = YES, bc = NO160.124924

4 ETW000[dev trc,00000]db_con_check_dirty: db_con_dirty = YES150.124939

4 ETW000[dev trc,00000]vv Ds_prep_open(head_p=7fff89772ad0, In=0)260.124965

4 ETW000[dev trc,00000]vv cursor_open(head_p=7fff89772ad0, In=0, re=0)320.124997

4 ETW000[dev trc,00000]-->DbSlPrepare(DBSL_SELECT, con=0, ssp=7f7590de6508, dap=7f7590de6470), tok=7f7590de64e8, stid=0000NULL

4 ETW000340.125031

4 ETW000[dev trc,00000]build_stmt() -> OK430.125074

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 ETW0001130.125187

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected400.125227

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

4 ETW000340.125261

4 ETW000[dev trc,00000]SELECT EXECUTABLE,SAPRELEASE,HOSTNAME,PLATFORM,DBVENDOR,TIMESTAMP,PATCHNO,DBSLPATCHN FROM PATCHHIST WHERE EXECUTABLE = 'R3

4 ETW000280.125289

4 ETW000[dev trc,00000]trans' AND TIMESTAMP = (SELECT MAX(TIMESTAMP) FROM PATCHHIST WHERE EXECUTABLE = 'R3trans' AND SAPRELEASE = '742' AND HOSTN

4 ETW000260.125315

4 ETW000[dev trc,00000]AME = 'svrqas01' AND PLATFORM = 'Linux' AND DBVENDOR = 'ORA')

4 ETW000370.125352

4 ETW000[dev trc,00000]stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK1360.125488

4 ETW000[dev trc,00000]DbSlPrepare(lit=0, lob=0, fae=0, col=0, mrk=0,sch=2d52270, scp=2d5ba30, tab=' ') -> 0=DBSL_ERR_OK

4 ETW000450.125533

4 ETW000[dev trc,00000]-->DbSlBegRead(con=0, ssp=7f7590de6508, dap=7f7590de6470), sch=2d52270, stid=0000NULL, tok=7f7590de64e8, prepared=1

4 ETW000370.125570

4 ETW000[dev trc,00000]-->DbSlBegRead(#0: con=0, ssp=7f7590de6508, dap=7f7590de6470), In=0, Out=0, sch=2d52270, scp=2d5ba30, tab=' '

4 ETW000500.125620

4 ETW000[dev trc,00000]stmt=SELECT EXECUTABLE,SAPRELEASE,HOSTNAME,PLATFORM,DBVENDOR,TIMESTAMP,PATCHNO,DBSLPATCHN FROM PATCHHIST WHERE EXECUTABLE = 'R3

4 ETW000340.125654

4 ETW000[dev trc,00000]trans' AND TIMESTAMP = (SELECT MAX(TIMESTAMP) FROM PATCHHIST WHERE EXECUTABLE = 'R3trans' AND SAPRELEASE = '742' AND HOSTN

4 ETW000270.125681

4 ETW000[dev trc,00000]AME = 'svrqas01' AND PLATFORM = 'Linux' AND DBVENDOR = 'ORA')

4 ETW000280.125709

4 ETW000[dev trc,00000]7f7590de6508->id_p=(nil)270.125736

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

4 ETW000[dev trc,00000]DbSlBegRead(#0) -> 0=DBSL_ERR_OK210.125780

4 ETW000[dev trc,00000]^^ cursor_open(cid=0) -> OK190.125799

4 ETW000[dev trc,00000]^^ Ds_prep_open(cid=0)200.125819

4 ETW000[dev trc,00000]} dsql_open()=0, *cu_id_p=0170.125836

4 ETW000[dev trc,00000]{ dsql_fetch (con_da=(0,R/3),cu_id=0,#output=8)200.125856

4 ETW000[dev trc,00000]vv Ds_fetch(head_p=7fff89772ad0, cid=0, #out=8, rows=1)280.125884

4 ETW000[dev trc,00000]-->DbSlExeRead(con=0, ssp=7f7590de6508, dap=7f7590de6470380.125922

4 ETW000[dev trc,00000]-->DbSlExeRead(#1: con=0, ssp=7f7590de6508, dap=7f7590de6470)250.125947

4 ETW000[dev trc,00000]bind_type_and_length(): 8 output variables200.125967

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

4 ETW000[dev trc,00000]1: DBSL_DATA_SHORT_CHAR, len=20, max=20, dec=0210.126010

4 ETW000[dev trc,00000]2: DBSL_DATA_SHORT_CHAR, len=44, max=44, dec=0220.126032

4 ETW000[dev trc,00000]3: DBSL_DATA_SHORT_CHAR, len=20, max=20, dec=0200.126052

4 ETW000[dev trc,00000]4: DBSL_DATA_SHORT_CHAR, len=6, max=6, dec=0210.126073

4 ETW000[dev trc,00000]5: DBSL_DATA_SHORT_CHAR, len=28, max=28, dec=0220.126095

4 ETW000[dev trc,00000]6: DBSL_DATA_SHORT_CHAR, len=20, max=20, dec=0210.126116

4 ETW000[dev trc,00000]7: DBSL_DATA_SHORT_CHAR, len=20, max=20, dec=0200.126136

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

4 ETW000480.126184

4 ETW000[dev trc,00000]-oci_define( 0: SQLT_CHR , l= 40, con=0, stp=2f604a8, pv=2f0f790, in=2f0d1a0,rl=0000NULL,rc=0000NULL)

4 ETW000360.126220

4 ETW000[dev trc,00000]-oci_define( 1: SQLT_CHR , l= 20, con=0, stp=2f604a8, pv=2f15668, in=2f0d65e,rl=0000NULL,rc=0000NULL)

4 ETW000460.126266

4 ETW000[dev trc,00000]-oci_define( 2: SQLT_CHR , l= 44, con=0, stp=2f604a8, pv=2f185d4, in=2f0db1c,rl=0000NULL,rc=0000NULL)

4 ETW000370.126303

4 ETW000[dev trc,00000]-oci_define( 3: SQLT_CHR , l= 20, con=0, stp=2f604a8, pv=2f1ee28, in=2f0dfda,rl=0000NULL,rc=0000NULL)

4 ETW000380.126341

4 ETW000[dev trc,00000]-oci_define( 4: SQLT_CHR , l=6, con=0, stp=2f604a8, pv=2f21d94, in=2f0e498,rl=0000NULL,rc=0000NULL)

4 ETW000740.126415

4 ETW000[dev trc,00000]-oci_define( 5: SQLT_CHR , l= 28, con=0, stp=2f604a8, pv=2f22bce, in=2f0e956,rl=0000NULL,rc=0000NULL)

4 ETW000390.126454

4 ETW000[dev trc,00000]-oci_define( 6: SQLT_CHR , l= 20, con=0, stp=2f604a8, pv=2f26e32, in=2f0ee14,rl=0000NULL,rc=0000NULL)

4 ETW000360.126490

4 ETW000[dev trc,00000]-oci_define( 7: SQLT_CHR , l= 20, con=0, stp=2f604a8, pv=2f29d9e, in=2f0f2d2,rl=0000NULL,rc=0000NULL)

4 ETW000360.126526

4 ETW000[dev trc,00000]-->exec_fetch(con=0, bulk=0, sch=2d52270, dap=7f7590de6470, DBSL_SEQ_READ)

4 ETW000330.126559

4 ETW000[dev trc,00000]-->stmt_fetch(con=0, sch=2d52270, odp=2d5bac0, DBSL_SEQ_READ)220.126581

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

4 ETW000440.126625

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction440.126669

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

4 ETW000400.126709

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]280.126737

4 ETW000[dev trc,00000]OCIStmtExecute() completed, rc=100=OCI_NO_DATA, no further data7950.127532

4 ETW000[dev trc,00000]-> rc=1403=OCI_ERR_NOT_FOUND330.127565

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

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

4 ETW000320.127624

4 ETW000[dev trc,00000]stmt_fetch() -> orc=1403, 0=DBSL_ERR_OK220.127646

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

4 ETW000[dev trc,00000]head_p->sqlcode=1403, ->rec_cnt=1, ->mod_cnt=1920.127764

4 ETW000[dev trc,00000]^^ Ds_fetch() -> rc=0=DS_SAP_O_K210.127785

4 ETW000[dev trc,00000]} dsql_fetch()=0, rec_cnt=1, mod_cnt=1320.127817

4 ETW000[dev trc,00000]{ dsql_close (con_da=(0,R/3),cu_id=0)200.127837

4 ETW000[dev trc,00000]db_con_test_and_open: 0 open cursors (delta=-1)240.127861

4 ETW000[dev trc,00000]db_con_check_dirty: 0 open cursors, tx = YES, bc = NO70.127868

4 ETW000 [dev trc,00000]db_con_check_dirty: db_con_dirty = YES70.127875

4 ETW000[dev trc,00000]vv Ds_close(cid=0)120.127887

4 ETW000[dev trc,00000]vv cursor_close(cid=0)90.127896

4 ETW000[dev trc,00000]-->DbSlEndRead(#1: con=0, ssp=7f7590de6508, dap=7f7590de6470, sch=2d52270) -> 0=DBSL_ERR_OK

4 ETW000150.127911

4 ETW000[dev trc,00000]^^ cursor_close()90.127920

4 ETW000[dev trc,00000]^^ Ds_close()90.127929

4 ETW000[dev trc,00000]} dsql_close()=070.127936

4 ETW000[dev trc,00000]{ db_rtab( fcode = 'RT_DELETE', tname = 'PATCHHIST' ) {/bas/742_REL/src/flat/saprel.c:1582}

4 ETW000140.127950

4 ETW000[dev trc,00000]db_con_check_dirty: 0 open cursors, tx = YES, bc = NO100.127960

4 ETW000[dev trc,00000]db_con_check_dirty: db_con_dirty = YES70.127967

4 ETW000[dev trc,00000]CHECK_STMTID(17cc990): no cache (0,sch=(nil))100.127977

4 ETW000[dev trc,00000]-->DbSlModify(DBSL_DELETE, con=0, ssp=17cc920, dap=17cca10), sch=0000NULL, state=0

4 ETW000150.127992

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

4 ETW000[dev trc,00000]17cc920->id_p=17cc990: STID=' 3.PATCHHIST. 805306369.20141020135211'

4 ETW000150.128015

4 ETW000[dev trc,00000]DbSlModify(con=0) -> 13=DBSL_ERR_STMTID100.128025

4 ETW000[dev trc,00000]-->DbSlPrepare(DBSL_DELETE, con=0, ssp=17cc920, dap=17cca10), tok=17cc940, stid=17cc990

4 ETW000150.128040

4 ETW000[dev trc,00000]build_stmt() -> OK220.128062

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 ETW000530.128115

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected190.128134

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

4 ETW000150.128149

4 ETW000[dev trc,00000]DELETE FROM "PATCHHIST" WHERE "EXECUTABLE"=:A0 AND "SAPRELEASE"=:A1 AND "HOSTNAME"=:A2 AND "PLATFORM"=:A3 AND "DBVENDOR"=:

4 ETW000190.128168

4 ETW000[dev trc,00000] A4 AND "TIMESTAMP"=:A5

4 ETW000120.128180

4 ETW000[dev trc,00000]stmt_prepare() -> orc=0, rc=0=DBSL_ERR_OK370.128217

4 ETW000[dev trc,00000]DbSlPrepare(lit=0, lob=0, fae=0, col=6, mrk=6,sch=2d52308, scp=2d5bb50, tab='PATCHHIST') -> 0=DBSL_ERR_OK

4 ETW000180.128235

4 ETW000[dev trc,00000]db_con_check_dirty: 0 open cursors, tx = YES, bc = NO90.128244

4 ETW000[dev trc,00000]db_con_check_dirty: db_con_dirty = YES60.128250

4 ETW000[dev trc,00000]-->DbSlModify(DBSL_DELETE, con=0, ssp=17cc920, dap=17cca10, sch=2d52308), tab='PATCHHIST'

4 ETW000150.128265

4 ETW000[dev trc,00000]stmt=DELETE FROM "PATCHHIST" WHERE "EXECUTABLE"=:A0 AND "SAPRELEASE"=:A1 AND "HOSTNAME"=:A2 AND "PLATFORM"=:A3 AND "DBVENDOR"=:

4 ETW000150.128280

4 ETW000[dev trc,00000]A4 AND "TIMESTAMP"=:A5

4 ETW000130.128293

4 ETW000[dev trc,00000]17cc920->id_p=17cc990: STID=' 3.PATCHHIST. 805306369.20141020135211'

4 ETW000150.128308

4 ETW000[dev trc,00000]In00: DBSL_DATA_SHORT_CHAR(len=40, max=40, dec=0)100.128318

4 ETW000[dev trc,00000]In01: DBSL_DATA_SHORT_CHAR(len=20, max=20, dec=0)100.128328

4 ETW000[dev trc,00000]In02: DBSL_DATA_SHORT_CHAR(len=44, max=44, dec=0)100.128338

4 ETW000[dev trc,00000]In03: DBSL_DATA_SHORT_CHAR(len=20, max=20, dec=0)100.128348

4 ETW000[dev trc,00000]In04: DBSL_DATA_SHORT_CHAR(len=6, max=6, dec=0)100.128358

4 ETW000[dev trc,00000]In05: DBSL_DATA_SHORT_CHAR(len=28, max=28, dec=0)260.128384

4 ETW000[dev trc,00000]bind_type_and_length(): 6 input variables, col=6120.128396

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

4 ETW000[dev trc,00000]1: DBSL_DATA_SHORT_CHAR, len=20, max=20, dec=0100.128416

4 ETW000[dev trc,00000]2: DBSL_DATA_SHORT_CHAR, len=44, max=44, dec=0100.128426

4 ETW000[dev trc,00000]3: DBSL_DATA_SHORT_CHAR, len=20, max=20, dec=0100.128436

4 ETW000[dev trc,00000]4: DBSL_DATA_SHORT_CHAR, len=6, max=6, dec=0100.128446

4 ETW000[dev trc,00000]5: DBSL_DATA_SHORT_CHAR, len=28, max=28, dec=0100.128456

4 ETW000[dev trc,00000]bind_ind_and_values(IN,con=0,arr=714,col=6,rc=0,rl=6,flt=0,int=0,sh=0,uc=79)

4 ETW000200.128476

4 ETW000[dev trc,00000]-oci_bind( 0: SQLT_AFC , l= 40, con=0, stp=2f645a8, pv=2f11490, in=2f0d1a0,rl=2f0f318,rc=0000NULL)

4 ETW000220.128498

4 ETW000[dev trc,00000]-oci_bind( 1: SQLT_AFC , l= 20, con=0, stp=2f645a8, pv=2f18420, in=2f0d734,rl=2f0f8ac,rc=0000NULL)

4 ETW000250.128523

4 ETW000[dev trc,00000]-oci_bind( 2: SQLT_AFC , l= 44, con=0, stp=2f645a8, pv=2f1bbe8, in=2f0dcc8,rl=2f0fe40,rc=0000NULL)

4 ETW000190.128542

4 ETW000[dev trc,00000]-oci_bind( 3: SQLT_AFC , l= 20, con=0, stp=2f645a8, pv=2f236a0, in=2f0e25c,rl=2f103d4,rc=0000NULL)

4 ETW000200.128562

4 ETW000[dev trc,00000]-oci_bind( 4: SQLT_AFC , l=6, con=0, stp=2f645a8, pv=2f26e68, in=2f0e7f0,rl=2f10968,rc=0000NULL)

4 ETW000190.128581

4 ETW000[dev trc,00000]-oci_bind( 5: SQLT_AFC , l= 28, con=0, stp=2f645a8, pv=2f27f24, in=2f0ed84,rl=2f10efc,rc=0000NULL)

4 ETW000190.128600

4 ETW000[dev trc,00000]-->exec_modify(): bulk=0, input_cnt=6, lit_cnt=0, fae_cnt=0140.128614

4 ETW000[dev trc,00000]stmt_execute?: row_max=1, _xcnt=0, _i=1, _pcnt=0, _upto=4294967295, _total=0

4 ETW000180.128632

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

4 ETW000200.128652

4 ETW000[dev trc,00000]time 2017-05-13 00:38:06, con=0 connected, new transaction240.128676

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

4 ETW000160.128692

4 ETW000[dev trc,00000]-->OCIStmtExecute(con=0, svc=2e04028, err=2e02008): [dur. 0,000s]120.128704

4 ETW000[dev trc,00000]OCIStmtExecute(rpc=1): [dur. 0,004s]38210.132525

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

4 ETW000200.132545

4 ETW000[dev trc,00000]IN array size xcnt=1, IN->row_total=1100.132555

4 ETW000[dev trc,00000]orpc=1, DbCa.dbcount=1, DbSt.counter.dbrecords=1130.132568

4 ETW000[dev trc,00000]stmt_execute() -> orc=0 (orc1=0), rc=0=DBSL_ERR_OK100.132578

4 ETW000[dev trc,00000]<--exec_modify() -> 0=DBSL_ERR_OK, supply=999100.132588

4 ETW000[dev trc,00000]DbSlModify(con=0) -> 0=DBSL_ERR_OK100.132598

4 ETW000[dev trc,00000]} db_rtab( fcode = 'RT_DELETE', retcode = 0 )80.132606

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)330.132639

4 ETW000[dev trc,00000]all LL freed, no memory used for LL storage170.132656

4 ETW000[dev trc,00000]-->DbSlCommit(con=0,FORCE,DROP), 19 stmts executed, 0/0 open cur240.132680

4 ETW000[dev trc,00000]all LL freed, no memory used for LL storage150.132695

4 ETW000[dev trc,00000]-->oci_commit(con=0), time: 2017-05-13 00:38:06200.132715

4 ETW000[dev trc,00000]OCITransCommit(svc=2e04028, err=2e02008, OCI_DEFAULT)150.132730

4 ETW000[dev trc,00000]<--oci_commit(), orc=0, time: 2017-05-13 00:38:06365150.169245

4 ETW000[dev trc,00000]db_con_check_dirty: db_con_dirty = NO410.169286

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

4 ETW000trace to file pointer closed

4 ETW000trace at level 1 opened for a given file pointer

4 ETW000

4 ETW000 ================== STEP 1 =====================

4 ETW000 date&time: 13.05.2017 - 00:38:06

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:2290.000229

4 ETW000[dev trc,00000]Disconnecting con=0450.000274

4 ETW000[dev trc,00000]OCISessionEnd(con=0, svc=2e04028, srv=2e070d0='QE1'): Close session usr=2e3dc10, rc=0

4 ETW00015630.001837

4 ETW000[dev trc,00000]OCIServerDetach(stale(1) con=0, svc=2e04028): Server srv=2e070d0='QE1' detached

4 ETW0003140.002151

4 ETW000[dev trc,00000]Disconnected from connection 0330.002184

4 ETW000[dev trc,00000]statistics db_con_commit (com_total=1, com_tx=1)210.002205

4 ETW000[dev trc,00000]statistics db_con_rollback (roll_total=0, roll_tx=0)260.002231

4 ETW000 Disconnected from database.

4 ETW000 End of Transport (0000).

4 ETW000 date&time: 13.05.2017 - 00:38:06

10 |10000 characters needed characters left characters exceeded
* Please Login or Register to Answer, Follow or Comment.

1 Answer

Best Answer
Jude Bradley
May 17, 2017 at 03:18 PM
1

Hello Clement,

You are using an old kernel version here. It's showing patch 0

Please update to patch 500

refer to

https://launchpad.support.sap.com/#/notes/0000019466

Regards,

Jude

Share
10 |10000 characters needed characters left characters exceeded