Skip to Content
0
Former Member
Apr 30, 2008 at 10:08 AM

J2EE Status info unavailable

12894 Views

Hi Experts,

We have SAP ECC 6.0 on Windows with MS SQL server.

For setting up the DR site, we have installed a fresh installation compare to our Production system, also we have kept the same SAP SID.

After successfully installing the SAP system, we have restore the database on new system.

Now when try to start the SAP service, dispatcher is not coming successfully, it is giving the message as "Running the message server connection ok, Dialog Queue time: 0.00 sec, J2EE status info unavailable.

Below is the trace..

-


trc file: "dev_disp", trc level: 1, release: "700"

-


sysno 00

sid TRN

systemid 562 (PC with Windows NT)

relno 7000

patchlevel 0

patchno 102

intno 20050900

make: multithreaded, Unicode, 64 bit, optimized

pid 4008

Wed Apr 30 15:06:31 2008

kernel runs with dp version 224000(ext=109000) (@(#) DPLIB-INT-VERSION-224000-UC)

length of sys_adm_ext is 572 bytes

  • SWITCH TRC-HIDE on ***

***LOG Q00=> DpSapEnvInit, DPStart (00 4008) [dpxxdisp.c 1239]

shared lib "dw_xml.dll" version 102 successfully loaded

shared lib "dw_xtc.dll" version 102 successfully loaded

shared lib "dw_stl.dll" version 102 successfully loaded

shared lib "dw_gui.dll" version 102 successfully loaded

shared lib "dw_mdm.dll" version 102 successfully loaded

rdisp/softcancel_sequence : -> 0,5,-1

use internal message server connection to port 3900

Wed Apr 30 15:06:36 2008

  • WARNING => DpNetCheck: NiAddrToHost(1.0.0.0) took 4 seconds

***LOG GZZ=> 1 possible network problems detected - check tracefile and adjust the DNS settings [dpxxtool2.c 5355]

MtxInit: 30000 0 0

DpSysAdmExtInit: ABAP is active

DpSysAdmExtInit: VMC (JAVA VM in WP) is not active

DpIPCInit2: start server >inmucoprhd01_TRN_00 <

DpShMCreate: sizeof(wp_adm) 19136 (1472)

DpShMCreate: sizeof(tm_adm) 5584592 (27784)

DpShMCreate: sizeof(wp_ca_adm) 24000 (80)

DpShMCreate: sizeof(appc_ca_adm) 8000 (80)

DpCommTableSize: max/headSize/ftSize/tableSize=500/16/552064/552080

DpShMCreate: sizeof(comm_adm) 552080 (1088)

DpSlockTableSize: max/headSize/ftSize/fiSize/tableSize=0/0/0/0/0

DpShMCreate: sizeof(slock_adm) 0 (104)

DpFileTableSize: max/headSize/ftSize/tableSize=0/0/0/0

DpShMCreate: sizeof(file_adm) 0 (72)

DpShMCreate: sizeof(vmc_adm) 0 (1848)

DpShMCreate: sizeof(wall_adm) (41664/36752/64/192)

DpShMCreate: sizeof(gw_adm) 48

DpShMCreate: SHM_DP_ADM_KEY (addr: 000000000F200050, size: 6274496)

DpShMCreate: allocated sys_adm at 000000000F200050

DpShMCreate: allocated wp_adm at 000000000F201F40

DpShMCreate: allocated tm_adm_list at 000000000F206A00

DpShMCreate: allocated tm_adm at 000000000F206A60

DpShMCreate: allocated wp_ca_adm at 000000000F75A130

DpShMCreate: allocated appc_ca_adm at 000000000F75FEF0

DpShMCreate: allocated comm_adm at 000000000F761E30

DpShMCreate: system runs without slock table

DpShMCreate: system runs without file table

DpShMCreate: allocated vmc_adm_list at 000000000F7E8AC0

DpShMCreate: allocated gw_adm at 000000000F7E8B40

DpShMCreate: system runs without vmc_adm

DpShMCreate: allocated ca_info at 000000000F7E8B70

DpShMCreate: allocated wall_adm at 000000000F7E8B80

MBUF state OFF

DpCommInitTable: init table for 500 entries

EmInit: MmSetImplementation( 2 ).

MM global diagnostic options set: 0

<ES> client 0 initializing ....

<ES> InitFreeList

<ES> block size is 4096 kByte.

Using implementation view

<EsNT> Using memory model view.

<EsNT> Memory Reset disabled as NT default

<ES> 127 blocks reserved for free list.

ES initialized.

Wed Apr 30 15:06:37 2008

J2EE server info

start = TRUE

state = STARTED

pid = 4108

argv[0] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[1] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[2] = pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[3] = -DSAPSTART=1

argv[4] = -DCONNECT_PORT=1123

argv[5] = -DSAPSYSTEM=00

argv[6] = -DSAPSYSTEMNAME=TRN

argv[7] = -DSAPMYNAME=inmucoprhd01_TRN_00

argv[8] = -DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[9] = -DFRFC_FALLBACK=ON

argv[10] = -DFRFC_FALLBACK_HOST=localhost

start_lazy = 0

start_control = SAP J2EE startup framework

DpJ2eeStart: j2ee state = STARTED

rdisp/http_min_wait_dia_wp : 1 -> 1

***LOG CPS=> DpLoopInit, ICU ( 3.0 3.0 4.0.1) [dpxxdisp.c 1626]

***LOG Q0K=> DpMsAttach, mscon ( inmucoprhd01) [dpxxdisp.c 11664]

DpStartStopMsg: send start message (myname is >inmucoprhd01_TRN_00 <)

DpStartStopMsg: start msg sent

CCMS: AlInitGlobals : alert/use_sema_lock = TRUE.

CCMS: Initalizing shared memory of size 60000000 for monitoring segment.

CCMS: start to initalize 3.X shared alert area (first segment).

DpJ2eeLogin: j2ee state = CONNECTED

DpMsgAdmin: Set release to 7000, patchlevel 0

MBUF state PREPARED

MBUF component UP

DpMBufHwIdSet: set Hardware-ID

***LOG Q1C=> DpMBufHwIdSet [dpxxmbuf.c 1050]

DpMsgAdmin: Set patchno for this platform to 102

Release check o.K.

Wed Apr 30 15:06:45 2008

***LOG Q0I=> NiIRead: recv (10054: WSAECONNRESET: Connection reset by peer) [nixxi.cpp 4248]

  • ERROR => NiIRead: SiRecv failed for hdl 4 / sock 328

(SI_ECONN_BROKEN/10054; I4; ST; 127.0.0.1:1125) [nixxi.cpp 4248]

DpJ2eeMsgProcess: j2ee state = CONNECTED (NIECONN_BROKEN)

DpIJ2eeShutdown: send SIGINT to SAP J2EE startup framework (pid=4108)

  • ERROR => DpProcKill: kill failed [dpntdisp.c 371]

DpIJ2eeShutdown: j2ee state = SHUTDOWN

Wed Apr 30 15:06:53 2008

MBUF state ACTIVE

DpModState: change server state from STARTING to ACTIVE

Wed Apr 30 15:07:17 2008

J2EE server info

start = TRUE

state = STARTED

pid = 3436

argv[0] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[1] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[2] = pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[3] = -DSAPSTART=1

argv[4] = -DCONNECT_PORT=1190

argv[5] = -DSAPSYSTEM=00

argv[6] = -DSAPSYSTEMNAME=TRN

argv[7] = -DSAPMYNAME=inmucoprhd01_TRN_00

argv[8] = -DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[9] = -DFRFC_FALLBACK=ON

argv[10] = -DFRFC_FALLBACK_HOST=localhost

start_lazy = 0

start_control = SAP J2EE startup framework

DpJ2eeStart: j2ee state = STARTED

DpJ2eeLogin: j2ee state = CONNECTED

Wed Apr 30 15:07:19 2008

***LOG Q0I=> NiIRead: recv (10054: WSAECONNRESET: Connection reset by peer) [nixxi.cpp 4248]

  • ERROR => NiIRead: SiRecv failed for hdl 6 / sock 276

(SI_ECONN_BROKEN/10054; I4; ST; 127.0.0.1:1191) [nixxi.cpp 4248]

DpJ2eeMsgProcess: j2ee state = CONNECTED (NIECONN_BROKEN)

DpIJ2eeShutdown: send SIGINT to SAP J2EE startup framework (pid=3436)

  • ERROR => DpProcKill: kill failed [dpntdisp.c 371]

DpIJ2eeShutdown: j2ee state = SHUTDOWN

Wed Apr 30 15:07:37 2008

J2EE server info

start = TRUE

state = STARTED

pid = 4796

argv[0] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[1] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[2] = pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[3] = -DSAPSTART=1

argv[4] = -DCONNECT_PORT=1202

argv[5] = -DSAPSYSTEM=00

argv[6] = -DSAPSYSTEMNAME=TRN

argv[7] = -DSAPMYNAME=inmucoprhd01_TRN_00

argv[8] = -DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[9] = -DFRFC_FALLBACK=ON

argv[10] = -DFRFC_FALLBACK_HOST=localhost

start_lazy = 0

start_control = SAP J2EE startup framework

DpJ2eeStart: j2ee state = STARTED

DpJ2eeLogin: j2ee state = CONNECTED

Wed Apr 30 15:07:39 2008

***LOG Q0I=> NiIRead: recv (10054: WSAECONNRESET: Connection reset by peer) [nixxi.cpp 4248]

  • ERROR => NiIRead: SiRecv failed for hdl 4 / sock 272

(SI_ECONN_BROKEN/10054; I4; ST; 127.0.0.1:1203) [nixxi.cpp 4248]

DpJ2eeMsgProcess: j2ee state = CONNECTED (NIECONN_BROKEN)

DpIJ2eeShutdown: send SIGINT to SAP J2EE startup framework (pid=4796)

  • ERROR => DpProcKill: kill failed [dpntdisp.c 371]

DpIJ2eeShutdown: j2ee state = SHUTDOWN

Wed Apr 30 15:07:57 2008

J2EE server info

start = TRUE

state = STARTED

pid = 5056

argv[0] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[1] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[2] = pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[3] = -DSAPSTART=1

argv[4] = -DCONNECT_PORT=1213

argv[5] = -DSAPSYSTEM=00

argv[6] = -DSAPSYSTEMNAME=TRN

argv[7] = -DSAPMYNAME=inmucoprhd01_TRN_00

argv[8] = -DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[9] = -DFRFC_FALLBACK=ON

argv[10] = -DFRFC_FALLBACK_HOST=localhost

start_lazy = 0

start_control = SAP J2EE startup framework

DpJ2eeStart: j2ee state = STARTED

DpJ2eeLogin: j2ee state = CONNECTED

Wed Apr 30 15:07:59 2008

***LOG Q0I=> NiIRead: recv (10054: WSAECONNRESET: Connection reset by peer) [nixxi.cpp 4248]

  • ERROR => NiIRead: SiRecv failed for hdl 6 / sock 264

(SI_ECONN_BROKEN/10054; I4; ST; 127.0.0.1:1214) [nixxi.cpp 4248]

DpJ2eeMsgProcess: j2ee state = CONNECTED (NIECONN_BROKEN)

DpIJ2eeShutdown: send SIGINT to SAP J2EE startup framework (pid=5056)

  • ERROR => DpProcKill: kill failed [dpntdisp.c 371]

DpIJ2eeShutdown: j2ee state = SHUTDOWN

Wed Apr 30 15:08:07 2008

*

  • SWITCH TRC-LEVEL from 1 TO 2

*

-


C-STACK -


SAP (R) - R/3(TM) Callstack, Version 1.0

Copyright (C) SAP AG. All rights reserved.

-


Callstack without Exception:

App : disp+work.EXE (pid=4008)

When : 4/30/2008 15:8:9.468

Threads : 2

-


Computer Name : INMUCOPRHD01

User Name : SAPServiceTRN

-


Number of Processors: 8

Processor Type: EM64T Family 6 Model 15 Stepping 7

Windows Version : 5.2 Current Build: 3790

-


State Dump for Thread Id f84

-- > Stack Back Trace < --

FramePtr ReturnAd Param#1 Function Name

0000000007abf410 000007ff771b4e85 0000000000000000 ntdll!ZwWaitForSingleObject

0000000007abf5e0 000007ff77312375 0000000000000001 mswsock!<nosymbols>

0000000007abf670 0000000001571896 01c8aaa5000001c9 WS2_32!select

0000000007abf920 000000000157f625 0020002000200020 disp+work!SiSelect [sint.cpp (2947)]

0000000007abfb90 0000000001576e58 00000000003cc810 disp+work!SISEL_SEL_NT::select [sixxsel.cpp (2917)]

0000000007abfc80 0000000001574d37 0020002000200020 disp+work!NISEL_IMPL::selectInt [nixxsel.cpp (969)]

0000000007abfcc0 00000000015735bb 0000000008139b90 disp+work!NISEL_IMPL::select [nixxsel.cpp (915)]

0000000007abfd10 00000000004088a8 01c8aaa5e0a7a7ce disp+work!NiSelSelect [nixxsel.cpp (237)]

0000000007abfd40 000000000042bb73 0000000008139b90 disp+work!DpRqWaitFor [dpxxdisp.c (10767)]

0000000007abfeb0 000000000042cfbc 0000000008139b90 disp+work!DpLoopExec [dpxxdisp.c (1964)]

0000000007abfee0 0000000000401087 ffffffff00000002 disp+work!DpMain [dpxxdisp.c (1109)]

0000000007abff10 0000000001909031 0000000000000000 disp+work!nlsui_main [thxxanf.c (82)]

0000000007abff70 0000000077d5964c 0000000000000000 disp+work!wmainCRTStartup [crtexe.c (498)]

0000000007abffa0 0000000000000000 0000000001908ec0 kernel32!BaseProcessStart

-


State Dump for Thread Id d7c

-- > Stack Back Trace < --

FramePtr ReturnAd Param#1 Function Name

000000000f1ff8c0 0000000077d704bf 00000000003c3350 ntdll!ZwWaitForSingleObject

000000000f1ff960 000000000167fb51 0000000000000108 kernel32!WaitForSingleObjectEx

000000000f1ffbb0 00000000005f69f5 0000000000000001 disp+work!NTDebugProcess [ntstcdbg.c (501)]

000000000f1ffbe0 00000000004514f3 000000000f1ffea0 disp+work!CTrcStack [dptstack.c (182)]

000000000f1ffc30 00000000017fc9ac 000000000f1ffea0 disp+work!DpTrcOnOff [dpxxtool.c (2407)]

000000000f1ffe70 00000000017fcf76 0000000000000040 disp+work!SigISignalExecute [signt.c (901)]

000000000f1ffeb0 00000000017fd26f fffffffffffffffe disp+work!SigISignalHandling [signt.c (822)]

000000000f1fff40 000007ff7fc411c4 0000000000000000 disp+work!SigIMsgFunc [signt.c (632)]

000000000f1fff70 0000000077d6b6da 0000000077d6b6a0 msvcrt!endthreadex

000000000f1fffa0 0000000000000000 0000000000000000 kernel32!BaseThreadStart

-


-


Wed Apr 30 15:08:17 2008

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548297/390000 (in the past)

secs 1209548297, active req_info's 0x0/0x0/

DpGetSchedule: found slot 4 (type/tid/mode DPT_ENVCHECK/-1/255)

DpSetNextSchedule: next schedule for slot 4: 1209548317/406000 (20/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548317/406000

call DpEnvCheck

[DpWpDied] W0 lives (PID:4116 HANDLE:412)

[DpWpDied] W1 lives (PID:4124 HANDLE:404)

[DpWpDied] W2 lives (PID:4132 HANDLE:400)

[DpWpDied] W3 lives (PID:4140 HANDLE:396)

[DpWpDied] W4 lives (PID:4148 HANDLE:392)

[DpWpDied] W5 lives (PID:4156 HANDLE:388)

[DpWpDied] W6 lives (PID:4164 HANDLE:384)

[DpWpDied] W7 lives (PID:4172 HANDLE:380)

[DpWpDied] W8 lives (PID:4180 HANDLE:376)

[DpWpDied] W9 lives (PID:4188 HANDLE:372)

[DpWpDied] W10 lives (PID:4204 HANDLE:368)

[DpWpDied] W11 lives (PID:4216 HANDLE:364)

[DpWpDied] W12 lives (PID:4228 HANDLE:360)

DpVmCheck: vmc not active

DpGwCheck: 0

[DpProcDied] Process lives (PID:3840 HANDLE:424)

DpGwCheck: ok

NiICreateHandle: hdl 6 state NI_INITIAL

NiIInitSocket: set default settings for new hdl 6 / sock 264 (I4; ST)

NiIBind: hdl 6 bound to 1219 (IP only)

NiIBlockMode: set blockmode for hdl 6 FALSE

NiIListen: state of hdl 6 NI_LISTEN

NiIListen: listen for client requests on hdl 6

DpJ2eeStart: listen for J2EE server on hdl 6

SetEnvironmentVariable PPID=4008

start >D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE<

DpForkExec: program name=D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

DpForkExec: argv[1]="pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01"

DpForkExec: argv[2]="-DSAPSTART=1"

DpForkExec: argv[3]="-DCONNECT_PORT=1219"

DpForkExec: argv[4]="-DSAPSYSTEM=00"

DpForkExec: argv[5]="-DSAPSYSTEMNAME=TRN"

DpForkExec: argv[6]="-DSAPMYNAME=inmucoprhd01_TRN_00"

DpForkExec: argv[7]="-DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01"

DpForkExec: argv[8]="-DFRFC_FALLBACK=ON"

DpForkExec: argv[9]="-DFRFC_FALLBACK_HOST=localhost"

CreateProcess >D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE< (PID:1144 HANDLE:192)

DpAddSocketInfo: add info for socket 6 (type/idx=7/0)

J2EE server info

start = TRUE

state = STARTED

pid = 1144

argv[0] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[1] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[2] = pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[3] = -DSAPSTART=1

argv[4] = -DCONNECT_PORT=1219

argv[5] = -DSAPSYSTEM=00

argv[6] = -DSAPSYSTEMNAME=TRN

argv[7] = -DSAPMYNAME=inmucoprhd01_TRN_00

argv[8] = -DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[9] = -DFRFC_FALLBACK=ON

argv[10] = -DFRFC_FALLBACK_HOST=localhost

start_lazy = 0

start_control = SAP J2EE startup framework

DpJ2eeStart: j2ee state = STARTED

[DpProcDied] Process lives (PID:4100 HANDLE:432)

DpCheckTimeTab: check time table

DpGetSchedule: next schedule 1209548317/406000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548317/406000 20/0 sec/usec

DpTimeCheck: act sleep = 20000 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

J2EE LOGIN request received

NiICreateHandle: hdl 4 state NI_INITIAL

NiIInitSocket: set default settings for hdl 4 / sock 188 (I4; ST)

NiIBlockMode: set blockmode for hdl 4 FALSE

NiIAccept: state of hdl 4 NI_ACCEPTED

NiIAccept: hdl 6 accepted hdl 4 from 127.0.0.1:1220

NiIAccept: hdl 4 took local address 127.0.0.1:1219

NiLocalCheck: address 127.0.0.1 is local

NiICloseHandle: shutdown and close hdl 6 / sock 264 - sock -1

DpDelSocketInfo: del info for socket 6 (type=7)

NiIMyHostName: hostname = 'inmucoprhd01'

NiHsLGetNodeAddr: found hostname 'inmucoprhd01' in cache

NiIGetNodeAddr: hostname 'inmucoprhd01' = addr 10.100.15.47

DpAddSocketInfo: add info for socket 4 (type/idx=8/0)

DpJ2eeLogin: j2ee state = CONNECTED

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548317/406000 19/953000 sec/usec

DpTimeCheck: act sleep = 19953 msec

  • DP LOOP ***********

Wed Apr 30 15:08:19 2008

***LOG Q0I=> NiIRead: recv (10054: WSAECONNRESET: Connection reset by peer) [nixxi.cpp 4248]

  • ERROR => NiIRead: SiRecv failed for hdl 4 / sock 188

(SI_ECONN_BROKEN/10054; I4; ST; 127.0.0.1:1220) [nixxi.cpp 4248]

NiSelISelectInt: 1 handles selected (1 buffered)

DpLoopExec: Msg from J2EE server received

DpJ2eeMsgProcess

DpJ2eeMsgProcess: NiRead(rc=NIECONN_BROKEN), len=0

DpJ2eeMsgProcess: NiRead failed (NIECONN_BROKEN)

DpJ2eeMsgProcess: j2ee state = CONNECTED (NIECONN_BROKEN)

MsIDelService: delete service J2EE for myself

NiIWrite: hdl 3 sent data (wrt=161,pac=1,MESG_IO)

MsINiWrite: sent 161 bytes

send msg (len 110+51) to name MSG_SERVER, type 0, key -

MsSndName: MS_DEL_PROPERTY ok

Send 51 bytes to MSG_SERVER

MS_DEL_PROPERTY : asynchronous call

send MsDelService(J2EE) to msgserver

DpIJ2eeShutdown: send SIGINT to SAP J2EE startup framework (pid=1144)

killing process (1144) (SOFT_KILL)

  • ERROR => DpProcKill: kill failed [dpntdisp.c 371]

DpIJ2eeShutdown: j2ee state = SHUTDOWN

DpDelSocketInfo: del info for socket 4 (type=8)

NiICloseHandle: shutdown and close hdl 4 / sock 188

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548317/406000 17/844000 sec/usec

DpTimeCheck: act sleep = 17844 msec

  • DP LOOP ***********

NiIRead: hdl 3 received data (rcd=114,pac=1,MESG_IO)

NiSelISelectInt: 1 handles selected (1 buffered)

MsINiRead: received 114 bytes

MSG received, len 110+4, flag 3, from MSG_SERVER , typ 0, key -

opcode : MS_DEL_PROPERTY

retcode : MSOP_OK

version : 1

charset : 3

DpMsInfo: request from MSG_SERVER, opcode MS_DEL_PROPERTY

DpMsInfo: MS_DEL_PROPERTY for J2EE received

DpMBufServDel: service 2 deleted for inmucoprhd01_TRN_00

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548317/406000 17/844000 sec/usec

DpTimeCheck: act sleep = 17844 msec

  • DP LOOP ***********

Wed Apr 30 15:08:37 2008

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548317/406000 (in the past)

secs 1209548317, active req_info's 0x0/0x0/

DpGetSchedule: found slot 4 (type/tid/mode DPT_ENVCHECK/-1/255)

DpSetNextSchedule: next schedule for slot 4: 1209548337/421000 (20/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548317/640000

call DpEnvCheck

[DpWpDied] W0 lives (PID:4116 HANDLE:412)

[DpWpDied] W1 lives (PID:4124 HANDLE:404)

[DpWpDied] W2 lives (PID:4132 HANDLE:400)

[DpWpDied] W3 lives (PID:4140 HANDLE:396)

[DpWpDied] W4 lives (PID:4148 HANDLE:392)

[DpWpDied] W5 lives (PID:4156 HANDLE:388)

[DpWpDied] W6 lives (PID:4164 HANDLE:384)

[DpWpDied] W7 lives (PID:4172 HANDLE:380)

[DpWpDied] W8 lives (PID:4180 HANDLE:376)

[DpWpDied] W9 lives (PID:4188 HANDLE:372)

[DpWpDied] W10 lives (PID:4204 HANDLE:368)

[DpWpDied] W11 lives (PID:4216 HANDLE:364)

[DpWpDied] W12 lives (PID:4228 HANDLE:360)

DpVmCheck: vmc not active

DpGwCheck: 0

[DpProcDied] Process lives (PID:3840 HANDLE:424)

DpGwCheck: ok

NiICreateHandle: hdl 4 state NI_INITIAL

NiIInitSocket: set default settings for new hdl 4 / sock 188 (I4; ST)

NiIBind: hdl 4 bound to 1229 (IP only)

NiIBlockMode: set blockmode for hdl 4 FALSE

NiIListen: state of hdl 4 NI_LISTEN

NiIListen: listen for client requests on hdl 4

DpJ2eeStart: listen for J2EE server on hdl 4

SetEnvironmentVariable PPID=4008

start >D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE<

DpForkExec: program name=D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

DpForkExec: argv[1]="pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01"

DpForkExec: argv[2]="-DSAPSTART=1"

DpForkExec: argv[3]="-DCONNECT_PORT=1229"

DpForkExec: argv[4]="-DSAPSYSTEM=00"

DpForkExec: argv[5]="-DSAPSYSTEMNAME=TRN"

DpForkExec: argv[6]="-DSAPMYNAME=inmucoprhd01_TRN_00"

DpForkExec: argv[7]="-DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01"

DpForkExec: argv[8]="-DFRFC_FALLBACK=ON"

DpForkExec: argv[9]="-DFRFC_FALLBACK_HOST=localhost"

CreateProcess >D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE< (PID:5164 HANDLE:284)

DpAddSocketInfo: add info for socket 4 (type/idx=7/0)

J2EE server info

start = TRUE

state = STARTED

pid = 5164

argv[0] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[1] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[2] = pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[3] = -DSAPSTART=1

argv[4] = -DCONNECT_PORT=1229

argv[5] = -DSAPSYSTEM=00

argv[6] = -DSAPSYSTEMNAME=TRN

argv[7] = -DSAPMYNAME=inmucoprhd01_TRN_00

argv[8] = -DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[9] = -DFRFC_FALLBACK=ON

argv[10] = -DFRFC_FALLBACK_HOST=localhost

start_lazy = 0

start_control = SAP J2EE startup framework

DpJ2eeStart: j2ee state = STARTED

[DpProcDied] Process lives (PID:4100 HANDLE:432)

DpCheckTimeTab: check time table

DpGetSchedule: next schedule 1209548317/640000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548317/640000 0/219000 sec/usec

DpTimeCheck: act sleep = 219 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

J2EE LOGIN request received

NiICreateHandle: hdl 6 state NI_INITIAL

NiIInitSocket: set default settings for hdl 6 / sock 184 (I4; ST)

NiIBlockMode: set blockmode for hdl 6 FALSE

NiIAccept: state of hdl 6 NI_ACCEPTED

NiIAccept: hdl 4 accepted hdl 6 from 127.0.0.1:1230

NiIAccept: hdl 6 took local address 127.0.0.1:1229

NiLocalCheck: address 127.0.0.1 is local

NiICloseHandle: shutdown and close hdl 4 / sock 188 - sock -1

DpDelSocketInfo: del info for socket 4 (type=7)

NiIMyHostName: hostname = 'inmucoprhd01'

NiHsLGetNodeAddr: found hostname 'inmucoprhd01' in cache

NiIGetNodeAddr: hostname 'inmucoprhd01' = addr 10.100.15.47

DpAddSocketInfo: add info for socket 6 (type/idx=8/0)

DpJ2eeLogin: j2ee state = CONNECTED

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548317/640000 0/172000 sec/usec

DpTimeCheck: act sleep = 172 msec

  • DP LOOP ***********

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548317/640000 (in the past)

secs 1209548317, active req_info's 0x0/0x0/

DpGetSchedule: found slot 6 (type/tid/mode DPT_AUTOTH/-1/255)

next 1209548317/640000, 0 in queue, autothtime 60

DpSetNextSchedule: next schedule for slot 6: 1209548377/656000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548337/375000

activate auto th

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 85)

DpGetSchedule: next schedule 1209548337/375000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548337/375000 19/719000 sec/usec

DpTimeCheck: act sleep = 19719 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 1 request(s) in DIA queue ===>>

W0 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 85

-IN-- req_info SET_SYSTEM_USER DP_AUTO_TH

DpRqNormalHandle: set SYSTEM_USER T0 U1 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNormalHandle: new state of W0 is WP_RUN

DpRqNormalHandle: new state of T0/M0 = 0x42

DpRqNormalHandle: give rq_id 85 to W0 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548337/375000 19/719000 sec/usec

DpTimeCheck: act sleep = 19719 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_DP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 86

info for DIA: wait/run/hold/killed = 6/0/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_WAIT

REL WP ca_blk 40

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548337/375000 19/719000 sec/usec

DpTimeCheck: act sleep = 19719 msec

  • DP LOOP ***********

Wed Apr 30 15:08:38 2008

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1138

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 1 request(s) in DIA queue ===>>

W0 is free

-IN-- sender_id IC_MAN tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 0 len -1 rq_id 87

-IN-- req_info LOGIN DP_ICM_EVENT

-IN-- mpi rq <b> mpi resp <c> prot 1 obj fd -1 rq_id 0

-IN-- icm_opcode: ICM_PLUGIN_REQUEST

DpITmSlotClear: clear slot 14

DpListRemove: remove elem 14 from tmadm_free_list

DpListRemove: 187 elems in tmadm_free_list

DpListInsert: insert elem 14 into tmadm_inuse_list (at begin)

DpListInsert: 14 elems in tmadm_inuse_list

new terminal T14/U18, type=202, state=TM_CONNECTED

DpRqLoginHandle: resource check for T14 activated (resource=HTTP)

DpRqLoginHandle: set terminal name of external plugin to > 10.100.15.47<

DpRqNormalHandle: DpRqCheck o.k.

DpIncrCheckedResourcesCnt: intCnt/extCnt=1/1 (resource=HTTP)

MPI<c>3#4 WriteOOB 00000000 06000000 0E000000 00

DpRqNormalHandle: ICM request dispatched to W0 (14/18/0)

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNormalHandle: new state of W0 is WP_RUN

DpRqNormalHandle: new state of T14/M0 = 0x82

DpRqNormalHandle: give rq_id 87 to W0 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548337/375000 18/454000 sec/usec

DpTimeCheck: act sleep = 18454 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 14 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_DP uid 18 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 88

-IN-- req_info LOGOFF

info for DIA: wait/run/hold/killed = 6/0/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_WAIT

DpDecrCheckedResourcesCnt: intCnt/extCnt=0/0 (resource=HTTP)

DpGetSchedule: next schedule 1209548337/375000

DpGetSchedule: no schedule found

DpRqNoWpHandle: set dp_tm_adm of T14 to DP_SLOT_FREE

DpGetSchedule: next schedule 1209548337/375000

DpGetSchedule: no schedule found

DpITmSlotRelease: release slot 14

DpListInsert: insert elem 14 into tmadm_free_list (at begin)

DpListInsert: 188 elems in tmadm_free_list

DpListRemove: remove elem 14 from tmadm_inuse_list

DpListRemove: 13 elems in tmadm_inuse_list

REL WP ca_blk 40

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548337/375000 18/438000 sec/usec

DpTimeCheck: act sleep = 18438 msec

  • DP LOOP ***********

Wed Apr 30 15:08:39 2008

***LOG Q0I=> NiIRead: recv (10054: WSAECONNRESET: Connection reset by peer) [nixxi.cpp 4248]

  • ERROR => NiIRead: SiRecv failed for hdl 6 / sock 184

(SI_ECONN_BROKEN/10054; I4; ST; 127.0.0.1:1230) [nixxi.cpp 4248]

NiSelISelectInt: 1 handles selected (1 buffered)

DpLoopExec: Msg from J2EE server received

DpJ2eeMsgProcess

DpJ2eeMsgProcess: NiRead(rc=NIECONN_BROKEN), len=0

DpJ2eeMsgProcess: NiRead failed (NIECONN_BROKEN)

DpJ2eeMsgProcess: j2ee state = CONNECTED (NIECONN_BROKEN)

MsIDelService: delete service J2EE for myself

NiIWrite: hdl 3 sent data (wrt=161,pac=1,MESG_IO)

MsINiWrite: sent 161 bytes

send msg (len 110+51) to name MSG_SERVER, type 0, key -

MsSndName: MS_DEL_PROPERTY ok

Send 51 bytes to MSG_SERVER

MS_DEL_PROPERTY : asynchronous call

send MsDelService(J2EE) to msgserver

DpIJ2eeShutdown: send SIGINT to SAP J2EE startup framework (pid=5164)

killing process (5164) (SOFT_KILL)

  • ERROR => DpProcKill: kill failed [dpntdisp.c 371]

DpIJ2eeShutdown: j2ee state = SHUTDOWN

DpDelSocketInfo: del info for socket 6 (type=8)

NiICloseHandle: shutdown and close hdl 6 / sock 184

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548337/375000 17/797000 sec/usec

DpTimeCheck: act sleep = 17797 msec

  • DP LOOP ***********

NiIRead: hdl 3 received data (rcd=114,pac=1,MESG_IO)

NiSelISelectInt: 1 handles selected (1 buffered)

MsINiRead: received 114 bytes

MSG received, len 110+4, flag 3, from MSG_SERVER , typ 0, key -

opcode : MS_DEL_PROPERTY

retcode : MSOP_OK

version : 1

charset : 3

DpMsInfo: request from MSG_SERVER, opcode MS_DEL_PROPERTY

DpMsInfo: MS_DEL_PROPERTY for J2EE received

DpMBufServDel: service 2 deleted for inmucoprhd01_TRN_00

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548337/375000 17/797000 sec/usec

DpTimeCheck: act sleep = 17797 msec

  • DP LOOP ***********

Wed Apr 30 15:08:57 2008

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548337/375000 (in the past)

secs 1209548337, active req_info's 0x0/0x0/

DpGetSchedule: found slot 7 (type/tid/mode DPT_CALL_DELAYED/-1/255)

next 1209548337/390000, 0 in queue, call delayed freq 60

DpSetNextSchedule: next schedule for slot 7: 1209548397/390000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548337/375000

activate delayed function processing

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 89)

DpGetSchedule: found slot 8 (type/tid/mode DPT_SPOOLALRM/-1/255)

next 1209548337/390000, 0 in queue, spoolalrm 60

DpSetNextSchedule: next schedule for slot 8: 1209548397/390000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548337/375000

activate spool alarm

DpRqPutIntoQueue: put request into queue (reqtype 5, prio LOW, rq_id 90)

wake_evt_udp_now 1, no dgram needed

DpGetSchedule: found slot 0 (type/tid/mode DPT_BUFREF/-1/255)

next 1209548337/375000, 0 in queue, bufreftime 120

DpSetNextSchedule: next schedule for slot 0: 1209548457/390000 (120/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548337/375000

activate buffer refresh

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 91)

wake_evt_udp_now 1, no dgram needed

DpGetSchedule: found slot 1 (type/tid/mode DPT_DDLOG/-1/255)

next 1209548337/375000, 0 in queue, ddlogtime 120

DpSetNextSchedule: next schedule for slot 1: 1209548457/390000 (120/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548337/390000

activate ddlog

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 92)

wake_evt_udp_now 1, no dgram needed

DpGetSchedule: found slot 2 (type/tid/mode DPT_BTCSCHED/-1/255)

next 1209548337/390000, 0 in queue, btctime 60

DpSetNextSchedule: next schedule for slot 2: 1209548397/390000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548337/421000

activate btc-scheduler

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 93)

wake_evt_udp_now 1, no dgram needed

DpGetSchedule: next schedule 1209548337/421000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548337/421000 0/31000 sec/usec

DpTimeCheck: act sleep = 31 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 4 request(s) in DIA queue ===>>

W0 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 89

-IN-- req_info THDP_ADM SET_SYSTEM_USER

-IN-- thdp_adm_req_info CALL_DELAYED

DpRqNormalHandle: set SYSTEM_USER T0 U1 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNormalHandle: new state of W0 is WP_RUN

DpRqNormalHandle: new state of T0/M0 = 0x42

DpRqNormalHandle: give rq_id 89 to W0 ...

W1 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 91

-IN-- req_info BUFFER_REFRESH SET_SYSTEM_USER

DpRqNormalHandle: set SYSTEM_USER T1 U2 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 4/2/0/0 wps

DpRqNormalHandle: new state of W1 is WP_RUN

DpRqNormalHandle: new state of T1/M0 = 0x42

DpRqNormalHandle: give rq_id 91 to W1 ...

W2 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 92

-IN-- req_info THDP_ADM SET_SYSTEM_USER

-IN-- thdp_adm_req_info DDLOG

DpRqNormalHandle: set SYSTEM_USER T2 U3 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 3/3/0/0 wps

DpRqNormalHandle: new state of W2 is WP_RUN

DpRqNormalHandle: new state of T2/M0 = 0x42

DpRqNormalHandle: give rq_id 92 to W2 ...

W3 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 93

-IN-- req_info BTC_SCHEDULER SET_SYSTEM_USER

DpRqNormalHandle: set SYSTEM_USER T3 U4 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 2/4/0/0 wps

DpRqNormalHandle: new state of W3 is WP_RUN

DpRqNormalHandle: new state of T3/M0 = 0x42

DpRqNormalHandle: give rq_id 93 to W3 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 1 request(s) in SPO queue ===>>

W11 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type SPO

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 90

-IN-- req_info SET_SYSTEM_USER DP_SPOOL_ALRM

DpRqNormalHandle: set SYSTEM_USER T11 U12 M0

DpRqNormalHandle: DpRqCheck o.k.

info for SPO: wait/run/hold/killed = 0/1/0/0 wps

DpRqNormalHandle: new state of W11 is WP_RUN

DpRqNormalHandle: new state of T11/M0 = 0x42

DpRqNormalHandle: give rq_id 90 to W11 ...

DpRqNormalHandle: set dp_spoolwp_with_token = W11

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

WP blk 60 WORK_PROCESS 4124

WP blk 80 WORK_PROCESS 4132

WP blk 100 WORK_PROCESS 4140

WP blk 260 WORK_PROCESS 4216

APPC blk 12 WORK_PROCESS 4116

APPC blk 18 WORK_PROCESS 4124

APPC blk 24 WORK_PROCESS 4132

APPC blk 30 WORK_PROCESS 4140

APPC blk 78 WORK_PROCESS 4216

DpGetScheduleInfo: next_schedule: 1209548337/421000 0/31000 sec/usec

DpTimeCheck: act sleep = 31 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1134

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 11 wp_ca_blk 260 wp_id 11

-IN-- action SEND_TO_DP uid 12 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 8 rq_id 94

DpRqNoWpHandle: set dp_spoolwp_with_token = NO_WP

REL WP ca_blk 260

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

WP blk 60 WORK_PROCESS 4124

WP blk 80 WORK_PROCESS 4132

WP blk 100 WORK_PROCESS 4140

WP blk 261 WORK_PROCESS 4216

APPC blk 12 WORK_PROCESS 4116

APPC blk 18 WORK_PROCESS 4124

APPC blk 24 WORK_PROCESS 4132

APPC blk 30 WORK_PROCESS 4140

APPC blk 78 WORK_PROCESS 4216

DpGetScheduleInfo: next_schedule: 1209548337/421000 0/31000 sec/usec

DpTimeCheck: act sleep = 31 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1134

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 11 wp_ca_blk 261 wp_id 11

-IN-- action SEND_TO_DP uid 12 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 95

info for SPO: wait/run/hold/killed = 1/0/0/0 wps

DpRqNoWpHandle: new state of W11 is WP_WAIT

REL WP ca_blk 261

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

WP blk 60 WORK_PROCESS 4124

WP blk 80 WORK_PROCESS 4132

WP blk 100 WORK_PROCESS 4140

APPC blk 12 WORK_PROCESS 4116

APPC blk 18 WORK_PROCESS 4124

APPC blk 24 WORK_PROCESS 4132

APPC blk 30 WORK_PROCESS 4140

DpGetScheduleInfo: next_schedule: 1209548337/421000 0/31000 sec/usec

DpTimeCheck: act sleep = 31 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1132

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 1 wp_ca_blk 60 wp_id 1

-IN-- action SEND_TO_DP uid 2 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 96

info for DIA: wait/run/hold/killed = 3/3/0/0 wps

DpRqNoWpHandle: new state of W1 is WP_WAIT

REL WP ca_blk 60

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

WP blk 80 WORK_PROCESS 4132

WP blk 100 WORK_PROCESS 4140

APPC blk 12 WORK_PROCESS 4116

APPC blk 24 WORK_PROCESS 4132

APPC blk 30 WORK_PROCESS 4140

DpGetScheduleInfo: next_schedule: 1209548337/421000 0/31000 sec/usec

DpTimeCheck: act sleep = 31 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1140

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 3 wp_ca_blk 100 wp_id 3

-IN-- action SEND_TO_DP uid 4 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 97

info for DIA: wait/run/hold/killed = 4/2/0/0 wps

DpRqNoWpHandle: new state of W3 is WP_WAIT

REL WP ca_blk 100

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

WP blk 80 WORK_PROCESS 4132

APPC blk 12 WORK_PROCESS 4116

APPC blk 24 WORK_PROCESS 4132

DpGetScheduleInfo: next_schedule: 1209548337/421000 0/31000 sec/usec

DpTimeCheck: act sleep = 31 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_DP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 98

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_WAIT

REL WP ca_blk 40

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 80 WORK_PROCESS 4132

APPC blk 24 WORK_PROCESS 4132

DpGetScheduleInfo: next_schedule: 1209548337/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1133

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 2 wp_ca_blk 80 wp_id 2

-IN-- action SEND_TO_DP uid 3 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 99

info for DIA: wait/run/hold/killed = 6/0/0/0 wps

DpRqNoWpHandle: new state of W2 is WP_WAIT

REL WP ca_blk 80

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548337/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548337/421000 0/0 sec/usec

secs 1209548337, active req_info's 0x0/0x0/

DpGetSchedule: found slot 4 (type/tid/mode DPT_ENVCHECK/-1/255)

DpSetNextSchedule: next schedule for slot 4: 1209548357/421000 (20/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548357/421000

call DpEnvCheck

[DpWpDied] W0 lives (PID:4116 HANDLE:412)

[DpWpDied] W1 lives (PID:4124 HANDLE:404)

[DpWpDied] W2 lives (PID:4132 HANDLE:400)

[DpWpDied] W3 lives (PID:4140 HANDLE:396)

[DpWpDied] W4 lives (PID:4148 HANDLE:392)

[DpWpDied] W5 lives (PID:4156 HANDLE:388)

[DpWpDied] W6 lives (PID:4164 HANDLE:384)

[DpWpDied] W7 lives (PID:4172 HANDLE:380)

[DpWpDied] W8 lives (PID:4180 HANDLE:376)

[DpWpDied] W9 lives (PID:4188 HANDLE:372)

[DpWpDied] W10 lives (PID:4204 HANDLE:368)

[DpWpDied] W11 lives (PID:4216 HANDLE:364)

[DpWpDied] W12 lives (PID:4228 HANDLE:360)

DpVmCheck: vmc not active

DpGwCheck: 0

[DpProcDied] Process lives (PID:3840 HANDLE:424)

DpGwCheck: ok

NiICreateHandle: hdl 6 state NI_INITIAL

NiIInitSocket: set default settings for new hdl 6 / sock 184 (I4; ST)

NiIBind: hdl 6 bound to 1241 (IP only)

NiIBlockMode: set blockmode for hdl 6 FALSE

NiIListen: state of hdl 6 NI_LISTEN

NiIListen: listen for client requests on hdl 6

DpJ2eeStart: listen for J2EE server on hdl 6

SetEnvironmentVariable PPID=4008

start >D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE<

DpForkExec: program name=D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

DpForkExec: argv[1]="pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01"

DpForkExec: argv[2]="-DSAPSTART=1"

DpForkExec: argv[3]="-DCONNECT_PORT=1241"

DpForkExec: argv[4]="-DSAPSYSTEM=00"

DpForkExec: argv[5]="-DSAPSYSTEMNAME=TRN"

DpForkExec: argv[6]="-DSAPMYNAME=inmucoprhd01_TRN_00"

DpForkExec: argv[7]="-DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01"

DpForkExec: argv[8]="-DFRFC_FALLBACK=ON"

DpForkExec: argv[9]="-DFRFC_FALLBACK_HOST=localhost"

CreateProcess >D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE< (PID:5304 HANDLE:180)

DpAddSocketInfo: add info for socket 6 (type/idx=7/0)

J2EE server info

start = TRUE

state = STARTED

pid = 5304

argv[0] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[1] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[2] = pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[3] = -DSAPSTART=1

argv[4] = -DCONNECT_PORT=1241

argv[5] = -DSAPSYSTEM=00

argv[6] = -DSAPSYSTEMNAME=TRN

argv[7] = -DSAPMYNAME=inmucoprhd01_TRN_00

argv[8] = -DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[9] = -DFRFC_FALLBACK=ON

argv[10] = -DFRFC_FALLBACK_HOST=localhost

start_lazy = 0

start_control = SAP J2EE startup framework

DpJ2eeStart: j2ee state = STARTED

[DpProcDied] Process lives (PID:4100 HANDLE:432)

DpCheckTimeTab: check time table

DpGetSchedule: next schedule 1209548357/421000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548357/421000 20/0 sec/usec

DpTimeCheck: act sleep = 20000 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

J2EE LOGIN request received

NiICreateHandle: hdl 4 state NI_INITIAL

NiIInitSocket: set default settings for hdl 4 / sock 176 (I4; ST)

NiIBlockMode: set blockmode for hdl 4 FALSE

NiIAccept: state of hdl 4 NI_ACCEPTED

NiIAccept: hdl 6 accepted hdl 4 from 127.0.0.1:1242

NiIAccept: hdl 4 took local address 127.0.0.1:1241

NiLocalCheck: address 127.0.0.1 is local

NiICloseHandle: shutdown and close hdl 6 / sock 184 - sock -1

DpDelSocketInfo: del info for socket 6 (type=7)

NiIMyHostName: hostname = 'inmucoprhd01'

NiHsLGetNodeAddr: found hostname 'inmucoprhd01' in cache

NiIGetNodeAddr: hostname 'inmucoprhd01' = addr 10.100.15.47

DpAddSocketInfo: add info for socket 4 (type/idx=8/0)

DpJ2eeLogin: j2ee state = CONNECTED

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548357/421000 19/953000 sec/usec

DpTimeCheck: act sleep = 19953 msec

  • DP LOOP ***********

Wed Apr 30 15:08:59 2008

***LOG Q0I=> NiIRead: recv (10054: WSAECONNRESET: Connection reset by peer) [nixxi.cpp 4248]

  • ERROR => NiIRead: SiRecv failed for hdl 4 / sock 176

(SI_ECONN_BROKEN/10054; I4; ST; 127.0.0.1:1242) [nixxi.cpp 4248]

NiSelISelectInt: 1 handles selected (1 buffered)

DpLoopExec: Msg from J2EE server received

DpJ2eeMsgProcess

DpJ2eeMsgProcess: NiRead(rc=NIECONN_BROKEN), len=0

DpJ2eeMsgProcess: NiRead failed (NIECONN_BROKEN)

DpJ2eeMsgProcess: j2ee state = CONNECTED (NIECONN_BROKEN)

MsIDelService: delete service J2EE for myself

NiIWrite: hdl 3 sent data (wrt=161,pac=1,MESG_IO)

MsINiWrite: sent 161 bytes

send msg (len 110+51) to name MSG_SERVER, type 0, key -

MsSndName: MS_DEL_PROPERTY ok

Send 51 bytes to MSG_SERVER

MS_DEL_PROPERTY : asynchronous call

send MsDelService(J2EE) to msgserver

DpIJ2eeShutdown: send SIGINT to SAP J2EE startup framework (pid=5304)

killing process (5304) (SOFT_KILL)

  • ERROR => DpProcKill: kill failed [dpntdisp.c 371]

DpIJ2eeShutdown: j2ee state = SHUTDOWN

DpDelSocketInfo: del info for socket 4 (type=8)

NiICloseHandle: shutdown and close hdl 4 / sock 176

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548357/421000 17/843000 sec/usec

DpTimeCheck: act sleep = 17843 msec

  • DP LOOP ***********

NiIRead: hdl 3 received data (rcd=114,pac=1,MESG_IO)

NiSelISelectInt: 1 handles selected (1 buffered)

MsINiRead: received 114 bytes

MSG received, len 110+4, flag 3, from MSG_SERVER , typ 0, key -

opcode : MS_DEL_PROPERTY

retcode : MSOP_OK

version : 1

charset : 3

DpMsInfo: request from MSG_SERVER, opcode MS_DEL_PROPERTY

DpMsInfo: MS_DEL_PROPERTY for J2EE received

DpMBufServDel: service 2 deleted for inmucoprhd01_TRN_00

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548357/421000 17/843000 sec/usec

DpTimeCheck: act sleep = 17843 msec

  • DP LOOP ***********

Wed Apr 30 15:09:17 2008

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548357/421000 0/0 sec/usec

secs 1209548357, active req_info's 0x0/0x0/

DpGetSchedule: found slot 4 (type/tid/mode DPT_ENVCHECK/-1/255)

DpSetNextSchedule: next schedule for slot 4: 1209548377/421000 (20/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548377/421000

call DpEnvCheck

[DpWpDied] W0 lives (PID:4116 HANDLE:412)

[DpWpDied] W1 lives (PID:4124 HANDLE:404)

[DpWpDied] W2 lives (PID:4132 HANDLE:400)

[DpWpDied] W3 lives (PID:4140 HANDLE:396)

[DpWpDied] W4 lives (PID:4148 HANDLE:392)

[DpWpDied] W5 lives (PID:4156 HANDLE:388)

[DpWpDied] W6 lives (PID:4164 HANDLE:384)

[DpWpDied] W7 lives (PID:4172 HANDLE:380)

[DpWpDied] W8 lives (PID:4180 HANDLE:376)

[DpWpDied] W9 lives (PID:4188 HANDLE:372)

[DpWpDied] W10 lives (PID:4204 HANDLE:368)

[DpWpDied] W11 lives (PID:4216 HANDLE:364)

[DpWpDied] W12 lives (PID:4228 HANDLE:360)

DpVmCheck: vmc not active

DpGwCheck: 0

[DpProcDied] Process lives (PID:3840 HANDLE:424)

DpGwCheck: ok

NiICreateHandle: hdl 4 state NI_INITIAL

NiIInitSocket: set default settings for new hdl 4 / sock 176 (I4; ST)

NiIBind: hdl 4 bound to 1246 (IP only)

NiIBlockMode: set blockmode for hdl 4 FALSE

NiIListen: state of hdl 4 NI_LISTEN

NiIListen: listen for client requests on hdl 4

DpJ2eeStart: listen for J2EE server on hdl 4

SetEnvironmentVariable PPID=4008

start >D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE<

DpForkExec: program name=D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

DpForkExec: argv[1]="pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01"

DpForkExec: argv[2]="-DSAPSTART=1"

DpForkExec: argv[3]="-DCONNECT_PORT=1246"

DpForkExec: argv[4]="-DSAPSYSTEM=00"

DpForkExec: argv[5]="-DSAPSYSTEMNAME=TRN"

DpForkExec: argv[6]="-DSAPMYNAME=inmucoprhd01_TRN_00"

DpForkExec: argv[7]="-DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01"

DpForkExec: argv[8]="-DFRFC_FALLBACK=ON"

DpForkExec: argv[9]="-DFRFC_FALLBACK_HOST=localhost"

CreateProcess >D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE< (PID:5564 HANDLE:264)

DpAddSocketInfo: add info for socket 4 (type/idx=7/0)

J2EE server info

start = TRUE

state = STARTED

pid = 5564

argv[0] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[1] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[2] = pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[3] = -DSAPSTART=1

argv[4] = -DCONNECT_PORT=1246

argv[5] = -DSAPSYSTEM=00

argv[6] = -DSAPSYSTEMNAME=TRN

argv[7] = -DSAPMYNAME=inmucoprhd01_TRN_00

argv[8] = -DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[9] = -DFRFC_FALLBACK=ON

argv[10] = -DFRFC_FALLBACK_HOST=localhost

start_lazy = 0

start_control = SAP J2EE startup framework

DpJ2eeStart: j2ee state = STARTED

[DpProcDied] Process lives (PID:4100 HANDLE:432)

DpCheckTimeTab: check time table

DpGetSchedule: next schedule 1209548377/421000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548377/421000 20/0 sec/usec

DpTimeCheck: act sleep = 20000 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

J2EE LOGIN request received

NiICreateHandle: hdl 6 state NI_INITIAL

NiIInitSocket: set default settings for hdl 6 / sock 172 (I4; ST)

NiIBlockMode: set blockmode for hdl 6 FALSE

NiIAccept: state of hdl 6 NI_ACCEPTED

NiIAccept: hdl 4 accepted hdl 6 from 127.0.0.1:1247

NiIAccept: hdl 6 took local address 127.0.0.1:1246

NiLocalCheck: address 127.0.0.1 is local

NiICloseHandle: shutdown and close hdl 4 / sock 176 - sock -1

DpDelSocketInfo: del info for socket 4 (type=7)

NiIMyHostName: hostname = 'inmucoprhd01'

NiHsLGetNodeAddr: found hostname 'inmucoprhd01' in cache

NiIGetNodeAddr: hostname 'inmucoprhd01' = addr 10.100.15.47

DpAddSocketInfo: add info for socket 6 (type/idx=8/0)

DpJ2eeLogin: j2ee state = CONNECTED

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548377/421000 19/953000 sec/usec

DpTimeCheck: act sleep = 19953 msec

  • DP LOOP ***********

Wed Apr 30 15:09:19 2008

***LOG Q0I=> NiIRead: recv (10054: WSAECONNRESET: Connection reset by peer) [nixxi.cpp 4248]

  • ERROR => NiIRead: SiRecv failed for hdl 6 / sock 172

(SI_ECONN_BROKEN/10054; I4; ST; 127.0.0.1:1247) [nixxi.cpp 4248]

NiSelISelectInt: 1 handles selected (1 buffered)

DpLoopExec: Msg from J2EE server received

DpJ2eeMsgProcess

DpJ2eeMsgProcess: NiRead(rc=NIECONN_BROKEN), len=0

DpJ2eeMsgProcess: NiRead failed (NIECONN_BROKEN)

DpJ2eeMsgProcess: j2ee state = CONNECTED (NIECONN_BROKEN)

MsIDelService: delete service J2EE for myself

NiIWrite: hdl 3 sent data (wrt=161,pac=1,MESG_IO)

MsINiWrite: sent 161 bytes

send msg (len 110+51) to name MSG_SERVER, type 0, key -

MsSndName: MS_DEL_PROPERTY ok

Send 51 bytes to MSG_SERVER

MS_DEL_PROPERTY : asynchronous call

send MsDelService(J2EE) to msgserver

DpIJ2eeShutdown: send SIGINT to SAP J2EE startup framework (pid=5564)

killing process (5564) (SOFT_KILL)

  • ERROR => DpProcKill: kill failed [dpntdisp.c 371]

DpIJ2eeShutdown: j2ee state = SHUTDOWN

DpDelSocketInfo: del info for socket 6 (type=8)

NiICloseHandle: shutdown and close hdl 6 / sock 172

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548377/421000 17/843000 sec/usec

DpTimeCheck: act sleep = 17843 msec

  • DP LOOP ***********

NiIRead: hdl 3 received data (rcd=114,pac=1,MESG_IO)

NiSelISelectInt: 1 handles selected (1 buffered)

MsINiRead: received 114 bytes

MSG received, len 110+4, flag 3, from MSG_SERVER , typ 0, key -

opcode : MS_DEL_PROPERTY

retcode : MSOP_OK

version : 1

charset : 3

DpMsInfo: request from MSG_SERVER, opcode MS_DEL_PROPERTY

DpMsInfo: MS_DEL_PROPERTY for J2EE received

DpMBufServDel: service 2 deleted for inmucoprhd01_TRN_00

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548377/421000 17/843000 sec/usec

DpTimeCheck: act sleep = 17843 msec

  • DP LOOP ***********

Wed Apr 30 15:09:37 2008

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548377/421000 0/0 sec/usec

secs 1209548377, active req_info's 0x0/0x0/

DpGetSchedule: found slot 4 (type/tid/mode DPT_ENVCHECK/-1/255)

DpSetNextSchedule: next schedule for slot 4: 1209548397/421000 (20/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548377/656000

call DpEnvCheck

[DpWpDied] W0 lives (PID:4116 HANDLE:412)

[DpWpDied] W1 lives (PID:4124 HANDLE:404)

[DpWpDied] W2 lives (PID:4132 HANDLE:400)

[DpWpDied] W3 lives (PID:4140 HANDLE:396)

[DpWpDied] W4 lives (PID:4148 HANDLE:392)

[DpWpDied] W5 lives (PID:4156 HANDLE:388)

[DpWpDied] W6 lives (PID:4164 HANDLE:384)

[DpWpDied] W7 lives (PID:4172 HANDLE:380)

[DpWpDied] W8 lives (PID:4180 HANDLE:376)

[DpWpDied] W9 lives (PID:4188 HANDLE:372)

[DpWpDied] W10 lives (PID:4204 HANDLE:368)

[DpWpDied] W11 lives (PID:4216 HANDLE:364)

[DpWpDied] W12 lives (PID:4228 HANDLE:360)

DpVmCheck: vmc not active

DpGwCheck: 0

[DpProcDied] Process lives (PID:3840 HANDLE:424)

DpGwCheck: ok

NiICreateHandle: hdl 6 state NI_INITIAL

NiIInitSocket: set default settings for new hdl 6 / sock 172 (I4; ST)

NiIBind: hdl 6 bound to 1256 (IP only)

NiIBlockMode: set blockmode for hdl 6 FALSE

NiIListen: state of hdl 6 NI_LISTEN

NiIListen: listen for client requests on hdl 6

DpJ2eeStart: listen for J2EE server on hdl 6

SetEnvironmentVariable PPID=4008

start >D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE<

DpForkExec: program name=D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

DpForkExec: argv[1]="pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01"

DpForkExec: argv[2]="-DSAPSTART=1"

DpForkExec: argv[3]="-DCONNECT_PORT=1256"

DpForkExec: argv[4]="-DSAPSYSTEM=00"

DpForkExec: argv[5]="-DSAPSYSTEMNAME=TRN"

DpForkExec: argv[6]="-DSAPMYNAME=inmucoprhd01_TRN_00"

DpForkExec: argv[7]="-DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01"

DpForkExec: argv[8]="-DFRFC_FALLBACK=ON"

DpForkExec: argv[9]="-DFRFC_FALLBACK_HOST=localhost"

CreateProcess >D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE< (PID:5752 HANDLE:196)

DpAddSocketInfo: add info for socket 6 (type/idx=7/0)

J2EE server info

start = TRUE

state = STARTED

pid = 5752

argv[0] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[1] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[2] = pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[3] = -DSAPSTART=1

argv[4] = -DCONNECT_PORT=1256

argv[5] = -DSAPSYSTEM=00

argv[6] = -DSAPSYSTEMNAME=TRN

argv[7] = -DSAPMYNAME=inmucoprhd01_TRN_00

argv[8] = -DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[9] = -DFRFC_FALLBACK=ON

argv[10] = -DFRFC_FALLBACK_HOST=localhost

start_lazy = 0

start_control = SAP J2EE startup framework

DpJ2eeStart: j2ee state = STARTED

[DpProcDied] Process lives (PID:4100 HANDLE:432)

DpCheckTimeTab: check time table

DpGetSchedule: next schedule 1209548377/656000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548377/656000 0/235000 sec/usec

DpTimeCheck: act sleep = 235 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

J2EE LOGIN request received

NiICreateHandle: hdl 4 state NI_INITIAL

NiIInitSocket: set default settings for hdl 4 / sock 168 (I4; ST)

NiIBlockMode: set blockmode for hdl 4 FALSE

NiIAccept: state of hdl 4 NI_ACCEPTED

NiIAccept: hdl 6 accepted hdl 4 from 127.0.0.1:1257

NiIAccept: hdl 4 took local address 127.0.0.1:1256

NiLocalCheck: address 127.0.0.1 is local

NiICloseHandle: shutdown and close hdl 6 / sock 172 - sock -1

DpDelSocketInfo: del info for socket 6 (type=7)

NiIMyHostName: hostname = 'inmucoprhd01'

NiHsLGetNodeAddr: found hostname 'inmucoprhd01' in cache

NiIGetNodeAddr: hostname 'inmucoprhd01' = addr 10.100.15.47

DpAddSocketInfo: add info for socket 4 (type/idx=8/0)

DpJ2eeLogin: j2ee state = CONNECTED

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548377/656000 0/188000 sec/usec

DpTimeCheck: act sleep = 188 msec

  • DP LOOP ***********

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548377/656000 (in the past)

secs 1209548377, active req_info's 0x0/0x0/

DpGetSchedule: found slot 6 (type/tid/mode DPT_AUTOTH/-1/255)

next 1209548377/656000, 0 in queue, autothtime 60

DpSetNextSchedule: next schedule for slot 6: 1209548437/671000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548397/390000

activate auto th

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 100)

DpGetSchedule: next schedule 1209548397/390000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548397/390000 19/719000 sec/usec

DpTimeCheck: act sleep = 19719 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 1 request(s) in DIA queue ===>>

W0 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 100

-IN-- req_info SET_SYSTEM_USER DP_AUTO_TH

DpRqNormalHandle: set SYSTEM_USER T0 U1 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNormalHandle: new state of W0 is WP_RUN

DpRqNormalHandle: new state of T0/M0 = 0x42

DpRqNormalHandle: give rq_id 100 to W0 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548397/390000 19/719000 sec/usec

DpTimeCheck: act sleep = 19719 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_DP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 101

info for DIA: wait/run/hold/killed = 6/0/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_WAIT

REL WP ca_blk 40

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548397/390000 19/719000 sec/usec

DpTimeCheck: act sleep = 19719 msec

  • DP LOOP ***********

Wed Apr 30 15:09:38 2008

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1138

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 1 request(s) in DIA queue ===>>

W0 is free

-IN-- sender_id IC_MAN tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 0 len -1 rq_id 102

-IN-- req_info LOGIN DP_ICM_EVENT

-IN-- mpi rq <d> mpi resp <e> prot 1 obj fd -1 rq_id 0

-IN-- icm_opcode: ICM_PLUGIN_REQUEST

DpITmSlotClear: clear slot 14

DpListRemove: remove elem 14 from tmadm_free_list

DpListRemove: 187 elems in tmadm_free_list

DpListInsert: insert elem 14 into tmadm_inuse_list (at begin)

DpListInsert: 14 elems in tmadm_inuse_list

new terminal T14/U19, type=202, state=TM_CONNECTED

DpRqLoginHandle: resource check for T14 activated (resource=HTTP)

DpRqLoginHandle: set terminal name of external plugin to > 10.100.15.47<

DpRqNormalHandle: DpRqCheck o.k.

DpIncrCheckedResourcesCnt: intCnt/extCnt=1/1 (resource=HTTP)

MPI<e>2#4 WriteOOB 00000000 06000000 0E000000 00

DpRqNormalHandle: ICM request dispatched to W0 (14/19/0)

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNormalHandle: new state of W0 is WP_RUN

DpRqNormalHandle: new state of T14/M0 = 0x82

DpRqNormalHandle: give rq_id 102 to W0 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548397/390000 18/469000 sec/usec

DpTimeCheck: act sleep = 18469 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 14 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_DP uid 19 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 103

-IN-- req_info LOGOFF

info for DIA: wait/run/hold/killed = 6/0/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_WAIT

DpDecrCheckedResourcesCnt: intCnt/extCnt=0/0 (resource=HTTP)

DpGetSchedule: next schedule 1209548397/390000

DpGetSchedule: no schedule found

DpRqNoWpHandle: set dp_tm_adm of T14 to DP_SLOT_FREE

DpGetSchedule: next schedule 1209548397/390000

DpGetSchedule: no schedule found

DpITmSlotRelease: release slot 14

DpListInsert: insert elem 14 into tmadm_free_list (at begin)

DpListInsert: 188 elems in tmadm_free_list

DpListRemove: remove elem 14 from tmadm_inuse_list

DpListRemove: 13 elems in tmadm_inuse_list

REL WP ca_blk 40

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548397/390000 18/469000 sec/usec

DpTimeCheck: act sleep = 18469 msec

  • DP LOOP ***********

Wed Apr 30 15:09:39 2008

***LOG Q0I=> NiIRead: recv (10054: WSAECONNRESET: Connection reset by peer) [nixxi.cpp 4248]

  • ERROR => NiIRead: SiRecv failed for hdl 4 / sock 168

(SI_ECONN_BROKEN/10054; I4; ST; 127.0.0.1:1257) [nixxi.cpp 4248]

NiSelISelectInt: 1 handles selected (1 buffered)

DpLoopExec: Msg from J2EE server received

DpJ2eeMsgProcess

DpJ2eeMsgProcess: NiRead(rc=NIECONN_BROKEN), len=0

DpJ2eeMsgProcess: NiRead failed (NIECONN_BROKEN)

DpJ2eeMsgProcess: j2ee state = CONNECTED (NIECONN_BROKEN)

MsIDelService: delete service J2EE for myself

NiIWrite: hdl 3 sent data (wrt=161,pac=1,MESG_IO)

MsINiWrite: sent 161 bytes

send msg (len 110+51) to name MSG_SERVER, type 0, key -

MsSndName: MS_DEL_PROPERTY ok

Send 51 bytes to MSG_SERVER

MS_DEL_PROPERTY : asynchronous call

send MsDelService(J2EE) to msgserver

DpIJ2eeShutdown: send SIGINT to SAP J2EE startup framework (pid=5752)

killing process (5752) (SOFT_KILL)

  • ERROR => DpProcKill: kill failed [dpntdisp.c 371]

DpIJ2eeShutdown: j2ee state = SHUTDOWN

DpDelSocketInfo: del info for socket 4 (type=8)

NiICloseHandle: shutdown and close hdl 4 / sock 168

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548397/390000 17/812000 sec/usec

DpTimeCheck: act sleep = 17812 msec

  • DP LOOP ***********

NiIRead: hdl 3 received data (rcd=114,pac=1,MESG_IO)

NiSelISelectInt: 1 handles selected (1 buffered)

MsINiRead: received 114 bytes

MSG received, len 110+4, flag 3, from MSG_SERVER , typ 0, key -

opcode : MS_DEL_PROPERTY

retcode : MSOP_OK

version : 1

charset : 3

DpMsInfo: request from MSG_SERVER, opcode MS_DEL_PROPERTY

DpMsInfo: MS_DEL_PROPERTY for J2EE received

DpMBufServDel: service 2 deleted for inmucoprhd01_TRN_00

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548397/390000 17/812000 sec/usec

DpTimeCheck: act sleep = 17812 msec

  • DP LOOP ***********

Wed Apr 30 15:09:57 2008

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548397/390000 0/0 sec/usec

secs 1209548397, active req_info's 0x0/0x0/

DpGetSchedule: found slot 7 (type/tid/mode DPT_CALL_DELAYED/-1/255)

next 1209548397/390000, 0 in queue, call delayed freq 60

DpSetNextSchedule: next schedule for slot 7: 1209548457/390000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548397/390000

activate delayed function processing

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 104)

DpGetSchedule: found slot 8 (type/tid/mode DPT_SPOOLALRM/-1/255)

next 1209548397/390000, 0 in queue, spoolalrm 60

DpSetNextSchedule: next schedule for slot 8: 1209548457/390000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548397/390000

activate spool alarm

DpRqPutIntoQueue: put request into queue (reqtype 5, prio LOW, rq_id 105)

wake_evt_udp_now 1, no dgram needed

DpGetSchedule: found slot 2 (type/tid/mode DPT_BTCSCHED/-1/255)

next 1209548397/390000, 0 in queue, btctime 60

DpSetNextSchedule: next schedule for slot 2: 1209548457/390000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548397/421000

activate btc-scheduler

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 106)

wake_evt_udp_now 1, no dgram needed

DpGetSchedule: next schedule 1209548397/421000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548397/421000 0/31000 sec/usec

DpTimeCheck: act sleep = 31 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 2 request(s) in DIA queue ===>>

W0 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 104

-IN-- req_info THDP_ADM SET_SYSTEM_USER

-IN-- thdp_adm_req_info CALL_DELAYED

DpRqNormalHandle: set SYSTEM_USER T0 U1 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNormalHandle: new state of W0 is WP_RUN

DpRqNormalHandle: new state of T0/M0 = 0x42

DpRqNormalHandle: give rq_id 104 to W0 ...

W1 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 106

-IN-- req_info BTC_SCHEDULER SET_SYSTEM_USER

DpRqNormalHandle: set SYSTEM_USER T1 U2 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 4/2/0/0 wps

DpRqNormalHandle: new state of W1 is WP_RUN

DpRqNormalHandle: new state of T1/M0 = 0x42

DpRqNormalHandle: give rq_id 106 to W1 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 1 request(s) in SPO queue ===>>

W11 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type SPO

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 105

-IN-- req_info SET_SYSTEM_USER DP_SPOOL_ALRM

DpRqNormalHandle: set SYSTEM_USER T11 U12 M0

DpRqNormalHandle: DpRqCheck o.k.

info for SPO: wait/run/hold/killed = 0/1/0/0 wps

DpRqNormalHandle: new state of W11 is WP_RUN

DpRqNormalHandle: new state of T11/M0 = 0x42

DpRqNormalHandle: give rq_id 105 to W11 ...

DpRqNormalHandle: set dp_spoolwp_with_token = W11

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

WP blk 60 WORK_PROCESS 4124

WP blk 260 WORK_PROCESS 4216

APPC blk 12 WORK_PROCESS 4116

APPC blk 18 WORK_PROCESS 4124

APPC blk 78 WORK_PROCESS 4216

DpGetScheduleInfo: next_schedule: 1209548397/421000 0/31000 sec/usec

DpTimeCheck: act sleep = 31 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_DP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 107

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_WAIT

REL WP ca_blk 40

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 60 WORK_PROCESS 4124

WP blk 260 WORK_PROCESS 4216

APPC blk 18 WORK_PROCESS 4124

APPC blk 78 WORK_PROCESS 4216

DpGetScheduleInfo: next_schedule: 1209548397/421000 0/31000 sec/usec

DpTimeCheck: act sleep = 31 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1134

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 11 wp_ca_blk 260 wp_id 11

-IN-- action SEND_TO_DP uid 12 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 8 rq_id 108

DpRqNoWpHandle: set dp_spoolwp_with_token = NO_WP

REL WP ca_blk 260

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 60 WORK_PROCESS 4124

WP blk 261 WORK_PROCESS 4216

APPC blk 18 WORK_PROCESS 4124

APPC blk 78 WORK_PROCESS 4216

DpGetScheduleInfo: next_schedule: 1209548397/421000 0/31000 sec/usec

DpTimeCheck: act sleep = 31 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1134

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 11 wp_ca_blk 261 wp_id 11

-IN-- action SEND_TO_DP uid 12 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 109

info for SPO: wait/run/hold/killed = 1/0/0/0 wps

DpRqNoWpHandle: new state of W11 is WP_WAIT

REL WP ca_blk 261

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 60 WORK_PROCESS 4124

APPC blk 18 WORK_PROCESS 4124

DpGetScheduleInfo: next_schedule: 1209548397/421000 0/31000 sec/usec

DpTimeCheck: act sleep = 31 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1132

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 1 wp_ca_blk 60 wp_id 1

-IN-- action SEND_TO_DP uid 2 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 110

info for DIA: wait/run/hold/killed = 6/0/0/0 wps

DpRqNoWpHandle: new state of W1 is WP_WAIT

REL WP ca_blk 60

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548397/421000 0/31000 sec/usec

DpTimeCheck: act sleep = 31 msec

  • DP LOOP ***********

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548397/421000 0/0 sec/usec

secs 1209548397, active req_info's 0x0/0x0/

DpGetSchedule: found slot 4 (type/tid/mode DPT_ENVCHECK/-1/255)

DpSetNextSchedule: next schedule for slot 4: 1209548417/421000 (20/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548417/421000

call DpEnvCheck

[DpWpDied] W0 lives (PID:4116 HANDLE:412)

[DpWpDied] W1 lives (PID:4124 HANDLE:404)

[DpWpDied] W2 lives (PID:4132 HANDLE:400)

[DpWpDied] W3 lives (PID:4140 HANDLE:396)

[DpWpDied] W4 lives (PID:4148 HANDLE:392)

[DpWpDied] W5 lives (PID:4156 HANDLE:388)

[DpWpDied] W6 lives (PID:4164 HANDLE:384)

[DpWpDied] W7 lives (PID:4172 HANDLE:380)

[DpWpDied] W8 lives (PID:4180 HANDLE:376)

[DpWpDied] W9 lives (PID:4188 HANDLE:372)

[DpWpDied] W10 lives (PID:4204 HANDLE:368)

[DpWpDied] W11 lives (PID:4216 HANDLE:364)

[DpWpDied] W12 lives (PID:4228 HANDLE:360)

DpVmCheck: vmc not active

DpGwCheck: 0

[DpProcDied] Process lives (PID:3840 HANDLE:424)

DpGwCheck: ok

NiICreateHandle: hdl 4 state NI_INITIAL

NiIInitSocket: set default settings for new hdl 4 / sock 168 (I4; ST)

NiIBind: hdl 4 bound to 1268 (IP only)

NiIBlockMode: set blockmode for hdl 4 FALSE

NiIListen: state of hdl 4 NI_LISTEN

NiIListen: listen for client requests on hdl 4

DpJ2eeStart: listen for J2EE server on hdl 4

SetEnvironmentVariable PPID=4008

start >D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE<

DpForkExec: program name=D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

DpForkExec: argv[1]="pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01"

DpForkExec: argv[2]="-DSAPSTART=1"

DpForkExec: argv[3]="-DCONNECT_PORT=1268"

DpForkExec: argv[4]="-DSAPSYSTEM=00"

DpForkExec: argv[5]="-DSAPSYSTEMNAME=TRN"

DpForkExec: argv[6]="-DSAPMYNAME=inmucoprhd01_TRN_00"

DpForkExec: argv[7]="-DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01"

DpForkExec: argv[8]="-DFRFC_FALLBACK=ON"

DpForkExec: argv[9]="-DFRFC_FALLBACK_HOST=localhost"

CreateProcess >D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE< (PID:5880 HANDLE:184)

DpAddSocketInfo: add info for socket 4 (type/idx=7/0)

J2EE server info

start = TRUE

state = STARTED

pid = 5880

argv[0] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[1] = D:\usr\sap\TRN\DVEBMGS00\exe\jcontrol.EXE

argv[2] = pf=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[3] = -DSAPSTART=1

argv[4] = -DCONNECT_PORT=1268

argv[5] = -DSAPSYSTEM=00

argv[6] = -DSAPSYSTEMNAME=TRN

argv[7] = -DSAPMYNAME=inmucoprhd01_TRN_00

argv[8] = -DSAPPROFILE=D:\usr\sap\TRN\SYS\profile\TRN_DVEBMGS00_inmucoprhd01

argv[9] = -DFRFC_FALLBACK=ON

argv[10] = -DFRFC_FALLBACK_HOST=localhost

start_lazy = 0

start_control = SAP J2EE startup framework

DpJ2eeStart: j2ee state = STARTED

[DpProcDied] Process lives (PID:4100 HANDLE:432)

DpCheckTimeTab: check time table

DpGetSchedule: next schedule 1209548417/421000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548417/421000 20/0 sec/usec

DpTimeCheck: act sleep = 20000 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

J2EE LOGIN request received

NiICreateHandle: hdl 6 state NI_INITIAL

NiIInitSocket: set default settings for hdl 6 / sock 164 (I4; ST)

NiIBlockMode: set blockmode for hdl 6 FALSE

NiIAccept: state of hdl 6 NI_ACCEPTED

NiIAccept: hdl 4 accepted hdl 6 from 127.0.0.1:1269

NiIAccept: hdl 6 took local address 127.0.0.1:1268

NiLocalCheck: address 127.0.0.1 is local

NiICloseHandle: shutdown and close hdl 4 / sock 168 - sock -1

DpDelSocketInfo: del info for socket 4 (type=7)

NiIMyHostName: hostname = 'inmucoprhd01'

NiHsLGetNodeAddr: found hostname 'inmucoprhd01' in cache

NiIGetNodeAddr: hostname 'inmucoprhd01' = addr 10.100.15.47

DpAddSocketInfo: add info for socket 6 (type/idx=8/0)

DpJ2eeLogin: j2ee state = CONNECTED

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548417/421000 19/953000 sec/usec

DpTimeCheck: act sleep = 19953 msec

  • DP LOOP ***********

Wed Apr 30 15:09:59 2008

***LOG Q0I=> NiIRead: recv (10054: WSAECONNRESET: Connection reset by peer) [nixxi.cpp 4248]

  • ERROR => NiIRead: SiRecv failed for hdl 6 / sock 164

(SI_ECONN_BROKEN/10054; I4; ST; 127.0.0.1:1269) [nixxi.cpp 4248]

NiSelISelectInt: 1 handles selected (1 buffered)

DpLoopExec: Msg from J2EE server received

DpJ2eeMsgProcess

DpJ2eeMsgProcess: NiRead(rc=NIECONN_BROKEN), len=0

DpJ2eeMsgProcess: NiRead failed (NIECONN_BROKEN)

DpJ2eeMsgProcess: j2ee state = CONNECTED (NIECONN_BROKEN)

MsIDelService: delete service J2EE for myself

NiIWrite: hdl 3 sent data (wrt=161,pac=1,MESG_IO)

MsINiWrite: sent 161 bytes

send msg (len 110+51) to name MSG_SERVER, type 0, key -

MsSndName: MS_DEL_PROPERTY ok

Send 51 bytes to MSG_SERVER

MS_DEL_PROPERTY : asynchronous call

send MsDelService(J2EE) to msgserver

DpIJ2eeShutdown: send SIGINT to SAP J2EE startup framework (pid=5880)

killing process (5880) (SOFT_KILL)

  • ERROR => DpProcKill: kill failed [dpntdisp.c 371]

DpIJ2eeShutdown: j2ee state = SHUTDOWN

DpDelSocketInfo: del info for socket 6 (type=8)

NiICloseHandle: shutdown and close hdl 6 / sock 164

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548417/421000 17/843000 sec/usec

DpTimeCheck: act sleep = 17843 msec

  • DP LOOP ***********

NiIRead: hdl 3 received data (rcd=114,pac=1,MESG_IO)

NiSelISelectInt: 1 handles selected (1 buffered)

MsINiRead: received 114 bytes

MSG received, len 110+4, flag 3, from MSG_SERVER , typ 0, key -

opcode : MS_DEL_PROPERTY

retcode : MSOP_OK

version : 1

charset : 3

DpMsInfo: request from MSG_SERVER, opcode MS_DEL_PROPERTY

DpMsInfo: MS_DEL_PROPERTY for J2EE received

DpMBufServDel: service 2 deleted for inmucoprhd01_TRN_00

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548417/421000 17/843000 sec/usec

DpTimeCheck: act sleep = 17843 msec

  • DP LOOP ***********

Wed Apr 30 15:10:17 2008

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548417/421000 0/0 sec/usec

secs 1209548417, active req_info's 0x0/0x0/

DpGetSchedule: found slot 4 (type/tid/mode DPT_ENVCHECK/-1/255)

DpSetNextSchedule: next schedule for slot 4: 1209548437/421000 (20/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548437/421000

call DpEnvCheck

[DpWpDied] W0 lives (PID:4116 HANDLE:412)

[DpWpDied] W1 lives (PID:4124 HANDLE:404)

[DpWpDied] W2 lives (PID:4132 HANDLE:400)

[DpWpDied] W3 lives (PID:4140 HANDLE:396)

[DpWpDied] W4 lives (PID:4148 HANDLE:392)

[DpWpDied] W5 lives (PID:4156 HANDLE:388)

[DpWpDied] W6 lives (PID:4164 HANDLE:384)

[DpWpDied] W7 lives (PID:4172 HANDLE:380)

[DpWpDied] W8 lives (PID:4180 HANDLE:376)

[DpWpDied] W9 lives (PID:4188 HANDLE:372)

[DpWpDied] W10 lives (PID:4204 HANDLE:368)

[DpWpDied] W11 lives (PID:4216 HANDLE:364)

[DpWpDied] W12 lives (PID:4228 HANDLE:360)

DpVmCheck: vmc not active

DpGwCheck: 0

[DpProcDied] Process lives (PID:3840 HANDLE:424)

DpGwCheck: ok

DpEnvCheckJ2ee: switch off j2ee start flag

DpJ2eeDisableRestart

[DpProcDied] Process lives (PID:4100 HANDLE:432)

DpCheckTimeTab: check time table

DpGetSchedule: next schedule 1209548437/421000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548437/421000 20/0 sec/usec

DpTimeCheck: act sleep = 20000 msec

  • DP LOOP ***********

Wed Apr 30 15:10:37 2008

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548437/421000 0/0 sec/usec

secs 1209548437, active req_info's 0x0/0x0/

DpGetSchedule: found slot 4 (type/tid/mode DPT_ENVCHECK/-1/255)

DpSetNextSchedule: next schedule for slot 4: 1209548457/421000 (20/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548437/671000

call DpEnvCheck

[DpWpDied] W0 lives (PID:4116 HANDLE:412)

[DpWpDied] W1 lives (PID:4124 HANDLE:404)

[DpWpDied] W2 lives (PID:4132 HANDLE:400)

[DpWpDied] W3 lives (PID:4140 HANDLE:396)

[DpWpDied] W4 lives (PID:4148 HANDLE:392)

[DpWpDied] W5 lives (PID:4156 HANDLE:388)

[DpWpDied] W6 lives (PID:4164 HANDLE:384)

[DpWpDied] W7 lives (PID:4172 HANDLE:380)

[DpWpDied] W8 lives (PID:4180 HANDLE:376)

[DpWpDied] W9 lives (PID:4188 HANDLE:372)

[DpWpDied] W10 lives (PID:4204 HANDLE:368)

[DpWpDied] W11 lives (PID:4216 HANDLE:364)

[DpWpDied] W12 lives (PID:4228 HANDLE:360)

DpVmCheck: vmc not active

DpGwCheck: 0

[DpProcDied] Process lives (PID:3840 HANDLE:424)

DpGwCheck: ok

[DpProcDied] Process lives (PID:4100 HANDLE:432)

DpCheckTimeTab: check time table

DpGetSchedule: next schedule 1209548437/671000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548437/671000 0/250000 sec/usec

DpTimeCheck: act sleep = 250 msec

  • DP LOOP ***********

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548437/671000 0/0 sec/usec

secs 1209548437, active req_info's 0x0/0x0/

DpGetSchedule: found slot 6 (type/tid/mode DPT_AUTOTH/-1/255)

next 1209548437/671000, 0 in queue, autothtime 60

DpSetNextSchedule: next schedule for slot 6: 1209548497/671000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548457/390000

activate auto th

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 111)

DpGetSchedule: next schedule 1209548457/390000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548457/390000 19/719000 sec/usec

DpTimeCheck: act sleep = 19719 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 1 request(s) in DIA queue ===>>

W0 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 111

-IN-- req_info SET_SYSTEM_USER DP_AUTO_TH

DpRqNormalHandle: set SYSTEM_USER T0 U1 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNormalHandle: new state of W0 is WP_RUN

DpRqNormalHandle: new state of T0/M0 = 0x42

DpRqNormalHandle: give rq_id 111 to W0 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548457/390000 19/719000 sec/usec

DpTimeCheck: act sleep = 19719 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_DP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 112

info for DIA: wait/run/hold/killed = 6/0/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_WAIT

REL WP ca_blk 40

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548457/390000 19/719000 sec/usec

DpTimeCheck: act sleep = 19719 msec

  • DP LOOP ***********

Wed Apr 30 15:10:38 2008

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1138

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 1 request(s) in DIA queue ===>>

W0 is free

-IN-- sender_id IC_MAN tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 0 len -1 rq_id 113

-IN-- req_info LOGIN DP_ICM_EVENT

-IN-- mpi rq <f> mpi resp <10> prot 1 obj fd -1 rq_id 0

-IN-- icm_opcode: ICM_PLUGIN_REQUEST

DpITmSlotClear: clear slot 14

DpListRemove: remove elem 14 from tmadm_free_list

DpListRemove: 187 elems in tmadm_free_list

DpListInsert: insert elem 14 into tmadm_inuse_list (at begin)

DpListInsert: 14 elems in tmadm_inuse_list

new terminal T14/U20, type=202, state=TM_CONNECTED

DpRqLoginHandle: resource check for T14 activated (resource=HTTP)

DpRqLoginHandle: set terminal name of external plugin to > 10.100.15.47<

DpRqNormalHandle: DpRqCheck o.k.

DpIncrCheckedResourcesCnt: intCnt/extCnt=1/1 (resource=HTTP)

MPI<10>3#4 WriteOOB 00000000 06000000 0E000000 00

DpRqNormalHandle: ICM request dispatched to W0 (14/20/0)

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNormalHandle: new state of W0 is WP_RUN

DpRqNormalHandle: new state of T14/M0 = 0x82

DpRqNormalHandle: give rq_id 113 to W0 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548457/390000 18/469000 sec/usec

DpTimeCheck: act sleep = 18469 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 14 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_DP uid 20 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 114

-IN-- req_info LOGOFF

info for DIA: wait/run/hold/killed = 6/0/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_WAIT

DpDecrCheckedResourcesCnt: intCnt/extCnt=0/0 (resource=HTTP)

DpGetSchedule: next schedule 1209548457/390000

DpGetSchedule: no schedule found

DpRqNoWpHandle: set dp_tm_adm of T14 to DP_SLOT_FREE

DpGetSchedule: next schedule 1209548457/390000

DpGetSchedule: no schedule found

DpITmSlotRelease: release slot 14

DpListInsert: insert elem 14 into tmadm_free_list (at begin)

DpListInsert: 188 elems in tmadm_free_list

DpListRemove: remove elem 14 from tmadm_inuse_list

DpListRemove: 13 elems in tmadm_inuse_list

REL WP ca_blk 40

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548457/390000 18/469000 sec/usec

DpTimeCheck: act sleep = 18469 msec

  • DP LOOP ***********

Wed Apr 30 15:10:57 2008

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548457/390000 (in the past)

secs 1209548457, active req_info's 0x0/0x0/

DpGetSchedule: found slot 7 (type/tid/mode DPT_CALL_DELAYED/-1/255)

next 1209548457/390000, 0 in queue, call delayed freq 60

DpSetNextSchedule: next schedule for slot 7: 1209548517/406000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548457/390000

activate delayed function processing

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 115)

DpGetSchedule: found slot 8 (type/tid/mode DPT_SPOOLALRM/-1/255)

next 1209548457/390000, 0 in queue, spoolalrm 60

DpSetNextSchedule: next schedule for slot 8: 1209548517/406000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548457/390000

activate spool alarm

DpRqPutIntoQueue: put request into queue (reqtype 5, prio LOW, rq_id 116)

wake_evt_udp_now 1, no dgram needed

DpGetSchedule: found slot 0 (type/tid/mode DPT_BUFREF/-1/255)

next 1209548457/390000, 0 in queue, bufreftime 120

DpSetNextSchedule: next schedule for slot 0: 1209548577/406000 (120/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548457/390000

activate buffer refresh

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 117)

wake_evt_udp_now 1, no dgram needed

DpGetSchedule: found slot 1 (type/tid/mode DPT_DDLOG/-1/255)

next 1209548457/390000, 0 in queue, ddlogtime 120

DpSetNextSchedule: next schedule for slot 1: 1209548577/406000 (120/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548457/390000

activate ddlog

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 118)

wake_evt_udp_now 1, no dgram needed

DpGetSchedule: found slot 2 (type/tid/mode DPT_BTCSCHED/-1/255)

next 1209548457/390000, 0 in queue, btctime 60

DpSetNextSchedule: next schedule for slot 2: 1209548517/406000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548457/421000

activate btc-scheduler

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 119)

wake_evt_udp_now 1, no dgram needed

DpGetSchedule: next schedule 1209548457/421000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548457/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 4 request(s) in DIA queue ===>>

W0 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 115

-IN-- req_info THDP_ADM SET_SYSTEM_USER

-IN-- thdp_adm_req_info CALL_DELAYED

DpRqNormalHandle: set SYSTEM_USER T0 U1 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNormalHandle: new state of W0 is WP_RUN

DpRqNormalHandle: new state of T0/M0 = 0x42

DpRqNormalHandle: give rq_id 115 to W0 ...

W1 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 117

-IN-- req_info BUFFER_REFRESH SET_SYSTEM_USER

DpRqNormalHandle: set SYSTEM_USER T1 U2 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 4/2/0/0 wps

DpRqNormalHandle: new state of W1 is WP_RUN

DpRqNormalHandle: new state of T1/M0 = 0x42

DpRqNormalHandle: give rq_id 117 to W1 ...

W2 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 118

-IN-- req_info THDP_ADM SET_SYSTEM_USER

-IN-- thdp_adm_req_info DDLOG

DpRqNormalHandle: set SYSTEM_USER T2 U3 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 3/3/0/0 wps

DpRqNormalHandle: new state of W2 is WP_RUN

DpRqNormalHandle: new state of T2/M0 = 0x42

DpRqNormalHandle: give rq_id 118 to W2 ...

W3 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 119

-IN-- req_info BTC_SCHEDULER SET_SYSTEM_USER

DpRqNormalHandle: set SYSTEM_USER T3 U4 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 2/4/0/0 wps

DpRqNormalHandle: new state of W3 is WP_RUN

DpRqNormalHandle: new state of T3/M0 = 0x42

DpRqNormalHandle: give rq_id 119 to W3 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 1 request(s) in SPO queue ===>>

W11 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type SPO

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 116

-IN-- req_info SET_SYSTEM_USER DP_SPOOL_ALRM

DpRqNormalHandle: set SYSTEM_USER T11 U12 M0

DpRqNormalHandle: DpRqCheck o.k.

info for SPO: wait/run/hold/killed = 0/1/0/0 wps

DpRqNormalHandle: new state of W11 is WP_RUN

DpRqNormalHandle: new state of T11/M0 = 0x42

DpRqNormalHandle: give rq_id 116 to W11 ...

DpRqNormalHandle: set dp_spoolwp_with_token = W11

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 60 WORK_PROCESS 4124

WP blk 80 WORK_PROCESS 4132

WP blk 100 WORK_PROCESS 4140

WP blk 260 WORK_PROCESS 4216

APPC blk 12 WORK_PROCESS 4116

APPC blk 18 WORK_PROCESS 4124

APPC blk 24 WORK_PROCESS 4132

APPC blk 30 WORK_PROCESS 4140

APPC blk 78 WORK_PROCESS 4216

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548457/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_DP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 120

info for DIA: wait/run/hold/killed = 3/3/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_WAIT

REL WP ca_blk 40

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 60 WORK_PROCESS 4124

WP blk 100 WORK_PROCESS 4140

WP blk 260 WORK_PROCESS 4216

APPC blk 18 WORK_PROCESS 4124

APPC blk 30 WORK_PROCESS 4140

APPC blk 78 WORK_PROCESS 4216

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548457/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1133

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 2 wp_ca_blk 80 wp_id 2

-IN-- action SEND_TO_DP uid 3 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 121

info for DIA: wait/run/hold/killed = 4/2/0/0 wps

DpRqNoWpHandle: new state of W2 is WP_WAIT

REL WP ca_blk 80

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 60 WORK_PROCESS 4124

WP blk 100 WORK_PROCESS 4140

WP blk 260 WORK_PROCESS 4216

APPC blk 18 WORK_PROCESS 4124

APPC blk 30 WORK_PROCESS 4140

APPC blk 78 WORK_PROCESS 4216

DpGetScheduleInfo: next_schedule: 1209548457/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1132

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 1 wp_ca_blk 60 wp_id 1

-IN-- action SEND_TO_DP uid 2 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 122

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W1 is WP_WAIT

REL WP ca_blk 60

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 100 WORK_PROCESS 4140

WP blk 260 WORK_PROCESS 4216

APPC blk 30 WORK_PROCESS 4140

APPC blk 78 WORK_PROCESS 4216

DpGetScheduleInfo: next_schedule: 1209548457/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1134

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 11 wp_ca_blk 260 wp_id 11

-IN-- action SEND_TO_DP uid 12 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 8 rq_id 123

DpRqNoWpHandle: set dp_spoolwp_with_token = NO_WP

REL WP ca_blk 260

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 100 WORK_PROCESS 4140

WP blk 261 WORK_PROCESS 4216

APPC blk 30 WORK_PROCESS 4140

APPC blk 78 WORK_PROCESS 4216

DpGetScheduleInfo: next_schedule: 1209548457/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1134

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 11 wp_ca_blk 261 wp_id 11

-IN-- action SEND_TO_DP uid 12 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 124

info for SPO: wait/run/hold/killed = 1/0/0/0 wps

DpRqNoWpHandle: new state of W11 is WP_WAIT

REL WP ca_blk 261

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 100 WORK_PROCESS 4140

APPC blk 30 WORK_PROCESS 4140

DpGetScheduleInfo: next_schedule: 1209548457/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1140

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 3 wp_ca_blk 100 wp_id 3

-IN-- action SEND_TO_DP uid 4 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 125

info for DIA: wait/run/hold/killed = 6/0/0/0 wps

DpRqNoWpHandle: new state of W3 is WP_WAIT

REL WP ca_blk 100

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548457/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548457/421000 0/0 sec/usec

secs 1209548457, active req_info's 0x0/0x0/

DpGetSchedule: found slot 4 (type/tid/mode DPT_ENVCHECK/-1/255)

DpSetNextSchedule: next schedule for slot 4: 1209548477/421000 (20/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548477/421000

call DpEnvCheck

[DpWpDied] W0 lives (PID:4116 HANDLE:412)

[DpWpDied] W1 lives (PID:4124 HANDLE:404)

[DpWpDied] W2 lives (PID:4132 HANDLE:400)

[DpWpDied] W3 lives (PID:4140 HANDLE:396)

[DpWpDied] W4 lives (PID:4148 HANDLE:392)

[DpWpDied] W5 lives (PID:4156 HANDLE:388)

[DpWpDied] W6 lives (PID:4164 HANDLE:384)

[DpWpDied] W7 lives (PID:4172 HANDLE:380)

[DpWpDied] W8 lives (PID:4180 HANDLE:376)

[DpWpDied] W9 lives (PID:4188 HANDLE:372)

[DpWpDied] W10 lives (PID:4204 HANDLE:368)

[DpWpDied] W11 lives (PID:4216 HANDLE:364)

[DpWpDied] W12 lives (PID:4228 HANDLE:360)

DpVmCheck: vmc not active

DpGwCheck: 0

[DpProcDied] Process lives (PID:3840 HANDLE:424)

DpGwCheck: ok

[DpProcDied] Process lives (PID:4100 HANDLE:432)

DpCheckTimeTab: check time table

DpGetSchedule: next schedule 1209548477/421000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548477/421000 20/0 sec/usec

DpTimeCheck: act sleep = 20000 msec

  • DP LOOP ***********

Wed Apr 30 15:11:17 2008

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548477/421000 0/0 sec/usec

secs 1209548477, active req_info's 0x0/0x0/

DpGetSchedule: found slot 4 (type/tid/mode DPT_ENVCHECK/-1/255)

DpSetNextSchedule: next schedule for slot 4: 1209548497/421000 (20/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548497/421000

call DpEnvCheck

DpEnvCheck: check idle message server connection

NiIWrite: hdl 3 sent data (wrt=8,pac=1,MESG_IO)

NiICheck: hdl 3 sent NI_PING to partner

NiICheck2: hdl 3 sent NI_PING to partner

DpEnvCheck: waiting for ms pong

[DpWpDied] W0 lives (PID:4116 HANDLE:412)

[DpWpDied] W1 lives (PID:4124 HANDLE:404)

[DpWpDied] W2 lives (PID:4132 HANDLE:400)

[DpWpDied] W3 lives (PID:4140 HANDLE:396)

[DpWpDied] W4 lives (PID:4148 HANDLE:392)

[DpWpDied] W5 lives (PID:4156 HANDLE:388)

[DpWpDied] W6 lives (PID:4164 HANDLE:384)

[DpWpDied] W7 lives (PID:4172 HANDLE:380)

[DpWpDied] W8 lives (PID:4180 HANDLE:376)

[DpWpDied] W9 lives (PID:4188 HANDLE:372)

[DpWpDied] W10 lives (PID:4204 HANDLE:368)

[DpWpDied] W11 lives (PID:4216 HANDLE:364)

[DpWpDied] W12 lives (PID:4228 HANDLE:360)

DpVmCheck: vmc not active

DpGwCheck: 0

[DpProcDied] Process lives (PID:3840 HANDLE:424)

DpGwCheck: ok

[DpProcDied] Process lives (PID:4100 HANDLE:432)

DpCheckTimeTab: check time table

DpGetSchedule: next schedule 1209548497/421000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548497/421000 20/0 sec/usec

DpTimeCheck: act sleep = 20000 msec

  • DP LOOP ***********

NiIRead: hdl 3 received data (rcd=8,pac=1,MESG_IO)

NiBufIProcMsg: hdl 3 received NI_PONG: wait_count: 1

Wed Apr 30 15:11:37 2008

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548497/421000 0/0 sec/usec

secs 1209548497, active req_info's 0x0/0x0/

DpGetSchedule: found slot 4 (type/tid/mode DPT_ENVCHECK/-1/255)

DpSetNextSchedule: next schedule for slot 4: 1209548517/421000 (20/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548497/671000

call DpEnvCheck

NiICheck2: number of pending messages: 0

[DpWpDied] W0 lives (PID:4116 HANDLE:412)

[DpWpDied] W1 lives (PID:4124 HANDLE:404)

[DpWpDied] W2 lives (PID:4132 HANDLE:400)

[DpWpDied] W3 lives (PID:4140 HANDLE:396)

[DpWpDied] W4 lives (PID:4148 HANDLE:392)

[DpWpDied] W5 lives (PID:4156 HANDLE:388)

[DpWpDied] W6 lives (PID:4164 HANDLE:384)

[DpWpDied] W7 lives (PID:4172 HANDLE:380)

[DpWpDied] W8 lives (PID:4180 HANDLE:376)

[DpWpDied] W9 lives (PID:4188 HANDLE:372)

[DpWpDied] W10 lives (PID:4204 HANDLE:368)

[DpWpDied] W11 lives (PID:4216 HANDLE:364)

[DpWpDied] W12 lives (PID:4228 HANDLE:360)

DpVmCheck: vmc not active

DpGwCheck: 0

[DpProcDied] Process lives (PID:3840 HANDLE:424)

DpGwCheck: ok

[DpProcDied] Process lives (PID:4100 HANDLE:432)

DpCheckTimeTab: check time table

DpGetSchedule: next schedule 1209548497/671000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548497/671000 0/250000 sec/usec

DpTimeCheck: act sleep = 250 msec

  • DP LOOP ***********

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548497/671000 0/0 sec/usec

secs 1209548497, active req_info's 0x0/0x0/

DpGetSchedule: found slot 6 (type/tid/mode DPT_AUTOTH/-1/255)

next 1209548497/671000, 0 in queue, autothtime 60

DpSetNextSchedule: next schedule for slot 6: 1209548557/671000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548517/375000

activate auto th

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 126)

DpGetSchedule: next schedule 1209548517/375000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548517/375000 19/704000 sec/usec

DpTimeCheck: act sleep = 19704 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 1 request(s) in DIA queue ===>>

W0 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 126

-IN-- req_info SET_SYSTEM_USER DP_AUTO_TH

DpRqNormalHandle: set SYSTEM_USER T0 U1 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNormalHandle: new state of W0 is WP_RUN

DpRqNormalHandle: new state of T0/M0 = 0x42

DpRqNormalHandle: give rq_id 126 to W0 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548517/375000 19/704000 sec/usec

DpTimeCheck: act sleep = 19704 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_DP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 127

info for DIA: wait/run/hold/killed = 6/0/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_WAIT

REL WP ca_blk 40

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548517/375000 19/704000 sec/usec

DpTimeCheck: act sleep = 19704 msec

  • DP LOOP ***********

Wed Apr 30 15:11:38 2008

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1138

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 1 request(s) in DIA queue ===>>

W0 is free

-IN-- sender_id IC_MAN tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 0 len -1 rq_id 128

-IN-- req_info LOGIN DP_ICM_EVENT

-IN-- mpi rq <11> mpi resp <12> prot 1 obj fd -1 rq_id 0

-IN-- icm_opcode: ICM_PLUGIN_REQUEST

DpITmSlotClear: clear slot 14

DpListRemove: remove elem 14 from tmadm_free_list

DpListRemove: 187 elems in tmadm_free_list

DpListInsert: insert elem 14 into tmadm_inuse_list (at begin)

DpListInsert: 14 elems in tmadm_inuse_list

new terminal T14/U21, type=202, state=TM_CONNECTED

DpRqLoginHandle: resource check for T14 activated (resource=HTTP)

DpRqLoginHandle: set terminal name of external plugin to > 10.100.15.47<

DpRqNormalHandle: DpRqCheck o.k.

DpIncrCheckedResourcesCnt: intCnt/extCnt=1/1 (resource=HTTP)

MPI<12>2#4 WriteOOB 00000000 06000000 0E000000 00

DpRqNormalHandle: ICM request dispatched to W0 (14/21/0)

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNormalHandle: new state of W0 is WP_RUN

DpRqNormalHandle: new state of T14/M0 = 0x82

DpRqNormalHandle: give rq_id 128 to W0 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548517/375000 18/454000 sec/usec

DpTimeCheck: act sleep = 18454 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 14 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_DP uid 21 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 129

-IN-- req_info LOGOFF

info for DIA: wait/run/hold/killed = 6/0/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_WAIT

DpDecrCheckedResourcesCnt: intCnt/extCnt=0/0 (resource=HTTP)

DpGetSchedule: next schedule 1209548517/375000

DpGetSchedule: no schedule found

DpRqNoWpHandle: set dp_tm_adm of T14 to DP_SLOT_FREE

DpGetSchedule: next schedule 1209548517/375000

DpGetSchedule: no schedule found

DpITmSlotRelease: release slot 14

DpListInsert: insert elem 14 into tmadm_free_list (at begin)

DpListInsert: 188 elems in tmadm_free_list

DpListRemove: remove elem 14 from tmadm_inuse_list

DpListRemove: 13 elems in tmadm_inuse_list

REL WP ca_blk 40

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548517/375000 18/454000 sec/usec

DpTimeCheck: act sleep = 18454 msec

  • DP LOOP ***********

Wed Apr 30 15:11:57 2008

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548517/375000 (in the past)

secs 1209548517, active req_info's 0x0/0x0/

DpGetSchedule: found slot 3 (type/tid/mode DPT_RESTART_ALL/-1/255)

DpTimeCheck: reschedule DPT_RESTART_ALL in 300 seconds

DpSetNextSchedule: next schedule for slot 3: 1209548817/390000 (300/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548517/390000

DpRestartWps: activating:

DpGetSchedule: found slot 5 (type/tid/mode DPT_AUTOABAP/-1/255)

next 1209548517/390000, 0 in queue, autoabaptime 300

DpSetNextSchedule: next schedule for slot 5: 1209548817/390000 (300/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548517/406000

activate auto abap

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 130)

DpGetSchedule: next schedule 1209548517/406000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548517/406000 0/16000 sec/usec

DpTimeCheck: act sleep = 16 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 1 request(s) in DIA queue ===>>

W0 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 130

-IN-- req_info SET_SYSTEM_USER DP_AUTO_ABAP

DpRqNormalHandle: set SYSTEM_USER T0 U1 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNormalHandle: new state of W0 is WP_RUN

DpRqNormalHandle: new state of T0/M0 = 0x42

DpRqNormalHandle: give rq_id 130 to W0 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548517/406000 0/16000 sec/usec

DpTimeCheck: act sleep = 16 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action WAKE_UP_WPS uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 8 rq_id 131

DpWakeUpWps: wake up all wp's

REL WP ca_blk 40

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 41 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548517/406000 0/16000 sec/usec

DpTimeCheck: act sleep = 16 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 41 wp_id 0

-IN-- action SEND_MSG_ADMIN uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 0 len 140 rq_id 132

-IN-- req_info DP_APPL_SERV_INFO

info for DIA: wait/run/hold/killed = 5/0/1/0 wps

DpRqNoWpHandle: new state of W0 is WP_HOLD

msgkey: 0 1 0 => 0000000100000002

DpRqNoWpHandle: wait for MS

NiIWrite: hdl 3 sent data (wrt=250,pac=1,MESG_IO)

MsINiWrite: sent 250 bytes

send msg (len 110+140) to name -, type 0, key 0000000100000002

REL WP ca_blk 41

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548517/406000 0/16000 sec/usec

DpTimeCheck: act sleep = 16 msec

  • DP LOOP ***********

NiIRead: hdl 3 received data (rcd=562,pac=1,MESG_IO)

NiSelISelectInt: 1 handles selected (1 buffered)

MsINiRead: received 562 bytes

MSG received, len 110+452, flag 4, from inmucoprhd01_TRN_00 , typ 0, key 0000000100000002

admin-answer from ms-layer

msgkey: 0000000100000002 => 0 1 0

DpMsgProcess: reset wait for MS

reset SET_SYSTEM_USER flag

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

LOCK WP ca_blk 0

copy data to wp_ca_blk 0

make DISP owner of wp_ca_blk 0

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 133)

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid 0 wp_ca_blk 0 wp_id -1

-IN-- action SEND_MSG_ADMIN uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 460 rq_id 133

-IN-- req_info DP_ADMIN

DpRqNoWpHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_RUN

DpRqNoWpHandle: new state of T0/M0 = 0x42

DpRqNoWpHandle: give rq_id 133 to W0 ...

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 0 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548517/406000 0/16000 sec/usec

DpTimeCheck: act sleep = 16 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 0 wp_id 0

-IN-- action SEND_MSG_ADMIN uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 0 len 348 rq_id 134

-IN-- req_info DP_APPL_SERV_INFO

info for DIA: wait/run/hold/killed = 5/0/1/0 wps

DpRqNoWpHandle: new state of W0 is WP_HOLD

msgkey: 0 1 0 => 0000000100000003

DpRqNoWpHandle: wait for MS

NiIWrite: hdl 3 sent data (wrt=458,pac=1,MESG_IO)

MsINiWrite: sent 458 bytes

send msg (len 110+348) to name -, type 0, key 0000000100000003

REL WP ca_blk 0

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548517/406000 0/0 sec/usec

secs 1209548517, active req_info's 0xA000/0x0/

DpGetSchedule: found slot 7 (type/tid/mode DPT_CALL_DELAYED/-1/255)

next 1209548517/406000, 0 in queue, call delayed freq 60

DpSetNextSchedule: next schedule for slot 7: 1209548577/406000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548517/406000

activate delayed function processing

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 135)

DpGetSchedule: found slot 8 (type/tid/mode DPT_SPOOLALRM/-1/255)

next 1209548517/406000, 0 in queue, spoolalrm 60

DpSetNextSchedule: next schedule for slot 8: 1209548577/406000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548517/406000

activate spool alarm

DpRqPutIntoQueue: put request into queue (reqtype 5, prio LOW, rq_id 136)

wake_evt_udp_now 1, no dgram needed

DpGetSchedule: found slot 2 (type/tid/mode DPT_BTCSCHED/-1/255)

next 1209548517/406000, 0 in queue, btctime 60

DpSetNextSchedule: next schedule for slot 2: 1209548577/406000 (60/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548517/421000

activate btc-scheduler

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 137)

wake_evt_udp_now 1, no dgram needed

DpGetSchedule: next schedule 1209548517/421000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548517/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiIRead: hdl 3 received data (rcd=1082,pac=1,MESG_IO)

NiSelISelectInt: 2 handles selected (1 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

MsINiRead: received 1082 bytes

MSG received, len 110+972, flag 4, from inmucoprhd01_TRN_00 , typ 0, key 0000000100000003

admin-answer from ms-layer

msgkey: 0000000100000003 => 0 1 0

DpMsgProcess: reset wait for MS

reset SET_SYSTEM_USER flag

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

LOCK WP ca_blk 0

copy data to wp_ca_blk 0

make DISP owner of wp_ca_blk 0

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 138)

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid 0 wp_ca_blk 0 wp_id -1

-IN-- action SEND_MSG_ADMIN uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 980 rq_id 138

-IN-- req_info DP_ADMIN

DpRqNoWpHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_RUN

DpRqNoWpHandle: new state of T0/M0 = 0x42

DpRqNoWpHandle: give rq_id 138 to W0 ...

DpRqServiceQueue: 2 request(s) in DIA queue ===>>

W1 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 135

-IN-- req_info THDP_ADM SET_SYSTEM_USER

-IN-- thdp_adm_req_info CALL_DELAYED

DpRqNormalHandle: set SYSTEM_USER T1 U2 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 4/2/0/0 wps

DpRqNormalHandle: new state of W1 is WP_RUN

DpRqNormalHandle: new state of T1/M0 = 0x42

DpRqNormalHandle: give rq_id 135 to W1 ...

W2 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 137

-IN-- req_info BTC_SCHEDULER SET_SYSTEM_USER

DpRqNormalHandle: set SYSTEM_USER T2 U3 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 3/3/0/0 wps

DpRqNormalHandle: new state of W2 is WP_RUN

DpRqNormalHandle: new state of T2/M0 = 0x42

DpRqNormalHandle: give rq_id 137 to W2 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 1 request(s) in SPO queue ===>>

W11 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk -1 wp_id -1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type SPO

-IN-- new_stat NO_CHANGE mode 255 len -1 rq_id 136

-IN-- req_info SET_SYSTEM_USER DP_SPOOL_ALRM

DpRqNormalHandle: set SYSTEM_USER T11 U12 M0

DpRqNormalHandle: DpRqCheck o.k.

info for SPO: wait/run/hold/killed = 0/1/0/0 wps

DpRqNormalHandle: new state of W11 is WP_RUN

DpRqNormalHandle: new state of T11/M0 = 0x42

DpRqNormalHandle: give rq_id 136 to W11 ...

DpRqNormalHandle: set dp_spoolwp_with_token = W11

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 0 WORK_PROCESS 4116

WP blk 60 WORK_PROCESS 4124

WP blk 80 WORK_PROCESS 4132

WP blk 260 WORK_PROCESS 4216

APPC blk 12 WORK_PROCESS 4116

APPC blk 18 WORK_PROCESS 4124

APPC blk 24 WORK_PROCESS 4132

APPC blk 78 WORK_PROCESS 4216

DpGetScheduleInfo: next_schedule: 1209548517/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 0 wp_id 0

-IN-- action SEND_MSG_REQUES uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 0 len 76 rq_id 139

-IN-- forward NOWP

-IN-- req_info DP_APPL_SERV_INFO

info for DIA: wait/run/hold/killed = 3/2/1/0 wps

DpRqNoWpHandle: new state of W0 is WP_HOLD

msgkey: 0 1 0 => 0000000100000004

DpRqNoWpHandle: waiting for MS

NiIWrite: hdl 3 sent data (wrt=178,pac=1,MESG_IO)

MsINiWrite: sent 178 bytes

send msg (len 110+68) to name MSG_SERVER , type 0, key 0000000100000004

REL WP ca_blk 0

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 80 WORK_PROCESS 4132

WP blk 260 WORK_PROCESS 4216

APPC blk 12 WORK_PROCESS 4116

APPC blk 24 WORK_PROCESS 4132

APPC blk 78 WORK_PROCESS 4216

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548517/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1132

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 1 wp_ca_blk 60 wp_id 1

-IN-- action SEND_TO_DP uid 2 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 140

info for DIA: wait/run/hold/killed = 4/1/1/0 wps

DpRqNoWpHandle: new state of W1 is WP_WAIT

REL WP ca_blk 60

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 80 WORK_PROCESS 4132

WP blk 260 WORK_PROCESS 4216

APPC blk 12 WORK_PROCESS 4116

APPC blk 24 WORK_PROCESS 4132

APPC blk 78 WORK_PROCESS 4216

DpGetScheduleInfo: next_schedule: 1209548517/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiIRead: hdl 3 received data (rcd=114,pac=1,MESG_IO)

NiSelISelectInt: 1 handles selected (1 buffered)

MsINiRead: received 114 bytes

MSG received, len 110+4, flag 3, from MSG_SERVER , typ 0, key 0000000100000004

opcode : MS_SET_PROPERTY

retcode : MSOP_OK

version : 1

charset : 3

msg-answer from ms-layer

msgkey: 0000000100000004 => 0 1 0

DpMsgProcess: reset wait for MS

reset SET_SYSTEM_USER flag

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

LOCK WP ca_blk 0

copy data to wp_ca_blk 0

make DISP owner of wp_ca_blk 0

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 141)

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid 0 wp_ca_blk 0 wp_id -1

-IN-- action SEND_TO_WP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 12 rq_id 141

DpRqNoWpHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 4/2/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_RUN

DpRqNoWpHandle: new state of T0/M0 = 0x42

DpRqNoWpHandle: give rq_id 141 to W0 ...

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 0 WORK_PROCESS 4116

WP blk 80 WORK_PROCESS 4132

WP blk 260 WORK_PROCESS 4216

APPC blk 12 WORK_PROCESS 4116

APPC blk 24 WORK_PROCESS 4132

APPC blk 78 WORK_PROCESS 4216

DpGetScheduleInfo: next_schedule: 1209548517/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 0 wp_id 0

-IN-- action SEND_MSG_ADMIN uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 0 len 244 rq_id 142

-IN-- req_info DP_APPL_SERV_INFO

info for DIA: wait/run/hold/killed = 4/1/1/0 wps

DpRqNoWpHandle: new state of W0 is WP_HOLD

msgkey: 0 1 0 => 0000000100000005

DpRqNoWpHandle: wait for MS

NiIWrite: hdl 3 sent data (wrt=354,pac=1,MESG_IO)

MsINiWrite: sent 354 bytes

send msg (len 110+244) to name -, type 0, key 0000000100000005

REL WP ca_blk 0

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 80 WORK_PROCESS 4132

APPC blk 12 WORK_PROCESS 4116

APPC blk 24 WORK_PROCESS 4132

APPC blk 78 WORK_PROCESS 4216

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548517/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1134

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 11 wp_ca_blk 260 wp_id 11

-IN-- action SEND_TO_DP uid 12 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 8 rq_id 143

DpRqNoWpHandle: set dp_spoolwp_with_token = NO_WP

REL WP ca_blk 260

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 80 WORK_PROCESS 4132

WP blk 261 WORK_PROCESS 4216

APPC blk 12 WORK_PROCESS 4116

APPC blk 24 WORK_PROCESS 4132

APPC blk 78 WORK_PROCESS 4216

DpGetScheduleInfo: next_schedule: 1209548517/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiIRead: hdl 3 received data (rcd=354,pac=1,MESG_IO)

NiSelISelectInt: 1 handles selected (1 buffered)

MsINiRead: received 354 bytes

MSG received, len 110+244, flag 4, from inmucoprhd01_TRN_00 , typ 0, key 0000000100000005

admin-answer from ms-layer

msgkey: 0000000100000005 => 0 1 0

DpMsgProcess: reset wait for MS

reset SET_SYSTEM_USER flag

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

LOCK WP ca_blk 0

copy data to wp_ca_blk 0

make DISP owner of wp_ca_blk 0

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 144)

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid 0 wp_ca_blk 0 wp_id -1

