kernel 114 error

[Former Member]

I upgraded ERP SR2 kernel level 114 from 111 so now in dispatcher the message is "dispatcher started but dialog queue in standstill"

dev-disp:

WARNING => DpRqServiceQueue: timeout of HIGH PRIO msg, return DP_CANT_HANDLE_REQ

I increased the no of dialog workprocess and reduced abap/buffer as well but went in vain.

[former_member433984 · Accepted solution]

are the WP starting and running? ca you post dev_disp and dev_w0 here?

[Former Member · Accepted solution]

dev_disp:-

-

---

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

-

---

sysno 00

sid DEV

systemid 562 (PC with Windows NT)

relno 7000

patchlevel 0

patchno 114

intno 20050900

make: multithreaded, Unicode, 64 bit, optimized

pid 3948

Tue Jan 15 16:08:20 2008

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

length of sys_adm_ext is 576 bytes

• SWITCH TRC-HIDE on ***

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

shared lib "dw_xml.dll" version 114 successfully loaded

shared lib "dw_xtc.dll" version 114 successfully loaded

shared lib "dw_stl.dll" version 114 successfully loaded

shared lib "dw_gui.dll" version 114 successfully loaded

shared lib "dw_mdm.dll" version 114 successfully loaded

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

use internal message server connection to port 3900

Tue Jan 15 16:08:24 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 5361]

MtxInit: 30000 0 0

DpSysAdmExtInit: ABAP is active

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

DpIPCInit2: start server >MRVdev_DEV_00 <

DpShMCreate: sizeof(wp_adm) 22208 (1480)

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 (1864)

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

DpShMCreate: sizeof(gw_adm) 48

DpShMCreate: SHM_DP_ADM_KEY (addr: 000000000F280050, size: 6278096)

DpShMCreate: allocated sys_adm at 000000000F280050

DpShMCreate: allocated wp_adm at 000000000F282150

DpShMCreate: allocated tm_adm_list at 000000000F287810

DpShMCreate: allocated tm_adm at 000000000F287870

DpShMCreate: allocated wp_ca_adm at 000000000F7DAF40

DpShMCreate: allocated appc_ca_adm at 000000000F7E0D00

DpShMCreate: allocated comm_adm at 000000000F7E2C40

DpShMCreate: system runs without slock table

DpShMCreate: system runs without file table

DpShMCreate: allocated vmc_adm_list at 000000000F8698D0

DpShMCreate: allocated gw_adm at 000000000F869950

DpShMCreate: system runs without vmc_adm

DpShMCreate: allocated ca_info at 000000000F869980

DpShMCreate: allocated wall_adm at 000000000F869990

Tue Jan 15 16:08:25 2008

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.

rdisp/http_min_wait_dia_wp : 1 -> 1

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

***LOG Q0K=> DpMsAttach, mscon ( MRVdev) [dpxxdisp.c 11753]

DpStartStopMsg: send start message (myname is >MRVdev_DEV_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).

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 114

Release check o.K.

Tue Jan 15 16:08:33 2008

MBUF state ACTIVE

DpModState: change server state from STARTING to ACTIVE

Tue Jan 15 16:08:34 2008

• WARNING => DpRqServiceQueue: timeout of HIGH PRIO msg, return DP_CANT_HANDLE_REQ

Tue Jan 15 16:24:54 2008

DpSigInt: caught signal 2

DpHalt: shutdown server >MRVdev_DEV_00 < (normal)

DpModState: change server state from ACTIVE to SHUTDOWN

Stop work processes

Tue Jan 15 16:24:55 2008

Stop gateway

Stop icman

Terminate gui connections

wait for end of work processes

wait for end of gateway

waiting for termination of gateway ...

Tue Jan 15 16:24:56 2008

wait for end of icman

waiting for termination of icman ...

Tue Jan 15 16:24:57 2008

waiting for termination of icman ...

