cancel
Showing results for 
Search instead for 
Did you mean: 

Shadow instance not starting

former_member238981
Discoverer
0 Kudos

Hello Basis Experts,

Im having an issue during an EHP7 upgrade with SUM in my devlopment environment.

Inital problem was i had not so much memory, so had to play with the resources of CI and Shadow Instance. After an error in SUM i had to change instance profile of shadow instance but im not able to start it again (even recovering a backup or instance profile file).

I have tried differents memory configurations, but it seems not to work.

Does someone know whats happening please? I copy dev_w0 and dev_disp files below.

Thanks in advance and kind regards

DEV_DISP

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

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

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

sysno      31

sid        HR6

systemid   562 (PC with Windows NT)

relno      7410

patchlevel 0

patchno    36

intno      20020600

make       multithreaded, Unicode, 64 bit, optimized

profile    E:\usr\sap\HR6\SUM\abap\system\HR6\SYS\profile\HR6_DVEBMGS31_sapconv103

pid        5948

Mon Jul 07 16:21:09 2014

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

length of sys_adm_ext is 500 bytes

***LOG Q00=> DpSapEnvInit, DPStart (31 5948) [dpInit.c     596]

  shared lib "dw_xml.dll" version 36 successfully loaded

  shared lib "dw_xtc.dll" version 36 successfully loaded

  shared lib "dw_stl.dll" version 36 successfully loaded

  shared lib "dw_gui.dll" version 36 successfully loaded

  shared lib "dw_mdm.dll" version 36 successfully loaded

  shared lib "dw_rndrt.dll" version 36 successfully loaded

  shared lib "dw_abp.dll" version 36 successfully loaded

DpCheckMulticast: check of IP v4 multicast address o.k.

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

use internal message server connection to port 3931

rdisp/shutdown/disable_login : 0

rdisp/snapshot(CREATE): DP_CS_RESOURCES_EXHAUSTED

rdisp/snapshot(PERIOD):300 sec

rdisp/snapshot(LINES):10000 lines

DpCommonParamInit: rdisp/core_file_size = default --> no change

***LOG Q42=> DpSapEnvInit, DPStart () [dpInit.c     687]

Mon Jul 07 16:21:13 2014

*** WARNING => DpNetCheck: NiHostToAddr(www.doesnotexist0134.qqq.nxst) took 4 seconds

Mon Jul 07 16:21:21 2014

*** WARNING => DpNetCheck: NiAddrToHost(1.0.0.0) took 8 seconds

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

MtxInit: 30000 0 0

DpIPCInit2: write dp-profile-values into sys_adm_ext

DpIPCInit2: start server >sapconv103_HR6_31                       <

DpShMCreate: alloate/attach shared memory (mode=CREATE)

DpShMCreate: sizeof(wp_adm) 13248 (1104)

DpShMCreate: sizeof(tm_adm) 51472080 (256080)

DpShMCreate: sizeof(ca_adm) 432000 (72)

DpCommTableSize: max/headSize/ftSize/tableSize=500/16/7464064/7583152

DpShMCreate: sizeof(comm_adm) 7583152 (14912)

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

DpShMCreate: sizeof(slock_adm) 0 (296)

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

DpShMCreate: sizeof(file_adm) 0 (80)

DpSockTableSize: max/headSize/ftSize/tableSize=500/16/520064/520080

DpShMCreate: sizeof(sock_adm) 520080 (1016)

DpShMCreate: sizeof(vmc_adm) 0 (3208)

DpShMCreate: sizeof(wall_adm) (ft=41664/fi=67472/hd=64/rec=192)

DpShMCreate: sizeof(amc_rec_adm) (ft=86464/fi=67472/hd=64/rec=416)

DpShMCreate: sizeof(websocket_adm) (ft=28864/hd=64/rec=272)

DpShMCreate: sizeof(gw_adm) 64

DpShMCreate: sizeof(j2ee_adm) 3936