-IN-- action SEND_MSG_ADMIN uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 252 rq_id 144

-IN-- req_info DP_ADMIN

DpRqNoWpHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 4/2/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_RUN

DpRqNoWpHandle: new state of T0/M0 = 0x42

DpRqNoWpHandle: give rq_id 144 to W0 ...

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 0 WORK_PROCESS 4116

WP blk 80 WORK_PROCESS 4132

APPC blk 12 WORK_PROCESS 4116

APPC blk 24 WORK_PROCESS 4132

APPC blk 78 WORK_PROCESS 4216

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548517/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1134

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 11 wp_ca_blk 261 wp_id 11

-IN-- action SEND_TO_DP uid 12 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 145

info for SPO: wait/run/hold/killed = 1/0/0/0 wps

DpRqNoWpHandle: new state of W11 is WP_WAIT

REL WP ca_blk 261

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 0 WORK_PROCESS 4116

WP blk 80 WORK_PROCESS 4132

APPC blk 12 WORK_PROCESS 4116

APPC blk 24 WORK_PROCESS 4132

DpGetScheduleInfo: next_schedule: 1209548517/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 0 wp_id 0

-IN-- action SEND_MSG_ADMIN uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 0 len 452 rq_id 146

-IN-- req_info DP_APPL_SERV_INFO