Tue Jan 15 16:24:58 2008

waiting for termination of icman ...

Tue Jan 15 16:24:59 2008

waiting for termination of icman ...

Tue Jan 15 16:25:00 2008

waiting for termination of icman ...

Tue Jan 15 16:25:01 2008

waiting for termination of icman ...

Tue Jan 15 16:25:02 2008

waiting for termination of icman ...

Tue Jan 15 16:25:03 2008

waiting for termination of icman ...

Tue Jan 15 16:25:04 2008

waiting for termination of icman ...

Tue Jan 15 16:25:05 2008

DpStartStopMsg: send stop message (myname is >MRVdev_DEV_00 <)

DpStartStopMsg: stop msg sent

Tue Jan 15 16:25:06 2008

DpHalt: sync with message server o.k.

detach from message server

***LOG Q0M=> DpMsDetach, ms_detach () [dpxxdisp.c 12099]

MBUF state OFF

MBUF component DOWN

cleanup EM

***LOG Q05=> DpHalt, DPStop ( 3948) [dpxxdisp.c 10371]

dev_w0:

-

---

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

-

---

*

• ACTIVE TRACE LEVEL 1

• ACTIVE TRACE COMPONENTS all, MJ

*

B

B Tue Jan 15 16:08:25 2008

B create_con (con_name=R/3)

B Loading DB library 'F:\usr\sap\DEV\DVEBMGS00\exe\dbmssslib.dll' ...

B Library 'F:\usr\sap\DEV\DVEBMGS00\exe\dbmssslib.dll' loaded

B Version of 'F:\usr\sap\DEV\DVEBMGS00\exe\dbmssslib.dll' is "700.08", patchlevel (0.109)

B New connection 0 created

M sysno 00

M sid DEV

M systemid 562 (PC with Windows NT)

M relno 7000

M patchlevel 0

M patchno 114

M intno 20050900

M make: multithreaded, Unicode, 64 bit, optimized

M pid 2416

M

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

M length of sys_adm_ext is 576 bytes

M ***LOG Q0Q=> tskh_init, WPStart (Workproc 0 2416) [dpxxdisp.c 1301]

I MtxInit: 30000 0 0

M DpSysAdmExtCreate: ABAP is active

M DpSysAdmExtCreate: VMC (JAVA VM in WP) is not active

M

M Tue Jan 15 16:08:26 2008

M DpShMCreate: sizeof(wp_adm) 22208 (1480)

M DpShMCreate: sizeof(tm_adm) 5584592 (27784)

M DpShMCreate: sizeof(wp_ca_adm) 24000 (80)

M DpShMCreate: sizeof(appc_ca_adm) 8000 (80)

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

M DpShMCreate: sizeof(comm_adm) 552080 (1088)

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

M DpShMCreate: sizeof(slock_adm) 0 (104)

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

M DpShMCreate: sizeof(file_adm) 0 (72)

M DpShMCreate: sizeof(vmc_adm) 0 (1864)

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

M DpShMCreate: sizeof(gw_adm) 48

M DpShMCreate: SHM_DP_ADM_KEY (addr: 000000000F280050, size: 6278096)

M DpShMCreate: allocated sys_adm at 000000000F280050

M DpShMCreate: allocated wp_adm at 000000000F282150

M DpShMCreate: allocated tm_adm_list at 000000000F287810

M DpShMCreate: allocated tm_adm at 000000000F287870

M DpShMCreate: allocated wp_ca_adm at 000000000F7DAF40

M DpShMCreate: allocated appc_ca_adm at 000000000F7E0D00

M DpShMCreate: allocated comm_adm at 000000000F7E2C40

M DpShMCreate: system runs without slock table

M DpShMCreate: system runs without file table

M DpShMCreate: allocated vmc_adm_list at 000000000F8698D0

M DpShMCreate: allocated gw_adm at 000000000F869950

