on 07-19-2016 10:25 AM
Hi,
In your log:
ERROR: -1 in function ExeNormalModify (execute) [line 25020]
C (587) [ZZZZZ] [SAP][ASE ODBC Driver][Adaptive Server Enterprise]Identity value overflow for field 'SEQNUMBER' in table 'DDLOG'.
Solution:
1939932 - Error SQL587 "Identity value overflow for field 'SEQNUMBER' in table 'DDLOG'" - SAP ASE for Business Suite
Kind Regards,
Johan
You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.
You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.
You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.
Dear Sajmal,
Hope you are doing good.
Can you try to free up a session using dpmon utility and then try to login; maybe restart a workprocess.
DPMON Dispatcher Monitor - Application Server Infrastructure - SCN Wiki
Hope this helps.
_ _ _ _ _ _ _ __ _ _
Kind Regards,
Hemanth
SAP Product Support
_ _ _ _ _ _ _ _ _ _ _
Join me online: http://scn.sap.com/people/hemanth.kumar/content
You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.
Hi Ning,
We already check that, log is too long so its not well to post that here...
dev_disp trace shows "Work process is die",
dev_wo shows
-----------------------
rdisp/wp_auto_restart = 0 / 5 sec
M rdisp/wp_abap_restart = 0
M ThSetThToolParam : restartable_wp[0] = FALSE
M ThSetThToolParam : restartable_wp[1] = TRUE
M ThSetThToolParam : restartable_wp[2] = TRUE
M ThSetThToolParam : restartable_wp[3] = FALSE
M ThSetThToolParam : restartable_wp[4] = TRUE
M ThSetThToolParam : restartable_wp[5] = TRUE
M ThSetThToolParam : restartable_wp[6] = TRUE
Is problem related to this..???
Thanks and Regards,
Sajmal
dev_w0
-----------
---------------------------------------------------
trc file: "dev_w0", trc level: 1, release: "741"
---------------------------------------------------
*
* ACTIVE TRACE LEVEL 1
* ACTIVE TRACE COMPONENTS all, MJ
*
M sysno 00
M sid QA1
M systemid 562 (PC with Windows NT)
M relno 7410
M patchlevel 0
M patchno 225
M intno 20020600
M make multithreaded, Unicode, 64 bit, optimized
M profile \\baiodevcct\sapmnt\QA1\SYS\profile\QA1_DVEBMGS00_baiodevcct
M pid 5552
M
M
M Tue Jul 19 14:40:44 2016
M kernel runs with dp version 216000(ext=117000) (@(#) DPLIB-INT-VERSION-216000-UC)
M length of sys_adm_ext is 500 bytes
M ***LOG Q0Q=> tskh_init, WPStart (Workp. 0 5552) [dpInit.c 748]
M DpCommonParamInit: rdisp/core_file_size = default --> no change
I MtxInit: 0 0 0
M DpIPCInit2: read dp-profile-values from sys_adm_ext
M DpShMCreate: alloate/attach shared memory (mode=ATTACH)
M DpShMCreate: sizeof(wp_adm) 23184 (1104)
M DpShMCreate: sizeof(tm_adm) 13040880 (64880)
M DpShMCreate: sizeof(ca_adm) 432000 (72)
M DpCommTableSize: max/headSize/ftSize/tableSize=500/16/1832064/1951152
M DpShMCreate: sizeof(comm_adm) 1951152 (3648)
M DpSlockTableSize: max/headSize/ftSize/fiSize/tableSize=0/0/0/0/0
M DpShMCreate: sizeof(slock_adm) 0 (296)
M DpFileTableSize: max/headSize/ftSize/tableSize=0/0/0/0
M DpShMCreate: sizeof(file_adm) 0 (80)
M DpSockTableSize: max/headSize/ftSize/tableSize=500/16/520064/520080
M DpShMCreate: sizeof(sock_adm) 520080 (1016)
M DpShMCreate: sizeof(vmc_adm) 0 (3208)
M DpShMCreate: sizeof(wall_adm) (ft=41664/fi=67472/hd=64/rec=192)
M DpShMCreate: sizeof(amc_rec_adm) (ft=86464/fi=67472/hd=64/rec=416)
M DpShMCreate: sizeof(websocket_adm) (ft=28864/hd=64/rec=272)
M DpShMCreate: sizeof(gw_adm) 64
M DpShMCreate: sizeof(j2ee_adm) 3936
M DpShMCreate: SHM_DP_ADM_KEY (addr: 000000000C030050, size: 16369648
M DpShMCreate: allocated sys_adm at 000000000C030250
M DpShMCreate: allocated wp_adm_list at 000000000C042100
M DpShMCreate: allocated wp_adm at 000000000C042420
M DpShMCreate: allocated tm_adm_list at 000000000C0480B0
M DpShMCreate: allocated tm_adm at 000000000C0482F0
M DpShMCreate: allocated ca_adm at 000000000CCB81E0
M DpShMCreate: allocated comm_adm at 000000000CD21B60
M DpShMCreate: system runs without slock table
M DpShMCreate: allocated sock_adm at 000000000CEFE310
M DpShMCreate: allocated vmc_adm_list at 000000000CF7D4A0
M DpShMCreate: system runs without VMC
M DpShMCreate: allocated gw_adm at 000000000CF7D740
M DpShMCreate: allocated j2ee_adm at 000000000CF7D980
M DpShMCreate: allocated ca_info at 000000000CF7EAE0
M DpShMCreate: allocated wall_adm (ft) at 000000000CF7ED20
M DpShMCreate: allocated wall_adm (fi) at 000000000CF891E0
M DpShMCreate: allocated wall_adm (head) at 000000000CF99B70
M DpShMCreate: allocated amc_rec_adm (ft) at 000000000CF99DB0
M DpShMCreate: allocated amc_rec_adm (fi) at 000000000CFAF170
M DpShMCreate: allocated amc_rec_adm (head) at 000000000CFBFB00
M DpShMCreate: allocated websocket_adm (ft) at 000000000CFBFD40
M DpShMCreate: allocated websocket_adm (head) at 000000000CFC7000
M DpShMCreate: initialized 21 eyes
M DpCommAttachTable: attached comm table (header=000000000CD21B60/ft=000000000CD21B70/fi=000000000CEE0FF0)
M DpSockAttachTable: attached sock table (header=000000000CEFE310/ft=000000000CEFE320)
X EmInit: MmSetImplementation( 2 ).
X MM global diagnostic options set: 0
X <ES> client 0 initializing ....
X <ES> EsILock: use Mutex for locking
X Using implementation view
X <EsNT> Using memory model view.
M <EsNT> Memory Reset disabled as NT default
X ES initialized.
X mm.dump: set global maximum dump mem to 192 MB
X EsRegisterEmCheck: Register EmGetEsHandles at 00007FF608411C90
M
M Tue Jul 19 14:40:45 2016
M ThStart: taskhandler started
M ThInit: initializing DIA work process W0
X MMX: use precise segment size globally
M rdisp/sapgui_data_trace : 1 -> 1
M
M Tue Jul 19 14:40:46 2016
M ThInit: running on host baiodevcct
I MtxInit: 0 0 0
M
M Tue Jul 19 14:40:47 2016
M calling db_connect ...
B Loading DB library 'G:\usr\sap\QA1\DVEBMGS00\exe\dbsybslib.dll' ...
B Library 'G:\usr\sap\QA1\DVEBMGS00\exe\dbsybslib.dll' loaded
B Version of 'G:\usr\sap\QA1\DVEBMGS00\exe\dbsybslib.dll' is "741.10", patchlevel (0.111)
C trace file set
C Callback functions for dynamic profile parameter registered
B read_con_info_ssfs(): DBSL supports extended connect protocol
B ==> connect info for default DB will be read from ssfs
C dbs/syb/bcddec: FALSE
C dbs/syb/fetchArraySize: 1000
C database is local: connect_timeout: 3
C Thread ID:5244
C lib_dbsl 741 10/21/2014 16:59:00
C connection unquiesced
C Using dynamic link library 'G:\usr\sap\QA1\DVEBMGS00\exe\dbsybslib.dll'
C dbsybslib.dll patch info
C SAP patchlevel 0
C SAP patchno 201
C Last SYBASE DBSL patchlevel 0
C Last SYBASE DBSL patchno 111
C Last SYBASE DBSL patchcomment SYB: stat stack overflow (2080663)
C
C Tue Jul 19 14:40:48 2016
C spid 86 comm rd ODBC
C spid 150 unc rd ODBC
C Driver: Adaptive Server Enterprise Driver release: 15.7.0.1260
C Driver full version: SAP ASE ODBC Driver/15.7/SP126 PL/P/AMD64/Windows/drvmain/Build 1260/64-bit/Normal/Sun Apr 13 UTC 20:37:36 2014/SQLLEN8
C Driver uses SQLLEN8
C dbs/syb/cache_size: 200
C GetServerInfo version: Adaptive Server Enterprise/15.7/EBF 22777 SMP SP122 /P/X64/Windows Server/ase157sp12x/3662/64-bit/OPT/Sat Apr 19 01:26:01 2014
C GetServerInfo release: 15.7.0.122
C GetServerInfo architecture: x86_64
C GetServerInfo edition: P
C GetServerInfo byte width: 64 bit
C DbSlConnect hdl: 0
C trace file set
B Connection 0 opened (DBSL handle 0)
M ThDbConnect: db_connect o.k.
X
X Tue Jul 19 14:40:53 2016
X EmInit: MmSetImplementation( 2 ).
X MM global diagnostic options set: 0
X <ES> client 0 initializing ....
X Using implementation view
X ES initialized.
X mm.dump: set global maximum dump mem to 192 MB
X EsRegisterEmCheck: Register EmGetEsHandles at 00007FF608411C90
B
B Tue Jul 19 14:40:54 2016
B db_con_shm_ini: WP_ID = 0, WP_CNT = 21, CON_ID = -1
B Start CursorInit
B TBI initializing lock manager ...
B TBI locking : multiple locks
B TBI lock manager impl: semamphore
B dbtbxbuf: Buffer TBI64 (addr: 0000000058EE0140, size: 4033333520, end: 000000014955CA50)
B DBI: init TBI BUFFER (data): start=000007DE5E701000 length=3899659264 end=000007DF46E02400
B dbprotocol: table logging switched off for all clients
B DbModifyHelper::maxItabInvalidationThreshold = 20
B dbsync[db_syinit]: successfully attached to shared memory, sync_adm_p = 0000000000260050
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 = 2145094697
B oldest_gap = (2147483647,19700101053000)
B time_of_last_sync = 20160719144049
B MySysId = 'baiodevcct 00'
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 = 21
B blockSize = 512
B maxObjects = 335060
B maxObjectSize = 311604352
B freeListVectorSize = 489
B hashVectorSize = 670129
B bufferSize = 1372407808
B maxBlocks = 2434409
B freeBlocksCnt = 2434409
B mutexVectorSize = 670131, ADMIN_MUTEX = 670129, INVAL_MUTEX = 670130
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 = 21
B blockSize = 512
B maxObjects = 2000
B maxObjectSize = 859648
B freeListVectorSize = 17
B hashVectorSize = 4001
B bufferSize = 4194304
B maxBlocks = 6716
B freeBlocksCnt = 6716
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 = 21
B blockSize = 512
B maxObjects = 2000
B maxObjectSize = 577920
B freeListVectorSize = 587
B hashVectorSize = 4001
B bufferSize = 3072000
B maxBlocks = 4515
B freeBlocksCnt = 4515
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 = 21
B blockSize = 256
B maxObjects = 2000
B maxObjectSize = 859584
B freeListVectorSize = 33
B hashVectorSize = 4001
B bufferSize = 4194304
B maxBlocks = 13431
B freeBlocksCnt = 13431
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: 0000000061A00050, size: 4400000)
M ThCreateNoBuffer allocated 548152 bytes for 1000 entries at 0000000062490050
M ThCreateNoBuffer index size: 3000 elems
M ThCreateVBAdm allocated 33376 bytes (50 server) at 0000000000270050
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 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 0000000003678DC0
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
S
S Tue Jul 19 14:40:55 2016
S found processing queue enabled
S found spool memory service RSPO-RCLOCKS at 0000000062AE00D0
S doing lock recovery
S setting server cache root
S found spool memory service RSPO-SERVERCACHE at 0000000062AE0730
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 43684 bytes at 0000000000280050
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 ***GENER* Trace switched on ***
A
A ---PXA-------------------------------------------
A PXA INITIALIZATION
A PXA: increasing number of fragments to stay below recommended size of 2GB
A PXA: Locked PXA-Semaphore.
A System page size: 4kb, total admin_size: 1020868kb, dir_size: 145332kb.
A Attached to PXA (address 00007FFCA4FD0050 - 00007FFFFFFD0050, size 14073856K, 7 fragments of 1864712K )
A *** using a guard page at PXA start to protect parameters and release info ***
A abap/pxa = shared protect gen_remote
A PXA: checking structure sizes: 760|272|16
A PXA INITIALIZATION FINISHED
A ---PXA-------------------------------------------
A
A ATRA: pfclock execution time = 0
A abap/force_local_update_task=0
A ABAP ShmAdm attached (addr=000007DF4760F000 leng=1920974848 end=000007DFB9E0B000)
A >> Shm MMADM area (addr=000007DF62459340 leng=22612032 end=000007DF639E9B80)
A >> Shm MMDAT area (addr=000007DF639EA000 leng=1447170048 end=000007DFB9E0B000)
A RFC Destination> destination baiodevcct_QA1_00 host baiodevcct system QA1 systnr 0 (baiodevcct_QA1_00)
A RFC Options> H=baiodevcct,S=00,d=2,
B dbrda: Redirect database access is disabled via rsdb/rda profile parameter setting.
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>' [SYBASE:741.10]):
B max_blocking_factor = 50, min_blocking_factor = 1,
B max_in_blocking_factor = 128, min_in_blocking_factor = 1,
B max_union_blocking_factor = 50, min_union_blocking_factor = 1,
B prefer_union_all = 0, prefer_join = 0,
B prefer_fix_blocking = 0, prefer_in_itab_opt = 1,
B convert AVG = 1, alias table FUPD = 0,
B escape_as_literal = 0,
B select * =0x0f, character encoding = STD / []:X,
B use_hints = abap->1, dbif->0x1, upto->0
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: 741, [7410.0.225.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)=="G:\usr\sap\QA1\DVEBMGS00/sec"
N
N =================================================
N === SSF INITIALIZATION:
N ===...SSF Security Toolkit name SAPSECULIB .
N ===...SSF library is G:\usr\sap\QA1\DVEBMGS00\exe\sapcrypto.dll .
N ===...SSF default hash algorithm is SHA1 .
N ===...SSF default symmetric encryption algorithm is AES128-CBC .
N ===...SSF lib codepage is set to 1 .
N ===...SECUDIR="G:\usr\sap\QA1\DVEBMGS00/sec"
N ===...loading of Security Toolkit successfully completed.
N === CommonCryptoLib (SAPCRYPTOLIB) Version 8.4.22 pl40 (Jul 23 2014) MT-safe
N =================================================
N
N Tue Jul 19 14:40:57 2016
N SignInit: successfully obtained handle for Security Context cache
N SPNegoInit: SPNego disabled ("spnego/enable" not set to 1)
M JrfcVmcRegisterNativesDriver o.k.
E EnqId_Initialize: local EnqId initialization o.k.
M ThrtAmcInit: use DB table AMC_RECEIVER for AMC dispatching
A
A Tue Jul 19 14:40:58 2016
A AppServerTimeSync, checkLocalTime():
A Initializing local WP variables:
A zdate_LastLocalTime with 1468919458
A zdate_LastLocalBias with 0
A ***GENER* Trace switched off ***
B DBREPO: MAJOR_VERS part of REPOLOAD primary key
B DBREPO: set new access functions for table REPOLOAD
E
E Tue Jul 19 14:41:02 2016
E Enqueue Info: enque/use_pfclock2 = FALSE
S found spool memory service RSPO-ACTIONS at 0000000062AEA470
M
M Tue Jul 19 14:41:33 2016
M SecAudit(rsauinit): WP attached to existing shared memory.
M SecAudit(RsauShmInit): addr of SHM for Audit.. = 00000000002A0050
M SecAudit(RsauShmInit): addr of RSAUSHM........ = 00000000002A1050
M SecAudit(RsauShmInit): addr of RSAUSLOTINFO... = 00000000002A1D90
M SecAudit(RsauShmInit): addr of RSAUSLOTS...... = 00000000002A1DA0
B
B Tue Jul 19 14:47:02 2016
B dbsync[db_syexe]: { wait=0, call_no=2, current_ts=20160719144702, last_counter=2145094697
B
B Tue Jul 19 14:49:02 2016
B dbsync[db_syexe]: { wait=0, call_no=3, current_ts=20160719144902, last_counter=2145094697
D
D Tue Jul 19 14:49:35 2016
D GuiStatus: table test
D GuiStatus set generate inline ts >20160719091935,197<
C ERROR: -1 in function ExeNormalModify (execute) [line 25020]
C (587) [ZZZZZ] [SAP][ASE ODBC Driver][Adaptive Server Enterprise]Identity value overflow for fi
C eld 'SEQNUMBER' in table 'DDLOG'.
C
C sql statement is ==> INSERT INTO DDLOG ( TIMESTAMP, SYSTEMID, NBLENGTH, NOTEBOOK) VALUES ( ? , ? , ?
C , ? )
C /* R3:D:/depot/bas/741_REL/src/krn/dbi/dbs/dbs:566 T:DDLOG M:000 */
C
C transaction aborted by server
B ***LOG BY4=> sql error 587 performing INS on table DDLOG [dbsynseq 587]
B ***LOG BY0=> [ASE Error SQL587][SAP][ASE ODBC Driver][Adaptive Server Enterprise]Identity value overflow for field 'SEQNUMBER' in table 'DDLOG'.
[dbsynseq 587]
B ***LOG BZY=> unexpected return code 2 calling ins_ddlog [dbsync 1399]
B db_syflush (TRUE) failed
B db_con_commit received error 1024 in before-commit action (con_hdl = 0, th_commit = 1, returning 8
M ***LOG R38=> ThICommit, db_commit98 ( 001024) [thDatabase.c 432]
M ***LOG R18=> ThISendRequest, ThICommit () [thRequest.c 3762]
M in_ThErrHandle: 1
M *** ERROR => ThISendRequest: ThICommit (step TH_WORK_SYNC, thRc ERROR-DB-COMMIT_ERROR, action RESTART_WP, level 1) [thxxhead.c 2358]
M {root-id=40F2E99D447A1ED693B23CCC7F5D4359}_{conn-id=00000000000000000000000000000000}_0
M ThIErrHandle: set thRc ERROR-DB-COMMIT_ERROR for T0_U187_M0
M ThResetEmMagic: reset em magic for T0_U187_M0_I0
M
M Info for wp 0
M
M pid = 5552
M severity = 0
M status = 0
M stat = WP_RUN
M waiting_for = NO_WAITING
M workerType = DP_WORKER_DIAWP
M currentSession = T0_U187_M0
M lastSession = T0_U185_M6
M act_cs_count = 0
M csTrack = 0
M csTrackRwExcl = 0
M csTrackRwShrd = 0
M mode_cleaned_counter = 0
M control_flag = 0
M report = >SAPLTHFB <
M action = 0
M tab_name = > <
M
M Info for Session T0_U187_M0_I0
M
M tm state = 2
M uid = 187
M term type = 0x1
M withDisplay = 0x1
M cpic_no = 0
M cpic_idx = -1
M usr = > <
M terminal = >dell-PC <
M client = >000<
M appc_tm_conv_idx = -1
M allowCreateMode = YES
M blockSoftCanel = NO
M Session Resources:
M HEAD: adr/max_elems/act_elems/tbl = 000000000C057DF0/0/0/0000000000000000
M imode = 0
M is_cancelled = NO
M ThrtGetTaskTypeOfSession: taskType of T0_U187_M0: THRT_TASK_DIA
M task_type = THRT_TASK_DIA
M thRc = Internal error, session terminated (16797705)
M detachReason = DP_DETACH_REASON_GUI
M async_receives = 0
M em handle = 0
M abap session state = DP_SES_ATTACHED
M em state = DP_EM_ATTACHED
M resetReason = 0
M softcancel = 0
M cancelInitiator = INVALID
M cleanupMethod = DP_DEFAULT_CLEANING
M master hook = invalid T-1_M255
M slave hook = invalid T-1_M255
M debuggingActive = 0
M tcode = > <
M act_wp = 0
M last_wp = 0
M client conversation_ID = > <
M server conversation_ID = > <
M lock = 0
M max enq infos = 0
M act enq infos = 0
M em_hyper_hdl = 000007DFB9E4CF40
M plugin_info = NULL
M act_plugin_hdl = -1
M act_plugin_no = 0
M max_plugin_no = 0
M Context Resources:
M HEAD: adr/max_elems/act_elems/tbl = 000000000C048C80/0/0/0000000000000000
M ThSelPrintMask: selMask at 000007DFB9E1D1E0 level 0, T0_U187_M0:
M item 0
M handler = REQ_HANDLER_GUI
M
M
M ThIErrHandle: current incoming request:
M
M rq_id 8231
M -IN-- ca_blk 0 len 110
M -IN-- sDataLen 20 sData 64656C6C2D504300000000006823480700000000
M -IN-- reqHdlId REQ_HANDLER_GUI
M -IN-- sender address:
M -IN-- type LOCAL
M -IN-- agentType TERMINAL
M -IN-- session T0_U187_M0
M -IN-- receiver address:
M -IN-- type LOCAL
M -IN-- agentType WORKER workerTyp DIA
M -IN-- session T0_U187_M0
M
M *****************************************************************************
M *
M * LOCATION SAP-Server baiodevcct_QA1_00 on host baiodevcct (wp 0)
M * ERROR ThISendRequest: ThICommit
M *
M * TIME Tue Jul 19 14:49:35 2016
M * RELEASE 741
M * COMPONENT Taskhandler
M * VERSION 1
M * RC 16797705
M * MODULE D:/depot/bas/741_REL/src/krn/si/th/thxxhead.c
M * LINE 2544
M * COUNTER 1
M *
M *****************************************************************************
M
M PfRejectStatistic: clear statistic record
M PfClearAllRec: clear statistic area
M PfClearAllRec: statRecordAction = STAT_RECORD_ACTION_REJECT
M Entering TH_CALLHOOKS
M ThCallHooks: call hooks for event BEFORE_DUMP
M ThCallHooks: call hook >TrThHookFunc< for event BEFORE_DUMP
M TrThHookFunc: called for WP dump
M ThCallHooks: call hook >ThrBtcCallLgCl< for event BEFORE_DUMP
M ThCallHooks: call hook >ThrSaveSPAFields< for event BEFORE_DUMP
M ThrSaveSPAFields: save spa fields
M ThIErrHandle: entering ThSetStatError
M PfSetError: clear statistic record
M PfClearAllRec: clear statistic area
M PfClearAllRec: statRecordAction = STAT_RECORD_ACTION_REJECT
C -> SybBreak
C SybBreak 0
B db_sqlbreak() = 15
M *** WARNING => ThCallDbBreak: db_sqlbreak failed (16388), caller=ThIErrHandle
M ThIErrHandle: action is RESTART_WP, skip rollback
M ThIErrHandle: do not call ThrCoreInfo (no_core_info=0, in_dynp_env=1)
M ThIErrHandle: Entering ThReplyToMsg
M ThIErrHandle: Entering ThErrHdlUser
M ThErrHdlUser: set thRc (ERROR-DB-COMMIT_ERROR)
M ThErrHdlUser: detach session
M ThSessionDetach: detach session of T0_U187_M0 (em_hdl=0)
M ThSessionDetach: call ab_rollout
M ThSessionDetach: act abap state of T0_U187_M0 is DP_SES_DETACHED
M ThSessionDetach: act em state of T0_U187_M0 = DP_EM_DETACHED
M ThSetDetachTime: detached session of T0_U187_M0 in 378 us
M ThSessionDetach: detach o.k.
M DpWpSetExtraAction: extraAction of W0=WP_ROLL_IN_AFTER_DUMP (after DP_BIT_OR) [thxxhead.c:2951]
M call ThrShutDown ...
B Disconnecting from ALL connections:
B Wp Hdl ConName ConId ConState TX BC OC HC PRM RCT INF TIM MAX OPT Date Time DBHost Program
B 000 000 R/3 000000000 ACTIVE YES NO 000 NO YES NO NO 000 255 255 20160719 144047 baiodevcct
C DbSlDisconnect hdl: 0
B Disconnected from connection 0
B statistics db_con_commit (com_total=117, com_tx=26)
B statistics db_con_rollback (roll_total=2, roll_tx=0)
M ***LOG Q02=> wp_halt, WPStop (Workp. 0 5552) [dpnttool.c 335]
---------------------------------------------------
trc file: "dev_w0", trc level: 1, release: "741"
---------------------------------------------------
*
* ACTIVE TRACE LEVEL 1
* ACTIVE TRACE COMPONENTS all, MJ
*
M sysno 00
M sid QA1
M systemid 562 (PC with Windows NT)
M relno 7410
M patchlevel 0
M patchno 225
M intno 20020600
M make multithreaded, Unicode, 64 bit, optimized
M profile \\baiodevcct\sapmnt\QA1\SYS\profile\QA1_DVEBMGS00_baiodevcct
M pid 3596
M
M
M Tue Jul 19 14:49:43 2016
M kernel runs with dp version 216000(ext=117000) (@(#) DPLIB-INT-VERSION-216000-UC)
M length of sys_adm_ext is 500 bytes
M ***LOG Q0Q=> tskh_init, WPStart (Workp. 0 3596) [dpInit.c 748]
M DpCommonParamInit: rdisp/core_file_size = default --> no change
I MtxInit: 0 0 0
M
M Tue Jul 19 14:49:44 2016
M DpIPCInit2: read dp-profile-values from sys_adm_ext
M DpShMCreate: alloate/attach shared memory (mode=ATTACH)
M DpShMCreate: sizeof(wp_adm) 23184 (1104)
M DpShMCreate: sizeof(tm_adm) 13040880 (64880)
M DpShMCreate: sizeof(ca_adm) 432000 (72)
M DpCommTableSize: max/headSize/ftSize/tableSize=500/16/1832064/1951152
M DpShMCreate: sizeof(comm_adm) 1951152 (3648)
M DpSlockTableSize: max/headSize/ftSize/fiSize/tableSize=0/0/0/0/0
M DpShMCreate: sizeof(slock_adm) 0 (296)
M DpFileTableSize: max/headSize/ftSize/tableSize=0/0/0/0
M DpShMCreate: sizeof(file_adm) 0 (80)
M DpSockTableSize: max/headSize/ftSize/tableSize=500/16/520064/520080
M DpShMCreate: sizeof(sock_adm) 520080 (1016)
M DpShMCreate: sizeof(vmc_adm) 0 (3208)
M DpShMCreate: sizeof(wall_adm) (ft=41664/fi=67472/hd=64/rec=192)
M DpShMCreate: sizeof(amc_rec_adm) (ft=86464/fi=67472/hd=64/rec=416)
M DpShMCreate: sizeof(websocket_adm) (ft=28864/hd=64/rec=272)
M DpShMCreate: sizeof(gw_adm) 64
M DpShMCreate: sizeof(j2ee_adm) 3936
M DpShMCreate: SHM_DP_ADM_KEY (addr: 000000000C210050, size: 16369648
M DpShMCreate: allocated sys_adm at 000000000C210250
M DpShMCreate: allocated wp_adm_list at 000000000C222100
M DpShMCreate: allocated wp_adm at 000000000C222420
M DpShMCreate: allocated tm_adm_list at 000000000C2280B0
M DpShMCreate: allocated tm_adm at 000000000C2282F0
M DpShMCreate: allocated ca_adm at 000000000CE981E0
M DpShMCreate: allocated comm_adm at 000000000CF01B60
M DpShMCreate: system runs without slock table
M DpShMCreate: allocated sock_adm at 000000000D0DE310
M DpShMCreate: allocated vmc_adm_list at 000000000D15D4A0
M DpShMCreate: system runs without VMC
M DpShMCreate: allocated gw_adm at 000000000D15D740
M DpShMCreate: allocated j2ee_adm at 000000000D15D980
M DpShMCreate: allocated ca_info at 000000000D15EAE0
M DpShMCreate: allocated wall_adm (ft) at 000000000D15ED20
M DpShMCreate: allocated wall_adm (fi) at 000000000D1691E0
M DpShMCreate: allocated wall_adm (head) at 000000000D179B70
M DpShMCreate: allocated amc_rec_adm (ft) at 000000000D179DB0
M DpShMCreate: allocated amc_rec_adm (fi) at 000000000D18F170
M DpShMCreate: allocated amc_rec_adm (head) at 000000000D19FB00
M DpShMCreate: allocated websocket_adm (ft) at 000000000D19FD40
M DpShMCreate: allocated websocket_adm (head) at 000000000D1A7000
M DpShMCreate: initialized 21 eyes
M DpCommAttachTable: attached comm table (header=000000000CF01B60/ft=000000000CF01B70/fi=000000000D0C0FF0)
M DpSockAttachTable: attached sock table (header=000000000D0DE310/ft=000000000D0DE320)
X EmInit: MmSetImplementation( 2 ).
X MM global diagnostic options set: 0
X <ES> client 0 initializing ....
X <ES> EsILock: use Mutex for locking
X Using implementation view
X <EsNT> Using memory model view.
M <EsNT> Memory Reset disabled as NT default
X ES initialized.
X mm.dump: set global maximum dump mem to 192 MB
X EsRegisterEmCheck: Register EmGetEsHandles at 00007FF608411C90
M ThStart: taskhandler started
M ThInit: initializing DIA work process W0
X MMX: use precise segment size globally
M rdisp/sapgui_data_trace : 1 -> 1
M ThInit: found previous user T0_U0_M187
M
M Tue Jul 19 14:49:45 2016
M ThInit: running on host baiodevcct
I MtxInit: 0 0 0
M calling db_connect ...
B Loading DB library 'G:\usr\sap\QA1\DVEBMGS00\exe\dbsybslib.dll' ...
B Library 'G:\usr\sap\QA1\DVEBMGS00\exe\dbsybslib.dll' loaded
B Version of 'G:\usr\sap\QA1\DVEBMGS00\exe\dbsybslib.dll' is "741.10", patchlevel (0.111)
C trace file set
C Callback functions for dynamic profile parameter registered
B read_con_info_ssfs(): DBSL supports extended connect protocol
B ==> connect info for default DB will be read from ssfs
C dbs/syb/bcddec: FALSE
C dbs/syb/fetchArraySize: 1000
C database is local: connect_timeout: 3
C Thread ID:2496
C lib_dbsl 741 10/21/2014 16:59:00
C connection unquiesced
C Using dynamic link library 'G:\usr\sap\QA1\DVEBMGS00\exe\dbsybslib.dll'
C dbsybslib.dll patch info
C SAP patchlevel 0
C SAP patchno 201
C Last SYBASE DBSL patchlevel 0
C Last SYBASE DBSL patchno 111
C Last SYBASE DBSL patchcomment SYB: stat stack overflow (2080663)
C
C Tue Jul 19 14:49:46 2016
C spid 130 comm rd ODBC
C spid 218 unc rd ODBC
C Driver: Adaptive Server Enterprise Driver release: 15.7.0.1260
C Driver full version: SAP ASE ODBC Driver/15.7/SP126 PL/P/AMD64/Windows/drvmain/Build 1260/64-bit/Normal/Sun Apr 13 UTC 20:37:36 2014/SQLLEN8
C Driver uses SQLLEN8
C dbs/syb/cache_size: 200
C GetServerInfo version: Adaptive Server Enterprise/15.7/EBF 22777 SMP SP122 /P/X64/Windows Server/ase157sp12x/3662/64-bit/OPT/Sat Apr 19 01:26:01 2014
C GetServerInfo release: 15.7.0.122
C GetServerInfo architecture: x86_64
C GetServerInfo edition: P
C GetServerInfo byte width: 64 bit
C DbSlConnect hdl: 0
C trace file set
B Connection 0 opened (DBSL handle 0)
M ThDbConnect: db_connect o.k.
X EmInit: MmSetImplementation( 2 ).
X MM global diagnostic options set: 0
X <ES> client 0 initializing ....
X Using implementation view
X ES initialized.
X mm.dump: set global maximum dump mem to 192 MB
X EsRegisterEmCheck: Register EmGetEsHandles at 00007FF608411C90
B
B Tue Jul 19 14:49:47 2016
B db_con_shm_ini: WP_ID = 0, WP_CNT = 21, CON_ID = -1
B Start CursorInit
B TBI initializing lock manager ...
B TBI locking : multiple locks
B TBI lock manager impl: semamphore
B dbtbxbuf: Buffer TBI64 (addr: 0000000059100140, size: 4033333520, end: 000000014977CA50)
B DBI: init TBI BUFFER (data): start=000007DE5E701000 length=3899659264 end=000007DF46E02400
B dbprotocol: table logging switched off for all clients
B DbModifyHelper::maxItabInvalidationThreshold = 20
B dbsync[db_syinit]: successfully attached to shared memory, sync_adm_p = 0000000000AF0050
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 = 2145094697
B oldest_gap = (2147483647,19700101053000)
B time_of_last_sync = 20160719144902
B MySysId = 'baiodevcct 00'
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 = 21
B blockSize = 512
B maxObjects = 335060
B maxObjectSize = 311604352
B freeListVectorSize = 489
B hashVectorSize = 670129
B bufferSize = 1372407808
B maxBlocks = 2434409
B freeBlocksCnt = 2434390
B mutexVectorSize = 670131, ADMIN_MUTEX = 670129, INVAL_MUTEX = 670130
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 = 21
B blockSize = 512
B maxObjects = 2000
B maxObjectSize = 859648
B freeListVectorSize = 17
B hashVectorSize = 4001
B bufferSize = 4194304
B maxBlocks = 6716
B freeBlocksCnt = 6716
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 = 21
B blockSize = 512
B maxObjects = 2000
B maxObjectSize = 577920
B freeListVectorSize = 587
B hashVectorSize = 4001
B bufferSize = 3072000
B maxBlocks = 4515
B freeBlocksCnt = 4298
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 = 21
B blockSize = 256
B maxObjects = 2000
B maxObjectSize = 859584
B freeListVectorSize = 33
B hashVectorSize = 4001
B bufferSize = 4194304
B maxBlocks = 13431
B freeBlocksCnt = 13431
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: 0000000061BA0050, size: 4400000)
M ThCreateNoBuffer allocated 548152 bytes for 1000 entries at 0000000000B80050
M ThCreateNoBuffer index size: 3000 elems
M ThCreateVBAdm allocated 33376 bytes (50 server) at 0000000000C10050
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
G Tue Jul 19 14:49:48 2016
G RelWritePermissionForShm( pLocation = 120, pEnforce = 0 )
G GetWritePermissionForShm( pLocation = 99, pEnforce = 1 )
G RelWritePermissionForShm( pLocation = 100, pEnforce = 1 )
S *** init spool environment
S TSPEVJOB updates outside critical section: event_update_nocsec = 1
S initialize debug system
T Stack direction is downwards.
T debug control: prepare exclude for printer trace
T new memory block 0000000004058DC0
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
S found processing queue enabled
S found spool memory service RSPO-RCLOCKS at 0000000062BE00D0
S doing lock recovery
S setting server cache root
S found spool memory service RSPO-SERVERCACHE at 0000000062BE0730
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 43684 bytes at 0000000000C20050
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 ***GENER* Trace switched on ***
A
A ---PXA-------------------------------------------
A PXA INITIALIZATION
A PXA: increasing number of fragments to stay below recommended size of 2GB
A PXA: Locked PXA-Semaphore.
A System page size: 4kb, total admin_size: 1020868kb, dir_size: 145332kb.
A Attached to PXA (address 00007FFCA4FD0050 - 00007FFFFFFD0050, size 14073856K, 7 fragments of 1864712K )
A *** using a guard page at PXA start to protect parameters and release info ***
A abap/pxa = shared protect gen_remote
A PXA: checking structure sizes: 760|272|16
A PXA INITIALIZATION FINISHED
A ---PXA-------------------------------------------
A
A ATRA: pfclock execution time = 0
A abap/force_local_update_task=0
A ABAP ShmAdm attached (addr=000007DF4760F000 leng=1920974848 end=000007DFB9E0B000)
A >> Shm MMADM area (addr=000007DF62459340 leng=22612032 end=000007DF639E9B80)
A >> Shm MMDAT area (addr=000007DF639EA000 leng=1447170048 end=000007DFB9E0B000)
A RFC Destination> destination baiodevcct_QA1_00 host baiodevcct system QA1 systnr 0 (baiodevcct_QA1_00)
A RFC Options> H=baiodevcct,S=00,d=2,
B dbrda: Redirect database access is disabled via rsdb/rda profile parameter setting.
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>' [SYBASE:741.10]):
B max_blocking_factor = 50, min_blocking_factor = 1,
B max_in_blocking_factor = 128, min_in_blocking_factor = 1,
B max_union_blocking_factor = 50, min_union_blocking_factor = 1,
B prefer_union_all = 0, prefer_join = 0,
B prefer_fix_blocking = 0, prefer_in_itab_opt = 1,
B convert AVG = 1, alias table FUPD = 0,
B escape_as_literal = 0,
B select * =0x0f, character encoding = STD / []:X,
B use_hints = abap->1, dbif->0x1, upto->0
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: 741, [7410.0.225.20020600]
W ITS Plugin: Int.version, [34]
W ITS Plugin: Feature set: [34]
W ===... Calling itsp_Init in external dll ===>
W PpioRecoverLocks, table: 000007DFB9E4CA00
W PpioRecoverLocks, number of file locks 256
W PpioRecoverLocks: file lock set to: 0000000000000000
W PpioRecoverLocks: directory lock set to: 0000000000000000
W PpioRecoverLocks: global lock set to: 0000000000000000
W PpioRecoverLocks() done
W PprcRecoverLocks, table: 000007DFB9E4CEF0
W PprcRecoverLocks: directory lock set to: 0000000000000000
W PprcRecoverLocks() done
W === ipl_Init() returns 0, ITSPE_OK: OK
W =================================================
N VSI: WP init in ABAP VM completed with rc=0
N SsfSapSecin: getenv(SECUDIR)=="G:\usr\sap\QA1\DVEBMGS00/sec"
N
N =================================================
N === SSF INITIALIZATION:
N ===...SSF Security Toolkit name SAPSECULIB .
N ===...SSF library is G:\usr\sap\QA1\DVEBMGS00\exe\sapcrypto.dll .
N ===...SSF default hash algorithm is SHA1 .
N ===...SSF default symmetric encryption algorithm is AES128-CBC .
N ===...SSF lib codepage is set to 1 .
N ===...SECUDIR="G:\usr\sap\QA1\DVEBMGS00/sec"
N ===...loading of Security Toolkit successfully completed.
N === CommonCryptoLib (SAPCRYPTOLIB) Version 8.4.22 pl40 (Jul 23 2014) MT-safe
N =================================================
N
N Tue Jul 19 14:49:50 2016
N SignInit: successfully obtained handle for Security Context cache
N SPNegoInit: SPNego disabled ("spnego/enable" not set to 1)
M JrfcVmcRegisterNativesDriver o.k.
E EnqId_Initialize: local EnqId initialization o.k.
M ThrtAmcInit: use DB table AMC_RECEIVER for AMC dispatching
M ThCheckPrevUser: previous user was T0_U187_M0, clean counter TH_NO_CLEANUP
M ThCheckPrevUser: clean previous user T0_U187_M0_I0
M ThAlarm: set alarm to 60 sec
M
M Info for wp 0
M
M pid = 3596
M severity = 0
M status = 0
M stat = WP_NEW
M extraAction = WP_ROLL_IN_AFTER_DUMP
M waiting_for = NO_WAITING
M workerType = DP_WORKER_DIAWP
M currentSession = T0_U187_M0
M lastSession = T0_U187_M0
M act_cs_count = 0
M csTrack = 0
M csTrackRwExcl = 0
M csTrackRwShrd = 0
M mode_cleaned_counter = 1
M control_flag = 2000000
M report = >SAPLTHFB <
M action = 0
M tab_name = > <
M
M Info for Session T0_U187_M0_I0
M
M tm state = 2
M uid = 187
M term type = 0x1
M withDisplay = 0x1
M cpic_no = 0
M cpic_idx = -1
M usr = > <
M terminal = >dell-PC <
M client = >000<
M SESSION_CLEANED_COUNTER = TH_CLEANUP_WITH_FULL_ABAP_ATTACH
M appc_tm_conv_idx = -1
M allowCreateMode = YES
M blockSoftCanel = NO
M Session Resources:
M HEAD: adr/max_elems/act_elems/tbl = 000000000C237DF0/0/0/0000000000000000
M imode = 0
M is_cancelled = NO
M task_type = THRT_TASK_DIA
M thRc = Internal error, session terminated (16797705)
M detachReason = DP_DETACH_REASON_GUI
M async_receives = 0
M em handle = 0
M abap session state = DP_SES_DETACHED
M em state = DP_EM_DETACHED
M resetReason = 0
M softcancel = 0
M cancelInitiator = INVALID
M cleanupMethod = DP_DEFAULT_CLEANING
M master hook = invalid T-1_M255
M slave hook = invalid T-1_M255
M debuggingActive = 0
M tcode = > <
M act_wp = 0
M last_wp = 0
M client conversation_ID = > <
M server conversation_ID = > <
M lock = 0
M max enq infos = 0
M act enq infos = 0
M em_hyper_hdl = 000007DFB9E4CF40
M plugin_info = NULL
M act_plugin_hdl = -1
M act_plugin_no = 0
M max_plugin_no = 0
M Context Resources:
M HEAD: adr/max_elems/act_elems/tbl = 000000000C228C80/0/0/0000000000000000
M ThSelPrintMask: selMask at 000007DFB9E1D1E0 level 0, T0_U187_M0:
M item 0
M handler = REQ_HANDLER_GUI
M
M DpWpSetWaitingFor: W0 doesn't wait (NO_WAITING)
M ThCheckPrevUser: th_step = TH_WORK_SYNC
M DpIWpSetNewStat: switched W0 from WP_NEW to WP_RUN
M DpIWpSetNewStat: info for DIA: new/wait/run/hold/standby/killed = 0/9/1/0/0/0 wps
M ThCleanPrevUser: clean T0_U187_M0_I0, cleanup method DP_DEFAULT_CLEANING, clean counter TH_CLEANUP_WITH_FULL_ABAP_ATTACH
M DpWpSetExtraAction: extraAction of W0= (after DP_BIT_SET) [thxxhead.c:3274]
M ThCleanPrevUser: cleanup after dump, sitch to TH_CLEANUP_WITH_SHORT_ABAP_ATTACH
M RstrNotifyUserChange: user/client = ( /000)
M PfRejectStatistic: clear statistic record
M PfClearAllRec: clear statistic area
M PfClearAllRec: statRecordAction = STAT_RECORD_ACTION_REJECT
M ThGetAbapRollinLevel: return TH_CLEANUP_WITH_SHORT_ABAP_ATTACH
M ThCleanPrevUser: no full attach possible, switch to default cleanup
M ThISessionAttach: attach session of T0_U187_M0 (em_hdl = 0, abap rollin level = TH_ABAP_ROLL_IN_STORE)
M ThISessionAttach: act em state of T0_U187_M0 = DP_EM_ATTACHED
M ThCallHooks: call hooks for event AFTER_EM_SESSION_ATTACH
M SosISearchAnchor: found anchor 000007DFB9E2C870 for type/name 2/4
M SosISearchAnchor: found anchor 000007DFB9E30360 for type/name 2/5
M SosISearchAnchor: found anchor 000007DFB9E30460 for type/name 2/6
M SosISearchAnchor: found anchor 000007DFB9E381C0 for type/name 2/7
M SosISearchAnchor: found anchor 000007DFB9E7F850 for type/name 1/16
M SosISearchAnchor: found anchor 000007C9A1E00A90 for type/name 3/0
M SosISearchAnchor: found anchor 000007C9A1E036C0 for type/name 3/1
M SosISearchAnchor: found anchor 000007C9A1E046A0 for type/name 3/2
M SosISearchAnchor: found anchor 000007C9A1E0C3E0 for type/name 3/3
M SosISearchAnchor: found anchor 000007C9A1E0EC20 for type/name 3/4
M SosISearchAnchor: found anchor 000007C9A1E11460 for type/name 3/5
M SosISearchAnchor: found anchor 000007C9A1E11730 for type/name 3/6
M SosISearchAnchor: found anchor 000007C9A1E11A00 for type/name 3/7
M SosISearchAnchor: found anchor 000007C9A1E11AC0 for type/name 3/8
M SosISearchAnchor: found anchor 000007C9A1E11F20 for type/name 3/9
M SosISearchAnchor: found anchor 000007C9A1E122D0 for type/name 3/10
M ThCheckAfterRollIn: o.k.
M ThISessionAttachInternalSession: roll in abap store
M ThISessionAttachInternalSession: act abap state of T0_U187_M0 is DP_SES_ATTACHED
M ThCallHooks: call hooks for event AFTER_ROLL_IN
M TrThHookFunc: called for Rollin
M SosISearchAnchor: no anchor for type/name 1/5
M ThSwitchSapTrace: current OFF want OFF
M SosISearchAnchor: no anchor for type/name 1/13
M ThSetAttachTime: attached session of T0_U187_M0 in 399 us
M ThCallHooks: call hooks for event AFTER_SESSION_ATTACH
M PfAttachRecord: statRecordAction is STAT_RECORD_ACTION_REJECT, return
M ThSessionAttach: attach o.k.
M ThDeleteSession2: delete T0_U187_M0 with thRc ERROR-CORE-PROCESS_CRASHED
M ThTSCancel: set T0_U187_M0 in status cancelled
M DpSesSetLastRequestTime: set last req time 20160719 14:49:50 for T0_U187_M0
M ThDeleteThisSession: delete T0_U187_M0, thRc=16789514
M DpSesGetWorkerType: return workerType DIA for T0_U187
M DpRqCreate: creating REQ_HANDLER_SESSION request (rq_id 8272, slot 0)
M ThDeleteThisSession: jump back with reqHandlerId REQ_HANDLER_SESSION
M ThRqHandleWithShortJump: short jump with REQ_HANDLER_SESSION request (rq_id 8272)
M ThISelItemExists: item not found in selMask stack of T0_U187_M0 with 0 level
M ThISelItemExists: Stack of T0_U187_M0
M ThSelPrintMask: selMask at 000007DFB9E1D1E0 level 0, T0_U187_M0:
M item 0
M handler = REQ_HANDLER_GUI
M ThSelDelItem: item (REQ_HANDLER_SESSION / TH_SEL_MASK_NO_PARAM) not found in all selMasks of T0_U187_M0
M ThSelAllocateMask: allocated selMask for T0_U187_M0 (000007DFB9E1DB40, 260 bytes), maxMask 4096 maxItems 10
M ThSelPushLevel: new level is 1 for T0_U187_M0, (popOption=1)
M ThRqSetCheckSessionQueueImmediately: check session queue without select
M ThISelItemExists: item not found in selMask stack of T0_U187_M0 with 1 level
M ThISelItemExists: Stack of T0_U187_M0
M ThSelPrintMask: selMask of level 1 is empty
M ThSelPrintMask: selMask at 000007DFB9E1D1E0 level 0, T0_U187_M0:
M item 0
M handler = REQ_HANDLER_GUI
M ThSelAddItem: added 1 (hidden=0) item (REQ_HANDLER_SESSION / TH_SEL_MASK_NO_PARAM / hide=0) at index 0 of selMask level 1 (1 items) of T0_U187_M0
M ThSelPrintMask: selMask at 000007DFB9E1D1E0 level 1, T0_U187_M0:
M item 0
M handler = REQ_HANDLER_SESSION
M ThSelPrintMask: selMask at 000007DFB9E1D1E0 level 0, T0_U187_M0:
M item 0
M handler = REQ_HANDLER_GUI
M DpWpSetExtraAction: extraAction of W0=DP_NO_DYNAMIC_WP_CHECK (after DP_BIT_OR) [thRequest.c:788]
M ThRqSendAndRelease: sending REQ_HANDLER_SESSION request with TASK_SWITCH,SET_HOLD
M ThISendRequest: REQ_HANDLER_SESSION (rq_id 8272) from T0_U187_M0 user= to WORKER, thSendType=TASK_SWITCH,SET_HOLD(0x9))
M ThRqNeedsHandShake: sendtype is switch or hold, no handshake, counter is 0
M ThGetStrategy (task_switch=1, inline_hold=0, holdWp=1)
M ThrtGetStrategy: abap strategy ROLL / O.K.
M ThGetStrategy: hold wp, don't detach session
M ThNewWpStat (task_switch=1, hold=1)
M ThNewWpStat: strategy hold, set WP_HOLD
M ThISendRequest: new wp stat: WP_HOLD
M ThISendRequest: th_step = TH_WORK_NOSYNC
M DpRqSendRequestWithFilter: REQ_HANDLER_SESSION (rq_id 8272) from WORKER to WORKER
M rq_id 8272
M -OUT- ca_blk -1 len 0
M -OUT- prio HIGH
M -OUT- sDataLen 20 sData 030000000A3000010A3000010000000000000000
M -OUT- reqHdlId REQ_HANDLER_SESSION
M -OUT- sender address:
M -OUT- type LOCAL
M -OUT- agentType WORKER workerTyp DIA workerNum 0
M -OUT- session T0_U187_M0
M -OUT- receiver address:
M -OUT- type LOCAL
M -OUT- agentType WORKER workerTyp DIA
M -OUT- session T0_U187_M0
M RqQAddRequest: Add request rq_id 8272 (DIA) to queue <T0_U187_M0> in slot 31 at the beginning
M Dump of queue <T0_U187_M0> in slot 31 (1 requests, in use, port=0):
M -1 <- 1 (rq_id 8272, DIA, REQ_HANDLER_SESSION) -> -1
M RqQQueueGetNumberOfRequests: Queue <T0_U187_M0> in slot 31 contains 1 requests of type DIA
M DpRqPutIntoQueue: put request into DIA queue (workerType 1, prio HIGH, rq_id 8272), queue has 1 requests
M DpRqFree: freeing REQ_HANDLER_SESSION request (rq_id 8272, slot 0)
M ThTriggerTaskSwitch: trigger task switch
M ThTriggerTaskSwitch: th_step = TH_WORK_NOSYNC
M ThITriggerTaskSwitch: perform task switch
M ThPerformTaskSwitch: set inPrivMode = 0 for T0_U187_M0
M ThCallHooks: call hooks for event BEFORE_TASK_SWITCH
M PfTaskSwitch: handle event BEFORE_TASK_SWITCH
M PfTaskSwitch: record action is STAT_RECORD_ACTION_REJECT, return
M TrThHookFunc: called for task switch
M ThrtApcCleanup: handle event BEFORE_TASK_SWITCH
M ThWpHandleStateChange: new state of W0 is WP_HOLD (current state is WP_RUN)
M DpIWpSetNewStat: switched W0 from WP_RUN to WP_HOLD
M DpIWpSetNewStat: info for DIA: new/wait/run/hold/standby/killed = 0/9/0/1/0/0 wps
M ThWpHandleStateChange: new state of W0 is WP_HOLD
M ThWpHandleStateChange: skip dynamic wp check
M ThPerformTaskSwitch: return TH_HOLD_FOR_NEW_REQUEST
M TskhLoop: Got TaskHandlerMessage 2
M TskhLoopResetState: reset after request handling(ics=0)
M DpWpSetExtraAction: extraAction of W0= (after DP_BIT_AND) [thxxhead.c:1967]
M ThISelItemExists: item not found in selMask stack of T0_U187_M0 with 1 level
M paramType = TH_SEL_MASK_SNC_PARAM
M ThISelItemExists: Stack of T0_U187_M0
M ThSelPrintMask: selMask at 000007DFB9E1D1E0 level 1, T0_U187_M0:
M item 0
M handler = REQ_HANDLER_SESSION
M ThSelPrintMask: selMask at 000007DFB9E1D1E0 level 0, T0_U187_M0:
M item 0
M handler = REQ_HANDLER_GUI
M
M ********* W0 LOOP (DIA) *********
M ThRqAcceptImpl (called_inline=0, timeout=-1)
M ThrtSetFirstRequestOfSession: set false for T0_U187_M0
M ThRqAcceptImpl: keep time slice
M ThRqWaitFor: wait for next request (timeout=-1)
M ThRqWaitFor: wait for request
M ThRqCheckQueues: check queues in W0 with state WP_HOLD, timeout=-1
M NiICreateHandle: hdl 193 state NI_INITIAL_CON
M NiIInitSocket: set default settings for new hdl 193/sock 1468 (I4; DG)
M NiDgHdlCreateForProto: state of hdl 193 NI_DG_UNCONNECTED
M NiISetSockOpt: set option SOL_SOCKET-SO_REUSEADDR of hdl 193 to FALSE
M NiIBind: hdl 193 bound to 127.0.0.1:59189
M NiIBlockMode: set blockmode for hdl 193 FALSE
M RqQQueueGetSelectableHandle: Queue <W0> in slot 5 has selectable hdl 193 (port=59189) and W0
M NiICreateHandle: hdl 201 state NI_INITIAL_CON
M NiIInitSocket: set default settings for new hdl 201/sock 1476 (I4; DG)
M NiDgHdlCreateForProto: state of hdl 201 NI_DG_UNCONNECTED
M NiISetSockOpt: set option SOL_SOCKET-SO_REUSEADDR of hdl 201 to FALSE
M NiIBind: hdl 201 bound to 127.0.0.1:59190
M NiIBlockMode: set blockmode for hdl 201 FALSE
M RqQQueueGetSelectableHandle: Queue <T0_U187_M0> in slot 31 has selectable hdl 201 (port=59190) and W0
M NiICreateHandle: hdl 209 state NI_INITIAL_CON
M NiIInitSocket: set default settings for new hdl 209/sock 1480 (I4; DG)
M NiDgHdlCreateForProto: state of hdl 209 NI_DG_UNCONNECTED
M NiISetSockOpt: set option SOL_SOCKET-SO_REUSEADDR of hdl 209 to FALSE
M NiIConnectSocket: connection of hdl 209 established to 127.0.0.1:59190
M NiDgHdlConnect: state of hdl 209 NI_DG_CONNECTED
M RqQQueueNotifySelectableHandleAsync: Created new NI connection for queue <T0_U187_M0> in slot 31 on port 59190 (59191)
M RqQQueueNotifySelectableHandleAsync: Signal selectable handle for queue <T0_U187_M0> in slot 31 on port 59190 (id=0)
M NiDgHdlSend: hdl 209 sent 1 of 1 bytes to 127.0.0.1:59190
M ThRqGetSessionQueueSelectHandle: return selectable hdl 201 for session queue 31 (T0_U187_M0)
M ThRqCheckQueuesCreateSelectSet: added selection handle 201 for session queue to select set
M ThRqResetCheckSessionQueueImmediately: reset immediate session queue check
M RqQQueueGetNumberOfRequests: Queue <T0_U187_M0> in slot 31 contains 1 requests of type DIA
M ThRqGetLengthOfSessionQueue: session queue of T0_U187_M0 has 1 requests
M ThRqCheckQueues: Check session queue without select
M ThRqCheckQueuesHandleUserQueue: -------------> Check requests in queue
M NiDgHdlRecvFrom: hdl 201 received 1 bytes from 127.0.0.1:59191
M RqQQueueGetRequest: Eat one selectable handle wakeup (id=0), 1. receive
M RqQQueueGetRequest: Eat selectable handle wakeup for queue <T0_U187_M0> in slot 31 (before cs)
M RqQQueueGetRequest: Get request of queue <T0_U187_M0> in slot 31 (timeout=0)
M ThRqCheckRequestFunc: Check rq_id 8272
M ThIsAsyncInput (T0_U187_M0_I0, P-1, C-1, data=0000000000000000, rq_id 8272, respId 0..)
M reqHandlerId=REQ_HANDLER_SESSION (74)
M ThSelReqInfoForHandler: search item (REQ_HANDLER_SESSION / TH_SEL_MASK_NO_PARAM / --) in selMask stack level 1 of T0_U187_M0
M ThISelItemExists: found item 0 (REQ_HANDLER_SESSION / TH_SEL_MASK_NO_PARAM / hide=0) in selMask level 1, T0_U187_M0
M ThSelReqInfoForHandler: return TH_SEL_REQ_PROCESS
M ThSelDelItemWithIndex: delete item 0 (REQ_HANDLER_SESSION / TH_SEL_MASK_NO_PARAM) in selMask level 1 with 1 items (hidden=0), T0_U187_M0
M handler = REQ_HANDLER_SESSION
M ThRqSetCheckSessionQueueImmediately: check session queue without select
M ThSelRestoreMask: pop selMask level 1 of T0_U187_M0
M ThRqSetCheckSessionQueueImmediately: check session queue without select
M ThSelPopLevel: set selMask level 0 for T0_U187_M0
M ThSelPrintMask: selMask at 000007DFB9E1D1E0 level 0, T0_U187_M0:
M item 0
M handler = REQ_HANDLER_GUI
M ThIsAsyncInput: process request REQ_HANDLER_SESSION, rq_id 8272
M RqQRequestFree: Free request in slot 1 (rq_id 8272)
M RqQQueueGetRequest: Request rq_id 8272 found in queue <T0_U187_M0> in slot 31
M rq_id 8272
M -IN-- ca_blk -1 len 0
M -IN-- prio HIGH
M -IN-- sDataLen 20 sData 030000000A3000010A3000010000000000000000
M -IN-- reqHdlId REQ_HANDLER_SESSION
M -IN-- sender address:
M -IN-- type LOCAL
M -IN-- agentType WORKER workerTyp DIA workerNum 0
M -IN-- session T0_U187_M0
M -IN-- receiver address:
M -IN-- type LOCAL
M -IN-- agentType WORKER workerTyp DIA
M -IN-- session T0_U187_M0
M DpRqCopyAndMoveData: copying REQ_HANDLER_SESSION request (rq_id 8272, slot 1)
M ThRqCheckQueuesHandleUserQueue: <------------- Check requests in queue
M ThRqCheckQueuesHandleUserQueue: Got rq_id 8272 from user queue
M ThWpSetCurrentSession: set WP's current session to T0_U187_M0_I0 (rq_cnt 1, last wp 0, last rq_id 8231)
M ThRqAcceptImpl: keep time slice
M DpWpSetWaitingFor: W0 doesn't wait (NO_WAITING)
M ThRqAcceptImpl: received req for current task at timestamp 1468919990/995000, queueTime 0 usec
M DpIWpSetNewStat: switched W0 from WP_HOLD to WP_RUN
M DpIWpSetNewStat: info for DIA: new/wait/run/hold/standby/killed = 0/9/1/0/0/0 wps
M ThRqAcceptImpl: new state of W0 is WP_RUN
M ThHdlControl: handle control 0X2000000
M DpICtlSetForWp: switch off control 0xffffffff for W0 (0x2000000 -> 0x0)
M DpCtlSetForSession: switch off control 0xffffffff for T0_U187_M0 (0x0 -> 0x0)
M ThRqAcceptImpl: accept rq_id 8272 for T0_U187_M0_I0 recv 1
M User Tname: dell-PC prot=DP_PLUGIN_PROTOCOL_NONE:
M
M rq_id 8272
M -IN-- ca_blk -1 len 0
M -IN-- prio HIGH
M -IN-- sDataLen 20 sData 030000000A3000010A3000010000000000000000
M -IN-- reqHdlId REQ_HANDLER_SESSION
M -IN-- sender address:
M -IN-- type LOCAL
M -IN-- agentType WORKER workerTyp DIA workerNum 0
M -IN-- session T0_U187_M0
M -IN-- receiver address:
M -IN-- type LOCAL
M -IN-- agentType WORKER workerTyp DIA
M -IN-- session T0_U187_M0
M
M RstrNotifyUserChange: user/client = ( /000)
M ThRqAcceptImpl: th_step = TH_WORK_SYNC
M ThRqSetCurrentRequest: making REQ_HANDLER_SESSION request (rq_id 8272) the current incoming request
M ThReceive: received SESSION request
M TskhLoop: received SESSION request (rq_id 8272)
M DpSesSetPrepareReqHandler: set prepare request attribute for T0_U187_M0
M ThHandleRequest: call prepare request SessionHandler for SESSION request
M ThCallHooks: call hooks for event PREPARE_REQUEST
M ThDtTraceStart:
M {root-id=40F2E99D447A1ED693B23CCC7F5D4359}_{conn-id=00000000000000000000000000000000}_0
M ThISessionAttach: act em state of T0_U187_M0 is DP_EM_ATTACHED, return
M ThSessionAttach: attach o.k.
M DpSesSetPrepareReqHandler: unset prepare request attribute for T0_U187_M0
M ThHandleRequest: call handler SessionHandler for SESSION request
M SessionHandler: handling SESSION request
M SessionHandler::handleRequest: handle opcode DP_SES_OPCODE_INTERNAL_DELETE_SESSION
M SessionHandler::handleRequest: delete T0_U187_M0 (thRc = ERROR-CORE-PROCESS_CRASHED)
M ThrtSetIsDynpSession: T0_U187_M0 is not a dynp session
M ThCheckMemoryState (return_after_error=1, afterDump=0)
M ThIDeleteSubSession (0, 0, 3, ><, 0, 255, TRUE)
M ThIDeleteSubSession: no modes found ..
M no sub modes
M ThPerformDeleteThisSession: switch off statistics
M PfSetError: clear statistic record
M PfClearAllRec: clear statistic area
M PfClearAllRec: statRecordAction = STAT_RECORD_ACTION_REJECT
M ThPerformDeleteThisSession: set status of T0_U187 to DP_LOGON_STATE_LOGGING_OFF
M ThPerformDeleteThisSession: last active mode (0) delete tid (0)
M ThPerformLogoff (thRc=ERROR-CORE-PROCESS_CRASHED)
M ThGetDbAction: thRc is 16789514, return TH_DB_ROLLBACK
M ThCheckMemoryState (return_after_error=1, afterDump=0)
M ThPerformLogoff: set status of T0_U187 to DP_LOGON_STATE_LOGGING_OFF
M ThFinalizeSession: finalize T0_U187_M0
M ThResFreeSession: free resources of T0_U187_M0 (normal mode, complete free), rc=ERROR-CORE-PROCESS_CRASHED, db_action=TH_DB_ROLLBACK
M ThCallEndOfSessionHooks: call BEFORE_SESSION_CANCEL hooks for T0_U187_M0
M ThCallHooks: call hooks for event BEFORE_SESSION_CANCEL
M ThrtGetTaskTypeOfSession: taskType of T0_U187_M0: THRT_TASK_DIA
M SosISearchAnchor: no anchor for type/name 1/13
M SosISearchAnchor: no anchor for type/name 1/14
M SosISearchAnchor: no anchor for type/name 1/15
M SosISearchAnchor: no anchor for type/name 1/15
M ThrtDbgSetDebugMode2: switch off debugging for T0_U187_M0
M SosISearchAnchor: no anchor for type/name 1/14
M SosISearchAnchor: no anchor for type/name 1/15
M SosISearchAnchor: no anchor for type/name 1/15
M ThrtDbgSetDebugMode2: switch off debugging for T0_U187_M0
M ThrtDestroySessionContainer: destroy session container of T0_U187_M0
M ThrtClearSessionAttributesOfSession: attributes of T0_U187_M0 =
M ThrtGuiDeleteScreen: skip non logoff request in logon state DP_LOGON_STATE_LOGGING_OFF
M ThrtApcCleanup: handle event BEFORE_SESSION_CANCEL
M SosISearchAnchor: no anchor for type/name 1/1
M ThCallEndOfSessionHooks: return
M ThIRollBack: call db_rollback
M ThCheckComOrRb (event=0, full_commit=1)
M ThCallHooks: call hooks for event BEFORE_ROLLBACK
M SosISearchAnchor: no anchor for type/name 1/10
M PfAStatRevertCollected: nothing to do
A AppServerTimeSync, checkLocalTime():
A Initializing local WP variables:
A zdate_LastLocalTime with 1468919990
A zdate_LastLocalBias with 0
D GuiStatus clear generate inline ts >20160719091950,995<
M SosISearchAnchor: no anchor for type/name 1/1
M ThCheckComOrRb (event=2, full_commit=1)
M ThCallHooks: call hooks for event AFTER_ROLLBACK
M ThNoCheckMutex: check for remaining locked intervals
M SosISearchAnchor: no anchor for type/name 1/8
M ThNoClearPrevErr: clear prev no err
M SosISearchAnchor: no anchor for type/name 1/1
M ThVBIRollBack: initialize TH-hooks
M SosIRegisterHook: add hook >ThVBICmRbHook(00007FF606B0A7E0/0000000000000000)< (condition/order=0xf/0) for event AFTER_COMMIT
M SosIRegisterHook: add hook >ThVBICmRbHook(00007FF606B0A7E0/0000000000000000)< (condition/order=0xf/0) for event AFTER_ROLLBACK
M ThVBIRollBack: no current update request pending
M ThICommit: full commit, set time, free resources for T0_U187_M0
M ThICommit: commit and free resources
M ThCheckComOrRb (event=1, full_commit=1)
M ThCallHooks: call hooks for event BEFORE_COMMIT
M SosISearchAnchor: no anchor for type/name 1/8
M ThCheckComOrRb (event=3, full_commit=1)
M ThCallHooks: call hooks for event AFTER_COMMIT
M ThVBICmRbHook: called for commit
M SosISearchAnchor: no anchor for type/name 1/8
M ThNoClearPrevErr: clear prev no err
M SosISearchAnchor: no anchor for type/name 1/1
M ThrClearMemory o.k.
M ThCallHooks: call hooks for event AFTER_STORAGE_FREE
M ThICommit o.k.
M PfRejectStatistic: clear statistic record
M PfClearAllRec: clear statistic area
M PfClearAllRec: statRecordAction = STAT_RECORD_ACTION_REJECT
M ThDealComm: T0_U187_M0 has no cpic conns
M ThCleanAllInternalSessions: cleanup all internal modes of T0_U187_M0
M ThrEndMode: call ab_endmode (END_MODE_CLEAR_EMODE)
M RstrNotifyUserChange: user/client = ( /000)
M ThGetTransactionId: got trans id (SPA) >E6914DE6FA63F1EB835940F2E99D447A< (32)
M ThEppGetConnectionCounter: read connectionCounter 0 from epp 0
M ***LOG R47=> ThResFreeSession, delete () [thxxmode.c 1080]
M ThGetTransactionId: got trans id (SPA) >E6914DE6FA63F1EB835940F2E99D447A< (32)
M ThEppGetConnectionCounter: read connectionCounter 0 from epp 0
M ThGetEnqInfo: no enq info found
M ThVBIRollBack: no current update request pending
M ThSelDeleteStack: delete selMask stack of T0_U187_M0 (000007DFB9E1D1E0)
M ThSelDeleteStack: delete selMask level 0 (000007DFB9E1DA10)
M ThSelDeleteStack: delete selMask level 1 (000007DFB9E1DB40)
M ThSelDeleteStack: delete stack (000007DFB9E1D1E0)
M ThPageFree: free (187,0,0, mode = 2)
M ThRmFree: cleanup resources for T0_U187_M0
M RmCleanUpResources3: hdr/tbl/ext_tbl/free/keep = 000000000C228C80/0000000000000000/0/1/0
M RmCleanUpResources3: no resources registered
M ThRmFree: reset eg state of T0_U187_M0
M ThEppResetAdm: invalidate epp adm for T0_U187_M0 at 000007DFB9E1D630
M ThCallHooks: call hooks for event BEFORE_SESSION_DELETE
M ThEmFree: Delete 1 internal sessions
M SosIFreeAnchorArray: free imode anchor array for T0_U187_M0_I0 at 0x000007DFB9E1D5B0
M ThEmFree: call EmContextDelete (em_hdl=0)
M ThEmFree: act em state of T0_U187_M0 = DP_EM_NO_CONTEXT
M ThClearSession: T0_U187_M0 (next/prev 0/0) , last session (0 remaining sessions)
M ThWpSetCurrentSession: set WP's current session to NO SESSION (rq_cnt 0, last wp -1, last rq_id 0)
M ThInvalidateActRequestQueue: Reset request queue
M ThRqReleaseQueueSelectHandle: release selectable handle of queue 31 (T0_U187_M0) from [thRequest.c:882]
M ThRqReleaseQueueSelectHandle: invalidate selectable hdl 201 of session queue
M NiICloseHandle: shutdown and close hdl 201/sock 1476
M RqQQueueReleaseSelectableHandle: Queue <T0_U187_M0> in slot 31 released selectable hdl 201 (port=59190) W-1
M RqQQueueDestroy: Destroy queue <T0_U187_M0> in slot 31 (10372)
M ThFindValidSession: T0_U187 has no sessions
M ThFinalizeSession: Release T0_U187
M ThResFreeLogon: free resources of T0_U187
M ThWpSetCurrentSession: set WP's current session to T0_U187_M6_I0 (rq_cnt 0, last wp -1, last rq_id 0)
M RmCleanUpResources3: hdr/tbl/ext_tbl/free/keep = 000000000C237DF0/0000000000000000/1/1/0
M RmCleanUpResources3: no resources registered
M ThCallHooks: call hooks for event BEFORE_LOGOFF
M SosISearchAnchor: found anchor 000007DFB9E30460 for type/name 2/6
M SosISearchAnchor: found anchor 000007DFB9E381C0 for type/name 2/7
M ThrtGuiDeleteScreen: send end msg to terminal (thRc ERROR-CORE-PROCESS_CRASHED)
M DpRqCreate: creating REQ_HANDLER_GUI_RESP request (rq_id 8274, slot 2)
M DpCaLockBlk: my ca_blk start index is 666
M DpCaLockBlk: locked ca_blk 666
M ThrtIGetT100: read tskh msg 23 from msg area 14 (db rel 740)
M ThrtCodepageConvSysToFront: different code pages (system/frontend = >4103< / >1100<)
M ThrtICodepageConvert: convert 146 bytes from 4103 to 1100
M ThrtICodepageConvert: converted string has 73 bytes
M ThISendToGui (thSendType = TH_SEND_RETURN) to UI of T0_U187_M6
M ThISendToGui: set term_output_sent
M ThCompressReq: length < threshold (74 < 1024), don't compress
M PfIncrGuiRoundtrips: gui output (guicnt=2)
M PfWriteStatisticOnEndOfProcessing: statRecordAction is STAT_RECORD_ACTION_REJECT, don't change
M ThRqSend: sending REQ_HANDLER_GUI_RESP request with TH_SEND_RETURN
M ThISendRequest: REQ_HANDLER_GUI_RESP (rq_id 8274) from T0_U187_M6 user= to TERMINAL, thSendType=TH_SEND_RETURN(0x0))
M ThRqNeedsHandShake: session in special state, reset counter, no handshake
M ThGetStrategy (task_switch=0, inline_hold=0, holdWp=0)
M ThrtGetStrategy: abap strategy ROLL / O.K.
M ThISendRequest: new wp stat: WP_RUN
M Address Offset Data to Terminal
M ------------------------------------------------------------------------
M 000000000E7CD050 000000 00020001 00010000 576f726b 2070726f |........Work pro|
M 000000000E7CD060 000016 63657373 20726573 74617274 65643b20 |cess restarted; |
M ------------------------------------------------------------------------
M DpRqSendRequestWithFilter: REQ_HANDLER_GUI_RESP (rq_id 8274) from WORKER to TERMINAL
M DpCaGiveUpOwnerOfBlk: give up ownership of ca_blk 666
M rq_id 8274
M -OUT- ca_blk 666 len 82
M -OUT- reqHdlId REQ_HANDLER_GUI_RESP
M -OUT- sender address:
M -OUT- type LOCAL
M -OUT- agentType WORKER workerTyp DIA workerNum 0
M -OUT- session T0_U187_M6
M -OUT- receiver address:
M -OUT- type LOCAL
M -OUT- agentType TERMINAL
M -OUT- session T0_U187_M6
M RqQAddRequest: Add request rq_id 8274 (NOWP) to queue <DispatcherQueue> in slot 0 at the end
M Dump of queue <DispatcherQueue> in slot 0 (1 requests, in use, port=53872):
M -1 <- 1 (rq_id 8274, NOWP, REQ_HANDLER_GUI_RESP) -> -1
M NiICreateHandle: hdl 202 state NI_INITIAL_CON
M NiIInitSocket: set default settings for new hdl 202/sock 1476 (I4; DG)
M NiDgHdlCreateForProto: state of hdl 202 NI_DG_UNCONNECTED
M NiISetSockOpt: set option SOL_SOCKET-SO_REUSEADDR of hdl 202 to FALSE
M NiIConnectSocket: connection of hdl 202 established to 127.0.0.1:53872
M NiDgHdlConnect: state of hdl 202 NI_DG_CONNECTED
M RqQQueueNotifySelectableHandleAsync: Created new NI connection for queue <DispatcherQueue> in slot 0 on port 53872 (59192)
M RqQQueueNotifySelectableHandleAsync: Signal selectable handle for queue <DispatcherQueue> in slot 0 on port 53872 (id=126)
M NiDgHdlSend: hdl 202 sent 1 of 1 bytes to 127.0.0.1:53872
M RqQQueueGetNumberOfRequests: Queue <DispatcherQueue> in slot 0 contains 1 requests of type NOWP
M DpRqPutIntoQueue: put request into TERMINAL queue (workerType 0, prio LOW, rq_id 8274), queue has 1 requests
M DpRqFree: freeing REQ_HANDLER_GUI_RESP request (rq_id 8274, slot 2)
M ThEmFree: delete hyper context (hyperHdl=000007DFB9E4CF40)
M ThEmFree: delete eg session heap manager for T0_U187, eg_session_handle=000007DFB9E1C770
M ThWpSetCurrentSession: set WP's current session to NO SESSION (rq_cnt 0, last wp -1, last rq_id 0)
M ThDeleteLogonEntry: release T0_U187
M DpITmSlotRelease: release T0_U187
M DpListRemove: remove elem 0 from tmadm_inuse_list
M DpListRemove: 0 elems in tmadm_inuse_list
M DpListInsert: insert elem 0 into tmadm_free_list (at begin)
M DpListInsert: 200 elems in tmadm_free_list
M ThReleaseWp: release W0
M ThGetStrategy (task_switch=1, inline_hold=0, holdWp=0)
M ThrtGetStrategy: abap strategy ROLL / O.K.
M ThNewWpStat (task_switch=1, hold=0)
M ThNewWpStat: task switch, set WP_WAIT
M ThReleaseWp: new wp stat: WP_WAIT
M ThTriggerTaskSwitch: trigger task switch
M ThTriggerTaskSwitch: th_step = TH_WORK_NOSYNC
M ThITriggerTaskSwitch: perform task switch
M ThrtSetSapExt: session not attached
M ThCallHooks: call hooks for event BEFORE_TASK_SWITCH
M PfTaskSwitch: handle event BEFORE_TASK_SWITCH
M PfTaskSwitch: record action is STAT_RECORD_ACTION_REJECT, return
M TrThHookFunc: called for task switch
M ThrtApcCleanup: handle event BEFORE_TASK_SWITCH
M DpSesGetPrepareReqHandler: NO_SESSION_INFOThRqReplaceCurrentRequest: freeing current incoming request REQ_HANDLER_SESSION (rq_id 8272)
M DpRqFree: freeing REQ_HANDLER_SESSION request (rq_id 8272, slot 1)
M rdisp/wp_auto_restart = 0 / 5 sec
M rdisp/wp_abap_restart = 0
M ThSetThToolParam : restartable_wp[0] = FALSE
M ThSetThToolParam : restartable_wp[1] = TRUE
M ThSetThToolParam : restartable_wp[2] = TRUE
M ThSetThToolParam : restartable_wp[3] = FALSE
M ThSetThToolParam : restartable_wp[4] = TRUE
M ThSetThToolParam : restartable_wp[5] = TRUE
M ThSetThToolParam : restartable_wp[6] = TRUE
M ThWpHandleStateChange: new state of W0 is WP_WAIT (current state is WP_RUN)
M DpAddReqHandlingTime: add 0.000000 us runtime to runningQueueTimeSum[DIA], sum = 0.000000 us
M DpIWpSetNewStat: switched W0 from WP_RUN to WP_WAIT
M DpIWpSetNewStat: info for DIA: new/wait/run/hold/standby/killed = 0/10/0/0/0/0 wps
M ThWpHandleStateChange: new state of W0 is WP_WAIT
M ThPerformTaskSwitch: return TH_WAIT_FOR_REQUEST
M TskhLoop: Got TaskHandlerMessage 1
M TskhLoopResetState: reset after request handling(ics=0)
M DpWpSetExtraAction: extraAction of W0= (after DP_BIT_AND) [thxxhead.c:1967]
M ThISelItemExists: no stack found
M ThWpSetCurrentSession: set WP's current session to NO SESSION (rq_cnt 0, last wp -1, last rq_id 0)
M DpRqFreePendingRequests: freed 0 pending request
M TskhLoopResetState: switch back to normal tracel level 1 (after request handling)
E
E Tue Jul 19 14:50:12 2016
E Enqueue Info: enque/use_pfclock2 = FALSE
B
B Tue Jul 19 14:51:02 2016
B DBREPO: MAJOR_VERS part of REPOLOAD primary key
B DBREPO: set new access functions for table REPOLOAD
A ***GENER* Trace switched off ***
A bgRFC> [R] Activate_supervisor with iv_use_none =
A
A Tue Jul 19 14:51:03 2016
A bgRFC> [R] Calling BGRFC_CHECK_SCHEDULERS dest = BGRFC_SUPERVISOR
M
M Tue Jul 19 15:26:12 2016
M SecAudit(rsauinit): WP attached to existing shared memory.
M SecAudit(RsauShmInit): addr of SHM for Audit.. = 0000000000C40050
M SecAudit(RsauShmInit): addr of RSAUSHM........ = 0000000000C41050
M SecAudit(RsauShmInit): addr of RSAUSLOTINFO... = 0000000000C41D90
M SecAudit(RsauShmInit): addr of RSAUSLOTS...... = 0000000000C41DA0
A
A Tue Jul 19 15:31:03 2016
A bgRFC> [R] Activate_supervisor with iv_use_none =
A bgRFC> [R] Calling BGRFC_CHECK_SCHEDULERS dest = BGRFC_SUPERVISOR
S
S Tue Jul 19 15:32:03 2016
S found spool memory service RSPO-ACTIONS at 0000000062BEA470
B
B Tue Jul 19 15:33:03 2016
B dbsync[db_syexe]: { wait=0, call_no=25, current_ts=20160719153303, last_counter=2145094697
B
B Tue Jul 19 15:35:03 2016
B dbsync[db_syexe]: { wait=0, call_no=26, current_ts=20160719153503, last_counter=2145094697
C
C Tue Jul 19 15:36:03 2016
C dbs/syb/fetchArraySize: 1000
C database is local: connect_timeout: 3
C Thread ID:2496
C lib_dbsl 741 10/21/2014 16:59:00
C connection unquiesced
C Using dynamic link library 'G:\usr\sap\QA1\DVEBMGS00\exe\dbsybslib.dll'
C dbsybslib.dll patch info
C SAP patchlevel 0
C SAP patchno 201
C Last SYBASE DBSL patchlevel 0
C Last SYBASE DBSL patchno 111
C Last SYBASE DBSL patchcomment SYB: stat stack overflow (2080663)
C spid 158 comm rd ODBC
C spid 161 unc rd ODBC
C Driver: Adaptive Server Enterprise Driver release: 15.7.0.1260
C Driver full version: SAP ASE ODBC Driver/15.7/SP126 PL/P/AMD64/Windows/drvmain/Build 1260/64-bit/Normal/Sun Apr 13 UTC 20:37:36 2014/SQLLEN8
C Driver uses SQLLEN8
C dbs/syb/cache_size: 200
C GetServerInfo version: Adaptive Server Enterprise/15.7/EBF 22777 SMP SP122 /P/X64/Windows Server/ase157sp12x/3662/64-bit/OPT/Sat Apr 19 01:26:01 2014
C GetServerInfo release: 15.7.0.122
C GetServerInfo architecture: x86_64
C GetServerInfo edition: P
C GetServerInfo byte width: 64 bit
C DbSlConnect hdl: 1
B Connection 1 opened (DBSL handle 1)
C ERROR: -1 in function ExeNormalModify (execute) [line 25020]
C (587) [ZZZZZ] [SAP][ASE ODBC Driver][Adaptive Server Enterprise]Identity value overflow for fi
C eld 'SEQNUMBER' in table 'DDLOG'.
C
C sql statement is ==> INSERT INTO DDLOG ( TIMESTAMP, SYSTEMID, NBLENGTH, NOTEBOOK) VALUES ( ? , ? , ?
C , ? )
C /* R3:D:/depot/bas/741_REL/src/krn/dbi/dbs/dbs:566 T:DDLOG M:000 */
C
C transaction aborted by server
B ***LOG BY4=> sql error 587 performing INS on table DDLOG [dbsynseq 587]
B ***LOG BY0=> [ASE Error SQL587][SAP][ASE ODBC Driver][Adaptive Server Enterprise]Identity value overflow for field 'SEQNUMBER' in table 'DDLOG'.
[dbsynseq 587]
B ***LOG BZY=> unexpected return code 2 calling ins_ddlog [dbsync 1399]
B db_syflush (TRUE) failed
B db_con_commit received error 1024 in before-commit action (con_hdl = 0, th_commit = 1, returning 8
M ***LOG R38=> ThICommit, db_commit98 ( 001024) [thDatabase.c 432]
M ***LOG R18=> ThCommit, ThICommit () [thDatabase.c 254]
M in_ThErrHandle: 1
M *** ERROR => ThCommit: ThICommit (step TH_WORK_SYNC, thRc ERROR-DB-COMMIT_ERROR, action RESTART_WP, level 1) [thxxhead.c 2358]
M {root-id=40F2E99D447A1ED693B30CBADD26A359}_{conn-id=00000000000000000000000000000000}_0
M ThIErrHandle: set thRc ERROR-DB-COMMIT_ERROR for T10_U1158_M0
M ThResetEmMagic: reset em magic for T10_U1158_M0_I1
M
M Info for wp 0
M
M pid = 3596
M severity = 0
M status = 0
M stat = WP_RUN
M waiting_for = NO_WAITING
M workerType = DP_WORKER_DIAWP
M currentSession = T10_U1158_M0
M lastSession = T10_U1158_M0
M act_cs_count = 0
M csTrack = 0
M csTrackRwExcl = 0
M csTrackRwShrd = 0
M mode_cleaned_counter = 0
M control_flag = 200000
M report = >SAPLTHFB <
M action = 0
M tab_name = > <
M
M Info for Session T10_U1158_M0_I1
M
M tm state = 2
M uid = 1158
M term type = 0x4
M withDisplay = 0x0
M cpic_no = 0
M cpic_idx = -1
M usr = >SAPSYS <
M terminal = > <
M client = >000<
M appc_tm_conv_idx = -1
M allowCreateMode = YES
M blockSoftCanel = NO
M Session Resources:
M HEAD: adr/max_elems/act_elems/tbl = 000000000C2D6450/0/0/0000000000000000
M imode = 1
M is_cancelled = NO
M ThrtGetTaskTypeOfSession: taskType of T10_U1158_M0: THRT_TASK_AUTOABAP
M task_type = THRT_TASK_AUTOABAP
M thRc = Internal error, session terminated (16797705)
M detachReason = DP_DETACH_REASON_NONE
M async_receives = 0
M em handle = 0
M abap session state = DP_SES_ATTACHED
M em state = DP_EM_ATTACHED
M resetReason = 0
M softcancel = 0
M cancelInitiator = INVALID
M cleanupMethod = DP_DEFAULT_CLEANING
M master hook = invalid T-1_M255
M slave hook = invalid T-1_M255
M debuggingActive = 0
M tcode = > <
M act_wp = 0
M last_wp = 0
M client conversation_ID = > <
M server conversation_ID = > <
M lock = 0
M max enq infos = 9
M act enq infos = 2
M em_hyper_hdl = 000007DFB9E42220
M plugin_info = NULL
M act_plugin_hdl = -1
M act_plugin_no = 0
M max_plugin_no = 0
M Context Resources:
M HEAD: adr/max_elems/act_elems/tbl = 000000000C2C72E0/0/0/0000000000000000
M reply name = >local <
M respId = 32594
M resp handler = REQ_HANDLER_AUTOABAP_RESP
M ThSelPrintMask: selMask of level 1 is empty
M ThSelPrintMask: selMask of level 0 is empty
M
M
M ThIErrHandle: current incoming request:
M
M rq_id 33213
M -IN-- ca_blk -1 len 0
M -IN-- prio HIGH
M -IN-- reqHdlId REQ_HANDLER_RESUME_ABAP_VM
M -IN-- sender address:
M -IN-- type LOCAL
M -IN-- agentType WORKER workerTyp DIA workerNum 0
M -IN-- session T10_U1158_M0
M -IN-- receiver address:
M -IN-- type LOCAL
M -IN-- agentType WORKER workerTyp DIA
M -IN-- session T10_U1158_M0
M
M *****************************************************************************
M *
M * LOCATION SAP-Server baiodevcct_QA1_00 on host baiodevcct (wp 0)
M * ERROR ThCommit: ThICommit
M *
M * TIME Tue Jul 19 15:36:03 2016
M * RELEASE 741
M * COMPONENT Taskhandler
M * VERSION 1
M * RC 16797705
M * MODULE D:/depot/bas/741_REL/src/krn/si/th/thxxhead.c
M * LINE 2544
M * COUNTER 1
M *
M *****************************************************************************
M
M PfRejectStatistic: clear statistic record
M PfClearAllRec: clear statistic area
M PfClearAllRec: statRecordAction = STAT_RECORD_ACTION_REJECT
M Entering TH_CALLHOOKS
M ThCallHooks: call hooks for event BEFORE_DUMP
M ThCallHooks: call hook >TrThHookFunc< for event BEFORE_DUMP
M TrThHookFunc: called for WP dump
M ThCallHooks: call hook >ThrBtcCallLgCl< for event BEFORE_DUMP
M ThCallHooks: call hook >ThrSaveSPAFields< for event BEFORE_DUMP
M ThrSaveSPAFields: save spa fields
M ThIErrHandle: entering ThSetStatError
M PfSetError: clear statistic record
M PfClearAllRec: clear statistic area
M PfClearAllRec: statRecordAction = STAT_RECORD_ACTION_REJECT
C -> SybBreak
C SybBreak 0
B db_sqlbreak() = 15
M *** WARNING => ThCallDbBreak: db_sqlbreak failed (16388), caller=ThIErrHandle
M ThIErrHandle: action is RESTART_WP, skip rollback
M ThIErrHandle: do not call ThrCoreInfo (no_core_info=0, in_dynp_env=1)
M ThIErrHandle: Entering ThReplyToMsg
M ThReplyToMsg: reply name: local,
M resp handler: REQ_HANDLER_AUTOABAP_RESP, respId 32594
M *** WARNING => ThReplyToMsg: send reply msg REQ_HANDLER_AUTOABAP_RESP to waiting session [thxxmode.c 1910]
M DpRqCreate: creating REQ_HANDLER_AUTOABAP_RESP request (rq_id 33216, slot 56)
M ThRqSend: sending REQ_HANDLER_AUTOABAP_RESP request with TH_SEND_RETURN
M ThISendRequest: REQ_HANDLER_AUTOABAP_RESP (rq_id 33216) from T10_U1158_M0 user=SAPSYS to DISP, thSendType=TH_SEND_RETURN(0x0))
M ThRqNeedsHandShake: is a response, reset counter, no handshake
M ThGetStrategy (task_switch=0, inline_hold=0, holdWp=0)
M ThrtGetStrategy: abap strategy ROLL / O.K.
M ThISendRequest: new wp stat: WP_RUN
M ThClearResponseInfo: clear response info for T10_U1158_M0
M DpRqSendRequestWithFilter: REQ_HANDLER_AUTOABAP_RESP (rq_id 33216) from WORKER to DISP
M rq_id 33216
M -OUT- ca_blk -1 len 0
M -OUT- reqHdlId REQ_HANDLER_AUTOABAP_RESP
M -OUT- sender address:
M -OUT- type LOCAL
M -OUT- agentType WORKER workerTyp DIA workerNum 0
M -OUT- session T10_U1158_M0
M -OUT- receiver address:
M -OUT- type LOCAL
M -OUT- agentType DISP
M -OUT- respId 32594
M RqQAddRequest: Add request rq_id 33216 (NOWP) to queue <DispatcherQueue> in slot 0 at the end
M Dump of queue <DispatcherQueue> in slot 0 (1 requests, in use, port=53872):
M -1 <- 5 (rq_id 33216, NOWP, REQ_HANDLER_AUTOABAP_RESP) -> -1
M RqQQueueNotifySelectableHandleAsync: Reuse NI connection for queue <DispatcherQueue> in slot 0 on port 53872 (10026)
M RqQQueueNotifySelectableHandleAsync: Signal selectable handle for queue <DispatcherQueue> in slot 0 on port 53872 (id=4)
M NiDgHdlSend: hdl 207 sent 1 of 1 bytes to 127.0.0.1:53872
M RqQQueueGetNumberOfRequests: Queue <DispatcherQueue> in slot 0 contains 1 requests of type NOWP
M DpRqPutIntoQueue: put request into DISP queue (workerType 0, prio LOW, rq_id 33216), queue has 1 requests
M DpRqFree: freeing REQ_HANDLER_AUTOABAP_RESP request (rq_id 33216, slot 56)
M ThIErrHandle: Entering ThErrHdlUser
M ThErrHdlUser: set thRc (ERROR-DB-COMMIT_ERROR)
M ThErrHdlUser: detach session
M ThSessionDetach: detach session of T10_U1158_M0 (em_hdl=0)
M ThSessionDetach: call ab_rollout
M ThSessionDetach: act abap state of T10_U1158_M0 is DP_SES_DETACHED
M ThSessionDetach: act em state of T10_U1158_M0 = DP_EM_DETACHED
M ThSetDetachTime: detached session of T10_U1158_M0 in 358 us
M ThSessionDetach: detach o.k.
M DpWpSetExtraAction: extraAction of W0=WP_ROLL_IN_AFTER_DUMP (after DP_BIT_OR) [thxxhead.c:2951]
M call ThrShutDown ...
B Disconnecting from ALL connections:
B Wp Hdl ConName ConId ConState TX BC OC HC PRM RCT INF TIM MAX OPT Date Time DBHost Program
B 000 000 R/3 000000000 ACTIVE YES NO 000 NO YES NO NO 000 255 255 20160719 144945 baiodevcct
B 000 001 R/3*SCSM_CON 000000001 INACTIVE NO NO 000 NO NO NO NO 004 255 255 20160719 153603 baiodevcct SAPLSCSMROUTE
C DbSlDisconnect hdl: 0
B Disconnected from connection 0
C DbSlDisconnect hdl: 1
B Disconnected from connection 1
B statistics db_con_commit (com_total=471, com_tx=22)
B statistics db_con_rollback (roll_total=4, roll_tx=0)
M ***LOG Q02=> wp_halt, WPStop (Workp. 0 3596) [dpnttool.c 335]
---------------------------------------------------
trc file: "dev_w0", trc level: 1, release: "741"
---------------------------------------------------
*
* ACTIVE TRACE LEVEL 1
* ACTIVE TRACE COMPONENTS all, MJ
*
M sysno 00
M sid QA1
M systemid 562 (PC with Windows NT)
M relno 7410
M patchlevel 0
M patchno 225
M intno 20020600
M make multithreaded, Unicode, 64 bit, optimized
M profile \\baiodevcct\sapmnt\QA1\SYS\profile\QA1_DVEBMGS00_baiodevcct
M pid 5924
M
M
M Tue Jul 19 15:36:04 2016
M kernel runs with dp version 216000(ext=117000) (@(#) DPLIB-INT-VERSION-216000-UC)
M length of sys_adm_ext is 500 bytes
M ***LOG Q0Q=> tskh_init, WPStart (Workp. 0 5924) [dpInit.c 748]
M DpCommonParamInit: rdisp/core_file_size = default --> no change
I MtxInit: 0 0 0
M DpIPCInit2: read dp-profile-values from sys_adm_ext
M DpShMCreate: alloate/attach shared memory (mode=ATTACH)
M DpShMCreate: sizeof(wp_adm) 23184 (1104)
M DpShMCreate: sizeof(tm_adm) 13040880 (64880)
M DpShMCreate: sizeof(ca_adm) 432000 (72)
M DpCommTableSize: max/headSize/ftSize/tableSize=500/16/1832064/1951152
M DpShMCreate: sizeof(comm_adm) 1951152 (3648)
M DpSlockTableSize: max/headSize/ftSize/fiSize/tableSize=0/0/0/0/0
M DpShMCreate: sizeof(slock_adm) 0 (296)
M DpFileTableSize: max/headSize/ftSize/tableSize=0/0/0/0
M DpShMCreate: sizeof(file_adm) 0 (80)
M DpSockTableSize: max/headSize/ftSize/tableSize=500/16/520064/520080
M DpShMCreate: sizeof(sock_adm) 520080 (1016)
M DpShMCreate: sizeof(vmc_adm) 0 (3208)
M DpShMCreate: sizeof(wall_adm) (ft=41664/fi=67472/hd=64/rec=192)
M DpShMCreate: sizeof(amc_rec_adm) (ft=86464/fi=67472/hd=64/rec=416)
M DpShMCreate: sizeof(websocket_adm) (ft=28864/hd=64/rec=272)
M DpShMCreate: sizeof(gw_adm) 64
M DpShMCreate: sizeof(j2ee_adm) 3936
M DpShMCreate: SHM_DP_ADM_KEY (addr: 000000000BED0050, size: 16369648
M DpShMCreate: allocated sys_adm at 000000000BED0250
M DpShMCreate: allocated wp_adm_list at 000000000BEE2100
M DpShMCreate: allocated wp_adm at 000000000BEE2420
M DpShMCreate: allocated tm_adm_list at 000000000BEE80B0
M DpShMCreate: allocated tm_adm at 000000000BEE82F0
M DpShMCreate: allocated ca_adm at 000000000CB581E0
M DpShMCreate: allocated comm_adm at 000000000CBC1B60
M DpShMCreate: system runs without slock table
M DpShMCreate: allocated sock_adm at 000000000CD9E310
M DpShMCreate: allocated vmc_adm_list at 000000000CE1D4A0
M DpShMCreate: system runs without VMC
M DpShMCreate: allocated gw_adm at 000000000CE1D740
M DpShMCreate: allocated j2ee_adm at 000000000CE1D980
M DpShMCreate: allocated ca_info at 000000000CE1EAE0
M DpShMCreate: allocated wall_adm (ft) at 000000000CE1ED20
M DpShMCreate: allocated wall_adm (fi) at 000000000CE291E0
M DpShMCreate: allocated wall_adm (head) at 000000000CE39B70
M DpShMCreate: allocated amc_rec_adm (ft) at 000000000CE39DB0
M DpShMCreate: allocated amc_rec_adm (fi) at 000000000CE4F170
M DpShMCreate: allocated amc_rec_adm (head) at 000000000CE5FB00
M DpShMCreate: allocated websocket_adm (ft) at 000000000CE5FD40
M DpShMCreate: allocated websocket_adm (head) at 000000000CE67000
M DpShMCreate: initialized 21 eyes
M DpCommAttachTable: attached comm table (header=000000000CBC1B60/ft=000000000CBC1B70/fi=000000000CD80FF0)
M DpSockAttachTable: attached sock table (header=000000000CD9E310/ft=000000000CD9E320)
X EmInit: MmSetImplementation( 2 ).
X MM global diagnostic options set: 0
X <ES> client 0 initializing ....
X <ES> EsILock: use Mutex for locking
X Using implementation view
X <EsNT> Using memory model view.
M <EsNT> Memory Reset disabled as NT default
X ES initialized.
X mm.dump: set global maximum dump mem to 192 MB
X EsRegisterEmCheck: Register EmGetEsHandles at 00007FF608411C90
M ThStart: taskhandler started
M ThInit: initializing DIA work process W0
X MMX: use precise segment size globally
M rdisp/sapgui_data_trace : 1 -> 1
M ThInit: found previous user T10_U0_M134
M
M Tue Jul 19 15:36:05 2016
M ThInit: running on host baiodevcct
I MtxInit: 0 0 0
M
M Tue Jul 19 15:36:06 2016
M calling db_connect ...
B Loading DB library 'G:\usr\sap\QA1\DVEBMGS00\exe\dbsybslib.dll' ...
B Library 'G:\usr\sap\QA1\DVEBMGS00\exe\dbsybslib.dll' loaded
B Version of 'G:\usr\sap\QA1\DVEBMGS00\exe\dbsybslib.dll' is "741.10", patchlevel (0.111)
C trace file set
C Callback functions for dynamic profile parameter registered
B read_con_info_ssfs(): DBSL supports extended connect protocol
B ==> connect info for default DB will be read from ssfs
C dbs/syb/bcddec: FALSE
C dbs/syb/fetchArraySize: 1000
C database is local: connect_timeout: 3
C Thread ID:3492
C lib_dbsl 741 10/21/2014 16:59:00
C connection unquiesced
C Using dynamic link library 'G:\usr\sap\QA1\DVEBMGS00\exe\dbsybslib.dll'
C dbsybslib.dll patch info
C SAP patchlevel 0
C SAP patchno 201
C Last SYBASE DBSL patchlevel 0
C Last SYBASE DBSL patchno 111
C Last SYBASE DBSL patchcomment SYB: stat stack overflow (2080663)
C
C Tue Jul 19 15:36:07 2016
C spid 186 comm rd ODBC
C spid 111 unc rd ODBC
C Driver: Adaptive Server Enterprise Driver release: 15.7.0.1260
C Driver full version: SAP ASE ODBC Driver/15.7/SP126 PL/P/AMD64/Windows/drvmain/Build 1260/64-bit/Normal/Sun Apr 13 UTC 20:37:36 2014/SQLLEN8
C Driver uses SQLLEN8
C dbs/syb/cache_size: 200
C GetServerInfo version: Adaptive Server Enterprise/15.7/EBF 22777 SMP SP122 /P/X64/Windows Server/ase157sp12x/3662/64-bit/OPT/Sat Apr 19 01:26:01 2014
C GetServerInfo release: 15.7.0.122
C GetServerInfo architecture: x86_64
C GetServerInfo edition: P
C GetServerInfo byte width: 64 bit
C DbSlConnect hdl: 0
C trace file set
B Connection 0 opened (DBSL handle 0)
M ThDbConnect: db_connect o.k.
X EmInit: MmSetImplementation( 2 ).
X MM global diagnostic options set: 0
X <ES> client 0 initializing ....
X Using implementation view
X ES initialized.
X mm.dump: set global maximum dump mem to 192 MB
X EsRegisterEmCheck: Register EmGetEsHandles at 00007FF608411C90
B db_con_shm_ini: WP_ID = 0, WP_CNT = 21, CON_ID = 2
B Start CursorInit
B TBI initializing lock manager ...
B TBI locking : multiple locks
B TBI lock manager impl: semamphore
B
B Tue Jul 19 15:36:08 2016
B dbtbxbuf: Buffer TBI64 (addr: 0000000058ED0140, size: 4033333520, end: 000000014954CA50)
B DBI: init TBI BUFFER (data): start=000007DE5E701000 length=3899659264 end=000007DF46E02400
B dbprotocol: table logging switched off for all clients
B DbModifyHelper::maxItabInvalidationThreshold = 20
B dbsync[db_syinit]: successfully attached to shared memory, sync_adm_p = 000000001B5C0050
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 = 2145094697
B oldest_gap = (2147483647,19700101053000)
B time_of_last_sync = 20160719153503
B MySysId = 'baiodevcct 00'
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 = 21
B blockSize = 512
B maxObjects = 335060
B maxObjectSize = 311604352
B freeListVectorSize = 489
B hashVectorSize = 670129
B bufferSize = 1372407808
B maxBlocks = 2434409
B freeBlocksCnt = 2434361
B mutexVectorSize = 670131, ADMIN_MUTEX = 670129, INVAL_MUTEX = 670130
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 = 21
B blockSize = 512
B maxObjects = 2000
B maxObjectSize = 859648
B freeListVectorSize = 17
B hashVectorSize = 4001
B bufferSize = 4194304
B maxBlocks = 6716
B freeBlocksCnt = 6716
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 = 21
B blockSize = 512
B maxObjects = 2000
B maxObjectSize = 577920
B freeListVectorSize = 587
B hashVectorSize = 4001
B bufferSize = 3072000
B maxBlocks = 4515
B freeBlocksCnt = 4298
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 = 21
B blockSize = 256
B maxObjects = 2000
B maxObjectSize = 859584
B freeListVectorSize = 33
B hashVectorSize = 4001
B bufferSize = 4194304
B maxBlocks = 13431
B freeBlocksCnt = 13431
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: 00000000619F0050, size: 4400000)
M ThCreateNoBuffer allocated 548152 bytes for 1000 entries at 0000000062480050
M ThCreateNoBuffer index size: 3000 elems
M ThCreateVBAdm allocated 33376 bytes (50 server) at 000000001B5D0050
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 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 0000000003508DC0
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
S
S Tue Jul 19 15:36:09 2016
S found processing queue enabled
S found spool memory service RSPO-RCLOCKS at 0000000062AD00D0
S doing lock recovery
S setting server cache root
S found spool memory service RSPO-SERVERCACHE at 0000000062AD0730
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 43684 bytes at 000000001B5E0050
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 ***GENER* Trace switched on ***
A
A ---PXA-------------------------------------------
A PXA INITIALIZATION
A PXA: increasing number of fragments to stay below recommended size of 2GB
A PXA: Locked PXA-Semaphore.
A System page size: 4kb, total admin_size: 1020868kb, dir_size: 145332kb.
A Attached to PXA (address 00007FFCA4FD0050 - 00007FFFFFFD0050, size 14073856K, 7 fragments of 1864712K )
A *** using a guard page at PXA start to protect parameters and release info ***
A abap/pxa = shared protect gen_remote
A PXA: checking structure sizes: 760|272|16
A PXA INITIALIZATION FINISHED
A ---PXA-------------------------------------------
A
A ATRA: pfclock execution time = 0
A abap/force_local_update_task=0
A ABAP ShmAdm attached (addr=000007DF4760F000 leng=1920974848 end=000007DFB9E0B000)
A >> Shm MMADM area (addr=000007DF62459340 leng=22612032 end=000007DF639E9B80)
A >> Shm MMDAT area (addr=000007DF639EA000 leng=1447170048 end=000007DFB9E0B000)
A RFC Destination> destination baiodevcct_QA1_00 host baiodevcct system QA1 systnr 0 (baiodevcct_QA1_00)
A RFC Options> H=baiodevcct,S=00,d=2,
B dbrda: Redirect database access is disabled via rsdb/rda profile parameter setting.
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>' [SYBASE:741.10]):
B max_blocking_factor = 50, min_blocking_factor = 1,
B max_in_blocking_factor = 128, min_in_blocking_factor = 1,
B max_union_blocking_factor = 50, min_union_blocking_factor = 1,
B prefer_union_all = 0, prefer_join = 0,
B prefer_fix_blocking = 0, prefer_in_itab_opt = 1,
B convert AVG = 1, alias table FUPD = 0,
B escape_as_literal = 0,
B select * =0x0f, character encoding = STD / []:X,
B use_hints = abap->1, dbif->0x1, upto->0
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: 741, [7410.0.225.20020600]
W ITS Plugin: Int.version, [34]
W ITS Plugin: Feature set: [34]
W ===... Calling itsp_Init in external dll ===>
W PpioRecoverLocks, table: 000007DFB9E4CA00
W PpioRecoverLocks, number of file locks 256
W PpioRecoverLocks: file lock set to: 0000000000000000
W PpioRecoverLocks: directory lock set to: 0000000000000000
W PpioRecoverLocks: global lock set to: 0000000000000000
W PpioRecoverLocks() done
W PprcRecoverLocks, table: 000007DFB9E4CEF0
W PprcRecoverLocks: directory lock set to: 0000000000000000
W PprcRecoverLocks() done
W === ipl_Init() returns 0, ITSPE_OK: OK
W =================================================
N VSI: WP init in ABAP VM completed with rc=0
N SsfSapSecin: getenv(SECUDIR)=="G:\usr\sap\QA1\DVEBMGS00/sec"
N
N =================================================
N === SSF INITIALIZATION:
N ===...SSF Security Toolkit name SAPSECULIB .
N ===...SSF library is G:\usr\sap\QA1\DVEBMGS00\exe\sapcrypto.dll .
N ===...SSF default hash algorithm is SHA1 .
N ===...SSF default symmetric encryption algorithm is AES128-CBC .
N ===...SSF lib codepage is set to 1 .
N ===...SECUDIR="G:\usr\sap\QA1\DVEBMGS00/sec"
N ===...loading of Security Toolkit successfully completed.
N === CommonCryptoLib (SAPCRYPTOLIB) Version 8.4.22 pl40 (Jul 23 2014) MT-safe
N =================================================
N
N Tue Jul 19 15:36:11 2016
N SignInit: successfully obtained handle for Security Context cache
N SPNegoInit: SPNego disabled ("spnego/enable" not set to 1)
M JrfcVmcRegisterNativesDriver o.k.
E EnqId_Initialize: local EnqId initialization o.k.
M ThrtAmcInit: use DB table AMC_RECEIVER for AMC dispatching
M ThCheckPrevUser: previous user was T10_U1158_M0, clean counter TH_NO_CLEANUP
M ThCheckPrevUser: clean previous user T10_U1158_M0_I1
M ThAlarm: set alarm to 60 sec
M
M Info for wp 0
M
M pid = 5924
M severity = 0
M status = 0
M stat = WP_NEW
M extraAction = WP_ROLL_IN_AFTER_DUMP
M waiting_for = NO_WAITING
M workerType = DP_WORKER_DIAWP
M currentSession = T10_U1158_M0
M lastSession = T10_U1158_M0
M act_cs_count = 0
M csTrack = 0
M csTrackRwExcl = 0
M csTrackRwShrd = 0
M mode_cleaned_counter = 1
M control_flag = 2200000
M report = >SAPMSSY8 <
M action = 0
M tab_name = > <
M
M Info for Session T10_U1158_M0_I1
M
M tm state = 2
M uid = 1158
M term type = 0x4
M withDisplay = 0x0
M cpic_no = 0
M cpic_idx = -1
M usr = >SAPSYS <
M terminal = > <
M client = >000<
M SESSION_CLEANED_COUNTER = TH_CLEANUP_WITH_FULL_ABAP_ATTACH
M appc_tm_conv_idx = -1
M allowCreateMode = YES
M blockSoftCanel = NO
M Session Resources:
M HEAD: adr/max_elems/act_elems/tbl = 000000000BF96450/0/0/0000000000000000
M imode = 1
M is_cancelled = NO
M task_type = THRT_TASK_AUTOABAP
M thRc = Internal error, session terminated (16797705)
M detachReason = DP_DETACH_REASON_NONE
M async_receives = 0
M em handle = 0
M abap session state = DP_SES_DETACHED
M em state = DP_EM_DETACHED
M resetReason = 0
M softcancel = 0
M cancelInitiator = INVALID
M cleanupMethod = DP_DEFAULT_CLEANING
M master hook = invalid T-1_M255
M slave hook = invalid T-1_M255
M debuggingActive = 0
M tcode = > <
M act_wp = 0
M last_wp = 0
M client conversation_ID = > <
M server conversation_ID = > <
M lock = 0
M max enq infos = 9
M act enq infos = 2
M em_hyper_hdl = 000007DFB9E42220
M plugin_info = NULL
M act_plugin_hdl = -1
M act_plugin_no = 0
M max_plugin_no = 0
M Context Resources:
M HEAD: adr/max_elems/act_elems/tbl = 000000000BF872E0/0/0/0000000000000000
M ThSelPrintMask: selMask of level 1 is empty
M ThSelPrintMask: selMask of level 0 is empty
M
M DpWpSetWaitingFor: W0 doesn't wait (NO_WAITING)
M ThCheckPrevUser: th_step = TH_WORK_SYNC
M DpIWpSetNewStat: switched W0 from WP_NEW to WP_RUN
M DpIWpSetNewStat: info for DIA: new/wait/run/hold/standby/killed = 0/8/2/0/0/0 wps
M ThCleanPrevUser: clean T10_U1158_M0_I1, cleanup method DP_DEFAULT_CLEANING, clean counter TH_CLEANUP_WITH_FULL_ABAP_ATTACH
M DpWpSetExtraAction: extraAction of W0= (after DP_BIT_SET) [thxxhead.c:3274]
M ThCleanPrevUser: cleanup after dump, sitch to TH_CLEANUP_WITH_SHORT_ABAP_ATTACH
M RstrNotifyUserChange: user/client = (SAPSYS /000)
M PfRejectStatistic: clear statistic record
M PfClearAllRec: clear statistic area
M PfClearAllRec: statRecordAction = STAT_RECORD_ACTION_REJECT
M ThGetAbapRollinLevel: return TH_CLEANUP_WITH_SHORT_ABAP_ATTACH
M ThCleanPrevUser: no full attach possible, switch to default cleanup
M ThISessionAttach: attach session of T10_U1158_M0 (em_hdl = 0, abap rollin level = TH_ABAP_ROLL_IN_STORE)
M ThISessionAttach: act em state of T10_U1158_M0 = DP_EM_ATTACHED
M ThCallHooks: call hooks for event AFTER_EM_SESSION_ATTACH
M SosISearchAnchor: found anchor 000007DFB9E2C870 for type/name 2/4
M SosISearchAnchor: found anchor 000007DFB9E30360 for type/name 2/5
M SosISearchAnchor: found anchor 000007DFB9E30460 for type/name 2/6
M SosISearchAnchor: found anchor 000007DFB9E381C0 for type/name 2/7
M SosISearchAnchor: found anchor 000007DFB9E7F850 for type/name 1/16
M SosISearchAnchor: found anchor 000007C9A1E00A90 for type/name 3/0
M SosISearchAnchor: found anchor 000007C9A1E036C0 for type/name 3/1
M SosISearchAnchor: found anchor 000007C9A1E046A0 for type/name 3/2
M SosISearchAnchor: found anchor 000007C9A1E0C3E0 for type/name 3/3
M SosISearchAnchor: found anchor 000007C9A1E0EC20 for type/name 3/4
M SosISearchAnchor: found anchor 000007C9A1E11460 for type/name 3/5
M SosISearchAnchor: found anchor 000007C9A1E11730 for type/name 3/6
M SosISearchAnchor: found anchor 000007C9A1E11A00 for type/name 3/7
M SosISearchAnchor: found anchor 000007C9A1E11AC0 for type/name 3/8
M SosISearchAnchor: found anchor 000007C9A1E11F20 for type/name 3/9
M SosISearchAnchor: found anchor 000007C9A1E122D0 for type/name 3/10
M ThCheckAfterRollIn: o.k.
M ThISessionAttachInternalSession: roll in abap store
M ThISessionAttachInternalSession: act abap state of T10_U1158_M0 is DP_SES_ATTACHED
M ThCallHooks: call hooks for event AFTER_ROLL_IN
M TrThHookFunc: called for Rollin
M SosISearchAnchor: no anchor for type/name 1/5
M ThSwitchSapTrace: current OFF want OFF
M SosISearchAnchor: no anchor for type/name 1/13
M ThSetAttachTime: attached session of T10_U1158_M0 in 529 us
M ThCallHooks: call hooks for event AFTER_SESSION_ATTACH
M PfAttachRecord: statRecordAction is STAT_RECORD_ACTION_REJECT, return
M ThSessionAttach: attach o.k.
M ThDeleteSession2: delete T10_U1158_M0 with thRc ERROR-CORE-PROCESS_CRASHED
M ThTSCancel: set T10_U1158_M0 in status cancelled
M DpSesSetLastRequestTime: set last req time 20160719 15:36:11 for T10_U1158_M0
M ThDeleteThisSession: delete T10_U1158_M0, thRc=16789514
M DpSesGetWorkerType: return workerType DIA for T10_U1158
M DpRqCreate: creating REQ_HANDLER_SESSION request (rq_id 33408, slot 0)
M ThDeleteThisSession: jump back with reqHandlerId REQ_HANDLER_SESSION
M ThRqHandleWithShortJump: short jump with REQ_HANDLER_SESSION request (rq_id 33408)
M ThISelItemExists: item not found in selMask stack of T10_U1158_M0 with 1 level
M ThISelItemExists: Stack of T10_U1158_M0
M ThSelPrintMask: selMask of level 1 is empty
M ThSelPrintMask: selMask of level 0 is empty
M ThSelDelItem: item (REQ_HANDLER_SESSION / TH_SEL_MASK_NO_PARAM) not found in all selMasks of T10_U1158_M0
M ThSelPushLevel: new level is 2 for T10_U1158_M0, (popOption=1)
M ThRqSetCheckSessionQueueImmediately: check session queue without select
M ThISelItemExists: item not found in selMask stack of T10_U1158_M0 with 2 level
M ThISelItemExists: Stack of T10_U1158_M0
M ThSelPrintMask: selMask of level 2 is empty
M ThSelPrintMask: selMask of level 1 is empty
M ThSelPrintMask: selMask of level 0 is empty
M ThSelAddItem: added 1 (hidden=0) item (REQ_HANDLER_SESSION / TH_SEL_MASK_NO_PARAM / hide=0) at index 0 of selMask level 2 (1 items) of T10_U1158_M0
M ThSelPrintMask: selMask at 000007DFB9E1D1E0 level 2, T10_U1158_M0:
M item 0
M handler = REQ_HANDLER_SESSION
M ThSelPrintMask: selMask of level 1 is empty
M ThSelPrintMask: selMask of level 0 is empty
M DpWpSetExtraAction: extraAction of W0=DP_NO_DYNAMIC_WP_CHECK (after DP_BIT_OR) [thRequest.c:788]
M ThRqSendAndRelease: sending REQ_HANDLER_SESSION request with TASK_SWITCH,SET_HOLD
M ThISendRequest: REQ_HANDLER_SESSION (rq_id 33408) from T10_U1158_M0 user=SAPSYS to WORKER, thSendType=TASK_SWITCH,SET_HOLD(0x9))
M ThRqNeedsHandShake: sendtype is switch or hold, no handshake, counter is 0
M ThGetStrategy (task_switch=1, inline_hold=0, holdWp=1)
M ThrtGetStrategy: abap strategy ROLL / O.K.
M ThGetStrategy: hold wp, don't detach session
M ThNewWpStat (task_switch=1, hold=1)
M ThNewWpStat: strategy hold, set WP_HOLD
M ThISendRequest: new wp stat: WP_HOLD
M ThISendRequest: th_step = TH_WORK_NOSYNC
M DpRqSendRequestWithFilter: REQ_HANDLER_SESSION (rq_id 33408) from WORKER to WORKER
M rq_id 33408
M -OUT- ca_blk -1 len 0
M -OUT- prio HIGH
M -OUT- sDataLen 20 sData 030000000A3000010A3000010000000000000000
M -OUT- reqHdlId REQ_HANDLER_SESSION
M -OUT- sender address:
M -OUT- type LOCAL
M -OUT- agentType WORKER workerTyp DIA workerNum 0
M -OUT- session T10_U1158_M0
M -OUT- receiver address:
M -OUT- type LOCAL
M -OUT- agentType WORKER workerTyp DIA
M -OUT- session T10_U1158_M0
M RqQAddRequest: Add request rq_id 33408 (DIA) to queue <T10_U1158_M0> in slot 41 at the beginning
M Dump of queue <T10_U1158_M0> in slot 41 (1 requests, in use, port=0):
M -1 <- 4 (rq_id 33408, DIA, REQ_HANDLER_SESSION) -> -1
M RqQQueueGetNumberOfRequests: Queue <T10_U1158_M0> in slot 41 contains 1 requests of type DIA
M DpRqPutIntoQueue: put request into DIA queue (workerType 1, prio HIGH, rq_id 33408), queue has 1 requests
M DpRqFree: freeing REQ_HANDLER_SESSION request (rq_id 33408, slot 0)
M ThTriggerTaskSwitch: trigger task switch
M ThTriggerTaskSwitch: th_step = TH_WORK_NOSYNC
M ThITriggerTaskSwitch: perform task switch
M ThPerformTaskSwitch: set inPrivMode = 0 for T10_U1158_M0
M ThCallHooks: call hooks for event BEFORE_TASK_SWITCH
M PfTaskSwitch: handle event BEFORE_TASK_SWITCH
M PfTaskSwitch: record action is STAT_RECORD_ACTION_REJECT, return
M TrThHookFunc: called for task switch
M ThrtApcCleanup: handle event BEFORE_TASK_SWITCH
M ThWpHandleStateChange: new state of W0 is WP_HOLD (current state is WP_RUN)
M DpIWpSetNewStat: switched W0 from WP_RUN to WP_HOLD
M DpIWpSetNewStat: info for DIA: new/wait/run/hold/standby/killed = 0/8/1/1/0/0 wps
M ThWpHandleStateChange: new state of W0 is WP_HOLD
M ThWpHandleStateChange: skip dynamic wp check
M ThPerformTaskSwitch: return TH_HOLD_FOR_NEW_REQUEST
M TskhLoop: Got TaskHandlerMessage 2
M TskhLoopResetState: reset after request handling(ics=0)
M DpWpSetExtraAction: extraAction of W0= (after DP_BIT_AND) [thxxhead.c:1967]
M ThISelItemExists: item not found in selMask stack of T10_U1158_M0 with 2 level
M paramType = TH_SEL_MASK_SNC_PARAM
M ThISelItemExists: Stack of T10_U1158_M0
M ThSelPrintMask: selMask at 000007DFB9E1D1E0 level 2, T10_U1158_M0:
M item 0
M handler = REQ_HANDLER_SESSION
M ThSelPrintMask: selMask of level 1 is empty
M ThSelPrintMask: selMask of level 0 is empty
M
M ********* W0 LOOP (DIA) *********
M ThRqAcceptImpl (called_inline=0, timeout=-1)
M ThRqAcceptImpl: keep time slice
M ThRqWaitFor: wait for next request (timeout=-1)
M ThRqWaitFor: wait for request
M ThRqCheckQueues: check queues in W0 with state WP_HOLD, timeout=-1
M NiICreateHandle: hdl 193 state NI_INITIAL_CON
M NiIInitSocket: set default settings for new hdl 193/sock 1476 (I4; DG)
M NiDgHdlCreateForProto: state of hdl 193 NI_DG_UNCONNECTED
M NiISetSockOpt: set option SOL_SOCKET-SO_REUSEADDR of hdl 193 to FALSE
M NiIBind: hdl 193 bound to 127.0.0.1:50811
M NiIBlockMode: set blockmode for hdl 193 FALSE
M RqQQueueGetSelectableHandle: Queue <W0> in slot 5 has selectable hdl 193 (port=50811) and W0
M NiICreateHandle: hdl 201 state NI_INITIAL_CON
M NiIInitSocket: set default settings for new hdl 201/sock 1484 (I4; DG)
M NiDgHdlCreateForProto: state of hdl 201 NI_DG_UNCONNECTED
M NiISetSockOpt: set option SOL_SOCKET-SO_REUSEADDR of hdl 201 to FALSE
M NiIBind: hdl 201 bound to 127.0.0.1:50812
M NiIBlockMode: set blockmode for hdl 201 FALSE
M RqQQueueGetSelectableHandle: Queue <T10_U1158_M0> in slot 41 has selectable hdl 201 (port=50812) and W0
M NiICreateHandle: hdl 209 state NI_INITIAL_CON
M NiIInitSocket: set default settings for new hdl 209/sock 1488 (I4; DG)
M NiDgHdlCreateForProto: state of hdl 209 NI_DG_UNCONNECTED
M NiISetSockOpt: set option SOL_SOCKET-SO_REUSEADDR of hdl 209 to FALSE
M NiIConnectSocket: connection of hdl 209 established to 127.0.0.1:50812
M NiDgHdlConnect: state of hdl 209 NI_DG_CONNECTED
M RqQQueueNotifySelectableHandleAsync: Created new NI connection for queue <T10_U1158_M0> in slot 41 on port 50812 (50813)
M RqQQueueNotifySelectableHandleAsync: Signal selectable handle for queue <T10_U1158_M0> in slot 41 on port 50812 (id=7)
M NiDgHdlSend: hdl 209 sent 1 of 1 bytes to 127.0.0.1:50812
M ThRqGetSessionQueueSelectHandle: return selectable hdl 201 for session queue 41 (T10_U1158_M0)
M ThRqCheckQueuesCreateSelectSet: added selection handle 201 for session queue to select set
M ThRqResetCheckSessionQueueImmediately: reset immediate session queue check
M RqQQueueGetNumberOfRequests: Queue <T10_U1158_M0> in slot 41 contains 1 requests of type DIA
M ThRqGetLengthOfSessionQueue: session queue of T10_U1158_M0 has 1 requests
M ThRqCheckQueues: Check session queue without select
M ThRqCheckQueuesHandleUserQueue: -------------> Check requests in queue
M NiDgHdlRecvFrom: hdl 201 received 1 bytes from 127.0.0.1:50813
M RqQQueueGetRequest: Eat one selectable handle wakeup (id=7), 1. receive
M RqQQueueGetRequest: Eat selectable handle wakeup for queue <T10_U1158_M0> in slot 41 (before cs)
M RqQQueueGetRequest: Get request of queue <T10_U1158_M0> in slot 41 (timeout=0)
M ThRqCheckRequestFunc: Check rq_id 33408
M ThIsAsyncInput (T10_U1158_M0_I1, P-1, C-1, data=0000000000000000, rq_id 33408, respId 0..)
M reqHandlerId=REQ_HANDLER_SESSION (74)
M ThSelReqInfoForHandler: search item (REQ_HANDLER_SESSION / TH_SEL_MASK_NO_PARAM / --) in selMask stack level 2 of T10_U1158_M0
M ThISelItemExists: found item 0 (REQ_HANDLER_SESSION / TH_SEL_MASK_NO_PARAM / hide=0) in selMask level 2, T10_U1158_M0
M ThSelReqInfoForHandler: return TH_SEL_REQ_PROCESS
M ThSelDelItemWithIndex: delete item 0 (REQ_HANDLER_SESSION / TH_SEL_MASK_NO_PARAM) in selMask level 2 with 1 items (hidden=0), T10_U1158_M0
M handler = REQ_HANDLER_SESSION
M ThRqSetCheckSessionQueueImmediately: check session queue without select
M ThSelRestoreMask: pop selMask level 2 of T10_U1158_M0
M ThRqSetCheckSessionQueueImmediately: check session queue without select
M ThSelPopLevel: set selMask level 1 for T10_U1158_M0
M ThSelPrintMask: selMask of level 1 is empty
M ThSelPrintMask: selMask of level 0 is empty
M ThIsAsyncInput: process request REQ_HANDLER_SESSION, rq_id 33408
M RqQRequestFree: Free request in slot 4 (rq_id 33408)
M RqQQueueGetRequest: Request rq_id 33408 found in queue <T10_U1158_M0> in slot 41
M rq_id 33408
M -IN-- ca_blk -1 len 0
M -IN-- prio HIGH
M -IN-- sDataLen 20 sData 030000000A3000010A3000010000000000000000
M -IN-- reqHdlId REQ_HANDLER_SESSION
M -IN-- sender address:
M -IN-- type LOCAL
M -IN-- agentType WORKER workerTyp DIA workerNum 0
M -IN-- session T10_U1158_M0
M -IN-- receiver address:
M -IN-- type LOCAL
M -IN-- agentType WORKER workerTyp DIA
M -IN-- session T10_U1158_M0
M DpRqCopyAndMoveData: copying REQ_HANDLER_SESSION request (rq_id 33408, slot 1)
M ThRqCheckQueuesHandleUserQueue: <------------- Check requests in queue
M ThRqCheckQueuesHandleUserQueue: Got rq_id 33408 from user queue
M ThWpSetCurrentSession: set WP's current session to T10_U1158_M0_I1 (rq_cnt 8, last wp 0, last rq_id 33213)
M ThRqAcceptImpl: keep time slice
M DpWpSetWaitingFor: W0 doesn't wait (NO_WAITING)
M ThRqAcceptImpl: received req for current task at timestamp 1468922771/877000, queueTime 0 usec
M DpIWpSetNewStat: switched W0 from WP_HOLD to WP_RUN
M DpIWpSetNewStat: info for DIA: new/wait/run/hold/standby/killed = 0/8/2/0/0/0 wps
M ThRqAcceptImpl: new state of W0 is WP_RUN
M ThHdlControl: handle control 0X2200000
M DpICtlSetForWp: switch off control 0xffffffff for W0 (0x2200000 -> 0x0)
M DpCtlSetForSession: switch off control 0xffffffff for T10_U1158_M0 (0x0 -> 0x0)
M DpICtlSetForWp: switch on control 0x200000 for W0 (0x0 -> 0x200000)
M ThRqAcceptImpl: accept rq_id 33408 for T10_U1158_M0_I1 recv 8
M User SAPSYS Tname: prot=DP_PLUGIN_PROTOCOL_NONE:
M
M rq_id 33408
M -IN-- ca_blk -1 len 0
M -IN-- prio HIGH
M -IN-- sDataLen 20 sData 030000000A3000010A3000010000000000000000
M -IN-- reqHdlId REQ_HANDLER_SESSION
M -IN-- sender address:
M -IN-- type LOCAL
M -IN-- agentType WORKER workerTyp DIA workerNum 0
M -IN-- session T10_U1158_M0
M -IN-- receiver address:
M -IN-- type LOCAL
M -IN-- agentType WORKER workerTyp DIA
M -IN-- session T10_U1158_M0
M
M RstrNotifyUserChange: user/client = (SAPSYS /000)
M ThRqAcceptImpl: th_step = TH_WORK_SYNC
M ThRqSetCurrentRequest: making REQ_HANDLER_SESSION request (rq_id 33408) the current incoming request
M ThReceive: received SESSION request
M TskhLoop: received SESSION request (rq_id 33408)
M DpSesSetPrepareReqHandler: set prepare request attribute for T10_U1158_M0
M ThHandleRequest: call prepare request SessionHandler for SESSION request
M ThCallHooks: call hooks for event PREPARE_REQUEST
M ThDtTraceStart:
M {root-id=40F2E99D447A1ED693B30CBADD26A359}_{conn-id=00000000000000000000000000000000}_0
M ThISessionAttach: act em state of T10_U1158_M0 is DP_EM_ATTACHED, return
M ThSessionAttach: attach o.k.
M DpSesSetPrepareReqHandler: unset prepare request attribute for T10_U1158_M0
M ThHandleRequest: call handler SessionHandler for SESSION request
M SessionHandler: handling SESSION request
M SessionHandler::handleRequest: handle opcode DP_SES_OPCODE_INTERNAL_DELETE_SESSION
M SessionHandler::handleRequest: delete T10_U1158_M0 (thRc = ERROR-CORE-PROCESS_CRASHED)
M ThrtSetIsDynpSession: T10_U1158_M0 is not a dynp session
M ThCheckMemoryState (return_after_error=1, afterDump=0)
M ThIDeleteSubSession (10, 0, 3, ><, 0, 255, TRUE)
M ThIDeleteSubSession: no modes found ..
M no sub modes
M ThPerformDeleteThisSession: switch off statistics
M PfSetError: clear statistic record
M PfClearAllRec: clear statistic area
M PfClearAllRec: statRecordAction = STAT_RECORD_ACTION_REJECT
M ThPerformDeleteThisSession: set status of T10_U1158 to DP_LOGON_STATE_LOGGING_OFF
M ThPerformDeleteThisSession: last active mode (0) delete tid (10)
M ThPerformLogoff (thRc=ERROR-CORE-PROCESS_CRASHED)
M ThGetDbAction: thRc is 16789514, return TH_DB_ROLLBACK
M ThCheckMemoryState (return_after_error=1, afterDump=0)
M ThCallHooks: call hooks for event LOGOFF_SYSTEM_USR
M ThrtGetTaskTypeOfSession: taskType of T10_U1158_M0: THRT_TASK_AUTOABAP
M ThPerformLogoff: set status of T10_U1158 to DP_LOGON_STATE_LOGGING_OFF
M ThFinalizeSession: finalize T10_U1158_M0
M ThResFreeSession: free resources of T10_U1158_M0 (normal mode, complete free), rc=ERROR-CORE-PROCESS_CRASHED, db_action=TH_DB_ROLLBACK
M ThCallEndOfSessionHooks: call BEFORE_SESSION_CANCEL hooks for T10_U1158_M0
M ThCallHooks: call hooks for event BEFORE_SESSION_CANCEL
M SosISearchAnchor: no anchor for type/name 1/13
M SosISearchAnchor: no anchor for type/name 1/14
M SosISearchAnchor: no anchor for type/name 1/15
M SosISearchAnchor: no anchor for type/name 1/15
M ThrtDbgSetDebugMode2: switch off debugging for T10_U1158_M0
M SosISearchAnchor: no anchor for type/name 1/14
M SosISearchAnchor: no anchor for type/name 1/15
M SosISearchAnchor: no anchor for type/name 1/15
M ThrtDbgSetDebugMode2: switch off debugging for T10_U1158_M0
M ThrtDestroySessionContainer: destroy session container of T10_U1158_M0
M ThrtClearSessionAttributesOfSession: attributes of T10_U1158_M0 =
M ThrtApcCleanup: handle event BEFORE_SESSION_CANCEL
M SosISearchAnchor: no anchor for type/name 1/1
M ThCallEndOfSessionHooks: return
M ThIRollBack: call db_rollback
M ThCheckComOrRb (event=0, full_commit=1)
M ThCallHooks: call hooks for event BEFORE_ROLLBACK
M SosISearchAnchor: no anchor for type/name 1/10
M PfAStatRevertCollected: nothing to do
M SosISearchAnchor: no anchor for type/name 1/1
M ThCheckComOrRb (event=2, full_commit=1)
M ThCallHooks: call hooks for event AFTER_ROLLBACK
M ThNoCheckMutex: check for remaining locked intervals
M SosISearchAnchor: no anchor for type/name 1/8
M ThNoClearPrevErr: clear prev no err
M SosISearchAnchor: no anchor for type/name 1/1
M ThVBIRollBack: initialize TH-hooks
M SosIRegisterHook: add hook >ThVBICmRbHook(00007FF606B0A7E0/0000000000000000)< (condition/order=0xf/0) for event AFTER_COMMIT
M SosIRegisterHook: add hook >ThVBICmRbHook(00007FF606B0A7E0/0000000000000000)< (condition/order=0xf/0) for event AFTER_ROLLBACK
M ThVBIRollBack: no current update request pending
M ThICommit: full commit, set time, free resources for T10_U1158_M0
M ThICommit: commit and free resources
M ThCheckComOrRb (event=1, full_commit=1)
M ThCallHooks: call hooks for event BEFORE_COMMIT
M SosISearchAnchor: no anchor for type/name 1/8
M ThCheckComOrRb (event=3, full_commit=1)
M ThCallHooks: call hooks for event AFTER_COMMIT
M ThVBICmRbHook: called for commit
M SosISearchAnchor: no anchor for type/name 1/8
M ThNoClearPrevErr: clear prev no err
M SosISearchAnchor: no anchor for type/name 1/1
M ThrClearMemory o.k.
M ThCallHooks: call hooks for event AFTER_STORAGE_FREE
M ThICommit o.k.
M PfRejectStatistic: clear statistic record
M PfClearAllRec: clear statistic area
M PfClearAllRec: statRecordAction = STAT_RECORD_ACTION_REJECT
M ThDealComm: T10_U1158_M0 has no cpic conns
M ThCleanAllInternalSessions: cleanup all internal modes of T10_U1158_M0
M ThVmcCleanInternalSession (deleteOfSession=1, AoS=0) for T10_U1158_M0_I1
M DpVmcGetVmByTmAdm: no vm found for T10_U1158_M0
M ThSesGetSessionType: no associated entry
M ThSesIsJavaSessionId: no associated entry
M ThVmcCleanInternalSession o.k.
M call ab_endImode
M ThCallHooks: call hooks for event BEFORE_INTERNAL_SESSION_POP
M SosIFreeAnchorArray: free imode anchor array for T10_U1158_M0_I1 at 0x000007DFB9E1D910
M ThCleanInternalSession: act abap state of T10_U1158_M0 is DP_SES_DETACHED
M ThCallHooks: call hooks for event AFTER_INTERNAL_SESSION_POP
M SosISearchAnchor: found anchor 000007C9A1E00A90 for type/name 3/0
M SosISearchAnchor: found anchor 000007C9A1E036C0 for type/name 3/1
M SosISearchAnchor: found anchor 000007C9A1E046A0 for type/name 3/2
M SosISearchAnchor: found anchor 000007C9A1E0C3E0 for type/name 3/3
M SosISearchAnchor: found anchor 000007C9A1E0EC20 for type/name 3/4
M SosISearchAnchor: found anchor 000007C9A1E11460 for type/name 3/5
M SosISearchAnchor: found anchor 000007C9A1E11730 for type/name 3/6
M SosISearchAnchor: found anchor 000007C9A1E11A00 for type/name 3/7
M SosISearchAnchor: found anchor 000007C9A1E11AC0 for type/name 3/8
M SosISearchAnchor: found anchor 000007C9A1E11F20 for type/name 3/9
M SosISearchAnchor: found anchor 000007C9A1E122D0 for type/name 3/10
M ThSessionAttachInternalSession: attach T10_U1158_M0_I0
M ThCheckEmMagic: check em magic at 000007C9A1F7FF50 for T10_U1158_M0_I0
M ThCheckEmMagic: em magic at 000007C9A1F7FF50 for T10_U1158_M0_I0 o.k.
M ThISessionAttachInternalSession: roll in abap store
M ThISessionAttachInternalSession: act abap state of T10_U1158_M0 is DP_SES_ATTACHED
M ThSessionAttachInternalSession: attach o.k.
M ThrEndMode: call ab_endmode (END_MODE_CLEAR_EMODE)
M RstrNotifyUserChange: user/client = (SAPSYS /000)
M ThGetTransactionId: got trans id (SPA) >65984DE6E9D6F136835940F2E99D447A< (32)
M ThEppGetRootContextIdAsUuid: ThEppGetRootContextIdAsXuuid for epp -2 failed (4/TH_EPP_BAD_HANDLE)
M ThEppGetConnectionIdAsUuid: ThEppGetConnectionIdAsXuuid for epp -2 failed (4/TH_EPP_BAD_HANDLE)
M ***LOG R47=> ThResFreeSession, delete () [thxxmode.c 1080]
M ThGetTransactionId: got trans id (SPA) >65984DE6E9D6F136835940F2E99D447A< (32)
M ThEppGetRootContextIdAsUuid: ThEppGetRootContextIdAsXuuid for epp -2 failed (4/TH_EPP_BAD_HANDLE)
M ThEppGetConnectionIdAsUuid: ThEppGetConnectionIdAsXuuid for epp -2 failed (4/TH_EPP_BAD_HANDLE)
M ThEnqFreeEnqueues: dequeue >20160719153603064000000000baiodevcct......................</1
M NiInit3: NI already initializes (init=1;cur=2048)
M Tue Jul 19 15:36:20 2016
M NiHLGetNodeAddr: got hostname 'baiodevcct' from operating system
M NiIGetNodeAddr: hostname 'baiodevcct' = addr 169.254.165.170
M NiSrvLGetServNo: got service name 'sapdp01' from operating system
M NiIGetServNo: servicename 'sapdp01' = port 3201
E Enqueue Info: enque/use_pfclock2 = FALSE
M NiICreateHandle: hdl 217 state NI_INITIAL_CON
M NiIInitSocket: set default settings for new hdl 217/sock 1472 (I4; ST)
M NiIBlockMode: set blockmode for hdl 217 FALSE
M NiICheckPendConnection: connection of hdl 217 to 169.254.165.170:3201 established
M NiIConnect: hdl 217 took local address 169.254.165.170:56083
M NiIConnect: state of hdl 217 NI_CONNECTED
M NiMyHostName: hostname = 'baiodevcct'
M EncDefaultName: set EncLocalName to baiodevcct_5924_217
M LOCAL UNICODE = 1
M SND: <I=0, M=0xABCDE123, D=CONNECTION_ADM, T=SYNC_REQUEST, MF=NO, len=92/92>
M NiIWrite: hdl 217 sent data (wrt=92,pac=1,MESG_IO)
M NiIRead: hdl 217 recv would block (errno=EAGAIN)
M NiIRead: hdl 217 received data (rcd=96,pac=1,MESG_IO)
M EncFragRecv: using copy mode for connection 000000006691B0E0
M RCV: <I=0, M=0xABCDE123, D=CONNECTION_ADM, T=RESPONSE, MF=NO, len=96/96>
M EncFragRecv: handle opcode ENC Parameter Response
M EncUnpack: Utf8sToUcs (baiodevcct_IOThread_0_4) read 24 bytes (count = 24)
M EncIDoOAMReq: read parameter max_recv_frag 262144
M EncIDoOAMReq: read parameter max_send_frag 262144
M EncIDoOAMReq: read parameter remote name baiodevcct_IOThread_0_4
M EncIDoOAMReq: read parameter remote msg types 59
M EncIDoOAMReq: read parameter remote version 3
M EncIDoOAMReq: read parameter remote unicode support YES
M EncRecvParams: negotiation successful: recv_frag 262144, send_frag 262144
M SND: <I=1, M=0xABCDE123, D=ASYNC_ENQUE, T=ASYNC_REQUEST, MF=NO, len=336/336>
M NiIWrite: hdl 217 sent data (wrt=336,pac=1,MESG_IO)
M ThDelEnqInfo: del enq_own >20160719153603064000000000baiodevcct......................</1
M ThDelEnqInfo: act enq info: 1
M ThGetEnqInfo: no enq info found
M ThEnqFreeEnqueues: dequeue >20160719153603064000010000baiodevcct......................</2
M SND: <I=2, M=0xABCDE123, D=ASYNC_ENQUE, T=ASYNC_REQUEST, MF=NO, len=336/336>
M NiIWrite: hdl 217 sent data (wrt=336,pac=1,MESG_IO)
M ThDelEnqInfo: del enq_own >20160719153603064000010000baiodevcct......................</2
M ThDelEnqInfo: act enq info: 0
M ThDelEnqInfo: no enq infos
M ThGetEnqInfo: no enq info found
M ThVBIRollBack: no current update request pending
M ThSelDeleteStack: delete selMask stack of T10_U1158_M0 (000007DFB9E1D1E0)
M ThSelDeleteStack: delete selMask level 1 (000007DFB9E1D630)
M ThSelDeleteStack: delete selMask level 2 (000007DFB9E1D7E0)
M ThSelDeleteStack: delete selMask level 3 (000007DFB9E1D990)
M ThSelDeleteStack: delete stack (000007DFB9E1D1E0)
M ThPageFree: free (1158,0,0, mode = 2)
M ThRmFree: cleanup resources for T10_U1158_M0
M RmCleanUpResources3: hdr/tbl/ext_tbl/free/keep = 000000000BF872E0/0000000000000000/0/1/0
M RmCleanUpResources3: no resources registered
M ThRmFree: reset eg state of T10_U1158_M0
M ThInvalidateEnqMem: reset enq memory 000007DFB9E8A620 of T10/M0
M ThCallHooks: call hooks for event BEFORE_SESSION_DELETE
M ThEmFree: Delete 1 internal sessions
M SosIFreeAnchorArray: free imode anchor array for T10_U1158_M0_I0 at 0x000007DFB9E1D5B0
M ThEmFree: call EmContextDelete (em_hdl=0)
M ThResetEmMagic: reset em magic for T10_U1158_M0_I0
M ThEmFree: act em state of T10_U1158_M0 = DP_EM_NO_CONTEXT
M ThClearSession: T10_U1158_M0 (next/prev 0/0) , last session (0 remaining sessions)
M ThWpSetCurrentSession: set WP's current session to NO SESSION (rq_cnt 0, last wp -1, last rq_id 0)
M ThInvalidateActRequestQueue: Reset request queue
M ThRqReleaseQueueSelectHandle: release selectable handle of queue 41 (T10_U1158_M0) from [thRequest.c:882]
M ThRqReleaseQueueSelectHandle: invalidate selectable hdl 201 of session queue
M NiICloseHandle: shutdown and close hdl 201/sock 1484
M RqQQueueReleaseSelectableHandle: Queue <T10_U1158_M0> in slot 41 released selectable hdl 201 (port=50812) W-1
M RqQQueueDestroy: Destroy queue <T10_U1158_M0> in slot 41 (12055)
M ThFindValidSession: T10_U1158 has no sessions
M ThFinalizeSession: Release T10_U1158
M ThResFreeLogon: free resources of T10_U1158
M ThWpSetCurrentSession: set WP's current session to invalid T10_M6_I0 (rq_cnt 0, last wp -1, last rq_id 0)
M RmCleanUpResources3: hdr/tbl/ext_tbl/free/keep = 000000000BF96450/0000000000000000/1/1/0
M RmCleanUpResources3: no resources registered
M ThCallHooks: call hooks for event BEFORE_LOGOFF
M SosISearchAnchor: found anchor 000007DFB9E30460 for type/name 2/6
M SosISearchAnchor: found anchor 000007DFB9E381C0 for type/name 2/7
M ThEmFree: delete hyper context (hyperHdl=000007DFB9E42220)
M ThEmFree: delete eg session heap manager for T10_U1158, eg_session_handle=000007DFB9E1C770
M ThWpSetCurrentSession: set WP's current session to NO SESSION (rq_cnt 0, last wp -1, last rq_id 0)
M ThDeleteLogonEntry: release T10_U1158
M DpITmSlotRelease: release T10_U1158
M DpListRemove: remove elem 10 from tmadm_inuse_list
M DpListRemove: 0 elems in tmadm_inuse_list
M DpListInsert: insert elem 10 into tmadm_free_list (at begin)
M DpListInsert: 200 elems in tmadm_free_list
M ThReleaseWp: release W0
M ThGetStrategy (task_switch=1, inline_hold=0, holdWp=0)
M ThrtGetStrategy: abap strategy ROLL / O.K.
M ThNewWpStat (task_switch=1, hold=0)
M ThNewWpStat: task switch, set WP_WAIT
M ThReleaseWp: new wp stat: WP_WAIT
M ThTriggerTaskSwitch: trigger task switch
M ThTriggerTaskSwitch: th_step = TH_WORK_NOSYNC
M ThITriggerTaskSwitch: perform task switch
M ThrtSetSapExt: session not attached
M ThCallHooks: call hooks for event BEFORE_TASK_SWITCH
M PfTaskSwitch: handle event BEFORE_TASK_SWITCH
M PfTaskSwitch: record action is STAT_RECORD_ACTION_REJECT, return
M TrThHookFunc: called for task switch
M ThrtApcCleanup: handle event BEFORE_TASK_SWITCH
M DpSesGetPrepareReqHandler: NO_SESSION_INFOThRqReplaceCurrentRequest: freeing current incoming request REQ_HANDLER_SESSION (rq_id 33408)
M DpRqFree: freeing REQ_HANDLER_SESSION request (rq_id 33408, slot 1)
M rdisp/wp_auto_restart = 0 / 5 sec
M rdisp/wp_abap_restart = 0
M ThSetThToolParam : restartable_wp[0] = FALSE
M ThSetThToolParam : restartable_wp[1] = TRUE
M ThSetThToolParam : restartable_wp[2] = TRUE
M ThSetThToolParam : restartable_wp[3] = FALSE
M ThSetThToolParam : restartable_wp[4] = TRUE
M ThSetThToolParam : restartable_wp[5] = TRUE
M ThSetThToolParam : restartable_wp[6] = TRUE
M ThWpHandleStateChange: new state of W0 is WP_WAIT (current state is WP_RUN)
M DpAddReqHandlingTime: add 15000.000000 us runtime to runningQueueTimeSum[DIA], sum = 15000.000000 us
M DpIWpSetNewStat: switched W0 from WP_RUN to WP_WAIT
M DpIWpSetNewStat: info for DIA: new/wait/run/hold/standby/killed = 0/10/0/0/0/0 wps
M ThWpHandleStateChange: new state of W0 is WP_WAIT
M ThPerformTaskSwitch: return TH_WAIT_FOR_REQUEST
M TskhLoop: Got TaskHandlerMessage 1
M TskhLoopResetState: reset after request handling(ics=0)
M DpWpSetExtraAction: extraAction of W0= (after DP_BIT_AND) [thxxhead.c:1967]
M ThISelItemExists: no stack found
M ThWpSetCurrentSession: set WP's current session to NO SESSION (rq_cnt 0, last wp -1, last rq_id 0)
M DpRqFreePendingRequests: freed 0 pending request
M TskhLoopResetState: switch back to normal tracel level 1 (after request handling)
A
A Tue Jul 19 15:37:03 2016
A AppServerTimeSync, checkLocalTime():
A Initializing local WP variables:
A zdate_LastLocalTime with 1468922823
A zdate_LastLocalBias with 0
B
B Tue Jul 19 15:56:03 2016
B DBREPO: MAJOR_VERS part of REPOLOAD primary key
B DBREPO: set new access functions for table REPOLOAD
A
A Tue Jul 19 15:56:12 2016
A ***GENER* Trace switched off ***
A bgRFC> [R] Activate_supervisor with iv_use_none =
A bgRFC> [R] Calling BGRFC_CHECK_SCHEDULERS dest = BGRFC_SUPERVISOR
M
M Tue Jul 19 16:06:17 2016
M SecAudit(rsauinit): WP attached to existing shared memory.
M SecAudit(RsauShmInit): addr of SHM for Audit.. = 000000001B7F0050
M SecAudit(RsauShmInit): addr of RSAUSHM........ = 000000001B7F1050
M SecAudit(RsauShmInit): addr of RSAUSLOTINFO... = 000000001B7F1D90
M SecAudit(RsauShmInit): addr of RSAUSLOTS...... = 000000001B7F1DA0
A
A Tue Jul 19 16:21:03 2016
A bgRFC> [R] Activate_supervisor with iv_use_none =
A bgRFC> [R] Calling BGRFC_CHECK_SCHEDULERS dest = BGRFC_SUPERVISOR
S
S Tue Jul 19 16:22:03 2016
S found spool memory service RSPO-ACTIONS at 0000000062ADA470
B
B Tue Jul 19 16:23:03 2016
B dbsync[db_syexe]: { wait=0, call_no=50, current_ts=20160719162303, last_counter=2145094697
dev_disp
--------------
---------------------------------------------------
trc file: "dev_disp", trc level: 1, release: "741"
---------------------------------------------------
sysno 00
sid QA1
systemid 562 (PC with Windows NT)
relno 7410
patchlevel 0
patchno 225
intno 20020600
make multithreaded, Unicode, 64 bit, optimized
profile \\baiodevcct\sapmnt\QA1\SYS\profile\QA1_DVEBMGS00_baiodevcct
pid 6072
Tue Jul 19 14:40:28 2016
kernel runs with dp version 216000(ext=117000) (@(#) DPLIB-INT-VERSION-216000-UC)
length of sys_adm_ext is 500 bytes
***LOG Q00=> DpSapEnvInit, DPStart (00 6072) [dpInit.c 598]
shared lib "dw_xml.dll" version 225 successfully loaded
shared lib "dw_xtc.dll" version 225 successfully loaded
shared lib "dw_stl.dll" version 225 successfully loaded
shared lib "dw_gui.dll" version 225 successfully loaded
shared lib "dw_rndrt.dll" version 225 successfully loaded
shared lib "dw_abp.dll" version 225 successfully loaded
DpCheckMulticast: check of IP v4 multicast address o.k.
rdisp/softcancel_sequence : -> 1,15,-5
use internal message server connection to port 3901
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
Tue Jul 19 14:40:37 2016
*** WARNING => DpNetCheck: NiHostToAddr(baiodevcct) took 9 seconds
Tue Jul 19 14:40:42 2016
*** WARNING => DpNetCheck: NiAddrToHost(1.0.0.0) took 4 seconds
***LOG GZZ=> 2 possible network problems detected - check tracefile and adjust the DNS settings [dpxxtool2.c 5036]
MtxInit: 30000 0 0
DpIPCInit2: write dp-profile-values into sys_adm_ext
DpIPCInit2: start server >baiodevcct_QA1_00 <
DpShMCreate: alloate/attach shared memory (mode=CREATE)
DpShMCreate: sizeof(wp_adm) 23184 (1104)
DpShMCreate: sizeof(tm_adm) 13040880 (64880)
DpShMCreate: sizeof(ca_adm) 432000 (72)
DpCommTableSize: max/headSize/ftSize/tableSize=500/16/1832064/1951152
DpShMCreate: sizeof(comm_adm) 1951152 (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=500/16/520064/520080
DpShMCreate: sizeof(sock_adm) 520080 (1016)
DpShMCreate: sizeof(vmc_adm) 0 (3208)
DpShMCreate: sizeof(wall_adm) (ft=41664/fi=67472/hd=64/rec=192)
DpShMCreate: sizeof(amc_rec_adm) (ft=86464/fi=67472/hd=64/rec=416)
DpShMCreate: sizeof(websocket_adm) (ft=28864/hd=64/rec=272)
DpShMCreate: sizeof(gw_adm) 64
DpShMCreate: sizeof(j2ee_adm) 3936
DpShMCreate: SHM_DP_ADM_KEY (addr: 000000000A420050, size: 16369648
DpShMCreate: allocated sys_adm at 000000000A420250
DpShMCreate: allocated wp_adm_list at 000000000A432100
DpShMCreate: allocated wp_adm at 000000000A432420
DpShMCreate: allocated tm_adm_list at 000000000A4380B0
DpShMCreate: allocated tm_adm at 000000000A4382F0
DpShMCreate: allocated ca_adm at 000000000B0A81E0
DpShMCreate: allocated comm_adm at 000000000B111B60
DpShMCreate: system runs without slock table
DpShMCreate: allocated sock_adm at 000000000B2EE310
DpShMCreate: allocated vmc_adm_list at 000000000B36D4A0
DpShMCreate: system runs without VMC
DpShMCreate: allocated gw_adm at 000000000B36D740
DpShMCreate: allocated j2ee_adm at 000000000B36D980
DpShMCreate: allocated ca_info at 000000000B36EAE0
DpShMCreate: allocated wall_adm (ft) at 000000000B36ED20
DpShMCreate: allocated wall_adm (fi) at 000000000B3791E0
DpShMCreate: allocated wall_adm (head) at 000000000B389B70
DpShMCreate: allocated amc_rec_adm (ft) at 000000000B389DB0
DpShMCreate: allocated amc_rec_adm (fi) at 000000000B39F170
DpShMCreate: allocated amc_rec_adm (head) at 000000000B3AFB00
DpShMCreate: allocated websocket_adm (ft) at 000000000B3AFD40
DpShMCreate: allocated websocket_adm (head) at 000000000B3B7000
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 = 10
#btc = 0
#standby = 0
#max = 21
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] = 8
withPrioTickets[RQ_Q_PRIO_NORMAL] = true
Prio Class Low
maxRuntime[RQ_Q_PRIO_LOW] = 1800 sec
maxRuntimeHalf[RQ_Q_PRIO_LOW] = 900 sec
maxTicketsForPrio[RQ_Q_PRIO_LOW] = 8
withPrioTickets[RQ_Q_PRIO_LOW] = true
Running requests[RQ_Q_PRIO_NORMAL] = 0
Running requests[RQ_Q_PRIO_LOW] = 0
DpCommAttachTable: attached comm table (header=000000000B111B60/ft=000000000B111B70/fi=000000000B2D0FF0)
DpSockAttachTable: attached sock table (header=000000000B2EE310/ft=000000000B2EE320)
MBUF state OFF
DpCommInitTable: init table for 500 entries
DpSockInitTable: init table for 500 entries
EmInit: MmSetImplementation( 2 ).
MM global diagnostic options set: 0
<ES> client 21 initializing ....
<ES> EsILock: use Mutex for locking
<ES> InitFreeList
<ES> block size is 4096 kByte.
<ES> Info: em/initial_size_MB( 91618MB) not multiple of em/blocksize_KB( 4096KB)
<ES> Info: em/initial_size_MB rounded up to 91620MB
<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 view
<EsNT> Using memory model view.
<EsNT> Memory Reset disabled as NT default
<ES> 22904 blocks reserved for free list.
ES initialized.
mm.dump: set global maximum dump mem to 192 MB
EsRegisterEmCheck: Register EmGetEsHandles at 00007FF608411C90
rdisp/calculateLoadAverage : 1
***LOG Q0K=> DpMsAttach, mscon ( baiodevcct) [dpMessageSer 1652]
DpStartStopMsg: send start message (myname is >baiodevcct_QA1_00 <)
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%
CreateProcess gwrd (PID:3404 HANDLE:1148)
CreateProcess ICM (PID:2664 HANDLE:1156)
create new work process W0 (PID:5552 HANDLE:1172)
create new work process W1 (PID:6096 HANDLE:1176)
create new work process W2 (PID:5036 HANDLE:1180)
create new work process W3 (PID:3456 HANDLE:1184)
create new work process W4 (PID:2764 HANDLE:1188)
create new work process W5 (PID:2336 HANDLE:1192)
create new work process W6 (PID:4664 HANDLE:1196)
create new work process W7 (PID:108 HANDLE:1200)
create new work process W8 (PID:1504 HANDLE:1204)
create new work process W9 (PID:4104 HANDLE:1208)
create new work process W10 (PID:5976 HANDLE:1212)
create new work process W11 (PID:5856 HANDLE:1228)
create new work process W12 (PID:3916 HANDLE:1232)
create new work process W13 (PID:3768 HANDLE:1236)
create new work process W14 (PID:3640 HANDLE:1240)
create new work process W15 (PID:5572 HANDLE:1244)
Tue Jul 19 14:40:43 2016
CCMS: Initialized monitoring segment of size 60000000.
CCMS: Initialized CCMS Headers in the shared monitoring segment.
CCMS: Checking Downtime Configuration of Monitoring Segment.
CCMS: AlMsUpload called by wp 1024.
Tue Jul 19 14:40:44 2016
CCMS: AlMsUpload successful for G:\usr\sap\QA1\DVEBMGS00\log\ALMTTREE.DAT (4686 MTEs).
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
Tue Jul 19 14:40:55 2016
MBUF state ACTIVE
DpMBufTypeMod: MBUF component UP (event=MBUF_DPEVT_UP)
DpMsgProcess: 1 server in MBUF
DpMsCheckServices()
Tue Jul 19 14:41:02 2016
DpMBufTypeMod: MBUF server state ACTIVE (event=MBUF_DPEVT_DSTATE)
DpModState: change server state from STARTING to ACTIVE
DpMsInfo: MOD for server baiodevcct_QA1_00
Tue Jul 19 14:41:22 2016
*** ERROR => DpHdlDeadWp: W6 (pid 4664) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W6 (pid = 4664)
********** SERVER SNAPSHOT 1 (Reason: Workprocess 6 died) - begin **********
Scheduler info
--------------
WP info
DpNumberOfDiaWps: dia_wps 9, standby_wps 0
#dia = 9
#btc = 3
#standby = 0
#max = 21
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] = 8
withPrioTickets[RQ_Q_PRIO_NORMAL] = true
Prio Class Low
maxRuntime[RQ_Q_PRIO_LOW] = 1800 sec
maxRuntimeHalf[RQ_Q_PRIO_LOW] = 900 sec
maxTicketsForPrio[RQ_Q_PRIO_LOW] = 8
withPrioTickets[RQ_Q_PRIO_LOW] = true
Actual tickets in use
actTicketsInUseForPrio[RQ_Q_PRIO_NORMAL] = 7
actTicketsInUseForPrio[RQ_Q_PRIO_LOW] = 7
Running requests[RQ_Q_PRIO_NORMAL] = 0
Running requests[RQ_Q_PRIO_LOW] = 0
Queue Statistics Tue Jul 19 09:11:22 2016
------------------------------------------------------------
Number of lost wakeup datagrams: 0
Max. number of queue elements : 14000
NOWP: 0 (peak 5, writeCount 116, readCount 116)
DIA : 0 (peak 4, writeCount 110, readCount 110)
UPD : 0 (peak 2, writeCount 4, readCount 4)
ENQ : 0 (peak 0, writeCount 0, readCount 0)
BTC : 0 (peak 2, writeCount 62, readCount 62)
SPO : 0 (peak 1, writeCount 3, readCount 3)
UP2 : 0 (peak 1, writeCount 1, readCount 1)
DISP: 0 (peak 5, writeCount 61, readCount 61)
GW : 0 (peak 1, writeCount 51, readCount 51)
IC : 0 (peak 1, writeCount 4, readCount 4)
LWP : 1 (peak 15, writeCount 18, readCount 17)
Session queue dump (high priority, 0 elements, peak 3):
Session queue dump (normal priority, 0 elements, peak 1):
Session queue dump (low priority, 0 elements, peak 1):
Dump of queue <W7> in slot 12 (1 requests, in use, port=49653):
-1 <- 7 (rq_id 3664, DIA, REQ_HANDLER_PROCESS) -> -1
Infos about some special queues:
Queue <StartServiceQueue> in slot 3 (port=0) has no requests
Workprocess Table (long) Tue Jul 19 09:11:22 2016
------------------------------------------------------------
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 |
|---+------+----+-------+-----+---+----+----------------+---------+------+---+-----+----------------------------------------+---+------------+--------------------+--------------------|
| 0|5552 |DIA | | | | | | | | | | | | | | |
| 1|6096 |DIA | | | | | | | | | | | | | | |
| 2|5036 |DIA | | | | | | | | | | | | | | |
| 3|3456 |DIA | | | | | | | | | | | | | | |
| 4|2764 |DIA | | | | | | | | | | | | | | |
| 5|2336 |DIA | | | | | | | | | | | | | | |
| 6| |DIA |WP_KILL| |1 |high|T1_U47_M0 |GUI | | | |SAPLTHFB |000| | | |
| 7|108 |DIA |WP_RUN | | |high|T0_U5_M0 |INTERNAL | | | 27|RSDBAMDP |000|SAPSYS | | |
| 8|1504 |DIA | | | | | | | | | | | | | | |
| 9|4104 |DIA | | | | | | | | | | | | | | |
| 10|5976 |UPD | | | | | | | | | | | | | | |
| 11|5856 |BTC | | | | | | | | | | | | | | |
| 12|3916 |BTC | | | | | | | | | | | | | | |
| 13|3768 |BTC | | | | | | | | | | | | | | |
| 14|3640 |SPO | | | | | | | | | | | | | | |
| 15|5572 |UP2 | | | | | | | | | | | | | | |
Session Table Tue Jul 19 09:11:22 2016
------------------------------------------------------------
|Logon-Type |Sess-Key |Cli|User |Terminal |Time |WP |Program |Prio|Tasks|Application-Info |Tcode |ES-Mem(KB)|
|------------+----------------+---+------------+--------------------+--------+---+----------------------------------------+----+-----+--------------------------------------------------+----------+----------|
|INTERNAL |T0_U5_M0 |000|SAPSYS | |14:40:55|7 |RSDBAMDP |high| | | |4138 |
|GUI |T1_U47_M0 |000| |baiodevcct |14:41:21|6 |SAPMSYST |high| | | |4138 |
CA Blocks
0 ca_blk slots of 6000 in use, 0 currently unowned (in request queues)
********** SERVER SNAPSHOT 1 (Reason: Workprocess 6 died) - end **********
***LOG Q41=> DpDumpInternalTables, () [dpxxdisp.c 3280]
create new work process W6 (PID:4252 HANDLE:1376)
Tue Jul 19 14:41:32 2016
DpTriggerSapSnapshot: start G:\usr\sap\QA1\DVEBMGS00\exe\sapcontrol.EXE
DpTriggerSapSnapshot: sapcontrol runs with pid 5496
Tue Jul 19 14:41:42 2016
*** ERROR => DpHdlDeadWp: W8 (pid 1504) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W8 (pid = 1504)
DpSkipSnapshot: last snapshot created at Tue Jul 19 14:41:32 2016
, skip new snapshot
create new work process W8 (PID:5108 HANDLE:1388)
DpCheckSapcontrolProcess: sapcontrol with pid 5496 terminated
Tue Jul 19 14:46:23 2016
*** ERROR => DpHdlDeadWp: W7 (pid 108) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W7 (pid = 108)
DpSkipSnapshot: last snapshot created at Tue Jul 19 14:41:32 2016
, skip new snapshot
create new work process W7 (PID:5840 HANDLE:516)
Tue Jul 19 14:49:43 2016
*** ERROR => DpHdlDeadWp: W0 (pid 5552) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W0 (pid = 5552)
********** SERVER SNAPSHOT 2 (Reason: Workprocess 0 died) - begin **********
Scheduler info
--------------
WP info
DpNumberOfDiaWps: dia_wps 9, standby_wps 0
#dia = 9
#btc = 3
#standby = 0
#max = 21
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] = 8
withPrioTickets[RQ_Q_PRIO_NORMAL] = true
Prio Class Low
maxRuntime[RQ_Q_PRIO_LOW] = 1800 sec
maxRuntimeHalf[RQ_Q_PRIO_LOW] = 900 sec
maxTicketsForPrio[RQ_Q_PRIO_LOW] = 8
withPrioTickets[RQ_Q_PRIO_LOW] = true
Actual tickets in use
actTicketsInUseForPrio[RQ_Q_PRIO_NORMAL] = 8
actTicketsInUseForPrio[RQ_Q_PRIO_LOW] = 8
Running requests[RQ_Q_PRIO_NORMAL] = 0
Running requests[RQ_Q_PRIO_LOW] = 0
Queue Statistics Tue Jul 19 09:19:43 2016
------------------------------------------------------------
Number of lost wakeup datagrams: 0
Max. number of queue elements : 14000
NOWP: 0 (peak 5, writeCount 573, readCount 573)
DIA : 0 (peak 4, writeCount 662, readCount 662)
UPD : 0 (peak 2, writeCount 6, readCount 6)
ENQ : 0 (peak 0, writeCount 0, readCount 0)
BTC : 0 (peak 3, writeCount 88, readCount 88)
SPO : 0 (peak 1, writeCount 21, readCount 21)
UP2 : 0 (peak 1, writeCount 3, readCount 3)
DISP: 0 (peak 5, writeCount 125, readCount 125)
GW : 0 (peak 2, writeCount 442, readCount 442)
IC : 0 (peak 1, writeCount 4, readCount 4)
LWP : 0 (peak 15, writeCount 47, readCount 47)
Session queue dump (high priority, 0 elements, peak 3):
Session queue dump (normal priority, 0 elements, peak 1):
Session queue dump (low priority, 0 elements, peak 1):
Infos about some special queues:
Queue <StartServiceQueue> in slot 3 (port=0) has no requests
Workprocess Table (long) Tue Jul 19 09:19:43 2016
------------------------------------------------------------
Current snapshot id: 2
Number of preemptions : 0
|No |Pid |Type|State |Cause|Err|Prio|Sess-Key |Sess-Type|Locked|Sem|Time |Program |Cli|User |Action |Action-Info |
|---+------+----+-------+-----+---+----+----------------+---------+------+---+-----+----------------------------------------+---+------------+--------------------+--------------------|
| 0| |DIA |WP_KILL| |1 |high|T0_U187_M0 |GUI | | | |SAPLTHFB |000| | | |
| 1|6096 |DIA | | | | | | | | | | | | | | |
| 2|5036 |DIA | | | | | | | | | | | | | | |
| 3|3456 |DIA | | | | | | | | | | | | | | |
| 4|2764 |DIA | | | | | | | | | | | | | | |
| 5|2336 |DIA | | | | | | | | | | | | | | |
| 6|4252 |DIA | | |1 | | | | | | | | | | | |
| 7|5840 |DIA | | |1 | | | | | | | | | | | |
| 8|5108 |DIA | | |1 | | | | | | | | | | | |
| 9|4104 |DIA | | | | | | | | | | | | | | |
| 10|5976 |UPD | | | | | | | | | | | | | | |
| 11|5856 |BTC | | | | | | | | | | | | | | |
| 12|3916 |BTC | | | | | | | | | | | | | | |
| 13|3768 |BTC | | | | | | | | | | | | | | |
| 14|3640 |SPO | | | | | | | | | | | | | | |
| 15|5572 |UP2 | | | | | | | | | | | | | | |
Session Table Tue Jul 19 09:19:43 2016
------------------------------------------------------------
|Logon-Type |Sess-Key |Cli|User |Terminal |Time |WP |Program |Prio|Tasks|Application-Info |Tcode |ES-Mem(KB)|
|------------+----------------+---+------------+--------------------+--------+---+----------------------------------------+----+-----+--------------------------------------------------+----------+----------|
|GUI |T0_U187_M0 |000| |dell-PC |14:49:35|0 |SAPMSYST |high| | | |4138 |
CA Blocks
0 ca_blk slots of 6000 in use, 0 currently unowned (in request queues)
********** SERVER SNAPSHOT 2 (Reason: Workprocess 0 died) - end **********
***LOG Q41=> DpDumpInternalTables, () [dpxxdisp.c 3280]
create new work process W0 (PID:3596 HANDLE:1200)
Tue Jul 19 14:49:53 2016
DpTriggerSapSnapshot: start G:\usr\sap\QA1\DVEBMGS00\exe\sapcontrol.EXE
DpTriggerSapSnapshot: sapcontrol runs with pid 3792
Tue Jul 19 14:50:03 2016
DpCheckSapcontrolProcess: sapcontrol with pid 3792 terminated
Tue Jul 19 14:51:23 2016
*** ERROR => DpHdlDeadWp: W2 (pid 5036) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W2 (pid = 5036)
DpSkipSnapshot: last snapshot created at Tue Jul 19 14:49:53 2016
, skip new snapshot
create new work process W2 (PID:5668 HANDLE:452)
Tue Jul 19 14:56:23 2016
*** ERROR => DpHdlDeadWp: W4 (pid 2764) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W4 (pid = 2764)
********** SERVER SNAPSHOT 3 (Reason: Workprocess 4 died) - begin **********
Scheduler info
--------------
WP info
DpNumberOfDiaWps: dia_wps 9, standby_wps 0
#dia = 9
#btc = 3
#standby = 0
#max = 21
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] = 8
withPrioTickets[RQ_Q_PRIO_NORMAL] = true
Prio Class Low
maxRuntime[RQ_Q_PRIO_LOW] = 1800 sec
maxRuntimeHalf[RQ_Q_PRIO_LOW] = 900 sec
maxTicketsForPrio[RQ_Q_PRIO_LOW] = 8
withPrioTickets[RQ_Q_PRIO_LOW] = true
Actual tickets in use
actTicketsInUseForPrio[RQ_Q_PRIO_NORMAL] = 8
actTicketsInUseForPrio[RQ_Q_PRIO_LOW] = 8
Running requests[RQ_Q_PRIO_NORMAL] = 0
Running requests[RQ_Q_PRIO_LOW] = 0
Queue Statistics Tue Jul 19 09:26:23 2016
------------------------------------------------------------
Number of lost wakeup datagrams: 0
Max. number of queue elements : 14000
NOWP: 0 (peak 5, writeCount 1030, readCount 1030)
DIA : 0 (peak 4, writeCount 1273, readCount 1273)
UPD : 0 (peak 2, writeCount 10, readCount 10)
ENQ : 0 (peak 0, writeCount 0, readCount 0)
BTC : 0 (peak 3, writeCount 161, readCount 161)
SPO : 0 (peak 1, writeCount 39, readCount 39)
UP2 : 0 (peak 1, writeCount 7, readCount 7)
DISP: 0 (peak 5, writeCount 185, readCount 185)
GW : 0 (peak 2, writeCount 837, readCount 837)
IC : 0 (peak 1, writeCount 4, readCount 4)
LWP : 0 (peak 15, writeCount 102, readCount 102)
Session queue dump (high priority, 0 elements, peak 3):
Session queue dump (normal priority, 0 elements, peak 1):
Session queue dump (low priority, 0 elements, peak 1):
Infos about some special queues:
Queue <StartServiceQueue> in slot 3 (port=0) has no requests
Workprocess Table (long) Tue Jul 19 09:26:23 2016
------------------------------------------------------------
Current snapshot id: 3
Number of preemptions : 0
|No |Pid |Type|State |Cause|Err|Prio|Sess-Key |Sess-Type|Locked|Sem|Time |Program |Cli|User |Action |Action-Info |
|---+------+----+-------+-----+---+----+----------------+---------+------+---+-----+----------------------------------------+---+------------+--------------------+--------------------|
| 0|3596 |DIA | | |1 | | | | | | | | | | | |
| 1|6096 |DIA | | | | | | | | | | | | | | |
| 2|5668 |DIA | | |1 | | | | | | | | | | | |
| 3|3456 |DIA | | | | | | | | | | | | | | |
| 4| |DIA |WP_KILL| |1 |high|T0_U301_M0 |INTERNAL | | | |SAPMSSY8 |000|SAPSYS | | |
| 5|2336 |DIA | | | | | | | | | | | | | | |
| 6|4252 |DIA | | |1 | | | | | | | | | | | |
| 7|5840 |DIA | | |1 | | | | | | | | | | | |
| 8|5108 |DIA | | |1 | | | | | | | | | | | |
| 9|4104 |DIA | | | | | | | | | | | | | | |
| 10|5976 |UPD | | | | | | | | | | | | | | |
| 11|5856 |BTC | | | | | | | | | | | | | | |
| 12|3916 |BTC | | | | | | | | | | | | | | |
| 13|3768 |BTC | | | | | | | | | | | | | | |
| 14|3640 |SPO | | | | | | | | | | | | | | |
| 15|5572 |UP2 | | | | | | | | | | | | | | |
Session Table Tue Jul 19 09:26:23 2016
------------------------------------------------------------
|Logon-Type |Sess-Key |Cli|User |Terminal |Time |WP |Program |Prio|Tasks|Application-Info |Tcode |ES-Mem(KB)|
|------------+----------------+---+------------+--------------------+--------+---+----------------------------------------+----+-----+--------------------------------------------------+----------+----------|
|INTERNAL |T0_U301_M0 |000|SAPSYS | |14:56:02|4 |SAPMSSY8 |high| | | |8235 |
CA Blocks
0 ca_blk slots of 6000 in use, 0 currently unowned (in request queues)
********** SERVER SNAPSHOT 3 (Reason: Workprocess 4 died) - end **********
***LOG Q41=> DpDumpInternalTables, () [dpxxdisp.c 3280]
create new work process W4 (PID:5804 HANDLE:1404)
Tue Jul 19 14:56:33 2016
DpTriggerSapSnapshot: start G:\usr\sap\QA1\DVEBMGS00\exe\sapcontrol.EXE
DpTriggerSapSnapshot: sapcontrol runs with pid 4744
Tue Jul 19 14:56:43 2016
DpCheckSapcontrolProcess: sapcontrol with pid 4744 terminated
Tue Jul 19 15:01:23 2016
*** ERROR => DpHdlDeadWp: W3 (pid 3456) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W3 (pid = 3456)
DpSkipSnapshot: last snapshot created at Tue Jul 19 14:56:33 2016
, skip new snapshot
create new work process W3 (PID:5908 HANDLE:1408)
Tue Jul 19 15:06:03 2016
*** ERROR => DpHdlDeadWp: W1 (pid 6096) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W1 (pid = 6096)
********** SERVER SNAPSHOT 4 (Reason: Workprocess 1 died) - begin **********
Scheduler info
--------------
WP info
DpNumberOfDiaWps: dia_wps 9, standby_wps 0
#dia = 9
#btc = 3
#standby = 0
#max = 21
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] = 8
withPrioTickets[RQ_Q_PRIO_NORMAL] = true
Prio Class Low
maxRuntime[RQ_Q_PRIO_LOW] = 1800 sec
maxRuntimeHalf[RQ_Q_PRIO_LOW] = 900 sec
maxTicketsForPrio[RQ_Q_PRIO_LOW] = 8
withPrioTickets[RQ_Q_PRIO_LOW] = true
Actual tickets in use
actTicketsInUseForPrio[RQ_Q_PRIO_NORMAL] = 7
actTicketsInUseForPrio[RQ_Q_PRIO_LOW] = 7
Running requests[RQ_Q_PRIO_NORMAL] = 0
Running requests[RQ_Q_PRIO_LOW] = 0
Queue Statistics Tue Jul 19 09:36:03 2016
------------------------------------------------------------
Number of lost wakeup datagrams: 0
Max. number of queue elements : 14000
NOWP: 0 (peak 5, writeCount 1523, readCount 1523)
DIA : 0 (peak 4, writeCount 2093, readCount 2093)
UPD : 0 (peak 2, writeCount 14, readCount 14)
ENQ : 0 (peak 0, writeCount 0, readCount 0)
BTC : 1 (peak 3, writeCount 499, readCount 498)
SPO : 0 (peak 1, writeCount 63, readCount 63)
UP2 : 0 (peak 1, writeCount 11, readCount 11)
DISP: 0 (peak 5, writeCount 280, readCount 280)
GW : 0 (peak 2, writeCount 1233, readCount 1233)
IC : 0 (peak 1, writeCount 4, readCount 4)
LWP : 1 (peak 15, writeCount 160, readCount 159)
Session queue dump (high priority, 0 elements, peak 3):
Session queue dump (normal priority, 0 elements, peak 1):
Session queue dump (low priority, 0 elements, peak 1):
Dump of queue <W5> in slot 10 (1 requests, in use, port=55266):
-1 <- 9 (rq_id 17871, DIA, REQ_HANDLER_PROCESS) -> -1
Infos about some special queues:
Queue <StartServiceQueue> in slot 3 (port=0) has no requests
Workprocess Table (long) Tue Jul 19 09:36:03 2016
------------------------------------------------------------
Current snapshot id: 4
Number of preemptions : 0
|No |Pid |Type|State |Cause|Err|Prio|Sess-Key |Sess-Type|Locked|Sem|Time |Program |Cli|User |Action |Action-Info |
|---+------+----+-------+-----+---+----+----------------+---------+------+---+-----+----------------------------------------+---+------------+--------------------+--------------------|
| 0|3596 |DIA | | |1 | | | | | | | | | | | |
| 1| |DIA |WP_KILL| |1 |high|T0_U556_M0 |INTERNAL | | | |SAPMSSY8 |000|SAPSYS | | |
| 2|5668 |DIA | | |1 | | | | | | | | | | | |
| 3|5908 |DIA | | |1 | | | | | | | | | | | |
| 4|5804 |DIA | | |1 | | | | | | | | | | | |
| 5|2336 |DIA |WP_HOLD|RFC | |high|T5_U557_M0 |INTERNAL | | | 1|CL_BGRFC_SUPERVISOR_START=====CP |000|SAPSYS | | |
| 6|4252 |DIA |WP_RUN | |1 |high|T4_U588_M0 |INTERNAL | | | 0| |000|SAPSYS |READSEQ |TBTCO |
| 7|5840 |DIA | | |1 | | | | | | | | | | | |
| 8|5108 |DIA | | |1 | | | | | | | | | | | |
| 9|4104 |DIA | | | | | | | | | | | | | | |
| 10|5976 |UPD | | | | | | | | | | | | | | |
| 11|5856 |BTC |WP_RUN | | |low |T7_U589_M0 |BATCH | | | 0| |000|SAPSYS | | |
| 12|3916 |BTC |WP_RUN | | |low |T1_U590_M0 |BATCH | | | 0| |000|SAPSYS | | |
| 13|3768 |BTC |WP_RUN | | |low |T12_U591_M0 |BATCH | | | 0|<BATCH> |000|SAPSYS |UPDATE |TBTCO |
| 14|3640 |SPO | | | | | | | | | | | | | | |
| 15|5572 |UP2 | | | | | | | | | | | | | | |
Session Table Tue Jul 19 09:36:03 2016
------------------------------------------------------------
|Logon-Type |Sess-Key |Cli|User |Terminal |Time |WP |Program |Prio|Tasks|Application-Info |Tcode |ES-Mem(KB)|
|------------+----------------+---+------------+--------------------+--------+---+----------------------------------------+----+-----+--------------------------------------------------+----------+----------|
|INTERNAL |T0_U556_M0 |000|SAPSYS | |15:06:02|1 |SAPMSSY8 |high| | | |8235 |
|BATCH |T1_U590_M0 |000|SAPSYS | |15:06:03|12 |SAPMSSY2 |low | | | |4139 |
|INTERNAL |T4_U588_M0 |000|SAPSYS | |15:06:03|6 |SAPMSSY2 |high| | | |4139 |
|INTERNAL |T5_U557_M0 |000|SAPSYS | |15:06:02|5 |RS_BGRFC_SCHEDULER_STARTUP |high| | | |4139 |
|BATCH |T7_U589_M0 |000|SAPSYS | |15:06:03|11 |RSBTCRTE |low | | | |8235 |
|BATCH |T12_U591_M0 |000|SAPSYS | |15:06:03|13 |SAPMSSY2 |low | | | |4138 |
CA Blocks
0 ca_blk slots of 6000 in use, 0 currently unowned (in request queues)
********** SERVER SNAPSHOT 4 (Reason: Workprocess 1 died) - end **********
***LOG Q41=> DpDumpInternalTables, () [dpxxdisp.c 3280]
create new work process W1 (PID:5496 HANDLE:1420)
Tue Jul 19 15:06:13 2016
DpTriggerSapSnapshot: start G:\usr\sap\QA1\DVEBMGS00\exe\sapcontrol.EXE
DpTriggerSapSnapshot: sapcontrol runs with pid 3088
Tue Jul 19 15:06:23 2016
DpCheckSapcontrolProcess: sapcontrol with pid 3088 terminated
Tue Jul 19 15:11:03 2016
*** ERROR => DpHdlDeadWp: W9 (pid 4104) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W9 (pid = 4104)
DpSkipSnapshot: last snapshot created at Tue Jul 19 15:06:13 2016
, skip new snapshot
create new work process W9 (PID:1008 HANDLE:1444)
Tue Jul 19 15:16:03 2016
*** ERROR => DpHdlDeadWp: W5 (pid 2336) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W5 (pid = 2336)
********** SERVER SNAPSHOT 5 (Reason: Workprocess 5 died) - begin **********
Scheduler info
--------------
WP info
DpNumberOfDiaWps: dia_wps 9, standby_wps 0
#dia = 9
#btc = 3
#standby = 0
#max = 21
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] = 8
withPrioTickets[RQ_Q_PRIO_NORMAL] = true
Prio Class Low
maxRuntime[RQ_Q_PRIO_LOW] = 1800 sec
maxRuntimeHalf[RQ_Q_PRIO_LOW] = 900 sec
maxTicketsForPrio[RQ_Q_PRIO_LOW] = 8
withPrioTickets[RQ_Q_PRIO_LOW] = true
Actual tickets in use
actTicketsInUseForPrio[RQ_Q_PRIO_NORMAL] = 8
actTicketsInUseForPrio[RQ_Q_PRIO_LOW] = 8
Running requests[RQ_Q_PRIO_NORMAL] = 0
Running requests[RQ_Q_PRIO_LOW] = 0
Queue Statistics Tue Jul 19 09:46:03 2016
------------------------------------------------------------
Number of lost wakeup datagrams: 0
Max. number of queue elements : 14000
NOWP: 0 (peak 5, writeCount 2025, readCount 2025)
DIA : 0 (peak 6, writeCount 2787, readCount 2787)
UPD : 0 (peak 2, writeCount 18, readCount 18)
ENQ : 0 (peak 0, writeCount 0, readCount 0)
BTC : 0 (peak 3, writeCount 591, readCount 591)
SPO : 0 (peak 1, writeCount 87, readCount 87)
UP2 : 0 (peak 1, writeCount 15, readCount 15)
DISP: 0 (peak 5, writeCount 362, readCount 362)
GW : 0 (peak 2, writeCount 1651, readCount 1651)
IC : 0 (peak 1, writeCount 4, readCount 4)
LWP : 0 (peak 15, writeCount 218, readCount 218)
Session queue dump (high priority, 0 elements, peak 3):
Session queue dump (normal priority, 0 elements, peak 1):
Session queue dump (low priority, 0 elements, peak 1):
Infos about some special queues:
Queue <StartServiceQueue> in slot 3 (port=0) has no requests
Workprocess Table (long) Tue Jul 19 09:46:03 2016
------------------------------------------------------------
Current snapshot id: 5
Number of preemptions : 0
|No |Pid |Type|State |Cause|Err|Prio|Sess-Key |Sess-Type|Locked|Sem|Time |Program |Cli|User |Action |Action-Info |
|---+------+----+-------+-----+---+----+----------------+---------+------+---+-----+----------------------------------------+---+------------+--------------------+--------------------|
| 0|3596 |DIA | | |1 | | | | | | | | | | | |
| 1|5496 |DIA | | |1 | | | | | | | | | | | |
| 2|5668 |DIA | | |1 | | | | | | | | | | | |
| 3|5908 |DIA | | |1 | | | | | | | | | | | |
| 4|5804 |DIA | | |1 | | | | | | | | | | | |
| 5| |DIA |WP_KILL| |1 |high|T12_U760_M0 |INTERNAL | | | |SAPMSSY8 |000|SAPSYS | | |
| 6|4252 |DIA | | |1 | | | | | | | | | | | |
| 7|5840 |DIA | | |1 | | | | | | | | | | | |
| 8|5108 |DIA | | |1 | | | | | | | | | | | |
| 9|1008 |DIA | | |1 | | | | | | | | | | | |
| 10|5976 |UPD | | | | | | | | | | | | | | |
| 11|5856 |BTC | | | | | | | | | | | | | | |
| 12|3916 |BTC | | | | | | | | | | | | | | |
| 13|3768 |BTC |WP_RUN | | |low |T4_U796_M0 |BATCH | | | 0|CL_SWF_RUN_RESTART_BATCH_ITEMSCP |210|WF-BATCH |DBOTHERS | |
| 14|3640 |SPO | | | | | | | | | | | | | | |
| 15|5572 |UP2 | | | | | | | | | | | | | | |
Session Table Tue Jul 19 09:46:03 2016
------------------------------------------------------------
|Logon-Type |Sess-Key |Cli|User |Terminal |Time |WP |Program |Prio|Tasks|Application-Info |Tcode |ES-Mem(KB)|
|------------+----------------+---+------------+--------------------+--------+---+----------------------------------------+----+-----+--------------------------------------------------+----------+----------|
|BATCH |T4_U796_M0 |210|WF-BATCH | |15:16:03|13 |RSWWERRE |low | | | |12343 |
|INTERNAL |T12_U760_M0 |000|SAPSYS | |15:16:02|5 |SAPMSSY8 |high| | | |8235 |
CA Blocks
0 ca_blk slots of 6000 in use, 0 currently unowned (in request queues)
********** SERVER SNAPSHOT 5 (Reason: Workprocess 5 died) - end **********
***LOG Q41=> DpDumpInternalTables, () [dpxxdisp.c 3280]
create new work process W5 (PID:5280 HANDLE:1456)
Tue Jul 19 15:16:13 2016
DpTriggerSapSnapshot: start G:\usr\sap\QA1\DVEBMGS00\exe\sapcontrol.EXE
DpTriggerSapSnapshot: sapcontrol runs with pid 4728
Tue Jul 19 15:16:23 2016
DpCheckSapcontrolProcess: sapcontrol with pid 4728 terminated
Tue Jul 19 15:21:03 2016
*** ERROR => DpHdlDeadWp: W6 (pid 4252) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W6 (pid = 4252)
DpSkipSnapshot: last snapshot created at Tue Jul 19 15:16:13 2016
, skip new snapshot
create new work process W6 (PID:5024 HANDLE:1384)
Tue Jul 19 15:26:03 2016
*** ERROR => DpHdlDeadWp: W7 (pid 5840) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W7 (pid = 5840)
********** SERVER SNAPSHOT 6 (Reason: Workprocess 7 died) - begin **********
Scheduler info
--------------
WP info
DpNumberOfDiaWps: dia_wps 9, standby_wps 0
#dia = 9
#btc = 3
#standby = 0
#max = 21
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] = 8
withPrioTickets[RQ_Q_PRIO_NORMAL] = true
Prio Class Low
maxRuntime[RQ_Q_PRIO_LOW] = 1800 sec
maxRuntimeHalf[RQ_Q_PRIO_LOW] = 900 sec
maxTicketsForPrio[RQ_Q_PRIO_LOW] = 8
withPrioTickets[RQ_Q_PRIO_LOW] = true
Actual tickets in use
actTicketsInUseForPrio[RQ_Q_PRIO_NORMAL] = 7
actTicketsInUseForPrio[RQ_Q_PRIO_LOW] = 7
Running requests[RQ_Q_PRIO_NORMAL] = 0
Running requests[RQ_Q_PRIO_LOW] = 0
Queue Statistics Tue Jul 19 09:56:03 2016
------------------------------------------------------------
Number of lost wakeup datagrams: 0
Max. number of queue elements : 14000
NOWP: 0 (peak 5, writeCount 2497, readCount 2497)
DIA : 0 (peak 6, writeCount 3434, readCount 3434)
UPD : 0 (peak 2, writeCount 22, readCount 22)
ENQ : 0 (peak 0, writeCount 0, readCount 0)
BTC : 0 (peak 3, writeCount 673, readCount 673)
SPO : 0 (peak 1, writeCount 111, readCount 111)
UP2 : 0 (peak 1, writeCount 19, readCount 19)
DISP: 0 (peak 5, writeCount 441, readCount 441)
GW : 0 (peak 2, writeCount 2042, readCount 2042)
IC : 0 (peak 1, writeCount 4, readCount 4)
LWP : 1 (peak 15, writeCount 276, readCount 275)
Session queue dump (high priority, 0 elements, peak 3):
Session queue dump (normal priority, 0 elements, peak 1):
Session queue dump (low priority, 0 elements, peak 1):
Dump of queue <W8> in slot 13 (1 requests, in use, port=65150):
-1 <- 3 (rq_id 27866, DIA, REQ_HANDLER_PROCESS) -> -1
Infos about some special queues:
Queue <StartServiceQueue> in slot 3 (port=0) has no requests
Workprocess Table (long) Tue Jul 19 09:56:03 2016
------------------------------------------------------------
Current snapshot id: 6
Number of preemptions : 0
|No |Pid |Type|State |Cause|Err|Prio|Sess-Key |Sess-Type|Locked|Sem|Time |Program |Cli|User |Action |Action-Info |
|---+------+----+-------+-----+---+----+----------------+---------+------+---+-----+----------------------------------------+---+------------+--------------------+--------------------|
| 0|3596 |DIA |WP_RUN | |1 |high|T11_U997_M0 |INTERNAL | | | 0| |000|SAPSYS | | |
| 1|5496 |DIA | | |1 | | | | | | | | | | | |
| 2|5668 |DIA | | |1 | | | | | | | | | | | |
| 3|5908 |DIA | | |1 | | | | | | | | | | | |
| 4|5804 |DIA | | |1 | | | | | | | | | | | |
| 5|5280 |DIA | | |1 | | | | | | | | | | | |
| 6|5024 |DIA | | |2 | | | | | | | | | | | |
| 7| |DIA |WP_KILL| |2 |high|T4_U959_M0 |INTERNAL | | | |SAPMSSY8 |000|SAPSYS | | |
| 8|5108 |DIA |WP_RUN | |1 |high|T2_U960_M0 |INTERNAL | | | 0|CL_BGRFC_SUPERVISOR_START=====CP |000|SAPSYS | | |
| 9|1008 |DIA | | |1 | | | | | | | | | | | |
| 10|5976 |UPD | | | | | | | | | | | | | | |
| 11|5856 |BTC | | | | | | | | | | | | | | |
| 12|3916 |BTC | | | | | | | | | | | | | | |
| 13|3768 |BTC | | | | | | | | | | | | | | |
| 14|3640 |SPO | | | | | | | | | | | | | | |
| 15|5572 |UP2 | | | | | | | | | | | | | | |
Session Table Tue Jul 19 09:56:03 2016
------------------------------------------------------------
|Logon-Type |Sess-Key |Cli|User |Terminal |Time |WP |Program |Prio|Tasks|Application-Info |Tcode |ES-Mem(KB)|
|------------+----------------+---+------------+--------------------+--------+---+----------------------------------------+----+-----+--------------------------------------------------+----------+----------|
|INTERNAL |T2_U960_M0 |000|SAPSYS | |15:26:03|8 |RS_BGRFC_SCHEDULER_STARTUP |high| | | |4139 |
|INTERNAL |T4_U959_M0 |000|SAPSYS | |15:26:03|7 |SAPMSSY8 |high| | | |8235 |
|INTERNAL |T11_U997_M0 |000|SAPSYS | |15:26:03|0 |SAPMSSY2 |high| | | |4148 |
CA Blocks
0 ca_blk slots of 6000 in use, 0 currently unowned (in request queues)
********** SERVER SNAPSHOT 6 (Reason: Workprocess 7 died) - end **********
***LOG Q41=> DpDumpInternalTables, () [dpxxdisp.c 3280]
create new work process W7 (PID:764 HANDLE:1480)
Tue Jul 19 15:26:13 2016
DpTriggerSapSnapshot: start G:\usr\sap\QA1\DVEBMGS00\exe\sapcontrol.EXE
DpTriggerSapSnapshot: sapcontrol runs with pid 5264
Tue Jul 19 15:26:23 2016
DpCheckSapcontrolProcess: sapcontrol with pid 5264 terminated
Tue Jul 19 15:31:03 2016
*** ERROR => DpHdlDeadWp: W8 (pid 5108) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W8 (pid = 5108)
DpSkipSnapshot: last snapshot created at Tue Jul 19 15:26:13 2016
, skip new snapshot
create new work process W8 (PID:5600 HANDLE:1468)
Tue Jul 19 15:36:03 2016
*** ERROR => DpHdlDeadWp: W0 (pid 3596) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W0 (pid = 3596)
********** SERVER SNAPSHOT 7 (Reason: Workprocess 0 died) - begin **********
Scheduler info
--------------
WP info
DpNumberOfDiaWps: dia_wps 9, standby_wps 0
#dia = 9
#btc = 3
#standby = 0
#max = 21
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] = 8
withPrioTickets[RQ_Q_PRIO_NORMAL] = true
Prio Class Low
maxRuntime[RQ_Q_PRIO_LOW] = 1800 sec
maxRuntimeHalf[RQ_Q_PRIO_LOW] = 900 sec
maxTicketsForPrio[RQ_Q_PRIO_LOW] = 8
withPrioTickets[RQ_Q_PRIO_LOW] = true
Actual tickets in use
actTicketsInUseForPrio[RQ_Q_PRIO_NORMAL] = 7
actTicketsInUseForPrio[RQ_Q_PRIO_LOW] = 7
Running requests[RQ_Q_PRIO_NORMAL] = 0
Running requests[RQ_Q_PRIO_LOW] = 0
Queue Statistics Tue Jul 19 10:06:03 2016
------------------------------------------------------------
Number of lost wakeup datagrams: 0
Max. number of queue elements : 14000
NOWP: 0 (peak 5, writeCount 2973, readCount 2973)
DIA : 0 (peak 6, writeCount 4070, readCount 4070)
UPD : 0 (peak 2, writeCount 26, readCount 26)
ENQ : 0 (peak 0, writeCount 0, readCount 0)
BTC : 0 (peak 3, writeCount 735, readCount 735)
SPO : 0 (peak 1, writeCount 135, readCount 135)
UP2 : 0 (peak 1, writeCount 23, readCount 23)
DISP: 0 (peak 5, writeCount 520, readCount 520)
GW : 0 (peak 2, writeCount 2437, readCount 2437)
IC : 0 (peak 1, writeCount 4, readCount 4)
LWP : 1 (peak 15, writeCount 334, readCount 333)
Session queue dump (high priority, 0 elements, peak 3):
Session queue dump (normal priority, 0 elements, peak 1):
Session queue dump (low priority, 0 elements, peak 1):
Dump of queue <W2> in slot 7 (1 requests, in use, port=57797):
-1 <- 1 (rq_id 32632, DIA, REQ_HANDLER_PROCESS) -> -1
Infos about some special queues:
Queue <StartServiceQueue> in slot 3 (port=0) has no requests
Workprocess Table (long) Tue Jul 19 10:06:03 2016
------------------------------------------------------------
Current snapshot id: 7
Number of preemptions : 0
|No |Pid |Type|State |Cause|Err|Prio|Sess-Key |Sess-Type|Locked|Sem|Time |Program |Cli|User |Action |Action-Info |
|---+------+----+-------+-----+---+----+----------------+---------+------+---+-----+----------------------------------------+---+------------+--------------------+--------------------|
| 0| |DIA |WP_KILL| |2 |high|T10_U1158_M0 |INTERNAL | | | |SAPMSSY8 |000|SAPSYS | | |
| 1|5496 |DIA | | |1 | | | | | | | | | | | |
| 2|5668 |DIA |WP_RUN | |1 |high|T2_U1159_M0 |INTERNAL | | | 0|CL_BGRFC_SUPERVISOR_START=====CP |000|SAPSYS | | |
| 3|5908 |DIA | | |1 | | | | | | | | | | | |
| 4|5804 |DIA |WP_RUN | |1 |high|T7_U1194_M0 |INTERNAL | | | 0| |000|SAPSYS | | |
| 5|5280 |DIA | | |1 | | | | | | | | | | | |
| 6|5024 |DIA | | |2 | | | | | | | | | | | |
| 7|764 |DIA | | |2 | | | | | | | | | | | |
| 8|5600 |DIA | | |2 | | | | | | | | | | | |
| 9|1008 |DIA | | |1 | | | | | | | | | | | |
| 10|5976 |UPD | | | | | | | | | | | | | | |
| 11|5856 |BTC | | | | | | | | | | | | | | |
| 12|3916 |BTC | | | | | | | | | | | | | | |
| 13|3768 |BTC | | | | | | | | | | | | | | |
| 14|3640 |SPO | | | | | | | | | | | | | | |
| 15|5572 |UP2 | | | | | | | | | | | | | | |
Session Table Tue Jul 19 10:06:03 2016
------------------------------------------------------------
|Logon-Type |Sess-Key |Cli|User |Terminal |Time |WP |Program |Prio|Tasks|Application-Info |Tcode |ES-Mem(KB)|
|------------+----------------+---+------------+--------------------+--------+---+----------------------------------------+----+-----+--------------------------------------------------+----------+----------|
|INTERNAL |T2_U1159_M0 |000|SAPSYS | |15:36:03|2 |RS_BGRFC_SCHEDULER_STARTUP |high| | | |4139 |
|INTERNAL |T7_U1194_M0 |000|SAPSYS | |15:36:03|4 |SAPMSSY2 |high| | | |4148 |
|INTERNAL |T10_U1158_M0 |000|SAPSYS | |15:36:03|0 |SAPMSSY8 |high| | | |8235 |
CA Blocks
0 ca_blk slots of 6000 in use, 0 currently unowned (in request queues)
********** SERVER SNAPSHOT 7 (Reason: Workprocess 0 died) - end **********
***LOG Q41=> DpDumpInternalTables, () [dpxxdisp.c 3280]
create new work process W0 (PID:5924 HANDLE:1196)
Tue Jul 19 15:36:13 2016
DpTriggerSapSnapshot: start G:\usr\sap\QA1\DVEBMGS00\exe\sapcontrol.EXE
DpTriggerSapSnapshot: sapcontrol runs with pid 5460
Tue Jul 19 15:36:23 2016
DpCheckSapcontrolProcess: sapcontrol with pid 5460 terminated
Tue Jul 19 15:41:03 2016
*** ERROR => DpHdlDeadWp: W2 (pid 5668) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W2 (pid = 5668)
DpSkipSnapshot: last snapshot created at Tue Jul 19 15:36:13 2016
, skip new snapshot
create new work process W2 (PID:5364 HANDLE:1476)
Tue Jul 19 15:46:03 2016
*** ERROR => DpHdlDeadWp: W4 (pid 5804) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W4 (pid = 5804)
********** SERVER SNAPSHOT 8 (Reason: Workprocess 4 died) - begin **********
Scheduler info
--------------
WP info
DpNumberOfDiaWps: dia_wps 9, standby_wps 0
#dia = 9
#btc = 3
#standby = 0
#max = 21
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] = 8
withPrioTickets[RQ_Q_PRIO_NORMAL] = true
Prio Class Low
maxRuntime[RQ_Q_PRIO_LOW] = 1800 sec
maxRuntimeHalf[RQ_Q_PRIO_LOW] = 900 sec
maxTicketsForPrio[RQ_Q_PRIO_LOW] = 8
withPrioTickets[RQ_Q_PRIO_LOW] = true
Actual tickets in use
actTicketsInUseForPrio[RQ_Q_PRIO_NORMAL] = 8
actTicketsInUseForPrio[RQ_Q_PRIO_LOW] = 8
Running requests[RQ_Q_PRIO_NORMAL] = 0
Running requests[RQ_Q_PRIO_LOW] = 0
Queue Statistics Tue Jul 19 10:16:03 2016
------------------------------------------------------------
Number of lost wakeup datagrams: 0
Max. number of queue elements : 14000
NOWP: 0 (peak 5, writeCount 3450, readCount 3450)
DIA : 0 (peak 6, writeCount 4697, readCount 4697)
UPD : 0 (peak 2, writeCount 30, readCount 30)
ENQ : 0 (peak 0, writeCount 0, readCount 0)
BTC : 0 (peak 3, writeCount 789, readCount 789)
SPO : 0 (peak 1, writeCount 159, readCount 159)
UP2 : 0 (peak 1, writeCount 27, readCount 27)
DISP: 0 (peak 5, writeCount 600, readCount 600)
GW : 0 (peak 2, writeCount 2832, readCount 2832)
IC : 0 (peak 1, writeCount 4, readCount 4)
LWP : 1 (peak 15, writeCount 392, readCount 391)
Session queue dump (high priority, 0 elements, peak 3):
Session queue dump (normal priority, 0 elements, peak 1):
Session queue dump (low priority, 0 elements, peak 1):
Dump of queue <W3> in slot 8 (1 requests, in use, port=54797):
-1 <- 15 (rq_id 37495, DIA, REQ_HANDLER_PROCESS) -> -1
Infos about some special queues:
Queue <StartServiceQueue> in slot 3 (port=0) has no requests
Workprocess Table (long) Tue Jul 19 10:16:03 2016
------------------------------------------------------------
Current snapshot id: 8
Number of preemptions : 0
|No |Pid |Type|State |Cause|Err|Prio|Sess-Key |Sess-Type|Locked|Sem|Time |Program |Cli|User |Action |Action-Info |
|---+------+----+-------+-----+---+----+----------------+---------+------+---+-----+----------------------------------------+---+------------+--------------------+--------------------|
| 0|5924 |DIA | | |2 | | | | | | | | | | | |
| 1|5496 |DIA | | |1 | | | | | | | | | | | |
| 2|5364 |DIA | | |2 | | | | | | | | | | | |
| 3|5908 |DIA |WP_RUN | |1 |high|T10_U1356_M0 |INTERNAL | | | 0|CL_BGRFC_SUPERVISOR_START=====CP |000|SAPSYS | | |
| 4| |DIA |WP_KILL| |2 |high|T2_U1355_M0 |INTERNAL | | | |SAPMSSY8 |000|SAPSYS | | |
| 5|5280 |DIA | | |1 | | | | | | | | | | | |
| 6|5024 |DIA | | |2 | | | | | | | | | | | |
| 7|764 |DIA | | |2 | | | | | | | | | | | |
| 8|5600 |DIA | | |2 | | | | | | | | | | | |
| 9|1008 |DIA | | |1 | | | | | | | | | | | |
| 10|5976 |UPD | | | | | | | | | | | | | | |
| 11|5856 |BTC | | | | | | | | | | | | | | |
| 12|3916 |BTC | | | | | | | | | | | | | | |
| 13|3768 |BTC | | | | | | | | | | | | | | |
| 14|3640 |SPO | | | | | | | | | | | | | | |
| 15|5572 |UP2 | | | | | | | | | | | | | | |
Session Table Tue Jul 19 10:16:03 2016
------------------------------------------------------------
|Logon-Type |Sess-Key |Cli|User |Terminal |Time |WP |Program |Prio|Tasks|Application-Info |Tcode |ES-Mem(KB)|
|------------+----------------+---+------------+--------------------+--------+---+----------------------------------------+----+-----+--------------------------------------------------+----------+----------|
|INTERNAL |T2_U1355_M0 |000|SAPSYS | |15:46:03|4 |SAPMSSY8 |high| | | |8235 |
|INTERNAL |T10_U1356_M0 |000|SAPSYS | |15:46:03|3 |RS_BGRFC_SCHEDULER_STARTUP |high| | | |4139 |
CA Blocks
0 ca_blk slots of 6000 in use, 0 currently unowned (in request queues)
********** SERVER SNAPSHOT 8 (Reason: Workprocess 4 died) - end **********
***LOG Q41=> DpDumpInternalTables, () [dpxxdisp.c 3280]
create new work process W4 (PID:5780 HANDLE:1448)
Tue Jul 19 15:46:13 2016
DpTriggerSapSnapshot: start G:\usr\sap\QA1\DVEBMGS00\exe\sapcontrol.EXE
DpTriggerSapSnapshot: sapcontrol runs with pid 6088
Tue Jul 19 15:46:23 2016
DpCheckSapcontrolProcess: sapcontrol with pid 6088 terminated
Tue Jul 19 15:51:03 2016
*** ERROR => DpHdlDeadWp: W3 (pid 5908) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W3 (pid = 5908)
DpSkipSnapshot: last snapshot created at Tue Jul 19 15:46:13 2016
, skip new snapshot
create new work process W3 (PID:2956 HANDLE:1472)
Tue Jul 19 15:56:04 2016
*** ERROR => DpHdlDeadWp: W1 (pid 5496) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W1 (pid = 5496)
********** SERVER SNAPSHOT 9 (Reason: Workprocess 1 died) - begin **********
Scheduler info
--------------
WP info
DpNumberOfDiaWps: dia_wps 9, standby_wps 0
#dia = 9
#btc = 3
#standby = 0
#max = 21
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] = 8
withPrioTickets[RQ_Q_PRIO_NORMAL] = true
Prio Class Low
maxRuntime[RQ_Q_PRIO_LOW] = 1800 sec
maxRuntimeHalf[RQ_Q_PRIO_LOW] = 900 sec
maxTicketsForPrio[RQ_Q_PRIO_LOW] = 8
withPrioTickets[RQ_Q_PRIO_LOW] = true
Actual tickets in use
actTicketsInUseForPrio[RQ_Q_PRIO_NORMAL] = 8
actTicketsInUseForPrio[RQ_Q_PRIO_LOW] = 8
Running requests[RQ_Q_PRIO_NORMAL] = 0
Running requests[RQ_Q_PRIO_LOW] = 0
Queue Statistics Tue Jul 19 10:26:04 2016
------------------------------------------------------------
Number of lost wakeup datagrams: 0
Max. number of queue elements : 14000
NOWP: 0 (peak 5, writeCount 3925, readCount 3925)
DIA : 0 (peak 6, writeCount 5345, readCount 5345)
UPD : 0 (peak 2, writeCount 34, readCount 34)
ENQ : 0 (peak 0, writeCount 0, readCount 0)
BTC : 0 (peak 3, writeCount 868, readCount 868)
SPO : 0 (peak 1, writeCount 183, readCount 183)
UP2 : 0 (peak 1, writeCount 31, readCount 31)
DISP: 0 (peak 5, writeCount 678, readCount 678)
GW : 0 (peak 2, writeCount 3227, readCount 3227)
IC : 0 (peak 1, writeCount 4, readCount 4)
LWP : 1 (peak 15, writeCount 450, readCount 449)
Session queue dump (high priority, 0 elements, peak 3):
Session queue dump (normal priority, 0 elements, peak 1):
Session queue dump (low priority, 0 elements, peak 1):
Dump of queue <W0> in slot 5 (1 requests, in use, port=50811):
-1 <- 4 (rq_id 42234, DIA, REQ_HANDLER_PROCESS) -> -1
Infos about some special queues:
Queue <StartServiceQueue> in slot 3 (port=0) has no requests
Workprocess Table (long) Tue Jul 19 10:26:04 2016
------------------------------------------------------------
Current snapshot id: 9
Number of preemptions : 0
|No |Pid |Type|State |Cause|Err|Prio|Sess-Key |Sess-Type|Locked|Sem|Time |Program |Cli|User |Action |Action-Info |
|---+------+----+-------+-----+---+----+----------------+---------+------+---+-----+----------------------------------------+---+------------+--------------------+--------------------|
| 0|5924 |DIA |WP_RUN | |2 |high|T10_U1551_M0 |INTERNAL | | | 1|<BGRFC WATCHDOG> |000|SAPSYS | | |
| 1| |DIA |WP_KILL| |2 |high|T14_U1550_M0 |INTERNAL | | | |SAPMSSY8 |000|SAPSYS | | |
| 2|5364 |DIA | | |2 | | | | | | | | | | | |
| 3|2956 |DIA | | |2 | | | | | | | | | | | |
| 4|5780 |DIA | | |2 | | | | | | | | | | | |
| 5|5280 |DIA | | |1 | | | | | | | | | | | |
| 6|5024 |DIA | | |2 | | | | | | | | | | | |
| 7|764 |DIA | | |2 | | | | | | | | | | | |
| 8|5600 |DIA | | |2 | | | | | | | | | | | |
| 9|1008 |DIA | | |1 | | | | | | | | | | | |
| 10|5976 |UPD | | | | | | | | | | | | | | |
| 11|5856 |BTC | | | | | | | | | | | | | | |
| 12|3916 |BTC | | | | | | | | | | | | | | |
| 13|3768 |BTC | | | | | | | | | | | | | | |
| 14|3640 |SPO | | | | | | | | | | | | | | |
| 15|5572 |UP2 | | | | | | | | | | | | | | |
Session Table Tue Jul 19 10:26:04 2016
------------------------------------------------------------
|Logon-Type |Sess-Key |Cli|User |Terminal |Time |WP |Program |Prio|Tasks|Application-Info |Tcode |ES-Mem(KB)|
|------------+----------------+---+------------+--------------------+--------+---+----------------------------------------+----+-----+--------------------------------------------------+----------+----------|
|INTERNAL |T10_U1551_M0 |000|SAPSYS | |15:56:03|0 | |high| | | |4138 |
|INTERNAL |T14_U1550_M0 |000|SAPSYS | |15:56:03|1 |SAPMSSY8 |high| | | |8235 |
CA Blocks
0 ca_blk slots of 6000 in use, 0 currently unowned (in request queues)
********** SERVER SNAPSHOT 9 (Reason: Workprocess 1 died) - end **********
***LOG Q41=> DpDumpInternalTables, () [dpxxdisp.c 3280]
create new work process W1 (PID:4788 HANDLE:1488)
Tue Jul 19 15:56:14 2016
DpTriggerSapSnapshot: start G:\usr\sap\QA1\DVEBMGS00\exe\sapcontrol.EXE
DpTriggerSapSnapshot: sapcontrol runs with pid 748
Tue Jul 19 15:56:24 2016
DpCheckSapcontrolProcess: sapcontrol with pid 748 terminated
Tue Jul 19 16:01:04 2016
*** ERROR => DpHdlDeadWp: W9 (pid 1008) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W9 (pid = 1008)
DpSkipSnapshot: last snapshot created at Tue Jul 19 15:56:14 2016
, skip new snapshot
create new work process W9 (PID:5660 HANDLE:1404)
Tue Jul 19 16:06:04 2016
*** ERROR => DpHdlDeadWp: W5 (pid 5280) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W5 (pid = 5280)
********** SERVER SNAPSHOT 10 (Reason: Workprocess 5 died) - begin **********
Scheduler info
--------------
WP info
DpNumberOfDiaWps: dia_wps 9, standby_wps 0
#dia = 9
#btc = 3
#standby = 0
#max = 21
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] = 8
withPrioTickets[RQ_Q_PRIO_NORMAL] = true
Prio Class Low
maxRuntime[RQ_Q_PRIO_LOW] = 1800 sec
maxRuntimeHalf[RQ_Q_PRIO_LOW] = 900 sec
maxTicketsForPrio[RQ_Q_PRIO_LOW] = 8
withPrioTickets[RQ_Q_PRIO_LOW] = true
Actual tickets in use
actTicketsInUseForPrio[RQ_Q_PRIO_NORMAL] = 8
actTicketsInUseForPrio[RQ_Q_PRIO_LOW] = 8
Running requests[RQ_Q_PRIO_NORMAL] = 0
Running requests[RQ_Q_PRIO_LOW] = 0
Queue Statistics Tue Jul 19 10:36:04 2016
------------------------------------------------------------
Number of lost wakeup datagrams: 0
Max. number of queue elements : 14000
NOWP: 0 (peak 5, writeCount 4430, readCount 4430)
DIA : 0 (peak 6, writeCount 6230, readCount 6230)
UPD : 0 (peak 2, writeCount 38, readCount 38)
ENQ : 0 (peak 0, writeCount 0, readCount 0)
BTC : 0 (peak 3, writeCount 1279, readCount 1279)
SPO : 0 (peak 1, writeCount 207, readCount 207)
UP2 : 0 (peak 2, writeCount 43, readCount 43)
DISP: 0 (peak 5, writeCount 778, readCount 778)
GW : 0 (peak 2, writeCount 3630, readCount 3630)
IC : 0 (peak 1, writeCount 4, readCount 4)
LWP : 0 (peak 15, writeCount 508, readCount 508)
Session queue dump (high priority, 0 elements, peak 3):
Session queue dump (normal priority, 0 elements, peak 1):
Session queue dump (low priority, 0 elements, peak 1):
Infos about some special queues:
Queue <StartServiceQueue> in slot 3 (port=0) has no requests
Workprocess Table (long) Tue Jul 19 10:36:04 2016
------------------------------------------------------------
Current snapshot id: 10
Number of preemptions : 0
|No |Pid |Type|State |Cause|Err|Prio|Sess-Key |Sess-Type|Locked|Sem|Time |Program |Cli|User |Action |Action-Info |
|---+------+----+-------+-----+---+----+----------------+---------+------+---+-----+----------------------------------------+---+------------+--------------------+--------------------|
| 0|5924 |DIA | | |2 | | | | | | | | | | | |
| 1|4788 |DIA | | |2 | | | | | | | | | | | |
| 2|5364 |DIA | | |2 | | | | | | | | | | | |
| 3|2956 |DIA | | |2 | | | | | | | | | | | |
| 4|5780 |DIA | | |2 | | | | | | | | | | | |
| 5| |DIA |WP_KILL| |2 |high|T10_U1811_M0 |INTERNAL | | | |SAPMSSY8 |000|SAPSYS | | |
| 6|5024 |DIA | | |2 | | | | | | | | | | | |
| 7|764 |DIA | | |2 | | | | | | | | | | | |
| 8|5600 |DIA | | |2 | | | | | | | | | | | |
| 9|5660 |DIA | | |2 | | | | | | | | | | | |
| 10|5976 |UPD | | | | | | | | | | | | | | |
| 11|5856 |BTC | | | | | | | | | | | | | | |
| 12|3916 |BTC |WP_RUN | | |low |T6_U1855_M0 |BATCH | | | 0| |000|DDIC | | |
| 13|3768 |BTC |WP_RUN | | |low |T13_U1853_M0 |BATCH | | | 1|RSSTAT98 |000|DDIC | | |
| 14|3640 |SPO | | | | | | | | | | | | | | |
| 15|5572 |UP2 | | | | | | | | | | | | | | |
Session Table Tue Jul 19 10:36:04 2016
------------------------------------------------------------
|Logon-Type |Sess-Key |Cli|User |Terminal |Time |WP |Program |Prio|Tasks|Application-Info |Tcode |ES-Mem(KB)|
|------------+----------------+---+------------+--------------------+--------+---+----------------------------------------+----+-----+--------------------------------------------------+----------+----------|
|BATCH |T6_U1855_M0 |000|DDIC | |16:06:04|12 |SWNCCOLL |low | | | |16429 |
|INTERNAL |T10_U1811_M0 |000|SAPSYS | |16:06:03|5 |SAPMSSY8 |high| | | |8235 |
|BATCH |T13_U1853_M0 |000|DDIC | |16:06:03|13 |RSSTAT98 |low | | | |16429 |
CA Blocks
0 ca_blk slots of 6000 in use, 0 currently unowned (in request queues)
********** SERVER SNAPSHOT 10 (Reason: Workprocess 5 died) - end **********
***LOG Q41=> DpDumpInternalTables, () [dpxxdisp.c 3280]
create new work process W5 (PID:1124 HANDLE:1456)
*** ERROR => DpHdlDeadWp: W13 (pid 3768) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W13 (pid = 3768)
DpSkipSnapshot: delayed snapshot exist, skip new snapshot
create new work process W13 (PID:4268 HANDLE:1496)
Tue Jul 19 16:06:14 2016
DpTriggerSapSnapshot: start G:\usr\sap\QA1\DVEBMGS00\exe\sapcontrol.EXE
DpTriggerSapSnapshot: sapcontrol runs with pid 4560
Tue Jul 19 16:06:24 2016
DpCheckSapcontrolProcess: sapcontrol with pid 4560 terminated
Tue Jul 19 16:11:04 2016
*** ERROR => DpHdlDeadWp: W6 (pid 5024) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W6 (pid = 5024)
DpSkipSnapshot: last snapshot created at Tue Jul 19 16:06:14 2016
, skip new snapshot
create new work process W6 (PID:6016 HANDLE:1504)
Tue Jul 19 16:16:04 2016
*** ERROR => DpHdlDeadWp: W7 (pid 764) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W7 (pid = 764)
********** SERVER SNAPSHOT 11 (Reason: Workprocess 7 died) - begin **********
Scheduler info
--------------
WP info
DpNumberOfDiaWps: dia_wps 9, standby_wps 0
#dia = 9
#btc = 3
#standby = 0
#max = 21
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] = 8
withPrioTickets[RQ_Q_PRIO_NORMAL] = true
Prio Class Low
maxRuntime[RQ_Q_PRIO_LOW] = 1800 sec
maxRuntimeHalf[RQ_Q_PRIO_LOW] = 900 sec
maxTicketsForPrio[RQ_Q_PRIO_LOW] = 8
withPrioTickets[RQ_Q_PRIO_LOW] = true
Actual tickets in use
actTicketsInUseForPrio[RQ_Q_PRIO_NORMAL] = 8
actTicketsInUseForPrio[RQ_Q_PRIO_LOW] = 8
Running requests[RQ_Q_PRIO_NORMAL] = 0
Running requests[RQ_Q_PRIO_LOW] = 0
Queue Statistics Tue Jul 19 10:46:04 2016
------------------------------------------------------------
Number of lost wakeup datagrams: 0
Max. number of queue elements : 14000
NOWP: 0 (peak 5, writeCount 4921, readCount 4921)
DIA : 0 (peak 6, writeCount 6908, readCount 6908)
UPD : 0 (peak 2, writeCount 42, readCount 42)
ENQ : 0 (peak 0, writeCount 0, readCount 0)
BTC : 0 (peak 3, writeCount 1349, readCount 1349)
SPO : 0 (peak 1, writeCount 231, readCount 231)
UP2 : 0 (peak 2, writeCount 51, readCount 51)
DISP: 0 (peak 5, writeCount 856, readCount 856)
GW : 0 (peak 2, writeCount 4041, readCount 4041)
IC : 0 (peak 1, writeCount 4, readCount 4)
LWP : 1 (peak 15, writeCount 566, readCount 565)
Session queue dump (high priority, 0 elements, peak 3):
Session queue dump (normal priority, 0 elements, peak 1):
Session queue dump (low priority, 0 elements, peak 1):
Dump of queue <W9> in slot 14 (1 requests, in use, port=52047):
-1 <- 0 (rq_id 54175, DIA, REQ_HANDLER_PROCESS) -> -1
Infos about some special queues:
Queue <StartServiceQueue> in slot 3 (port=0) has no requests
Workprocess Table (long) Tue Jul 19 10:46:04 2016
------------------------------------------------------------
Current snapshot id: 11
Number of preemptions : 0
|No |Pid |Type|State |Cause|Err|Prio|Sess-Key |Sess-Type|Locked|Sem|Time |Program |Cli|User |Action |Action-Info |
|---+------+----+-------+-----+---+----+----------------+---------+------+---+-----+----------------------------------------+---+------------+--------------------+--------------------|
| 0|5924 |DIA | | |2 | | | | | | | | | | | |
| 1|4788 |DIA | | |2 | | | | | | | | | | | |
| 2|5364 |DIA | | |2 | | | | | | | | | | | |
| 3|2956 |DIA | | |2 | | | | | | | | | | | |
| 4|5780 |DIA | | |2 | | | | | | | | | | | |
| 5|1124 |DIA | | |2 | | | | | | | | | | | |
| 6|6016 |DIA | | |3 | | | | | | | | | | | |
| 7| |DIA |WP_KILL| |3 |high|T7_U2022_M0 |INTERNAL | | | |SAPMSSY8 |000|SAPSYS | | |
| 8|5600 |DIA | | |2 | | | | | | | | | | | |
| 9|5660 |DIA |WP_RUN | |2 |high|T13_U2023_M0 |INTERNAL | | | 1|CL_BGRFC_SUPERVISOR_START=====CP |000|SAPSYS | | |
| 10|5976 |UPD | | | | | | | | | | | | | | |
| 11|5856 |BTC | | | | | | | | | | | | | | |
| 12|3916 |BTC | | | | | | | | | | | | | | |
| 13|4268 |BTC | | |1 | | | | | | | | | | | |
| 14|3640 |SPO | | | | | | | | | | | | | | |
| 15|5572 |UP2 | | | | | | | | | | | | | | |
Session Table Tue Jul 19 10:46:04 2016
------------------------------------------------------------
|Logon-Type |Sess-Key |Cli|User |Terminal |Time |WP |Program |Prio|Tasks|Application-Info |Tcode |ES-Mem(KB)|
|------------+----------------+---+------------+--------------------+--------+---+----------------------------------------+----+-----+--------------------------------------------------+----------+----------|
|INTERNAL |T7_U2022_M0 |000|SAPSYS | |16:16:03|7 |SAPMSSY8 |high| | | |8235 |
|INTERNAL |T13_U2023_M0 |000|SAPSYS | |16:16:03|9 |RS_BGRFC_SCHEDULER_STARTUP |high| | | |4139 |
CA Blocks
0 ca_blk slots of 6000 in use, 0 currently unowned (in request queues)
********** SERVER SNAPSHOT 11 (Reason: Workprocess 7 died) - end **********
***LOG Q41=> DpDumpInternalTables, () [dpxxdisp.c 3280]
create new work process W7 (PID:5340 HANDLE:1444)
Tue Jul 19 16:16:14 2016
DpTriggerSapSnapshot: start G:\usr\sap\QA1\DVEBMGS00\exe\sapcontrol.EXE
DpTriggerSapSnapshot: sapcontrol runs with pid 1748
Tue Jul 19 16:16:24 2016
DpCheckSapcontrolProcess: sapcontrol with pid 1748 terminated
Tue Jul 19 16:21:04 2016
*** ERROR => DpHdlDeadWp: W8 (pid 5600) died (severity=0, status=0) [dpxxwp.c 1383]
DpWpRecoverMutex: recover resources of W8 (pid = 5600)
DpSkipSnapshot: last snapshot created at Tue Jul 19 16:16:14 2016
, skip new snapshot
create new work process W8 (PID:4864 HANDLE:1508)
Hi Sajmal,
Do you also see errors mentioned in thread WPs are dying and can not be restarted with Eye... | SCN.If this is the case, please try to update kernel patch.
Regards,
Ning
Hi Sajmal,
Please check SAP note
2049643 - SAP ASE: getting dumps SYSTEM_CORE_DUMPED in SAP system
Regards
Prithviraj
Hi Prithvi,
Thanks for your replay,
We don't do any upgrade, add any support package and any component to the Server. Its working fine the last week ( Quality System). So I think it's not related to Kernel , from the log I think I related to database table problem. Trying to get that,
Thanks and Regards,
Sajmal
Hi Ning,
Thanks for your replay,
We don't do any upgrade, add any support package and any component to the Server. Its working fine the last week ( Quality System). So I think the problem not related to Kernel , from the log I think I related to database table problem. Trying to get that,
Thanks and Regards,
Sajmal
User | Count |
---|---|
86 | |
10 | |
10 | |
9 | |
7 | |
7 | |
6 | |
5 | |
4 | |
4 |
You must be a registered user to add a comment. If you've already registered, sign in. Otherwise, register and sign in.