info for DIA: wait/run/hold/killed = 4/1/1/0 wps

DpRqNoWpHandle: new state of W0 is WP_HOLD

msgkey: 0 1 0 => 0000000100000006

DpRqNoWpHandle: wait for MS

NiIWrite: hdl 3 sent data (wrt=562,pac=1,MESG_IO)

MsINiWrite: sent 562 bytes

send msg (len 110+452) to name -, type 0, key 0000000100000006

REL WP ca_blk 0

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 80 WORK_PROCESS 4132

APPC blk 12 WORK_PROCESS 4116

APPC blk 24 WORK_PROCESS 4132

DpGetScheduleInfo: next_schedule: 1209548517/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiIRead: hdl 3 received data (rcd=562,pac=1,MESG_IO)

NiSelISelectInt: 1 handles selected (1 buffered)

MsINiRead: received 562 bytes

MSG received, len 110+452, flag 4, from inmucoprhd01_TRN_00 , typ 0, key 0000000100000006

admin-answer from ms-layer

msgkey: 0000000100000006 => 0 1 0

DpMsgProcess: reset wait for MS

reset SET_SYSTEM_USER flag

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

LOCK WP ca_blk 0

copy data to wp_ca_blk 0

make DISP owner of wp_ca_blk 0

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 147)

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid 0 wp_ca_blk 0 wp_id -1