M DpShMCreate: system runs without vmc_adm

M DpShMCreate: allocated ca_info at 000000000F869980

M DpShMCreate: allocated wall_adm at 000000000F869990

X EmInit: MmSetImplementation( 2 ).

X MM global diagnostic options set: 0

X <ES> client 0 initializing ....

X Using implementation view

X <EsNT> Using memory model view.

M <EsNT> Memory Reset disabled as NT default

X ES initialized.

M ThInit: running on host MRVdev

M

M Tue Jan 15 16:08:27 2008

M calling db_connect ...

C Thread ID:2412

C Thank You for using the SLOLEDB-interface

C Using dynamic link library 'F:\usr\sap\DEV\DVEBMGS00\exe\dbmssslib.dll'

C dbmssslib.dll patch info

C patchlevel 0

C patchno 110

C patchcomment MSSQL: Connect error handling (1053754)

C np:(local) connection used on MRVDEV

C CopyLocalParameters: dbuser is 'dev'

C Using Provider SQLNCLI

C OpenOledbConnection: MARS property was set successfully.

C Provider Release:9.00.3042.00

C Using Provider SQLNCLI

C OpenOledbConnection: MARS property was set successfully.

C

C Tue Jan 15 16:08:28 2008

C Cache sizes: header 104 bytes, 20000 names (32960000 bytes), 500 dynamic statements (2876000 bytes), total 35836104 bytes

C Using shared procedure name cache MRVDEV_DEVDEV_DEV_MEM initialized by another process.

C Connected to db server : [MRVDEV] server_used : [np:(local)], dbname: DEV, dbuser: dev

C pn_id:MRVDEV_DEVDEV_DEV

C Using MARS (on sql 9.0)

B Connection 0 opened (DBSL handle 0)

B Wp Hdl ConName ConId ConState TX PRM RCT TIM MAX OPT Date Time DBHost

B 000 000 R/3 000000000 ACTIVE NO YES NO 000 255 255 20080115 160827 MRVDEV

C The IRow interface is supported by this OLEDB provider

M db_connect o.k.

M ICT: exclude compression: .zip,.cs,.rar,.arj,.z,.gz,.tar,.lzh,.cab,.hqx,.ace,.jar,.ear,.war,.css,.pdf,.js,.gzip,.uue,.bz2,.iso,.sda,.sar,.gif

I

I Tue Jan 15 16:08:31 2008

I MtxInit: 0 0 0

M SHM_PRES_BUF (addr: 000000001BC30050, size: 4400000)

M SHM_ROLL_AREA (addr: 000007FFED0E0050, size: 61440000)

M SHM_PAGING_AREA (addr: 000000001C070050, size: 32768000)

M SHM_ROLL_ADM (addr: 000000001DFC0050, size: 615040)

M SHM_PAGING_ADM (addr: 000000001E060050, size: 525344)

M ThCreateNoBuffer allocated 544152 bytes for 1000 entries at 000000001E0F0050

M ThCreateNoBuffer index size: 3000 elems

M ThCreateVBAdm allocated 12176 bytes (50 server) at 000000001E180050

X EmInit: MmSetImplementation( 2 ).

X MM global diagnostic options set: 0

X <ES> client 0 initializing ....

X Using implementation view

X ES initialized.

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

B dbtbxbuf: Buffer TABL (addr: 00000000236B0160, size: 30000000, end: 000000002534C4E0)

B dbtbxbuf: Buffer TABLP (addr: 0000000025350160, size: 10240000, end: 0000000025D14160)

B dbexpbuf: Buffer EIBUF (addr: 0000000025D30170, size: 4194304, end: 0000000026130170)

B dbexpbuf: Buffer ESM (addr: 0000000026140170, size: 4194304, end: 0000000026540170)

B dbexpbuf: Buffer CUA (addr: 0000000026550170, size: 3072000, end: 000000002683E170)