DpShMCreate: SHM_DP_ADM_KEY (addr: 0000000010050050, size: 60422880

Mon Jul 07 16:21:22 2014

DpShMCreate: allocated sys_adm at 0000000010050250

DpShMCreate: allocated wp_adm_list at 00000000100620E0

DpShMCreate: allocated wp_adm at 0000000010062400

DpShMCreate: allocated tm_adm_list at 00000000100659C0

DpShMCreate: allocated tm_adm at 0000000010065C00

DpShMCreate: allocated ca_adm at 000000001317C4D0

DpShMCreate: allocated comm_adm at 00000000131E5E50

DpShMCreate: system runs without slock table

DpShMCreate: allocated sock_adm at  0000000013921600

DpShMCreate: allocated vmc_adm_list at 00000000139A0790

DpShMCreate: system runs without VMC

DpShMCreate: allocated gw_adm at 00000000139A0A30

DpShMCreate: allocated j2ee_adm at 00000000139A0C70

DpShMCreate: allocated ca_info at 00000000139A1DD0

DpShMCreate: allocated wall_adm (ft) at 00000000139A2010

DpShMCreate: allocated wall_adm (fi) at 00000000139AC4D0

DpShMCreate: allocated wall_adm (head) at 00000000139BCE60

DpShMCreate: allocated amc_rec_adm (ft) at 00000000139BD0A0

DpShMCreate: allocated amc_rec_adm (fi) at 00000000139D2460

DpShMCreate: allocated amc_rec_adm (head) at 00000000139E2DF0

DpShMCreate: allocated websocket_adm (ft) at 00000000139E3030

DpShMCreate: allocated websocket_adm (head) at 00000000139EA2F0

DpShMCreate: initialized 21 eyes

DpSysAdmIntInit: initialize sys_adm

DpSysAdmIntInit: created queue 0 (DispatcherQueue)

DpSysAdmIntInit: created queue 1 (GatewayQueue)

DpSysAdmIntInit: created queue 2 (IcmanQueue)

DpSysAdmIntInit: created queue 3 (StartServiceQueue)

DpSysAdmIntInit: created queue 4 (DpMonQueue)

Scheduler info

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

WP info

  #dia     = 3

  #btc     = 0

  #standby = 0

  #max     = 12

General Scheduler info

  preemptionInfo.isActive           = true

  preemptionInfo.timeslice          = 500

  preemptionInfo.checkLoad          = true

Prio Class High

  maxRuntime[RQ_Q_PRIO_HIGH]     = infinite

  maxRuntimeHalf[RQ_Q_PRIO_HIGH] = infinite

Prio Class Normal

  maxRuntime[RQ_Q_PRIO_NORMAL]           = infinite

  maxRuntimeHalf[RQ_Q_PRIO_NORMAL]       = infinite

  maxTicketsForPrio[RQ_Q_PRIO_NORMAL]    = 2

  withPrioTickets[RQ_Q_PRIO_NORMAL]      = true

Prio Class Low

  maxRuntime[RQ_Q_PRIO_LOW]           = infinite

  maxRuntimeHalf[RQ_Q_PRIO_LOW]       = infinite

  maxTicketsForPrio[RQ_Q_PRIO_LOW]    = 2

  withPrioTickets[RQ_Q_PRIO_LOW]      = true

Running requests[RQ_Q_PRIO_NORMAL] = 0

Running requests[RQ_Q_PRIO_LOW] = 0

DpCommAttachTable: attached comm table (header=00000000131E5E50/ft=00000000131E5E60/fi=00000000139042E0)

DpSockAttachTable: attached sock table (header=0000000013921600/ft=0000000013921610)

MBUF state OFF

DpCommInitTable: init table for 500 entries

DpSockInitTable: init table for 500 entries

EmInit: MmSetImplementation( 2 ).

MM global diagnostic options set: 0

<ES> client 12 initializing ....

<ES> EsILock: use Semphore 33 for locking

<ES> block size is 4096 kByte.

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

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

<ES> Info: disclaim threshold = 0 MB

<ES> Info: disclaim coasting/alloc = 300 s

<ES> Info: disclaim coasting/free = 0 s

<ES> Info: blockdisclaimsize_KB = 0 KB

Using implementation view

<EsNT> Using memory model view.

<EsNT> Memory Reset disabled as NT default

<ES> 179 blocks reserved for free list.

ES initialized.

mm.dump: set maximum dump mem to 96 MB

rdisp/calculateLoadAverage : 1

***LOG Q0K=> DpMsAttach, mscon ( sapconv103) [dpMessageSer 1648]

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

DpStartStopMsg: start msg sent to message server o.k.

MBUF state LOADING

MPI: dynamic quotas disabled.

MPI init: pipes=4000 buffers=6395 reserved=1918 quota=10%

Mon Jul 07 16:21:23 2014

CreateProcess gwrd (PID:5540  HANDLE:956)

*** WARNING => System running without ICM - check rdisp/start_icman [dpInit.c     2625]

create new work process W0 (PID:3156 HANDLE:964)

create new work process W1 (PID:5988 HANDLE:976)

create new work process W2 (PID:5680 HANDLE:980)

create new work process W3 (PID:348 HANDLE:984)

create new work process W4 (PID:2576 HANDLE:988)

create new work process W5 (PID:352 HANDLE:992)

create new work process W6 (PID:3916 HANDLE:996)

CCMS: Initialized monitoring segment of size 60000000.

CCMS: Initialized CCMS Headers in the shared monitoring segment.

CCMS: Checking Downtime Configuration of Monitoring Segment.

Mon Jul 07 16:21:24 2014

CCMS: AlMsUpload called by wp 1024.

CCMS: AlMsUpload successful for E:\usr\sap\HR6\SUM\abap\system\HR6\DVEBMGS31\log\ALMTTREE.DAT (219 MTEs).

Mon Jul 07 16:21:25 2014

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

DpCheckPreemptionTicker: created thread for DpPremptionTicker

DpMBufHwIdSet: set Hardware-ID

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

MBUF state ACTIVE

DpMBufTypeMod: MBUF component UP (event=MBUF_DPEVT_UP)

DpMsgProcess: 1 server in MBUF

DpMsCheckServices()

DpMsgProcess: MBUF state is MBUF_ACTIVE

DpMBufReset: state = MBUF_PREPARED

Mon Jul 07 16:21:31 2014

***

*** DpRqNoWpHandle: SHUTDOWN request from W6 received (reason=DP_SHUTDOWN_UNKNOWN_REASON) ***

***

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

Force W0 in state WP_NEW to dump stack

Force W1 in state WP_NEW to dump stack

Force W2 in state WP_NEW to dump stack

Force W3 in state WP_NEW to dump stack

Force W4 in state WP_NEW to dump stack

Force W5 in state WP_NEW to dump stack

Force W6 in state WP_NEW to dump stack

Scheduler info

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

WP info

DpNumberOfDiaWps: dia_wps 3, standby_wps 0

  #dia     = 3

  #btc     = 2

  #standby = 0

  #max     = 12

General Scheduler info

  preemptionInfo.isActive           = true

  preemptionInfo.timeslice          = 500

  preemptionInfo.checkLoad          = true

Prio Class High

  maxRuntime[RQ_Q_PRIO_HIGH]     = infinite

  maxRuntimeHalf[RQ_Q_PRIO_HIGH] = infinite

Prio Class Normal

  maxRuntime[RQ_Q_PRIO_NORMAL]           = infinite

  maxRuntimeHalf[RQ_Q_PRIO_NORMAL]       = infinite

  maxTicketsForPrio[RQ_Q_PRIO_NORMAL]    = 2

  withPrioTickets[RQ_Q_PRIO_NORMAL]      = true

Prio Class Low

  maxRuntime[RQ_Q_PRIO_LOW]           = infinite

  maxRuntimeHalf[RQ_Q_PRIO_LOW]       = infinite

  maxTicketsForPrio[RQ_Q_PRIO_LOW]    = 2

  withPrioTickets[RQ_Q_PRIO_LOW]      = true

Actual tickets in use

  actTicketsInUseForPrio[RQ_Q_PRIO_NORMAL]    = 0

  actTicketsInUseForPrio[RQ_Q_PRIO_LOW]    = 0

Running requests[RQ_Q_PRIO_NORMAL] = 0

Running requests[RQ_Q_PRIO_LOW] = 0

Queue Statistics    Mon Jul 07 14:21:31 2014

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

Number of lost wakeup datagrams: 0

Max. number of queue elements : 14000

NOWP:     1 (peak     3, writeCount       25, readCount       24)

DIA :     2 (peak     2, writeCount        2, readCount        0)

UPD :     1 (peak     1, writeCount        1, readCount        0)

ENQ :     0 (peak     0, writeCount        0, readCount        0)

BTC :     0 (peak     0, writeCount        0, readCount        0)

SPO :     0 (peak     0, writeCount        0, readCount        0)

UP2 :     0 (peak     0, writeCount        0, readCount        0)

DISP:     0 (peak     2, writeCount       24, readCount       24)

GW  :     0 (peak     0, writeCount        0, readCount        0)

IC  :     1 (peak     1, writeCount        1, readCount        0)

LWP :     0 (peak     0, writeCount        0, readCount        0)

Session queue dump (high priority, 2 elements, peak 2):

  -1 <-   17 <                 EmbryoQueue_DIA> ->   18

  17 <-   18 <                 EmbryoQueue_UPD> ->   -1

Session queue dump (normal priority, 0 elements, peak 0):

Session queue dump (low priority, 0 elements, peak 0):

Dump of queue <IcmanQueue> in slot 2 (1 requests, in use, port=0):

  -1 <-    0 (rq_id 3418, NOWP,  REQ_HANDLER_ICMAN_OPCODE_RESP) ->   -1

Dump of queue <EmbryoQueue_DIA> in slot 17 (2 requests, port=0):

  -1 <-    1 (rq_id 3420,  DIA,             REQ_HANDLER_AUTOTH) ->    2

   1 <-    2 (rq_id 3439,  DIA,              REQ_HANDLER_MSADM) ->   -1

Dump of queue <EmbryoQueue_UPD> in slot 18 (1 requests, port=0):

  -1 <-    4 (rq_id 3462,  UPD,             REQ_HANDLER_UPDATE) ->   -1

Infos about some special queues:

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

Workprocess Table (long)        Mon Jul 07 14:21:31 2014

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

DEV_W0

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

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

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

*

*  ACTIVE TRACE LEVEL           1

*  ACTIVE TRACE COMPONENTS      all, MJ

*

M sysno      31

M sid        HR6

M systemid   562 (PC with Windows NT)

M relno      7410

M patchlevel 0

M patchno    36

M intno      20020600

M make       multithreaded, Unicode, 64 bit, optimized

M profile    E:\usr\sap\HR6\SUM\abap\system\HR6\SYS\profile\HR6_DVEBMGS31_sapconv103

M pid        3156

M

M Mon Jul 07 16:21:23 2014

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

M  length of sys_adm_ext is 500 bytes

M  ***LOG Q0Q=> tskh_init, WPStart (Workp. 0 3156) [dpInit.c     731]

M  DpCommonParamInit: rdisp/core_file_size = default --> no change

I  MtxInit: 30000 0 0

M  DpIPCInit2: read dp-profile-values from sys_adm_ext

M  DpShMCreate: alloate/attach shared memory (mode=ATTACH)

M  DpShMCreate: sizeof(wp_adm) 13248 (1104)

M  DpShMCreate: sizeof(tm_adm) 51472080 (256080)

M  DpShMCreate: sizeof(ca_adm) 432000 (72)

M  DpCommTableSize: max/headSize/ftSize/tableSize=500/16/7464064/7583152

M  DpShMCreate: sizeof(comm_adm) 7583152 (14912)

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

M  DpShMCreate: sizeof(slock_adm) 0 (296)

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

M  DpShMCreate: sizeof(file_adm) 0 (80)

M  DpSockTableSize: max/headSize/ftSize/tableSize=500/16/520064/520080

M  DpShMCreate: sizeof(sock_adm) 520080 (1016)

M  DpShMCreate: sizeof(vmc_adm) 0 (3208)

M  DpShMCreate: sizeof(wall_adm) (ft=41664/fi=67472/hd=64/rec=192)

M  DpShMCreate: sizeof(amc_rec_adm) (ft=86464/fi=67472/hd=64/rec=416)

M  DpShMCreate: sizeof(websocket_adm) (ft=28864/hd=64/rec=272)

M  DpShMCreate: sizeof(gw_adm) 64

M  DpShMCreate: sizeof(j2ee_adm) 3936

M  DpShMCreate: SHM_DP_ADM_KEY (addr: 0000000010660050, size: 60422880

M  DpShMCreate: allocated sys_adm at 0000000010660250

M  DpShMCreate: allocated wp_adm_list at 00000000106720E0

M  DpShMCreate: allocated wp_adm at 0000000010672400

M  DpShMCreate: allocated tm_adm_list at 00000000106759C0

M  DpShMCreate: allocated tm_adm at 0000000010675C00

M  DpShMCreate: allocated ca_adm at 000000001378C4D0

M  DpShMCreate: allocated comm_adm at 00000000137F5E50

M  DpShMCreate: system runs without slock table

M  DpShMCreate: allocated sock_adm at  0000000013F31600

M  DpShMCreate: allocated vmc_adm_list at 0000000013FB0790

M  DpShMCreate: system runs without VMC

M  DpShMCreate: allocated gw_adm at 0000000013FB0A30

M  DpShMCreate: allocated j2ee_adm at 0000000013FB0C70

M  DpShMCreate: allocated ca_info at 0000000013FB1DD0

M  DpShMCreate: allocated wall_adm (ft) at 0000000013FB2010

M  DpShMCreate: allocated wall_adm (fi) at 0000000013FBC4D0

M  DpShMCreate: allocated wall_adm (head) at 0000000013FCCE60

M  DpShMCreate: allocated amc_rec_adm (ft) at 0000000013FCD0A0

M  DpShMCreate: allocated amc_rec_adm (fi) at 0000000013FE2460

M  DpShMCreate: allocated amc_rec_adm (head) at 0000000013FF2DF0

M  DpShMCreate: allocated websocket_adm (ft) at 0000000013FF3030

M  DpShMCreate: allocated websocket_adm (head) at 0000000013FFA2F0

M  DpShMCreate: initialized 21 eyes

M  DpCommAttachTable: attached comm table (header=00000000137F5E50/ft=00000000137F5E60/fi=0000000013F142E0)

M  DpSockAttachTable: attached sock table (header=0000000013F31600/ft=0000000013F31610)

X  EmInit: MmSetImplementation( 2 ).

X  MM global diagnostic options set: 0

X  <ES> client 0 initializing ....

X  <ES> EsILock: use Semphore 33 for locking

X  Using implementation view

X  <EsNT> Using memory model view.

M  <EsNT> Memory Reset disabled as NT default

X  ES initialized.

X  mm.dump: set maximum dump mem to 96 MB

M  ThStart: taskhandler started

M  ThInit: initializing DIA work process W0

M Mon Jul 07 16:21:24 2014

M  ThInit: running on host sapconv103

I  MtxInit: 0 0 0

M  calling db_connect ...

B  Loading DB library 'E:\usr\sap\HR6\SUM\abap\exe\dbmssslib.dll' ...

B  Library 'E:\usr\sap\HR6\SUM\abap\exe\dbmssslib.dll' loaded

B  Version of 'E:\usr\sap\HR6\SUM\abap\exe\dbmssslib.dll' is "741.10", patchlevel (0.20)

C  Callback functions for dynamic profile parameter registered

C  Thread ID:3712

C  Thank You for using the SLODBC-interface

C  Using dynamic link library 'E:\usr\sap\HR6\SUM\abap\exe\dbmssslib.dll'

C  7410 dbmssslib.dll patch info

C    SAP patchlevel  0

C    SAP patchno  26

C    Last MSSQL DBSL patchlevel 0

C    Last MSSQL DBSL patchno         20

C    Last MSSQL DBSL patchcomment Retry on error 4711 (1972365)

C Mon Jul 07 16:21:25 2014

C  ODBC Driver chosen: SQL Server Native Client 11.0 native

C  lpc:(local) connection used on sapconv103

C  lpc:(local) connection used on sapconv103

C  Driver: sqlncli11.dll Driver release: 11.00.2100

C  GetDbRelease: 10.50.2500.00

C  GetDbRelease: Got DB release numbers (10,50,2500,0)

C  comm. rd. spid 77

C  unc. rd. spid 81

B  Connection 0 opened (DBSL handle 0)

M  ThDbConnect: db_connect o.k.

X Mon Jul 07 16:21:31 2014

X  EmInit: MmSetImplementation( 2 ).

X  MM global diagnostic options set: 0

X  <ES> client 0 initializing ....

X  Using implementation view

X  ES initialized.

X  mm.dump: set maximum dump mem to 96 MB

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

B  Start CursorInit

B  TBI initializing lock manager ...

B  TBI locking          : multiple locks

B  TBI lock manager impl: semamphore

B  dbtbxbuf: Buffer TBI64 (addr: 000000002BDE0140, size: 90945896, end: 000000003149BAA8)

B  DBI: init TBI BUFFER (data):  start=000007DFF7801000  length=86850560  end=000007DFFCAD4C00

B  dbprotocol: table logging switched off for all clients

B  dbsync[db_syinit]: successfully attached to shared memory, sync_adm_p = 0000000002910050

B  dbsync[db_syinit]: Buffer synchronisation started with

B    sync_concept      = SEQ_NR

B    sendon            = 0

B    bufreftime        = 120

B    max_gap_wait_time = 60

B    ddlog_del_time    = 60

B    last_counter      = 74

B    oldest_gap        = (2147483647,19700101010000)

B    time_of_last_sync = 20140707162128

B    MySysId           = 'sapconv103          31'

B  dbexpbuf[EXP_SHB]: successfully attached to shared memory

B  dbexpbuf[EXP_SHB]: buffer installed with the following properties

B    semKey             = 35

B    shmKey             = 54

B    wpCnt              = 12

B    blockSize          = 512

B    maxObjects         = 2621

B    maxObjectSize      = 2436224

B    freeListVectorSize = 489

B    hashVectorSize     = 5261

B    bufferSize         = 10737664

B    maxBlocks          = 19033

B    freeBlocksCnt      = 19033

B    mutexVectorSize    = 5263, ADMIN_MUTEX = 5261, INVAL_MUTEX = 5262

B    tracing            = 0

B    forceChecks        = 0

B    protectShm         = 0

B  dbexpbuf[EXP_SHM]: successfully attached to shared memory

B  dbexpbuf[EXP_SHM]: buffer installed with the following properties

B    semKey             = 56

B    shmKey             = 65

B    wpCnt              = 12

B    blockSize          = 512

B    maxObjects         = 2000

B    maxObjectSize      = 860032

B    freeListVectorSize = 17

B    hashVectorSize     = 4001

B    bufferSize         = 4194304

B    maxBlocks          = 6719

B    freeBlocksCnt      = 6719

B    mutexVectorSize    = 4003, ADMIN_MUTEX = 4001, INVAL_MUTEX = 4002

B    tracing            = 0

B    forceChecks        = 0

B    protectShm         = 0

B  dbexpbuf[EXP_CUA]: successfully attached to shared memory

B  dbexpbuf[EXP_CUA]: buffer installed with the following properties

B    semKey             = 30

B    shmKey             = 47

B    wpCnt              = 12

B    blockSize          = 512

B    maxObjects         = 2000

B    maxObjectSize      = 578304

B    freeListVectorSize = 587

B    hashVectorSize     = 4001

B    bufferSize         = 3072000

B    maxBlocks          = 4518

B    freeBlocksCnt      = 4518

B    mutexVectorSize    = 4003, ADMIN_MUTEX = 4001, INVAL_MUTEX = 4002

B    tracing            = 0

B    forceChecks        = 0

B    protectShm         = 0

B  dbexpbuf[EXP_OTR]: successfully attached to shared memory

B  dbexpbuf[EXP_OTR]: buffer installed with the following properties

B    semKey             = 55

B    shmKey             = 64

B    wpCnt              = 12

B    blockSize          = 256

B    maxObjects         = 2000

B    maxObjectSize      = 859904

B    freeListVectorSize = 33

B    hashVectorSize     = 4001

B    bufferSize         = 4194304

B    maxBlocks          = 13436

B    freeBlocksCnt      = 13436

B    mutexVectorSize    = 4003, ADMIN_MUTEX = 4001, INVAL_MUTEX = 4002

B    tracing            = 0

B    forceChecks        = 0

B    protectShm         = 0

B  NTAB: Structure of NTAB on DB is VERS_B, unicodelg of executable is 2, unicodelg of SVERS in nametab is 2

M  SHM_PRES_BUF (addr: 000000002D740050, size: 4400000)

M  ThCreateNoBuffer allocated 548152 bytes for 1000 entries at 0000000003280050

M  ThCreateNoBuffer index size: 3000 elems

M  ThCreateVBAdm allocated 33376 bytes (50 server) at 0000000002920050

M  ICT: exclude compression: *.zip,*.rar,*.arj,*.z,*.gz,*.tar,*.lzh,*.cab,*.hqx,*.ace,*.jar,*.ear,*.war,*.jpg,*.pdf,*.gzip,*.uue,*.bz2,*.iso,*.sda,*.sar,*.gif,*.png,*.swc,*.swf

G  RelWritePermissionForShm( pLocation = 120, pEnforce = 0 )

G  GetWritePermissionForShm( pLocation =  99, pEnforce = 1 )

G  RelWritePermissionForShm( pLocation = 100, pEnforce = 1 )

S  *** init spool environment

S  TSPEVJOB updates outside critical section: event_update_nocsec = 1

S  initialize debug system

T  Stack direction is downwards.

T  debug control: prepare exclude for printer trace

T  new memory block 000000002225D310

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 00000000227E00D0

S  doing lock recovery

S  setting server cache root

S  found spool memory service RSPO-SERVERCACHE at 00000000227E04A0

S    using messages for server info

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

S  size of open spool request entry: 2512 bytes

S  immediate print option for implicitely closed spool requests is disabled

M  ThrCreateShObjects allocated 25000 bytes at 0000000002940050

M  *** ERROR => ThrInitServInfo: MtxOpen failed (7) [thxxrun1.c   242]

M  *** ERROR => ThrExclusiveInitRunTime: ThrInitServInfo failed (-1) [thxxrun1.c   216]

M  *** ERROR => ThrExclusiveInitRunTime failed (-1) [thxxext.c    597]

M  *** ERROR => ThShMInit: ThExclusiveStartUp failed (-1) [thxxhead.c   1622]

M  *** ERROR => ThIPCInit: ThShMInit failed, shutdown server [thxxhead.c   1405]

M  call semaphore clean-up function ...

M  ***LOG Q0E=> DpSigGenHandler, Exception (e06d7363) [dpnttool.c   450]

M  ------------------ C-STACK ----------------------

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

Copyright (C) SAP AG. All rights reserved.

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

Application exception occurred:

Exception : e06d7363 (Uncaught C++ exception)

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

When      : 7/7/2014 16:21:37.42

Threads   : 2

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

Computer Name       : SAPCONV103

User Name           : SAPServiceHR6

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

Number of Processors: 4

Processor Type: Intel64 Family 6 Model 15 Stepping 6

Windows Version     : 6.1 Current Build: 7601

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

State Dump for Thread Id e80

*---->(FAULT) Stack Back Trace <----*

000000000206F440 00000000751014F1 000000000206F510 KERNELBASE!RaiseException

000000000206F4B0 000000013F1B0BBB 000000013F050000 MSVCR100!CxxThrowException

000000000206F520 000000013F1B2D7F 0000000000000002 disp+work!ThTriggerTaskSwitch [threquest.c (2636)]

000000000206F600 000000013F13E84C 00FFFFFFFFFFFFFF disp+work!ThISendRequest [threquest.c (3691)]

000000000206F630 000000013F13DDD4 0000000143276C28 disp+work!ThIPCInit [thxxhead.c (1413)]

000000000206F8F0 000000013F13D1C1 0000000000000000 disp+work!ThInit [thxxhead.c (1108)]

000000000206F950 000000013F063F1B 0000000000000000 disp+work!ThStart [thxxhead.c (770)]

000000000206F9B0 000000013F0527F6 FFFFFFFFFFFFFFFE disp+work!DpMain [dpinit.c (475)]

000000000206F9E0 0000000140F29386 0000000000000001 disp+work!nlsui_main [thxxanf.c (79)]

000000000206FA10 000000007785652D 0000000000000000 disp+work!__tmainCRTStartup [crtexe.c (552)]

000000000206FA40 0000000077AEC521 0000000000000000 kernel32!BaseThreadInitThunk

000000000206FA90 0000000000000000 0000000000000000 ntdll!RtlUserThreadStart

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

State Dump for Thread Id 1770

*----> Stack Back Trace <----*

000000000DD4F6A0 000007FEFE18C3FF 0000000000000000 ntdll!ZwFsControlFile

000000000DD4F710 0000000140CD46EF FFFFFFFFFFFFFFFE KERNELBASE!ConnectNamedPipe

000000000DD4F7B0 00000000750C1D9F 00000000078C1830 disp+work!SigIMsgFunc [signt.c (723)]

000000000DD4F7E0 00000000750C1E3B 0000000075152AC0 MSVCR100!endthreadex

000000000DD4F810 000000007785652D 0000000000000000 MSVCR100!endthreadex

000000000DD4F840 0000000077AEC521 0000000000000000 kernel32!BaseThreadInitThunk

000000000DD4F890 0000000000000000 0000000000000000 ntdll!RtlUserThreadStart

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

M  -------------------------------------------------

M Mon Jul 07 16:21:38 2014

M  call clean-up function ...

M  ThSigHandler (0, Signal)

M  in_ThErrHandle: 1

M  ThSigHandler: Signal for invalid T-1_M255 (step TH_WORK_NOSYNC, thRc ERROR-CORE-ABORTED_BY_SIGNAL, action RETURN_FOR_DUMP)

M  Info for wp 0

M    pid = 3156

M    severity = 0

M    status = 0

M    stat = WP_NEW

M    waiting_for = NO_WAITING

M    workerType = DP_WORKER_DIAWP

M    act_cs_count = 0

M    csTrack = 0

M    csTrackRwExcl = 0

M    csTrackRwShrd = 0

M    mode_cleaned_counter = 0

M    control_flag = 0

M    report = >                                        <

M    action = 0

M    tab_name = >                              <

M  ThIErrHandle: no current incoming request

M  *****************************************************************************

M  *

M  *  LOCATION    SAP-Server sapconv103_HR6_31 on host sapconv103 (wp 0)

M  *  ERROR       ThSigHandler: Signal

M  *

M  *  TIME        Mon Jul 07 16:21:38 2014

M  *  RELEASE     741

M  *  COMPONENT   Taskhandler

M  *  VERSION     1

M  *  RC          16789511

M  *  MODULE      D:/depot/bas/741_REL/src/krn/si/th/thxxhead.c

M  *  LINE        2470

M  *  COUNTER     1

M  *

M  *****************************************************************************

M  PfRejectStatistic: clear statistic record

M  PfClearAllRec: clear statistic area

M  PfClearAllRec: statRecordAction = STAT_RECORD_ACTION_REJECT

M  Entering TH_CALLHOOKS

M  ThCallHooks: call hooks for event BEFORE_DUMP

M  ThIErrHandle: entering ThSetStatError

C  SlBreak

B  db_sqlbreak() = 15

M  *** WARNING => ThCallDbBreak: db_sqlbreak failed (16388), caller=ThIErrHandle

M  ThIErrHandle: action is RETURN_FOR_DUMP, skip rollback

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

B  Disconnecting from ALL connections:

B  Wp  Hdl ConName          ConId     ConState     TX  BC  OC  HC  PRM RCT INF TIM MAX OPT Date     Time   DBHost         

B  000 000 R/3              000000000 INACTIVE     NO  NO  000 NO  YES NO  NO  000 255 255 20140707 162124 SAPCONV103                                              

B  Disconnected from connection 0

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

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

M  ThIErrHandle: Detach all shared memory segments in EM

M  ***LOG Q02=> wp_halt, WPStop (Workp. 0 3156) [dpnttool.c   335]

M  return from clean-up function ...

Current snapshot id: 1

Number of preemptions                   : 0

|No |Pid   |Type|State  |Cause|Err|Prio|Sess-Key        |Sess-Type|Locked|Sem|Time |Program                                 |Cli|User        |Action              |Action-Info         |

|---+------+----+-------+-----+---+----+----------------+---------+------+---+-----+----------------------------------------+---+------------+--------------------+--------------------|

|  0|3156  |DIA |WP_NEW |     |   |    |                |         |      |10 |     |                                        |   |            |                    |                    |

|  1|5988  |DIA |WP_NEW |     |   |    |                |         |      |10 |     |                                        |   |            |                    |                    |

|  2|5680  |DIA |WP_NEW |     |   |    |                |         |10    |   |     |                                        |   |            |                    |                    |

|  3|348   |UPD |WP_NEW |     |   |    |                |         |      |10 |     |                                        |   |            |                    |                    |

|  4|2576  |BTC |WP_NEW |     |   |    |                |         |      |   |     |                                        |   |            |                    |                    |

|  5|352   |BTC |WP_NEW |     |   |    |                |         |      |10 |     |                                        |   |            |                    |                    |

|  6|3916  |SPO |WP_NEW |     |   |    |                |         |      |   |     |                                        |   |            |                    |                    |

Session Table    Mon Jul 07 14:21:31 2014

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

No logons/sessions found

CA Blocks

    0 INVALID                    -1

    1 INVALID                    -1

2 ca_blk slots of 6000 in use, 2 currently unowned (in request queues)

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

Mon Jul 07 16:21:41 2014

DpTriggerSapSnapshot: start E:\usr\sap\HR6\SUM\abap\exe\sapcontrol.EXE

DpTriggerSapSnapshot: sapcontrol runs with pid 6416

***LOG Q41=> DpDumpInternalTables,  () [dpxxdisp.c   3262]

DpHalt: shutdown server >sapconv103_HR6_31                       < (normal)

DpModState: change server state from STARTING to SHUTDOWN

DpHalt: stop work processes

Mon Jul 07 16:21:43 2014

DpHalt: stop gateway

DpHalt: terminate gui connections

DpHalt: wait for end of work processes

DpHalt: wait for end of gateway

DpHalt: waiting for termination of gateway ...

Mon Jul 07 16:21:44 2014

[DpProcDied] Process died  (PID:5540  HANDLE:956  rc:0x0)

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

DpStartStopMsg: stop msg sent to message server o.k.

Mon Jul 07 16:21:45 2014

DpHalt: sync with message server o.k.

DpHalt: detach from message server

***LOG Q0M=> DpMsDetach, ms_detach () [dpMessageSer 2056]

MBUF state OFF

DpMBufTypeMod: MBUF component DOWN (event=MBUF_DPEVT_DOWN)

DpHalt: cleanup EM

***LOG Q05=> DpHalt, DPStop ( 5948) [dpInit.c     3488]

*******************************************************************************************************************

Accepted Solutions (1)

Accepted Solutions (1)

Reagan
Advisor
Advisor
0 Kudos

Hello

Based on the log files I believe you are missing some OS prerequisites.

Additionally check whether this SAP note is valid

1958065 - System does not start with activated SQL audit

Regards

RB

Answers (3)

Answers (3)

former_member238981
Discoverer
0 Kudos

Hello again,

thanks to everyone. I have tried all your solutions before posting here, but it didnt work.

Anyway, finally i was able to start the shadow instance. Reagan Benjamin gave me the idea from his first post. The solution to the problem was to update the kernel in shadow instance to last one available in SAP MarketPlace (Not just kernel stack, also d+w, R3trans, tp, etc. packets). With this new kernel, it is working at the moment.

Thanks again and best regards,

cherry_tian
Employee
Employee
0 Kudos

Hi, Lgnacio

I found the error message in dev_w0:

M  *** ERROR => ThrInitServInfo: MtxOpen failed (7) [thxxrun1.c   242]

M  *** ERROR => ThrExclusiveInitRunTime: ThrInitServInfo failed (-1) [thxxrun1.c   216]

M  *** ERROR => ThrExclusiveInitRunTime failed (-1) [thxxext.c    597]

M  *** ERROR => ThShMInit: ThExclusiveStartUp failed (-1) [thxxhead.c   1622]

M  *** ERROR => ThIPCInit: ThShMInit failed, shutdown server [thxxhead.c   1405]

It looks like some operating system resources (mutexes) are left over

from a previous crash of the instance. These resources seem to prevent

the instance from starting up again. In order to remove the resources

and restart the instance, please try the following:

Log on as <sid>adm

Execute the following commands:

    cleanipc 01 remove

    sapcontrol -nr 01 -function RestartService

    sapcontrol -nr 01 -function Start

(01 is the shadow instance number )

If it still fails to start, please attach the latest dev_w0 trace and dev_disp trace.

Best regards.

Cherry.

Reagan
Advisor
Advisor
0 Kudos

Log on as <sid>adm

Execute the following commands:

    cleanipc 01 remove

    sapcontrol -nr 01 -function RestartService

    sapcontrol -nr 01 -function Start

(01 is the shadow instance number )

How will cleanipc work on a Windows platform ?

Regards

RB

former_member188883
Active Contributor
0 Kudos

Hi Ignacio,

For testing purpose can you stop main development instance and then try starting shadow instance.

This is to rule out any problems with memory bottlenecks.

Regards,

Deepak Kori