-IN-- action SEND_MSG_ADMIN uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 460 rq_id 147

-IN-- req_info DP_ADMIN

DpRqNoWpHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 4/2/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_RUN

DpRqNoWpHandle: new state of T0/M0 = 0x42

DpRqNoWpHandle: give rq_id 147 to W0 ...

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 0 WORK_PROCESS 4116

WP blk 80 WORK_PROCESS 4132

APPC blk 12 WORK_PROCESS 4116

APPC blk 24 WORK_PROCESS 4132

DpGetScheduleInfo: next_schedule: 1209548517/421000 0/15000 sec/usec

DpTimeCheck: act sleep = 15 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1133

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 2 wp_ca_blk 80 wp_id 2

-IN-- action SEND_TO_DP uid 3 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 148

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W2 is WP_WAIT

REL WP ca_blk 80

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 0 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548517/421000 0/0 sec/usec

secs 1209548517, active req_info's 0xA000/0x0/

DpGetSchedule: found slot 4 (type/tid/mode DPT_ENVCHECK/-1/255)

DpSetNextSchedule: next schedule for slot 4: 1209548537/421000 (20/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548537/421000

call DpEnvCheck

[DpWpDied] W0 lives (PID:4116 HANDLE:412)

[DpWpDied] W1 lives (PID:4124 HANDLE:404)

[DpWpDied] W2 lives (PID:4132 HANDLE:400)

[DpWpDied] W3 lives (PID:4140 HANDLE:396)

[DpWpDied] W4 lives (PID:4148 HANDLE:392)

[DpWpDied] W5 lives (PID:4156 HANDLE:388)

[DpWpDied] W6 lives (PID:4164 HANDLE:384)

[DpWpDied] W7 lives (PID:4172 HANDLE:380)

[DpWpDied] W8 lives (PID:4180 HANDLE:376)

[DpWpDied] W9 lives (PID:4188 HANDLE:372)

[DpWpDied] W10 lives (PID:4204 HANDLE:368)

[DpWpDied] W11 lives (PID:4216 HANDLE:364)

[DpWpDied] W12 lives (PID:4228 HANDLE:360)

DpVmCheck: vmc not active

DpGwCheck: 0

[DpProcDied] Process lives (PID:3840 HANDLE:424)

DpGwCheck: ok

[DpProcDied] Process lives (PID:4100 HANDLE:432)

DpCheckTimeTab: check time table

DpGetSchedule: next schedule 1209548537/421000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548537/421000 20/0 sec/usec

DpTimeCheck: act sleep = 20000 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 0 wp_id 0

-IN-- action SEND_MSG_ONEWAY uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 5008 rq_id 149

-IN-- forward DIA

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH

DpRqNoWpHandle: short-cut, I am sender and receiver

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 0

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 149)