B dbexpbuf: Buffer OTR (addr: 0000000026840170, size: 4194304, end: 0000000026C40170)

M CCMS: AlInitGlobals : alert/use_sema_lock = TRUE.

S

S Tue Jan 15 16:08:32 2008

S *** init spool environment

S initialize debug system

T Stack direction is downwards.

T debug control: prepare exclude for printer trace

T new memory block 0000000013912930

S spool kernel/ddic check: Ok

S using table TSP02FX for frontend printing

S 1 spool work process(es) found

S frontend print via spool service enabled

S printer list size is 150

S printer type list size is 50

S queue size (profile) = 300

S hostspool list size = 3000

S option list size is 30

S found processing queue enabled

S found spool memory service RSPO-RCLOCKS at 000000002FFE00D0

S doing lock recovery

S setting server cache root

S found spool memory service RSPO-SERVERCACHE at 000000002FFE0580

S using messages for server info

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

S size of open spool request entry: 2272 bytes

S immediate print option for implicitely closed spool requests is disabled

A

A -PXA--

---

A PXA INITIALIZATION

A System page size: 4kb, total admin_size: 9288kb, dir_size: 9228kb.

A Attached to PXA (address 000007FFF0B80050, size 250000K)

A abap/pxa = shared protect gen_remote

A PXA INITIALIZATION FINISHED

A -PXA--

---

A

A ABAP ShmAdm attached (addr=000007FF4FEEA000 leng=20955136 end=000007FF512E6000)

A >> Shm MMADM area (addr=000007FF503C3ED0 leng=244096 end=000007FF503FF850)

A >> Shm MMDAT area (addr=000007FF50400000 leng=15622144 end=000007FF512E6000)

A RFC Destination> destination MRVdev_DEV_00 host MRVdev system DEV systnr 0 (MRVdev_DEV_00)

A RFC Options> H=MRVdev,S=00,d=2,

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

A

A RFC rfc/signon_error_log = -1

A RFC rfc/dump_connection_info = 0

A RFC rfc/dump_client_info = 0

A RFC rfc/cp_convert/ignore_error = 1

A RFC rfc/cp_convert/conversion_char = 23

A RFC rfc/wan_compress/threshold = 251

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

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

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

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

A RFC Method> initialize RemObjDriver for ABAP Objects

M ThrCreateShObjects allocated 15838 bytes at 0000000030150050

N

N Tue Jan 15 16:08:33 2008

N SsfSapSecin: putenv(SECUDIR=F:\usr\sap\DEV\DVEBMGS00\sec): ok

N

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

N === SSF INITIALIZATION:

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

N ===...SSF trace level is 0 .

N ===...SSF library is F:\usr\sap\DEV\DVEBMGS00\exe\sapsecu.dll .

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

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

N ===...sucessfully completed.

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

N

N Tue Jan 15 16:08:36 2008

N MskiInitLogonTicketCacheHandle: Logon Ticket cache pointer retrieved from shared memory.

N MskiInitLogonTicketCacheHandle: Workprocess runs with Logon Ticket cache.

M JrfcVmcRegisterNativesDriver o.k.

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

W === ipl_Init() called

B dbtran INFO (init_connection '<DEFAULT>' [MSSQL:700.08]):

B max_blocking_factor = 50, max_in_blocking_factor = 255,

B min_blocking_factor = 5, min_in_blocking_factor = 10,

B prefer_union_all = 1, prefer_join = 1,

B prefer_fix_blocking = 0, prefer_in_itab_opt = 0,

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

B escape_as_literal = 0, opt GE LE to BETWEEN = 0,

B select * =0x00, character encoding = STD / []:X,

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

B rule_fae->0, concat_fae->0, concat_fae_or->0

W ITS Plugin: Path dw_gui

W ITS Plugin: Description ITS Plugin - ITS rendering DLL

W ITS Plugin: sizeof(SAP_UC) 2

