cancel
Showing results for 
Search instead for 
Did you mean: 

Sap disp+work.exe not working problem.Here is the trace file.

Former Member
0 Kudos

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

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

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

sysno      00

sid        PID

systemid   562 (PC with Windows NT)

relno      7200

patchlevel 0

patchno    600

intno      20020600

make       multithreaded, Unicode, 64 bit, optimized

profile    \\SAPPISERVER\sapmnt\PID\SYS\profile\PID_DVEBMGS00_SAPPISERVER

pid        2124

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

length of sys_adm_ext is 592 bytes

*** SWITCH TRC-HIDE on ***

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

    shared lib "dw_xml.dll" version 600 successfully loaded

    shared lib "dw_xtc.dll" version 600 successfully loaded

    shared lib "dw_stl.dll" version 600 successfully loaded

    shared lib "dw_gui.dll" version 600 successfully loaded

    shared lib "dw_mdm.dll" version 600 successfully loaded

    shared lib "dw_rndrt.dll" version 600 successfully loaded

    shared lib "dw_abp.dll" version 600 successfully loaded

    shared lib "dw_sym.dll" version 600 successfully loaded

    shared lib "dw_aci.dll" version 600 successfully loaded

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

use internal message server connection to port 3901

rdisp/dynamic_wp_check : 1

rdisp/calculateLoadAverage : 1

Tue Mar 01 15:07:35 2016

*** 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  6484]

MtxInit: 30000 0 0

DpSysAdmExtInit: ABAP is active

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

display_tcp_ip:    0

DpIPCInit2: write dp-profile-values into sys_adm_ext

DpIPCInit2: start server >sappiserver_PID_00                      <

DpShMCreate: sizeof(wp_adm)        29328    (2256)

DpShMCreate: sizeof(tm_adm)        5517056    (27448)

DpShMCreate: sizeof(wp_ca_adm)        64000    (64)

DpShMCreate: sizeof(appc_ca_adm)    64000    (64)

DpCommTableSize: max/headSize/ftSize/tableSize=500/16/1384064/1384080

DpShMCreate: sizeof(comm_adm)        1384080    (2744)

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

DpShMCreate: sizeof(slock_adm)        0    (296)

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

DpShMCreate: sizeof(file_adm)        0    (80)

DpShMCreate: sizeof(vmc_adm)        0    (2160)

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

DpShMCreate: sizeof(gw_adm)    48

DpShMCreate: sizeof(j2ee_adm)    3952

DpShMCreate: SHM_DP_ADM_KEY        (addr: 000000000DB30050, size: 7161328)

DpShMCreate: allocated sys_adm at 000000000DB30060

DpShMCreate: allocated wp_adm_list at 000000000DB330D0

DpShMCreate: allocated wp_adm at 000000000DB332C0

DpShMCreate: allocated tm_adm_list at 000000000DB3A560

DpShMCreate: allocated tm_adm at 000000000DB3A5B0

DpShMCreate: allocated wp_ca_adm at 000000000E07D4C0

DpShMCreate: allocated appc_ca_adm at 000000000E08CED0

DpShMCreate: allocated comm_adm at 000000000E09C8E0

DpShMCreate: system runs without slock table

DpShMCreate: system runs without file table

DpShMCreate: allocated vmc_adm_list at 000000000E1EE780

DpShMCreate: system runs without vmc_adm

DpShMCreate: allocated gw_adm at 000000000E1EE830

DpShMCreate: allocated j2ee_adm at 000000000E1EE870

DpShMCreate: allocated ca_info at 000000000E1EF7F0

DpShMCreate: allocated wall_adm at 000000000E1EF880

DpCommAttachTable: attached comm table (header=000000000E09C8E0/ft=000000000E09C8F0)

DpSysAdmIntInit: initialize sys_adm

rdisp/test_roll : roll strategy is DP_NORMAL_ROLL

dia token check not active (5 token)

MBUF state OFF

DpCommInitTable: init table for 500 entries

DpRqQInit: keep protect_queue / slots_per_queue 0 / 2001 in sys_adm

rdisp/queue_size_check_value :  -> on,50,30,40,500,50,500,80

EmInit: MmSetImplementation( 2 ).

MM global diagnostic options set: 0

<ES> client 0 initializing ....

<ES> EsILock: use spinlock for locking

<ES> InitFreeList

<ES> block size is 4096 kByte.

<ES> Info: em/initial_size_MB( 1015MB) not multiple of em/blocksize_KB( 4096KB)