DpRqServiceQueue: 1 request(s) in DIA queue ===>>

W1 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk 0 wp_id 0

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len 5008 rq_id 149

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER

DpRqNormalHandle: set SYSTEM_USER T1 U2 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 4/2/0/0 wps

DpRqNormalHandle: new state of W1 is WP_RUN

DpRqNormalHandle: new state of T1/M0 = 0x42

DpRqNormalHandle: give rq_id 149 to W1 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

APPC blk 18 WORK_PROCESS 4124

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 19/468000 sec/usec

DpTimeCheck: act sleep = 19468 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 0 WORK_PROCESS 4124

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

APPC blk 18 WORK_PROCESS 4124

DpGetScheduleInfo: next_schedule: 1209548537/421000 19/468000 sec/usec

DpTimeCheck: act sleep = 19468 msec

  • DP LOOP ***********

Wed Apr 30 15:11:58 2008

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1132

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 1 wp_ca_blk 0 wp_id 1

-IN-- action SEND_MSG_ONEWAY uid 2 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 5008 rq_id 150

-IN-- forward BTC

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH

DpRqNoWpHandle: short-cut, I am sender and receiver

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 0

DpRqPutIntoQueue: put request into queue (reqtype 4, prio LOW, rq_id 150)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 1 request(s) in BTC queue ===>>