W ITS Plugin: Release: 700, [7000.0.114.20050900]

W ITS Plugin: Int.version, [33]

W ITS Plugin: Feature set: [14]

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

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

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

E Replication is disabled

E EnqCcInitialize: local lock table initialization o.k.

E EnqId_SuppressIpc: local EnqId initialization o.k.

E EnqCcInitialize: local enqueue client init o.k.

C

C Tue Jan 15 16:10:03 2008

C The IRow interface is supported by this OLEDB provider

M

M Tue Jan 15 16:24:54 2008

M in_ThErrHandle: 1

M ThResetEmMagic: reset em magic for T15/M0/I1

M ThIErrHandle: new stat of W0 is WP_SHUTDOWN

M ThIErrHandle: I'm during shutdown

M PfStatDisconnect: disconnect statistics

M Entering ThSetStatError

M invalidate act fields from T15/M0

C SQLBREAK: DBSL_CMD_SQLBREAK: CbOnCancel was not set. rc: 1

M ThIErrHandle: don't try rollback again

M ThShutDownServer: shutdown server

M PfStatIndInit: Initializing Index-Record

M PfWriteIntoFile: copied shared buf (25104 bytes) to local buf

M PfWriteIntoFile: write 25104 bytes into stat-file

M PfWriteIntoFile: writing Index

M min. start :1200393513/517503

M min. end :1200393513/619030

M max. end :1200394485/667609

M wpid :-1

M tasktypes :51324

M max. resp :8557745

M max. cpu :203125

M max.db

M no. of recs :125

M no. of bytes :25104

M PfWriteIntoFile: updated fileindex for file stat.DAT with endtime 1200394485 (15:1:2008 10:54:45)

M PfWriteIntoFile: updated fileindex

M PfStatIndInit: Initializing Index-Record

M PfWriteIntoFile: wrote buffer to file

M ThIErrHandle: do not call ThrCoreInfo (no_core_info=0, in_dynp_env=1)

M Entering ThReadDetachMode

M call ThrShutDown (1)...

B Disconnecting from ALL connections:

B Wp Hdl ConName ConId ConState TX PRM RCT TIM MAX OPT Date Time DBHost

B 000 000 R/3 000000000 ACTIVE YES YES NO 000 255 255 20080115 160827 MRVDEV

B Disconnected from connection 0

B statistics db_con_commit (com_total=5, com_tx=0)

B statistics db_con_rollback (roll_total=0, roll_tx=0)

M ***LOG Q02=> wp_halt, WPStop (Workproc 0 2416) [dpnttool.c 327]

[former_member433984 · Accepted solution]

the sytem run between 16:08 and 16:24 till you have stopped it (caught signal 2()

Tue Jan 15 16:08:34 2008

WARNING => DpRqServiceQueue: timeout of HIGH PRIO msg, return DP_CANT_HANDLE_REQ

Tue Jan 15 16:24:54 2008

DpSigInt: caught signal 2

but work process is not able to process the commands from dispatcher before it is ready with its initialization (16:08:36), I think you can simply omit the warning.

[Former Member · Accepted solution]

I am not able to login and getting the message "dispatcher started but dialog queue standstill"

[former_member433984 · Accepted solution]

can you check the status of WPs in SAP MMC (or use dpmon and post results here)? how many DIA WP are configured?

[Former Member · Accepted solution]

no of dialog WP is 8 and its equal with non-dialog WP

this same kernel is working well with instance 2 (qtsy) but facing the mentioned issue with instance 1 (dev).

Both instance on the same host.

[Former Member · Accepted solution]

suggestion from anybody

[former_member433984 · Accepted solution]

suggestion from somebody if you answer the last question...

[Former Member · Accepted solution]

earlier it was 6 then I made it as 8

[Former Member · Accepted solution]

I gave the details

[Former Member · Accepted solution]

anybody suggest some ideas to solve this problem?