<ES> Info: em/initial_size_MB rounded up to 1016MB

Using implementation view

<EsNT> Using memory model view.

<EsNT> Memory Reset disabled as NT default

<ES> 253 blocks reserved for free list.

ES initialized.

mm.dump: set maximum dump mem to 192 MB

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

EsRegisterEmCheck: Register EmGetEsHandles at 0000000140D62E90

DpVmcSetActive: set vmc state DP_VMC_NOT_ACTIVE

MPI: dynamic quotas disabled.

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

J2EE server info

  start = TRUE

  state = STARTED

  pid = 5108

  argv[0] = D:\usr\sap\PID\DVEBMGS00\exe\jstart.EXE

  argv[1] = D:\usr\sap\PID\DVEBMGS00\exe\jstart.EXE

  argv[2] = pf=\\SAPPISERVER\sapmnt\PID\SYS\profile\PID_DVEBMGS00_SAPPISERVER

  argv[3] = -DSAPSTART=1

  argv[4] = -DCONNECT_PORT=65000

  argv[5] = -DSAPSYSTEM=00

  argv[6] = -DSAPSYSTEMNAME=PID

  argv[7] = -DSAPMYNAME=sappiserver_PID_00

  argv[8] = -DSAPPROFILE=\\SAPPISERVER\sapmnt\PID\SYS\profile\PID_DVEBMGS00_SAPPISERVER

  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 ( 4.0.1 4.0.1 5.1) [dpxxdisp.c   1706]

Tue Mar 01 15:07:40 2016

*** ERROR => MsIAttachEx: NiBufConnect to sappiserver/3901 failed (rc=NIECONN_PENDING) [msxxi.c      718]

***LOG Q0L=> DpLoopInit, nomscon () [dpxxdisp.c   1805]

CCMS: SemInMgt: Semaphore Management initialized by AlAttachShm_Doublestack.

CCMS: SemInit: Semaphore 38 initialized by AlAttachShm_Doublestack.

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

DpJ2eeLogin: j2ee state = CONNECTED

DpAppcBlksLow: max appc blocks in queue is 500 (50 %)

DpWpBlksLow: max wp blocks in queue is 800 (80 %)

Tue Mar 01 15:08:25 2016

*** ERROR => MsIAttachEx: NiBufConnect to sappiserver/3901 failed (rc=NIECONN_PENDING) [msxxi.c      718]

*** ERROR => DpHdlDeadWp: W0 (pid 3804) died (severity=0, status=0) [dpxxwp.c     1739]

*** ERROR => DpHdlDeadWp: W1 (pid 2556) died (severity=0, status=0) [dpxxwp.c     1739]

*** ERROR => DpHdlDeadWp: W2 (pid 3536) died (severity=0, status=0) [dpxxwp.c     1739]

*** ERROR => DpHdlDeadWp: W3 (pid 3292) died (severity=0, status=0) [dpxxwp.c     1739]

*** ERROR => DpHdlDeadWp: W4 (pid 620) died (severity=0, status=0) [dpxxwp.c     1739]

*** ERROR => DpHdlDeadWp: W5 (pid 2928) died (severity=0, status=0) [dpxxwp.c     1739]

*** ERROR => DpHdlDeadWp: W6 (pid 4880) died (severity=0, status=0) [dpxxwp.c     1739]

*** ERROR => DpHdlDeadWp: W7 (pid 4916) died (severity=0, status=0) [dpxxwp.c     1739]

*** ERROR => DpHdlDeadWp: W8 (pid 4252) died (severity=0, status=0) [dpxxwp.c     1739]

*** ERROR => DpHdlDeadWp: W9 (pid 4952) died (severity=0, status=0) [dpxxwp.c     1739]

*** ERROR => DpHdlDeadWp: W10 (pid 3576) died (severity=0, status=0) [dpxxwp.c     1739]

*** DP_FATAL_ERROR => DpWPCheck: no more work processes

*** DISPATCHER EMERGENCY SHUTDOWN ***

increase tracelevel of WPs

NiWait: sleep (10000ms) ...

NiISelect: timeout 10000ms

NiISelect: maximum fd=1137

NiISelect: read-mask is NULL

NiISelect: write-mask is NULL

Tue Mar 01 15:08:35 2016

NiISelect: TIMEOUT occured (10000ms)

dump system status

Workprocess Table (long)            Tue Mar 01 09:38:35 2016

========================

No Type  Pid    Status  Cause Start Rstr  Err Sem Time Program          Cl  User         Action                    Table

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