W8 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk 0 wp_id 1

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type BTC

-IN-- new_stat NO_CHANGE mode 255 len 5008 rq_id 150

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER

DpRqNormalHandle: set SYSTEM_USER T8 U9 M0

DpRqNormalHandle: DpRqCheck o.k.

info for BTC: wait/run/hold/killed = 2/1/0/0 wps

DpRqNormalHandle: new state of W8 is WP_RUN

DpRqNormalHandle: new state of T8/M0 = 0x42

DpRqNormalHandle: give rq_id 150 to W8 ...

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

WP blk 60 WORK_PROCESS 4124

APPC blk 12 WORK_PROCESS 4116

APPC blk 18 WORK_PROCESS 4124

APPC blk 60 WORK_PROCESS 4180

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 19/390000 sec/usec

DpTimeCheck: act sleep = 19390 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 0 WORK_PROCESS 4180

WP blk 40 WORK_PROCESS 4116

WP blk 60 WORK_PROCESS 4124

APPC blk 12 WORK_PROCESS 4116

APPC blk 18 WORK_PROCESS 4124

APPC blk 60 WORK_PROCESS 4180

DpGetScheduleInfo: next_schedule: 1209548537/421000 19/390000 sec/usec

DpTimeCheck: act sleep = 19390 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1135

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 8 wp_ca_blk 0 wp_id 8