0 DIA       -1 Ended         no    no     1   0    0                                    NO_ACTION                          

1 DIA       -1 Ended         no    no     1   0    0                                    NO_ACTION                          

2 DIA       -1 Ended         no    no     1   0    0                                    NO_ACTION                          

3 DIA       -1 Ended         no    no     1   0    0                                    NO_ACTION                          

4 DIA       -1 Ended         no    no     1   0    0                                    NO_ACTION                          

5 UPD       -1 Ended         no    no     1   0    0                                    NO_ACTION                          

6 BTC       -1 Ended         no    no     1   0    0                                    NO_ACTION                          

7 BTC       -1 Ended         no    no     1   0    0                                    NO_ACTION                          

8 BTC       -1 Ended         no    no     1   0    0                                    NO_ACTION                          

9 SPO       -1 Ended         no    no     1   0    0                                    NO_ACTION                          

10 UP2       -1 Ended         no    no     1   0    0                                    NO_ACTION                          

Dispatcher Queue Statistics            Tue Mar 01 09:38:35 2016

===========================

+------+--------+--------+--------+------------+------------+

|  Typ |    now |   high |    max | writes     |  reads     |

+------+--------+--------+--------+------------+------------+

| NOWP |      0 |      3 |   2000 |          5 |          5 |

+------+--------+--------+--------+------------+------------+

|  DIA |      2 |      2 |   2000 |          2 |          0 |

+------+--------+--------+--------+------------+------------+

|  UPD |      0 |      0 |   2000 |          0 |          0 |

+------+--------+--------+--------+------------+------------+

|  ENQ |      0 |      0 |   2000 |          0 |          0 |

+------+--------+--------+--------+------------+------------+

|  BTC |      0 |      0 |   2000 |          0 |          0 |

+------+--------+--------+--------+------------+------------+

|  SPO |      0 |      0 |   2000 |          0 |          0 |

+------+--------+--------+--------+------------+------------+

|  UP2 |      0 |      0 |   2000 |          0 |          0 |

+------+--------+--------+--------+------------+------------+

max_rq_id        6

wake_evt_udp_now    0

wake events          total     6,  udp     3 ( 50%),  shm     3 ( 50%)

since last update    total     6,  udp     3 ( 50%),  shm     3 ( 50%)

DpGetLoadAverage: la1[1] = 0.166667 / -1.000000 %

DpGetLoadAverage: la5[1] = 0.033333 / -1.000000 %

DpGetLoadAverage: la15[1] = 0.033333 / -1.000000 %

Dispatcher Load Statistics

+------+---------+---------+---------+

|  Typ |     LA1 |     LA5 |    LA15 |

+------+---------+---------+---------+

|  DIA |   0.167 |   0.033 |   0.033 |

+------+---------+---------+---------+

DpGetLoadAverage: la1[2] = 0.000000 / -1.000000 %

DpGetLoadAverage: la5[2] = 0.000000 / -1.000000 %

DpGetLoadAverage: la15[2] = 0.000000 / -1.000000 %

|  UPD |   0.000 |   0.000 |   0.000 |

+------+---------+---------+---------+

DpGetLoadAverage: la1[3] = 0.000000 / -1.000000 %

DpGetLoadAverage: la5[3] = 0.000000 / -1.000000 %

DpGetLoadAverage: la15[3] = 0.000000 / -1.000000 %

|  ENQ |   0.000 |   0.000 |   0.000 |

+------+---------+---------+---------+

DpGetLoadAverage: la1[4] = 0.000000 / -1.000000 %

DpGetLoadAverage: la5[4] = 0.000000 / -1.000000 %

DpGetLoadAverage: la15[4] = 0.000000 / -1.000000 %

|  BTC |   0.000 |   0.000 |   0.000 |

+------+---------+---------+---------+

DpGetLoadAverage: la1[5] = 0.000000 / -1.000000 %

DpGetLoadAverage: la5[5] = 0.000000 / -1.000000 %

DpGetLoadAverage: la15[5] = 0.000000 / -1.000000 %

|  SPO |   0.000 |   0.000 |   0.000 |

+------+---------+---------+---------+

DpGetLoadAverage: la1[6] = 0.000000 / -1.000000 %

DpGetLoadAverage: la5[6] = 0.000000 / -1.000000 %

DpGetLoadAverage: la15[6] = 0.000000 / -1.000000 %

|  UP2 |   0.000 |   0.000 |   0.000 |

+------+---------+---------+---------+

Dump of tm_adm structure:            Tue Mar 01 09:38:35 2016

=========================

Term    uid  man user    term   lastop  mod wp  ta   a/i (modes)

Workprocess Comm. Area Blocks            Tue Mar 01 09:38:35 2016

=============================

Slots: 1000, Used: 0, Max: 1

+------+--------------+----------+-------------+

|   id | owner        |   pid    | eyecatcher  |

+------+--------------+----------+-------------+

NiWait: sleep (5000ms) ...

NiISelect: timeout 5000ms

NiISelect: maximum fd=1137

NiISelect: read-mask is NULL

NiISelect: write-mask is NULL

Tue Mar 01 15:08:40 2016

NiISelect: TIMEOUT occured (5000ms)

DpHalt: shutdown server >sappiserver_PID_00                      < (normal)

DpJ2eeDisableRestart

DpIJ2eeShutdown: send SIGQUIT to SAP J2EE startup framework (pid=5108)

killing proc (5108) (SOFTSHUTDOWN_KILL)

*** ERROR => DpProcKill: kill failed [dpntdisp.c   409]

DpIJ2eeShutdown: j2ee state = SHUTDOWN

NiBufISelUpdate: new MODE -- (r-) for hdl 33 in set0

SiSelNSet: set events of sock 1120 to: ---

NiBufISelRemove: remove hdl 33 from set0

SiSelNRemove: removed sock 1120 (pos=2)

SiSelNRemove: removed sock 1120

NiSelIRemove: removed hdl 33

DpDelSocketInfo: del info for nihdl 33 (pos/type=4/8)

NiICloseHandle: shutdown and close hdl 33/sock 1120

NiBufIClose: clear extension for hdl 33

DpHalt: switch off Shared memory profiling

ShmProtect( 57, 3 )