-IN-- action SEND_MSG_ONEWAY uid 9 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 5008 rq_id 151

-IN-- forward DIA

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH

DpRqNoWpHandle: short-cut, I am sender and receiver

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 0

DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 151)

DpRqServiceQueue: 1 request(s) in DIA queue ===>>

W2 is free

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk 0 wp_id 8

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

-IN-- new_stat NO_CHANGE mode 255 len 5008 rq_id 151

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER

DpRqNormalHandle: set SYSTEM_USER T2 U3 M0

DpRqNormalHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 3/3/0/0 wps

DpRqNormalHandle: new state of W2 is WP_RUN

DpRqNormalHandle: new state of T2/M0 = 0x42

DpRqNormalHandle: give rq_id 151 to W2 ...

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 0 WORK_PROCESS 4132

WP blk 40 WORK_PROCESS 4116

WP blk 60 WORK_PROCESS 4124

WP blk 200 WORK_PROCESS 4180

APPC blk 12 WORK_PROCESS 4116

APPC blk 18 WORK_PROCESS 4124

APPC blk 24 WORK_PROCESS 4132

APPC blk 60 WORK_PROCESS 4180

DpGetScheduleInfo: next_schedule: 1209548537/421000 19/343000 sec/usec

DpTimeCheck: act sleep = 19343 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 0 WORK_PROCESS 4132

WP blk 40 WORK_PROCESS 4116

WP blk 60 WORK_PROCESS 4124

WP blk 200 WORK_PROCESS 4180

APPC blk 12 WORK_PROCESS 4116

APPC blk 18 WORK_PROCESS 4124

APPC blk 24 WORK_PROCESS 4132

APPC blk 60 WORK_PROCESS 4180

DpGetScheduleInfo: next_schedule: 1209548537/421000 19/343000 sec/usec

DpTimeCheck: act sleep = 19343 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1135

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 8 wp_ca_blk 200 wp_id 8

-IN-- action SEND_TO_DP uid 9 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 152

info for BTC: wait/run/hold/killed = 3/0/0/0 wps

DpRqNoWpHandle: new state of W8 is WP_WAIT

REL WP ca_blk 200

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 0 WORK_PROCESS 4132

WP blk 40 WORK_PROCESS 4116

WP blk 60 WORK_PROCESS 4124

APPC blk 12 WORK_PROCESS 4116

APPC blk 18 WORK_PROCESS 4124

APPC blk 24 WORK_PROCESS 4132

DpGetScheduleInfo: next_schedule: 1209548537/421000 19/343000 sec/usec

DpTimeCheck: act sleep = 19343 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1133

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 2 wp_ca_blk 0 wp_id 2

-IN-- action SEND_TO_DP uid 3 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 153

info for DIA: wait/run/hold/killed = 4/2/0/0 wps

DpRqNoWpHandle: new state of W2 is WP_WAIT

REL WP ca_blk 0

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

WP blk 60 WORK_PROCESS 4124

APPC blk 12 WORK_PROCESS 4116

APPC blk 18 WORK_PROCESS 4124

DpGetScheduleInfo: next_schedule: 1209548537/421000 19/328000 sec/usec

DpTimeCheck: act sleep = 19328 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1132

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 1 wp_ca_blk 60 wp_id 1

-IN-- action SEND_TO_DP uid 2 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 154

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W1 is WP_WAIT

REL WP ca_blk 60

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548537/421000 18/921000 sec/usec

DpTimeCheck: act sleep = 18921 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REQUES uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 0 len 356 rq_id 155

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH DP_APPL_SERV_INFO

info for DIA: wait/run/hold/killed = 5/0/1/0 wps

DpRqNoWpHandle: new state of W0 is WP_HOLD

msgkey: 0 1 0 => 0000000100000008

DpRqNoWpHandle: waiting for MS

DpRqNoWpHandle: short-cut, I am sender and receiver

DpRqNoWpHandle: reset wait for MS

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 155)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 18/562000 sec/usec

DpTimeCheck: act sleep = 18562 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 255 len 356 rq_id 155

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER DP_APPL_SERV_INFO

ADM-request received

eyec AD-EYECATCH vers 1 type AD_REQUEST rec_size 104 rec_no 3

R# Op S# Ex Er | Data

-


+------

0 60 0 0 0 |

1 2 0 0 0 |

2 21 0 0 0 |

AdCvtRecToInt: opcode 60 (AD_SELFIDENT), ser 0, ex 0, errno 0

AD_SELFIDENT: >000SAPSYS RSDS_BP_CLSSAWP <

AdCvtRecToInt: opcode 2 (AD_WPSTAT), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 0, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 1, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 2, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 3, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 4, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 5, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 6, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 7, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 8, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 9, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 10, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 11, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 12, ex 1, errno 0

AdCvtRecToInt: opcode 21 (AD_RZL_STRG), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 21 (AD_RZL_STRG), ser 0, ex 1, errno 4

eyec AD-EYECATCH vers 1 type AD_REPLY rec_size 104 rec_no 15

R# Op S# Ex Er | Data

-


+------

0 60 0 1 0 |

1 2 0 1 0 |

2 2 1 1 0 |

3 2 2 1 0 |

4 2 3 1 0 |

5 2 4 1 0 |

ADM-reply created

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 155)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 18/562000 sec/usec

DpTimeCheck: act sleep = 18562 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REPLY uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 255 len 1604 rq_id 155

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER

DpRqNoWpHandle: short-cut, I am sender and receiver

msgkey: 0000000100000008 => 0 1 0

DpRqNoWpHandle: reset SET_SYSTEM_USER flag

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 155)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 18/562000 sec/usec

DpTimeCheck: act sleep = 18562 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 1604 rq_id 155

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH

DpRqNoWpHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_RUN

DpRqNoWpHandle: new state of T0/M0 = 0x42

DpRqNoWpHandle: give rq_id 155 to W0 ...

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548537/421000 18/562000 sec/usec

DpTimeCheck: act sleep = 18562 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REQUES uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 0 len 356 rq_id 156

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH DP_APPL_SERV_INFO

info for DIA: wait/run/hold/killed = 5/0/1/0 wps

DpRqNoWpHandle: new state of W0 is WP_HOLD

msgkey: 0 1 0 => 0000000100000009

DpRqNoWpHandle: waiting for MS

DpRqNoWpHandle: short-cut, I am sender and receiver

DpRqNoWpHandle: reset wait for MS

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 156)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 18/500000 sec/usec

DpTimeCheck: act sleep = 18500 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 255 len 356 rq_id 156

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER DP_APPL_SERV_INFO

ADM-request received

eyec AD-EYECATCH vers 1 type AD_REQUEST rec_size 104 rec_no 3

R# Op S# Ex Er | Data

-


+------

0 60 0 0 0 |

1 2 0 0 0 |

2 21 0 0 0 |

AdCvtRecToInt: opcode 60 (AD_SELFIDENT), ser 0, ex 0, errno 0

AD_SELFIDENT: >000SAPSYS RSDS_BP_FREEWP <

AdCvtRecToInt: opcode 2 (AD_WPSTAT), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 0, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 1, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 2, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 3, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 4, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 5, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 6, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 7, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 8, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 9, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 10, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 11, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 12, ex 1, errno 0

AdCvtRecToInt: opcode 21 (AD_RZL_STRG), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 21 (AD_RZL_STRG), ser 0, ex 1, errno 4

eyec AD-EYECATCH vers 1 type AD_REPLY rec_size 104 rec_no 15

R# Op S# Ex Er | Data

-


+------

0 60 0 1 0 |

1 2 0 1 0 |

2 2 1 1 0 |

3 2 2 1 0 |

4 2 3 1 0 |

5 2 4 1 0 |

ADM-reply created

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 156)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 18/500000 sec/usec

DpTimeCheck: act sleep = 18500 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REPLY uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 255 len 1604 rq_id 156

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER

DpRqNoWpHandle: short-cut, I am sender and receiver

msgkey: 0000000100000009 => 0 1 0

DpRqNoWpHandle: reset SET_SYSTEM_USER flag

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 156)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 18/500000 sec/usec

DpTimeCheck: act sleep = 18500 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 1604 rq_id 156

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH

DpRqNoWpHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_RUN

DpRqNoWpHandle: new state of T0/M0 = 0x42

DpRqNoWpHandle: give rq_id 156 to W0 ...

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548537/421000 18/500000 sec/usec

DpTimeCheck: act sleep = 18500 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REQUES uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 0 len 356 rq_id 157

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH DP_APPL_SERV_INFO

info for DIA: wait/run/hold/killed = 5/0/1/0 wps

DpRqNoWpHandle: new state of W0 is WP_HOLD

msgkey: 0 1 0 => 000000010000000A

DpRqNoWpHandle: waiting for MS

DpRqNoWpHandle: short-cut, I am sender and receiver

DpRqNoWpHandle: reset wait for MS

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 157)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 18/500000 sec/usec

DpTimeCheck: act sleep = 18500 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 255 len 356 rq_id 157

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER DP_APPL_SERV_INFO

ADM-request received

eyec AD-EYECATCH vers 1 type AD_REQUEST rec_size 104 rec_no 3

R# Op S# Ex Er | Data

-


+------

0 60 0 0 0 |

1 2 0 0 0 |

2 21 0 0 0 |

AdCvtRecToInt: opcode 60 (AD_SELFIDENT), ser 0, ex 0, errno 0