ShmProtect(SHM_PROFILE, SHM_PROT_RW

ShmProtect( 57, 1 )

ShmProtect(SHM_PROFILE, SHM_PROT_RD

DpWakeUpWps: wake up all wp's

DpHalt: stop work processes

DpHalt: stop gateway

killing process (2996) (SOFT_KILL)

DpHalt: stop icman

killing process (3208) (SOFT_KILL)

DpHalt: terminate gui connections

DpHalt: wait for end of work processes

DpHalt: wait for end of gateway

[DpProcDied] Process lives  (PID:2996  HANDLE:872)

DpHalt: waiting for termination of gateway ...

NiWait: sleep (1000ms) ...

NiISelect: timeout 1000ms

NiISelect: maximum fd=1137

NiISelect: read-mask is NULL

NiISelect: write-mask is NULL

Tue Mar 01 15:08:41 2016

NiISelect: TIMEOUT occured (1000ms)

*** ERROR => [DpProcDied] Process died  (PID:2996  HANDLE:872  rc:0x0) [dpnttool2.c  147]

DpHalt: wait for end of icman

[DpProcDied] Process lives  (PID:3208  HANDLE:880)

DpHalt: waiting for termination of icman ...

NiWait: sleep (1000ms) ...

NiISelect: timeout 1000ms

NiISelect: maximum fd=1137

NiISelect: read-mask is NULL

NiISelect: write-mask is NULL

Tue Mar 01 15:08:42 2016

NiISelect: TIMEOUT occured (1000ms)

[DpProcDied] Process lives  (PID:3208  HANDLE:880)

DpHalt: waiting for termination of icman ...

NiWait: sleep (1000ms) ...

NiISelect: timeout 1000ms

NiISelect: maximum fd=1137

NiISelect: read-mask is NULL

NiISelect: write-mask is NULL

Tue Mar 01 15:08:43 2016

NiISelect: TIMEOUT occured (1000ms)

[DpProcDied] Process lives  (PID:3208  HANDLE:880)

DpHalt: waiting for termination of icman ...

NiWait: sleep (1000ms) ...

NiISelect: timeout 1000ms

NiISelect: maximum fd=1137

NiISelect: read-mask is NULL

NiISelect: write-mask is NULL

Tue Mar 01 15:08:44 2016

NiISelect: TIMEOUT occured (1000ms)

[DpProcDied] Process lives  (PID:3208  HANDLE:880)

DpHalt: waiting for termination of icman ...

NiWait: sleep (1000ms) ...

NiISelect: timeout 1000ms

NiISelect: maximum fd=1137

NiISelect: read-mask is NULL

NiISelect: write-mask is NULL

Tue Mar 01 15:08:45 2016

NiISelect: TIMEOUT occured (1000ms)

[DpProcDied] Process lives  (PID:3208  HANDLE:880)

DpHalt: waiting for termination of icman ...

NiWait: sleep (1000ms) ...

NiISelect: timeout 1000ms

NiISelect: maximum fd=1137

NiISelect: read-mask is NULL

NiISelect: write-mask is NULL

Tue Mar 01 15:08:46 2016

NiISelect: TIMEOUT occured (1000ms)

*** ERROR => [DpProcDied] Process died  (PID:3208  HANDLE:880  rc:0x0) [dpnttool2.c  147]

*** ERROR => [DpProcDied] Process died  (PID:5108  HANDLE:876  rc:0x2) [dpnttool2.c  147]

DpHalt: not attached to the message server

DpHalt: cleanup EM

EsCleanup( )

EsCleanup ....

EmCleanup() -> 0

Es2Cleanup: Cleanup ES2

***LOG Q05=> DpHalt, DPStop ( 2124) [dpxxdisp.c   11605]

DpHalt: Good Bye .....

Accepted Solutions (0)

Answers (5)

Answers (5)

Former Member
0 Kudos

Hi Ravi,

A reason for this error is the ms_acl. Check the value of the ms/acl_info because the server could be denied in the try to access to the message server.

Kind regards

Francisco

raquel_gomez
Employee
Employee
0 Kudos

Hi Ravi,

Based on provided dispatcher trace file, it's running on SAPPISERVER, instance number 00.

When the dispatcher starts, it tries to connect to internal port of Message Server (39$$) , but it fails:

  Tue Mar 01 15:08:25 2016

    *** ERROR => MsIAttachEx: NiBufConnect to sappiserver/3901 failed (rc=NIECONN_PENDING) [msxxi.c      718]

Is there an ASCS running on same host (sappiserver), instance number 01? Please attach Message Server trace file (dev_ms).

Which is the value of following parameters:

rdisp/mshost

rdisp/msserv

rdisp/msserv_internal

Regards,
Raquel

former_member597129
Discoverer
0 Kudos

some times sapstartsvr  get corrupted . check note 1043592 and try replacing SAPSTARTSRV.EXE FILE as mentioned in note

Sriram2009
Active Contributor
0 Kudos

Hi Ravi.

Just do the full system restart and then check the SAP startup. or Are you installed  any antivirus software? is it blocking the ports?

Regards

SS

Former Member
0 Kudos

Hi Sriram,

              I don't have any antivirus installed in my system.

Thanks and Regards,

Ravi Teja

Former Member
0 Kudos

Hi Ravi,

There could be number of reason behind this and you have to check all the logs carefully.

1. Please try to restart the system completely.

2. Please check \etc\services, host file etc. Also check the any change in environment variables.

3. Please check your profile which defines the ports. Also please check rdisp/msserv_internal.

4. Please check if that port is being used by other service/application using netstat command.

5. If above does not work, please attach dev_ms, dev_w0 log files to check further.

Most importantly please try to find out what change has taken place recently. It will be easier to find the root cause then.

Regards,

Sujit Kumar Banerjee.

Former Member
0 Kudos

Hallo Ravi,

*** ERROR => MsIAttachEx: NiBufConnect to sappiserver/3901 failed

Have you checked your Windows firewall settings?

What's the status in the MMC, all grey??

Regards

Thomas

Former Member
0 Kudos

Hi Thomas,

                Thank you for your reply.My firewall settings are off.Status in my mmc is yellow.Actually I have 3 servers in mmc.SAPPISERVER0,SAPPISERVER1,SAPPISERVER2.status of only SAPPISERVER0 IN MY mmc is yellow.

Thanks and Regards,

Ravi Teja

Former Member
0 Kudos

Hallo Ravi,

I would also try to restart SAP? Have you applied any changes causing this issue?

Is there any error in dev_w0 etc.??

Regards

Thomas

isaias_freitas
Advisor
Advisor
0 Kudos

Hello Ravi,


*** ERROR => MsIAttachEx: NiBufConnect to sappiserver/3901 failed (rc=NIECONN_PENDING) [msxxi.c      718]

This indicates that the Dispatcher could not connect to the Message Server internal port (39$$, where "$$" is the instance number of the instance where the MS is running).

It also indicates that the hostname of the server where the MS is running would be "sappiserver", and this is not listed by you when you posted the SAP MMC status, replying to Thomas' inputs.

Do you have an ASCS instance? Is it started?

If this system runs in High Availability scenario, verify whether the SAP cluster group is fully started.

Regards,

Isaías