AD_SELFIDENT: >000SAPSYS RSDS_BP_TTLWP <

AdCvtRecToInt: opcode 2 (AD_WPSTAT), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 0, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 1, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 2, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 3, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 4, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 5, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 6, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 7, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 8, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 9, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 10, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 11, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 12, ex 1, errno 0

AdCvtRecToInt: opcode 21 (AD_RZL_STRG), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 21 (AD_RZL_STRG), ser 0, ex 1, errno 4

eyec AD-EYECATCH vers 1 type AD_REPLY rec_size 104 rec_no 15

R# Op S# Ex Er | Data

-


+------

0 60 0 1 0 |

1 2 0 1 0 |

2 2 1 1 0 |

3 2 2 1 0 |

4 2 3 1 0 |

5 2 4 1 0 |

ADM-reply created

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 157)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 18/500000 sec/usec

DpTimeCheck: act sleep = 18500 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REPLY uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 255 len 1604 rq_id 157

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER

DpRqNoWpHandle: short-cut, I am sender and receiver

msgkey: 000000010000000A => 0 1 0

DpRqNoWpHandle: reset SET_SYSTEM_USER flag

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 157)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 18/500000 sec/usec

DpTimeCheck: act sleep = 18500 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 1604 rq_id 157

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH

DpRqNoWpHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_RUN

DpRqNoWpHandle: new state of T0/M0 = 0x42

DpRqNoWpHandle: give rq_id 157 to W0 ...

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548537/421000 18/500000 sec/usec

DpTimeCheck: act sleep = 18500 msec

  • DP LOOP ***********

Wed Apr 30 15:11:59 2008

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REQUES uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 0 len 1396 rq_id 158

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH DP_APPL_SERV_INFO

info for DIA: wait/run/hold/killed = 5/0/1/0 wps

DpRqNoWpHandle: new state of W0 is WP_HOLD

msgkey: 0 1 0 => 000000010000000B

DpRqNoWpHandle: waiting for MS

DpRqNoWpHandle: short-cut, I am sender and receiver

DpRqNoWpHandle: reset wait for MS

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 158)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 17/796000 sec/usec

DpTimeCheck: act sleep = 17796 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 255 len 1396 rq_id 158

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER DP_APPL_SERV_INFO

ADM-request received

eyec AD-EYECATCH vers 1 type AD_REQUEST rec_size 104 rec_no 13

R# Op S# Ex Er | Data

-


+------

0 60 0 0 0 |

1 0 0 0 0 |

2 1 0 0 0 |

3 1 0 0 0 |

4 1 0 0 0 |

5 1 0 0 0 |

AdCvtRecToInt: opcode 60 (AD_SELFIDENT), ser 0, ex 0, errno 0

AD_SELFIDENT: >000SAPSYS SAPMSSY8 <

AdCvtRecToInt: opcode 0 (AD_GENERAL), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 0 (AD_GENERAL), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 20 (AD_RZL), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 20 (AD_RZL), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 20 (AD_RZL), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 20 (AD_RZL), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 20 (AD_RZL), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 20 (AD_RZL), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 21 (AD_RZL_STRG), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 21 (AD_RZL_STRG), ser 0, ex 1, errno 4

AdCvtRecToInt: opcode 21 (AD_RZL_STRG), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 21 (AD_RZL_STRG), ser 0, ex 1, errno 4

eyec AD-EYECATCH vers 1 type AD_REPLY rec_size 104 rec_no 13

R# Op S# Ex Er | Data

-


+------

0 60 0 1 0 |

1 0 0 1 0 |

2 1 0 1 0 |

3 1 0 1 0 |

4 1 0 1 0 |

5 1 0 1 0 |

ADM-reply created

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 158)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 17/796000 sec/usec

DpTimeCheck: act sleep = 17796 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REPLY uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 255 len 1396 rq_id 158

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER

DpRqNoWpHandle: short-cut, I am sender and receiver

msgkey: 000000010000000B => 0 1 0

DpRqNoWpHandle: reset SET_SYSTEM_USER flag

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 158)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 17/796000 sec/usec

DpTimeCheck: act sleep = 17796 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 1396 rq_id 158

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH

DpRqNoWpHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_RUN

DpRqNoWpHandle: new state of T0/M0 = 0x42

DpRqNoWpHandle: give rq_id 158 to W0 ...

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548537/421000 17/796000 sec/usec

DpTimeCheck: act sleep = 17796 msec

  • DP LOOP ***********

Wed Apr 30 15:12:00 2008

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REQUES uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 0 len 252 rq_id 161

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH DP_APPL_SERV_INFO

info for DIA: wait/run/hold/killed = 5/0/1/0 wps

DpRqNoWpHandle: new state of W0 is WP_HOLD

msgkey: 0 1 0 => 000000010000000C

DpRqNoWpHandle: waiting for MS

DpRqNoWpHandle: short-cut, I am sender and receiver

DpRqNoWpHandle: reset wait for MS

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 161)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 6 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 16/500000 sec/usec

DpTimeCheck: act sleep = 16500 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 255 len 252 rq_id 161

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER DP_APPL_SERV_INFO

ADM-request received

eyec AD-EYECATCH vers 1 type AD_REQUEST rec_size 104 rec_no 2

R# Op S# Ex Er | Data

-


+------

0 60 0 0 0 |

1 2 0 0 0 |

AdCvtRecToInt: opcode 60 (AD_SELFIDENT), ser 0, ex 0, errno 0

AD_SELFIDENT: >000SAPSYS SAPMSSY8 <

AdCvtRecToInt: opcode 2 (AD_WPSTAT), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 0, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 1, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 2, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 3, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 4, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 5, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 6, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 7, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 8, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 9, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 10, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 11, ex 1, errno 0

AdCvtRecToExt: opcode 2 (AD_WPSTAT), ser 12, ex 1, errno 0

eyec AD-EYECATCH vers 1 type AD_REPLY rec_size 104 rec_no 14

R# Op S# Ex Er | Data

-


+------

0 60 0 1 0 |

1 2 0 1 0 |

2 2 1 1 0 |

3 2 2 1 0 |

4 2 3 1 0 |

5 2 4 1 0 |

ADM-reply created

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 161)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 6 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 16/500000 sec/usec

DpTimeCheck: act sleep = 16500 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REPLY uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 255 len 1500 rq_id 161

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER

DpRqNoWpHandle: short-cut, I am sender and receiver

msgkey: 000000010000000C => 0 1 0

DpRqNoWpHandle: reset SET_SYSTEM_USER flag

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 161)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 6 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 16/500000 sec/usec

DpTimeCheck: act sleep = 16500 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 1500 rq_id 161

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH

DpRqNoWpHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_RUN

DpRqNoWpHandle: new state of T0/M0 = 0x42

DpRqNoWpHandle: give rq_id 161 to W0 ...

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 6 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548537/421000 16/500000 sec/usec

DpTimeCheck: act sleep = 16500 msec

  • DP LOOP ***********

Wed Apr 30 15:12:03 2008

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REQUES uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 0 len 1396 rq_id 162

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH DP_APPL_SERV_INFO

info for DIA: wait/run/hold/killed = 5/0/1/0 wps

DpRqNoWpHandle: new state of W0 is WP_HOLD

msgkey: 0 1 0 => 000000010000000D

DpRqNoWpHandle: waiting for MS

DpRqNoWpHandle: short-cut, I am sender and receiver

DpRqNoWpHandle: reset wait for MS

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 162)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 6 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 13/703000 sec/usec

DpTimeCheck: act sleep = 13703 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 255 len 1396 rq_id 162

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER DP_APPL_SERV_INFO

ADM-request received

eyec AD-EYECATCH vers 1 type AD_REQUEST rec_size 104 rec_no 13

R# Op S# Ex Er | Data

-


+------

0 60 0 0 0 |

1 0 0 0 0 |

2 1 0 0 0 |

3 1 0 0 0 |

4 1 0 0 0 |

5 1 0 0 0 |

AdCvtRecToInt: opcode 60 (AD_SELFIDENT), ser 0, ex 0, errno 0

AD_SELFIDENT: >000SAPSYS <

AdCvtRecToInt: opcode 0 (AD_GENERAL), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 0 (AD_GENERAL), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 20 (AD_RZL), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 20 (AD_RZL), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 20 (AD_RZL), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 20 (AD_RZL), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 20 (AD_RZL), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 20 (AD_RZL), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 21 (AD_RZL_STRG), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 21 (AD_RZL_STRG), ser 0, ex 1, errno 4

AdCvtRecToInt: opcode 21 (AD_RZL_STRG), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 21 (AD_RZL_STRG), ser 0, ex 1, errno 4

eyec AD-EYECATCH vers 1 type AD_REPLY rec_size 104 rec_no 13

R# Op S# Ex Er | Data

-


+------

0 60 0 1 0 |

1 0 0 1 0 |

2 1 0 1 0 |

3 1 0 1 0 |

4 1 0 1 0 |

5 1 0 1 0 |

ADM-reply created

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 162)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 6 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 13/703000 sec/usec

DpTimeCheck: act sleep = 13703 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REPLY uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 255 len 1396 rq_id 162

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER

DpRqNoWpHandle: short-cut, I am sender and receiver

msgkey: 000000010000000D => 0 1 0

DpRqNoWpHandle: reset SET_SYSTEM_USER flag

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 162)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 6 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 13/703000 sec/usec

DpTimeCheck: act sleep = 13703 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 1396 rq_id 162

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH

DpRqNoWpHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_RUN

DpRqNoWpHandle: new state of T0/M0 = 0x42

DpRqNoWpHandle: give rq_id 162 to W0 ...

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 6 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548537/421000 13/703000 sec/usec

DpTimeCheck: act sleep = 13703 msec

  • DP LOOP ***********

Wed Apr 30 15:12:11 2008

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REQUES uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 0 len 252 rq_id 164

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH DP_APPL_SERV_INFO

info for DIA: wait/run/hold/killed = 5/0/1/0 wps

DpRqNoWpHandle: new state of W0 is WP_HOLD

msgkey: 0 1 0 => 000000010000000E

DpRqNoWpHandle: waiting for MS

DpRqNoWpHandle: short-cut, I am sender and receiver

DpRqNoWpHandle: reset wait for MS

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 164)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 5/468000 sec/usec

DpTimeCheck: act sleep = 5468 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 255 len 252 rq_id 164

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER DP_APPL_SERV_INFO

ADM-request received

eyec AD-EYECATCH vers 1 type AD_REQUEST rec_size 104 rec_no 2

R# Op S# Ex Er | Data

-


+------

0 60 0 0 0 |

1 6 0 0 0 |

AdCvtRecToInt: opcode 60 (AD_SELFIDENT), ser 0, ex 0, errno 0

AD_SELFIDENT: >000SAPSYS CCUMEAS <

AdCvtRecToInt: opcode 6 (AD_USRLST), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 6 (AD_USRLST), ser 0, ex 1, errno 6

eyec AD-EYECATCH vers 1 type AD_REPLY rec_size 104 rec_no 2

R# Op S# Ex Er | Data

-


+------

0 60 0 1 0 |

1 6 0 1 6 |

ADM-reply created

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 164)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 5/468000 sec/usec

DpTimeCheck: act sleep = 5468 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REPLY uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 255 len 252 rq_id 164

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER

DpRqNoWpHandle: short-cut, I am sender and receiver

msgkey: 000000010000000E => 0 1 0

DpRqNoWpHandle: reset SET_SYSTEM_USER flag

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 164)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 5/468000 sec/usec

DpTimeCheck: act sleep = 5468 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 252 rq_id 164

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH

DpRqNoWpHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_RUN

DpRqNoWpHandle: new state of T0/M0 = 0x42

DpRqNoWpHandle: give rq_id 164 to W0 ...

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548537/421000 5/468000 sec/usec

DpTimeCheck: act sleep = 5468 msec

  • DP LOOP ***********

Wed Apr 30 15:12:12 2008

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REQUES uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 0 len 1396 rq_id 165

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH DP_APPL_SERV_INFO

info for DIA: wait/run/hold/killed = 5/0/1/0 wps

DpRqNoWpHandle: new state of W0 is WP_HOLD

msgkey: 0 1 0 => 000000010000000F

DpRqNoWpHandle: waiting for MS

DpRqNoWpHandle: short-cut, I am sender and receiver

DpRqNoWpHandle: reset wait for MS

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 165)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 5/343000 sec/usec

DpTimeCheck: act sleep = 5343 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_HOLD mode 255 len 1396 rq_id 165

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER DP_APPL_SERV_INFO

ADM-request received

eyec AD-EYECATCH vers 1 type AD_REQUEST rec_size 104 rec_no 13

R# Op S# Ex Er | Data

-


+------

0 60 0 0 0 |

1 0 0 0 0 |

2 1 0 0 0 |

3 1 0 0 0 |

4 1 0 0 0 |

5 1 0 0 0 |

AdCvtRecToInt: opcode 60 (AD_SELFIDENT), ser 0, ex 0, errno 0

AD_SELFIDENT: >000SAPSYS SAPMSSY6 <

AdCvtRecToInt: opcode 0 (AD_GENERAL), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 0 (AD_GENERAL), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 1 (AD_PROFILE), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 1 (AD_PROFILE), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 20 (AD_RZL), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 20 (AD_RZL), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 20 (AD_RZL), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 20 (AD_RZL), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 20 (AD_RZL), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 20 (AD_RZL), ser 0, ex 1, errno 0

AdCvtRecToInt: opcode 21 (AD_RZL_STRG), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 21 (AD_RZL_STRG), ser 0, ex 1, errno 4

AdCvtRecToInt: opcode 21 (AD_RZL_STRG), ser 0, ex 0, errno 0

AdCvtRecToExt: opcode 21 (AD_RZL_STRG), ser 0, ex 1, errno 4

eyec AD-EYECATCH vers 1 type AD_REPLY rec_size 104 rec_no 13

R# Op S# Ex Er | Data

-


+------

0 60 0 1 0 |

1 0 0 1 0 |

2 1 0 1 0 |

3 1 0 1 0 |

4 1 0 1 0 |

5 1 0 1 0 |

ADM-reply created

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 165)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 5/343000 sec/usec

DpTimeCheck: act sleep = 5343 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid -1 wp_ca_blk 40 wp_id 0

-IN-- action SEND_MSG_REPLY uid -1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 255 len 1396 rq_id 165

-IN-- forward NOWP

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH SET_SYSTEM_USER

DpRqNoWpHandle: short-cut, I am sender and receiver

msgkey: 000000010000000F => 0 1 0

DpRqNoWpHandle: reset SET_SYSTEM_USER flag

blks_in_queue/wp_ca_blk_no/wp_max_no = 0/300/13

make DISP owner of wp_ca_blk 40

DpRqPutIntoQueue: put request into queue (reqtype 0, prio LOW, rq_id 165)

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

APPC blk 12 WORK_PROCESS 4116

DISPATCHER has 1 WP and 0 APPC blks

DpGetScheduleInfo: next_schedule: 1209548537/421000 5/343000 sec/usec

DpTimeCheck: act sleep = 5343 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1122

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id DISPATCHER tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_WP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat NO_CHANGE mode 0 len 1396 rq_id 165

-IN-- req_info MSG_WITH_REQ_BUF MSG_WITH_OH

DpRqNoWpHandle: DpRqCheck o.k.

info for DIA: wait/run/hold/killed = 5/1/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_RUN

DpRqNoWpHandle: new state of T0/M0 = 0x42

DpRqNoWpHandle: give rq_id 165 to W0 ...

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

WP blk 40 WORK_PROCESS 4116

APPC blk 12 WORK_PROCESS 4116

DpGetScheduleInfo: next_schedule: 1209548537/421000 5/343000 sec/usec

DpTimeCheck: act sleep = 5343 msec

  • DP LOOP ***********

NiSelISelectInt: 1 handles selected (0 buffered)

NiDgHdlRecvFrom: hdl 0 received 14 bytes from 127.0.0.1:1141

DpRqServiceQueue: 1 request(s) in NOWP queue ===>>

-IN-- sender_id WORK_PROCESS tid 0 wp_ca_blk 40 wp_id 0

-IN-- action SEND_TO_DP uid 1 appc_ca_blk -1 type NOWP

-IN-- new_stat WP_WAIT mode 0 len 8 rq_id 166

info for DIA: wait/run/hold/killed = 6/0/0/0 wps

DpRqNoWpHandle: new state of W0 is WP_WAIT

REL WP ca_blk 40

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548537/421000 5/328000 sec/usec

DpTimeCheck: act sleep = 5328 msec

  • DP LOOP ***********

Wed Apr 30 15:12:17 2008

NiSelISelectInt: 0 handles selected (0 buffered)

DpRqServiceQueue: 0 request(s) in NOWP queue ===>>

DpRqServiceQueue: 0 request(s) in DIA queue ===>>

DpRqServiceQueue: 0 request(s) in UPD queue ===>>

DpRqServiceQueue: 0 request(s) in ENQ queue ===>>

DpRqServiceQueue: 0 request(s) in BTC queue ===>>

DpRqServiceQueue: 0 request(s) in SPO queue ===>>

DpRqServiceQueue: 0 request(s) in UP2 queue ===>>

DpGetScheduleInfo: next_schedule: 1209548537/421000 0/0 sec/usec

secs 1209548537, active req_info's 0x0/0x0/

DpGetSchedule: found slot 4 (type/tid/mode DPT_ENVCHECK/-1/255)

DpSetNextSchedule: next schedule for slot 4: 1209548557/421000 (20/0 sec/msec)

DpCalcNextSchedule: next_schedule: 1209548557/421000

call DpEnvCheck

[DpWpDied] W0 lives (PID:4116 HANDLE:412)

[DpWpDied] W1 lives (PID:4124 HANDLE:404)

[DpWpDied] W2 lives (PID:4132 HANDLE:400)

[DpWpDied] W3 lives (PID:4140 HANDLE:396)

[DpWpDied] W4 lives (PID:4148 HANDLE:392)

[DpWpDied] W5 lives (PID:4156 HANDLE:388)

[DpWpDied] W6 lives (PID:4164 HANDLE:384)

[DpWpDied] W7 lives (PID:4172 HANDLE:380)

[DpWpDied] W8 lives (PID:4180 HANDLE:376)

[DpWpDied] W9 lives (PID:4188 HANDLE:372)

[DpWpDied] W10 lives (PID:4204 HANDLE:368)

[DpWpDied] W11 lives (PID:4216 HANDLE:364)

[DpWpDied] W12 lives (PID:4228 HANDLE:360)

DpVmCheck: vmc not active

DpGwCheck: 0

[DpProcDied] Process lives (PID:3840 HANDLE:424)

DpGwCheck: ok

[DpProcDied] Process lives (PID:4100 HANDLE:432)

DpCheckTimeTab: check time table

DpGetSchedule: next schedule 1209548557/421000

DpGetSchedule: no schedule found

DpGetScheduleInfo: next_schedule: 1209548557/421000 20/0 sec/usec

DpTimeCheck: act sleep = 20000 msec

  • DP LOOP ***********

Request you to please provide the solution,

Regards,

JP