Skip to Content
0
Former Member
Oct 07, 2013 at 07:49 PM

Error when start SAP system

1476 Views

Hello,

I´m with some problems when I try to start our SAP system (ERP) through the SAP MMC. The SAP MMC show me the following error

I checked some log files... in sapstartsrv.log file I see the following text:

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

trc file: "sapstartsrv.log", trc level: 0, release: "720"

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

pid 2292

[Thr 2340] Mon Oct 07 18:26:50 2013

SAP HA Trace: SAP Microsoft Cluster library '720, patch 401, changelist 0' initialized

CCMS agent initialization for instance type ABAP: return code 0.

CCMS agent start: return code 0.

Initializing SAPControl Webservice

Starting AutoRestart thread

AutoRestart thread started, version check is enabled

SapSSLInit failed => https support disabled

Starting WebService Named Pipe thread

Starting WebService thread

Webservice named pipe thread started, listening on port \\.\pipe\sapcontrol_00

Webservice thread started, listening on port 50013

I also checked the dev_disp and dev_w0 files:

- dev_disp:

...

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

use internal message server connection to port 3900

rdisp/dynamic_wp_check : 1

rdisp/calculateLoadAverage : 1

Thu Oct 03 00:31:06 2013

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

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

MtxInit: 30000 0 0

DpSysAdmExtInit: ABAP is active

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

DpIPCInit2: write dp-profile-values into sys_adm_ext

DpIPCInit2: start server >PICES0401_SDP_00 <

DpShMCreate: sizeof(wp_adm) 54144 (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: 0000000003680050, size: 7186112)

DpShMCreate: allocated sys_adm at 0000000003680060

DpShMCreate: allocated wp_adm_list at 00000000036830B0

DpShMCreate: allocated wp_adm at 00000000036832A0

DpShMCreate: allocated tm_adm_list at 0000000003690630

DpShMCreate: allocated tm_adm at 0000000003690680

DpShMCreate: allocated wp_ca_adm at 0000000003BD3590

DpShMCreate: allocated appc_ca_adm at 0000000003BE2FA0

DpShMCreate: allocated comm_adm at 0000000003BF29B0

DpShMCreate: system runs without slock table

DpShMCreate: system runs without file table

DpShMCreate: allocated vmc_adm_list at 0000000003D44850

DpShMCreate: system runs without vmc_adm

DpShMCreate: allocated gw_adm at 0000000003D44900

DpShMCreate: allocated j2ee_adm at 0000000003D44940

DpShMCreate: allocated ca_info at 0000000003D458C0

DpShMCreate: allocated wall_adm at 0000000003D45950

DpCommAttachTable: attached comm table (header=0000000003BF29B0/ft=0000000003BF29C0)

DpSysAdmIntInit: initialize sys_adm

rdisp/test_roll : roll strategy is DP_NORMAL_ROLL

dia token check not active (11 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( 15358MB) not multiple of em/blocksize_KB( 4096KB)

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

Using implementation view

<EsNT> Using memory model view.

<EsNT> Memory Reset disabled as NT default

<ES> 3839 blocks reserved for free list.

ES initialized.

mm.dump: set maximum dump mem to 96 MB

DpVmcSetActive: set vmc state DP_VMC_NOT_ACTIVE

MPI: dynamic quotas disabled.

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

Thu Oct 03 00:31:08 2013

rdisp/http_min_wait_dia_wp : 1 -> 1

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

Thu Oct 03 00:31:09 2013

***LOG Q0K=> DpMsAttach, mscon ( PICES0401) [dpxxdisp.c 12674]

MBUF state LOADING

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

DpStartStopMsg: start msg sent

CCMS: SemInMgt: Semaphore Management initialized by AlAttachShm_Doublestack.

CCMS: SemInit: Semaphore 38 initialized by AlAttachShm_Doublestack.

Thu Oct 03 00:31:10 2013

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

DpMBufHwIdSet: set Hardware-ID

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

MBUF state ACTIVE

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

MBUF component UP

DpMsgProcess: 1 server in MBUF

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

Thu Oct 03 00:31:33 2013

DpModState: change server state from STARTING to ACTIVE

Thu Oct 03 00:32:35 2013

DpWpConf: change wps: DIA 11->10, VB 2->2, ENQ 1->1, BTC 5->6, SPO 2->2 VB2 1->1 RESTR 0->0 DYN 2->2

***LOG Q0V=> DpWpConf, mod_req ( 0DIABTC) [dpxxdisp.c 15546]

DpAdaptWppriv_max_no : 6 -> 5

DpWpConf: operation mode switch completed

Thu Oct 03 07:00:29 2013

DpWpConf: change wps: DIA 10->11, VB 2->2, ENQ 1->1, BTC 6->5, SPO 2->2 VB2 1->1 RESTR 0->0 DYN 2->2

***LOG Q0V=> DpWpConf, mod_req ( 16BTCDIA) [dpxxdisp.c 15546]

DpAdaptWppriv_max_no : 5 -> 6

DpWpConf: operation mode switch completed

Thu Oct 03 10:30:42 2013

***LOG Q0I=> NiIRead: P=10.10.50.7:50280; L=0.0.0.0:3200: recv (10053: WSAECONNABORTED: Software caused connection abort) [nixxi.cpp 5087]

*** ERROR => NiIRead: SiRecv failed for hdl 50/sock 940

(SI_ECONN_BROKEN/10053; I4; ST; P=10.10.50.7:50280; L=0.0.0.0:3200) [nixxi.cpp 5087]

DpRTmPrepareReq: network error of client T26, NiBufReceive (-6: NIECONN_BROKEN), dp_tm_status=3

Thu Oct 03 10:30:46 2013

DpRTmPrepareReq: client address of T26 is 10.10.50.7(10.10.50.7)

***LOG Q04=> DpRTmPrep, NiBufReceive (123 EBUTA 26 MW79KZY1KQJR) [dpxxdisp.c 12335]

RM-T26, U123, 500 EBUTA, MW79KZY1KQJR2J, 10:28:29, M2, W5, FBL3, 4/1

Thu Oct 03 11:49:30 2013

*** ERROR => DpCheckTerminals: NiCheck2(rc=-23) failed for tid: 28 (60secs)-> disconnecting [dpxxdisp.c 13256]

RM-T28, U154, 500 BOLIVEIRA, R98B3YM, 11:08:00, M3, W16, ME22, 5/1

Thu Oct 03 15:53:35 2013

*** ERROR => DpCheckTerminals: NiCheck2(rc=-23) failed for tid: 29 (60secs)-> disconnecting [dpxxdisp.c 13256]

RM-T29, U178, 500 BOLIVEIRA, R98B3YM, 15:32:26, M2, W7, ME22, 4/1

Thu Oct 03 17:33:39 2013

***LOG Q0I=> NiIRead: P=10.10.50.19:50133; L=0.0.0.0:3200: recv (10053: WSAECONNABORTED: Software caused connection abort) [nixxi.cpp 5087]

*** ERROR => NiIRead: SiRecv failed for hdl 69/sock 1104

(SI_ECONN_BROKEN/10053; I4; ST; P=10.10.50.19:50133; L=0.0.0.0:3200) [nixxi.cpp 5087]

DpRTmPrepareReq: network error of client T29, NiBufReceive (-6: NIECONN_BROKEN), dp_tm_status=3

Thu Oct 03 17:33:43 2013

DpRTmPrepareReq: client address of T29 is 10.10.50.19(10.10.50.19)

***LOG Q04=> DpRTmPrep, NiBufReceive (223 JQUEIROS 29 MW7UE6ZUEY2X) [dpxxdisp.c 12335]

RM-T29, U223, 500 JQUEIROS, MW7UE6ZUEY2XDE, 16:52:47, M0, W5, SE16, 2/2

Thu Oct 03 17:47:55 2013

*** ERROR => DpCheckTerminals: NiCheck2(rc=-23) failed for tid: 26 (60secs)-> disconnecting [dpxxdisp.c 13256]

RM-T26, U190, 500 EBUTA, MW79KZY1KQJR2J, 17:26:48, M3, W8, FB05, 5/3

Thu Oct 03 18:48:33 2013

DpSigInt: caught signal 2

DpHalt: shutdown server >PICES0401_SDP_00 < (normal)

DpModState: change server state from ACTIVE to SHUTDOWN

DpHalt: stop work processes

Thu Oct 03 18:48:34 2013

DpHalt: stop gateway

DpHalt: stop icman

DpHalt: terminate gui connections

DpHalt: wait for end of work processes

DpHalt: waiting for termination of work processes ...

Thu Oct 03 18:48:35 2013

DpHalt: waiting for termination of work processes ...

Thu Oct 03 18:48:36 2013

DpHalt: waiting for termination of work processes ...

Thu Oct 03 18:48:37 2013

DpHalt: waiting for termination of work processes ...

- dev_w0:

...

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

M length of sys_adm_ext is 588 bytes

M ***LOG Q0Q=> tskh_init, WPStart (Workp. 0 4052) [dpxxdisp.c 1382]

I MtxInit: 30000 0 0

M DpSysAdmExtCreate: ABAP is active

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

M DpIPCInit2: read dp-profile-values from sys_adm_ext

M DpShMCreate: sizeof(wp_adm) 54144 (2256)

M DpShMCreate: sizeof(tm_adm) 5517056 (27448)

M DpShMCreate: sizeof(wp_ca_adm) 64000 (64)

M DpShMCreate: sizeof(appc_ca_adm) 64000 (64)

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

M DpShMCreate: sizeof(comm_adm) 1384080 (2744)

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 DpShMCreate: sizeof(vmc_adm) 0 (2160)

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

M DpShMCreate: sizeof(gw_adm) 48

M DpShMCreate: sizeof(j2ee_adm) 3952

M DpShMCreate: SHM_DP_ADM_KEY (addr: 000000000C0C0050, size: 7186112)

M DpShMCreate: allocated sys_adm at 000000000C0C0060

M DpShMCreate: allocated wp_adm_list at 000000000C0C30B0

M DpShMCreate: allocated wp_adm at 000000000C0C32A0

M DpShMCreate: allocated tm_adm_list at 000000000C0D0630

M DpShMCreate: allocated tm_adm at 000000000C0D0680

M DpShMCreate: allocated wp_ca_adm at 000000000C613590

M DpShMCreate: allocated appc_ca_adm at 000000000C622FA0

M DpShMCreate: allocated comm_adm at 000000000C6329B0

M DpShMCreate: system runs without slock table

M DpShMCreate: system runs without file table

M DpShMCreate: allocated vmc_adm_list at 000000000C784850

M DpShMCreate: system runs without vmc_adm

M DpShMCreate: allocated gw_adm at 000000000C784900

M DpShMCreate: allocated j2ee_adm at 000000000C784940

M DpShMCreate: allocated ca_info at 000000000C7858C0

M DpShMCreate: allocated wall_adm at 000000000C785950

M DpCommAttachTable: attached comm table (header=000000000C6329B0/ft=000000000C6329C0)

M DpRqQInit: use protect_queue / slots_per_queue 0 / 2001 from sys_adm

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

X EmInit: MmSetImplementation( 2 ).

X MM global diagnostic options set: 0

X <ES> client 0 initializing ....

X <ES> EsILock: use spinlock 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 DpVmcSetActive: set vmc state DP_VMC_NOT_ACTIVE

M

M Thu Oct 03 00:31:10 2013

M ThStart: taskhandler started

M ThInit: initializing DIA work process W0

M

M Thu Oct 03 00:31:12 2013

M ThInit: running on host PICES0401

M calling db_connect ...

B Loading DB library 'K:\usr\sap\SDP\DVEBMGS00\exe\dbmssslib.dll' ...

B

B Thu Oct 03 00:31:13 2013

B Library 'K:\usr\sap\SDP\DVEBMGS00\exe\dbmssslib.dll' loaded

B Version of 'K:\usr\sap\SDP\DVEBMGS00\exe\dbmssslib.dll' is "720.00", patchlevel (0.324)

C Callback functions for dynamic profile parameter registered

C Thread ID:2292

C Thank You for using the SLODBC-interface

C Using dynamic link library 'K:\usr\sap\SDP\DVEBMGS00\exe\dbmssslib.dll'

C dbmssslib.dll patch info

C SAP patchlevel 0

C SAP patchno 401

C Last MSSQL DBSL patchlevel 0

C Last MSSQL DBSL patchno 324

C Last MSSQL DBSL patchcomment Local connection to a named instance does not use LPC (1782171)

C ODBC Driver chosen: SQL Server Native Client 10.0 native

C lpc:(local) connection used on PICES0401

C lpc:(local) connection used on PICES0401

C Driver: sqlncli10.dll Driver release: 10.00.2531

C GetDbRelease: 10.00.2531.00

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

B

B Thu Oct 03 00:31:15 2013

B Connection 0 opened (DBSL handle 0)

M ThInit: db_connect o.k.

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

I MtxInit: 0 0 0

M rdisp/thsend_order : -1 -> 0

M ThISend: set thsend_order to 0

M SHM_PRES_BUF (addr: 00000000183F0050, size: 4400000)

M SHM_ROLL_AREA (addr: 000007FFD1730050, size: 268435456)

M SHM_PAGING_AREA (addr: 0000000018830050, size: 134217728)

M SHM_ROLL_ADM (addr: 0000000020840050, size: 2767448)

M SHM_PAGING_ADM (addr: 0000000012F10050, size: 787488)

M ThCreateNoBuffer allocated 548152 bytes for 1000 entries at 0000000013260050

M ThCreateNoBuffer index size: 3000 elems

M ThCreateVBAdm allocated 31056 bytes (50 server) at 0000000002FC0050

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

B Thu Oct 03 00:31:19 2013

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

B

B Thu Oct 03 00:31:20 2013

B dbtbxbuf: Buffer TABL (addr: 0000000026870160, size: 30000000, end: 000000002850C4E0)

B dbtbxbuf: Profile: max_objects = 5000, displace = 1, reorg = 1

B dbtbxbuf: request_unit = 2000, sync_reload = 5, inval_reload = 5, parallel_penalty = 0

B dbtbxbuf: protect_shm = 0, force_checks = 0

B dbtbxbuf: tsize_retry = 14437376

B dbtbxbuf: obj_entry_size = 208, nt_genkey_entry_size = 28

B ***LOG BB0=> buffer TABL started with length 30000000 bytes [dbtbxbuf 16909]

B dbtbxbuf: Buffer TABLP (addr: 0000000028510160, size: 10240000, end: 0000000028ED4160)

B dbtbxbuf: Profile: max_objects = 500, displace = 1, reorg = 1

B dbtbxbuf: request_unit = 2000, sync_reload = 5, inval_reload = 5, parallel_penalty = 50

B dbtbxbuf: protect_shm = 0, force_checks = 0

B dbtbxbuf: tsize_retry = 5050112

B dbtbxbuf: obj_entry_size = 208, nt_genkey_entry_size = 28

B ***LOG BB0=> buffer TABLP started with length 10240000 bytes [dbtbxbuf 16909]

B dbtbxbuf: Reading TBX statistics:

B dbtbxbuf: 132 object entries precreated

B dbsync[db_syinit]: shared memory successfully created and initialised, sync_adm_p = 0000000002FD0050

B dbsync[db_syinit]: Buffer synchronisation started with

B sync_concept = SEQ_NR

B sendon = 1

B bufreftime = 120

B max_gap_wait_time = 60

B ddlog_del_time = 60

B last_counter = 262313

B oldest_gap = (2147483647,00000000000000)

B time_of_last_sync = 20131003003120

B MySysId = 'PICES0401 00'

B dbexpbuf[EXP_SHB]: Aquired semaphore 35 in db_exp_init(EXP_INIT)

B dbexpbuf[EXP_SHB]: shared memory layout of buffer EIBUF:

B EYE-CATCHER : 1 * 4 = 4

B ADMIN : 1 * 432 = 432

B RECOVERY : 24 * 40 = 960

B MUTEX VECTOR : 4001 * 52 = 208052

B OBJECT DIRECTORY : 2000 * 256 = 512000

B HASH VECTOR : 4001 * 8 = 32008

B STATISTICS : 1 * 200 = 200

B FREELIST : 65 * 8 = 520

B DATA SPACE : 13438 * 256 = 3440128

B dbexpbuf[EXP_SHB]: buffer EIBUF installed with

B semkey = 35

B shmkey = 54

B wp_n = 24

B sclass = 0

B block_length = 256

B max_objects = 2000

B max_obj_size = 859872

B pref_obj_size = 0

B est_large_obj_size = 16384

B free_vec_lg = 65

B hash_vec_size = 4001

B buffer_l = 4194304

B max_blocks = 13438

B free_blocks = 13438

B mutex_n = 4001

B max_mtx_wait_time = 17000

B recovery_delay = 500000

B tracing = 0

B force_checks = 0

B protect_shm = 0

B ***LOG BB0=> buffer EIBUF started with length 4096k bytes [dbexpbuf 2277]

B dbexpbuf[EXP_SHB]: semaphore 35 released in db_exp_init

B dbexpbuf[EXP_SHM]: Aquired semaphore 56 in db_exp_init(EXP_INIT)

B dbexpbuf[EXP_SHM]: shared memory layout of buffer ESM :

B EYE-CATCHER : 1 * 4 = 4

B ADMIN : 1 * 432 = 432

B RECOVERY : 24 * 40 = 960

B MUTEX VECTOR : 4001 * 52 = 208052

B OBJECT DIRECTORY : 2000 * 256 = 512000

B HASH VECTOR : 4001 * 8 = 32008

B STATISTICS : 1 * 200 = 200

B FREELIST : 65 * 8 = 520

B DATA SPACE : 13438 * 256 = 3440128

B dbexpbuf[EXP_SHM]: buffer ESM installed with

B semkey = 56

B shmkey = 65

B wp_n = 24

B sclass = 0

B block_length = 256

B max_objects = 2000

B max_obj_size = 859872

B pref_obj_size = 0

B est_large_obj_size = 16384

B free_vec_lg = 65

B hash_vec_size = 4001

B buffer_l = 4194304

B max_blocks = 13438

B free_blocks = 13438

B mutex_n = 4001

B max_mtx_wait_time = 17000

B recovery_delay = 500000

B tracing = 0

B force_checks = 0

B protect_shm = 0

B ***LOG BB0=> buffer ESM started with length 4096k bytes [dbexpbuf 2277]

B dbexpbuf[EXP_SHM]: semaphore 56 released in db_exp_init

B dbexpbuf[EXP_CUA]: Aquired semaphore 30 in db_exp_init(EXP_INIT)

B dbexpbuf[EXP_CUA]: shared memory layout of buffer CUA :

B EYE-CATCHER : 1 * 4 = 4

B ADMIN : 1 * 432 = 432

B RECOVERY : 24 * 40 = 960

B MUTEX VECTOR : 3001 * 52 = 156052

B OBJECT DIRECTORY : 1500 * 256 = 384000

B HASH VECTOR : 3001 * 8 = 24008

B STATISTICS : 1 * 200 = 200

B FREELIST : 193 * 8 = 1544

B DATA SPACE : 4892 * 512 = 2504704

B dbexpbuf[EXP_CUA]: buffer CUA installed with

B semkey = 30

B shmkey = 47

B wp_n = 24

B sclass = 10

B block_length = 512

B max_objects = 1500

B max_obj_size = 626016

B pref_obj_size = 0

B est_large_obj_size = 98304

B free_vec_lg = 193

B hash_vec_size = 3001

B buffer_l = 3072000

B max_blocks = 4892

B free_blocks = 4892

B mutex_n = 3001

B max_mtx_wait_time = 17000

B recovery_delay = 500000

B tracing = 0

B force_checks = 0

B protect_shm = 0

B ***LOG BB0=> buffer CUA started with length 3000k bytes [dbexpbuf 2277]

B dbexpbuf[EXP_CUA]: semaphore 30 released in db_exp_init

B dbexpbuf[EXP_OTR]: Aquired semaphore 55 in db_exp_init(EXP_INIT)

B dbexpbuf[EXP_OTR]: shared memory layout of buffer OTR :

B EYE-CATCHER : 1 * 4 = 4

B ADMIN : 1 * 432 = 432

B RECOVERY : 24 * 40 = 960

B MUTEX VECTOR : 4001 * 52 = 208052

B OBJECT DIRECTORY : 2000 * 256 = 512000

B HASH VECTOR : 4001 * 8 = 32008

B STATISTICS : 1 * 200 = 200

B FREELIST : 81 * 8 = 648

B DATA SPACE : 13437 * 256 = 3439872

B dbexpbuf[EXP_OTR]: buffer OTR installed with

B semkey = 55

B shmkey = 64

B wp_n = 24

B sclass = 13

B block_length = 256

B max_objects = 2000

B max_obj_size = 859808

B pref_obj_size = 0

B est_large_obj_size = 20480

B free_vec_lg = 81

B hash_vec_size = 4001

B buffer_l = 4194304

B max_blocks = 13437

B free_blocks = 13437

B mutex_n = 4001

B max_mtx_wait_time = 17000

B recovery_delay = 500000

B tracing = 0

B force_checks = 0

B protect_shm = 0

B ***LOG BB0=> buffer OTR started with length 4096k bytes [dbexpbuf 2277]

B dbexpbuf[EXP_OTR]: semaphore 55 released in db_exp_init

B ***LOG BB0=> buffer CALE started with length 500000 bytes [dbcalbuf 2211]

B

B Thu Oct 03 00:31:21 2013

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

B max_blocking_factor = 50, min_blocking_factor = 5,

B max_in_blocking_factor = 255, min_in_blocking_factor = 10,

B max_union_blocking_factor = 50, min_union_blocking_factor = 5,

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,

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

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

M

M Thu Oct 03 00:31:24 2013

M SecAudit(rsauinit): Start init of Security Audit Log for first wp.

M SecAudit(rsauinit): New shared memory created and attached, size = 19488.

M SecAudit(RsauShmInit): addr of SHM for Audit.... = 0000000002FE0050

M SecAudit(RsauShmInit): addr of RSAUSHM.......... = 0000000002FE1050

M SecAudit(RsauShmInit): addr of RSAUSLOTINFO..... = 0000000002FE1660

M SecAudit(RsauShmInit): addr of RSAUSLOTS........ = 0000000002FE1670

M SecAudit(RsauShmInit): SHM version.............. = 6

M SecAudit(RsauShmInit): max size of one file..... = 0 KB

M SecAudit(RsauShmInit): max size of all files.... = 102400 KB

M SecAudit(RsauShmInit): number of slots available = 90

M SecAudit(RsauShmInit): number of slots requested = 2

M SecAudit(RsauShmInit): user selection........... = 0

M SecAudit(RsauGetCurrentProfile): Init of shared memory completed

M SecAudit(RsauGetCurrentProfile): Security Audit Log not active

M SsfSapSecin: automatic application server initialization for SAPSECULIB

N SsfSapSecin: Looking for PSE in database

N SsfPseLoad: started...(path=K:\usr\sap\SDP\DVEBMGS00\sec, AS=PICES0401, instanceid=00)

N

N Thu Oct 03 00:31:25 2013

N SsfPseLoad: Downloading file K:\usr\sap\SDP\DVEBMGS00\sec\SAPHTTPCS.pse (client: , key: 135858, len: 1956)

N SsfPseLoad: Downloading file K:\usr\sap\SDP\DVEBMGS00\sec\SAPSYS.pse (client: , key: SYSPSE, len: 1885)

N SsfPseLoad: ended (2 of 2 sucessfully loaded, 2 checked...

N MskiCreateLogonTicketCache: Logon Ticket cache created in shared memory.

N MskiCreateLogonTicketCache: Logon Ticket cache pointer registered in shared memory.

N SignInitOnce: Security Context Cache created (max. 2500 entries, 1305600 bytes)

N No SEC_CONTEXT_COPY records found for deletion

I

I Thu Oct 03 00:31:26 2013

I MPI: dynamic quotas disabled.

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

M rdisp/thwpsf_critical_path : -1 -> 0

M CCMS: SemInMgt: Semaphore Management initialized by AlAttachShm_Doublestack.

M CCMS: SemInit: Semaphore 38 initialized by AlAttachShm_Doublestack.

G GetWritePermissionForShm( pLocation = 94, pEnforce = 1 )

G

G Thu Oct 03 00:31:27 2013

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 0000000029F1F650

S spool kernel/ddic check: Ok

S using table TSP02FX for frontend printing

S 2 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 0000000013C600D0

S doing lock recovery

S setting server cache root

S found spool memory service RSPO-SERVERCACHE at 0000000013C60800

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

A

A Thu Oct 03 00:31:28 2013

A ***GENER* Trace switched on ***

A

A ---PXA-------------------------------------------

A PXA INITIALIZATION

A

A Thu Oct 03 00:31:29 2013

A PXA: Locked PXA-Semaphore.

A System page size: 4kb, total admin_size: 37956kb, dir_size: 37132kb.

A Attached to PXA (address 000007FFE1760050, size 500000K, 1 fragments of 462044K )

A PXA allocated (address 000007FFE1760050, size 500000K)

A abap/pxa = shared protect gen_remote

A PXA: checking structure sizes: 752|272|16

A PXA INITIALIZATION FINISHED

A ---PXA-------------------------------------------

A

A ATRA: pfclock execution time = 1

A ABAP ShmAdm attached (addr=000007DFDF18C000 leng=20955136 end=000007DFE0588000)

A >> Shm MMADM area (addr=000007DFDF683C20 leng=242240 end=000007DFDF6BEE60)

A >> Shm MMDAT area (addr=000007DFDF6BF000 leng=15503360 end=000007DFE0588000)

A RFC Destination> destination PICES0401_SDP_00 host PICES0401 system SDP systnr 0 (PICES0401_SDP_00)

A RFC Options> H=PICES0401,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

H HTTP> Parameter icf/ssocookie_mandatory set to 0

A Hotpackage version: 6

M

M Thu Oct 03 00:31:30 2013

M ThrCreateShObjects allocated 49904 bytes at 0000000002FF0050

Y dyWpInit

Y ztta/dynpro_ara 800000

Y ztta/cua_ara 500000

Y ztta/diag_ara 250000

N SsfSapSecin: putenv(SECUDIR=K:\usr\sap\SDP\DVEBMGS00\sec): ok

N SsfSapSecin: PSE K:\usr\sap\SDP\DVEBMGS00\sec\SAPSYS.pse found!

N

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

N === SSF INITIALIZATION:

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

N ===...SSF library is K:\usr\sap\SDP\DVEBMGS00\exe\sapcrypto.dll .

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

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

N ===...loading of Security Toolkit successfully completed.

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

N

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

N === SSF INITIALIZATION:

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

N ===...SSF library is K:\usr\sap\SDP\DVEBMGS00\exe\sapsecu.dll .

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

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

N ===...SECUDIR="K:\usr\sap\SDP\DVEBMGS00\sec"

N ===...loading of Security Toolkit completed with rc 5 (SSF_SUP_NOTALLFUNCTIONS).

N === SAPSECULIB Version 5.4.28M-6

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

N

N Thu Oct 03 00:31:31 2013

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

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: 720, [7200.0.401.20020600]

W ITS Plugin: Int.version, [33]

W ITS Plugin: Feature set: [30]

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

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

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

N SignInit: successfully obtained handle for Security Context cache

N VSI: WP init in ABAP VM completed with rc=0

E

E Thu Oct 03 00:31:33 2013

E EnqLockTableAttach2: attach to lock table (size = 33554432)

E EnqLockTableMapToLocalContext: enque/use_pfclock2 = FALSE

E EnqId_Initialize: local EnqId initialization o.k.

M

M Thu Oct 03 00:31:36 2013

M 02.10.2013 23:31:36.961 PID=4052, TID=2292 SapTimer info. v1.119 SynchCount:0 , OwnerPid: 2592, ErrsCount: 0, SapTime-WindowsUtcTime=+1 millisec (max=+1), Nosync=35 sec, SynchsPerDay=0.000000, MaxQpcTimeMinusWindowsTimeMismatch: +0 millisec, TotalTimeCorrection=+0 millisec, QpcTime-WindowsUtcTime=+1 millisec (*)

A

A Thu Oct 03 00:31:39 2013

A UpdateProfile (new settings): off,krn_impl,(no dyn check),(no logging),(no stat err),(local generation),(no commit)

A UpdateProfile (new exceptions): (tmp_err),(home_err),(local_err)

A UpdateProfile (new version): 0

A ***GENER* Trace switched off ***

E

E Thu Oct 03 00:31:40 2013

E Enqueue Info: enque/use_pfclock2 = FALSE

E Enqueue Info: row condense enabled

S

S Thu Oct 03 00:32:29 2013

S found spool memory service RSPO-ACTIONS at 0000000013C6A540

M

M Thu Oct 03 00:32:35 2013

M ThReqtypeChanged: new type of work process W0 is BTC

W ipl_ipl_HookSwitchOpMode: switch to BTC

M PfSetStatLevel: new stat level = 1

M DpReadMinJvm: rdisp/min_jvm (REM): 0 -> 1

M DpReadMinJvm: rdisp/min_jvm (AUTOJAVA): 0 -> 1

M DpReadMinJvm: rdisp/min_jvm (TEMPLATE): 0 -> 1

C

C Thu Oct 03 08:45:29 2013

C Thread ID:2292

C Thank You for using the SLODBC-interface

C Using dynamic link library 'K:\usr\sap\SDP\DVEBMGS00\exe\dbmssslib.dll'

C dbmssslib.dll patch info

C SAP patchlevel 0

C SAP patchno 401

C Last MSSQL DBSL patchlevel 0

C Last MSSQL DBSL patchno 324

C Last MSSQL DBSL patchcomment Local connection to a named instance does not use LPC (1782171)

C ODBC Driver chosen: SQL Server Native Client 10.0 native

C lpc:(local) connection used on PICES0401

C lpc:(local) connection used on PICES0401

C Driver: sqlncli10.dll Driver release: 10.00.2531

C GetDbRelease: 10.00.2531.00

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

B Connection 1 opened (DBSL handle 1)

B

B Thu Oct 03 09:01:29 2013

B Disconnected from connection 1, con_da={R/3*MSS,14}

B

B Thu Oct 03 11:32:35 2013

B dbmyclu : info : my major identification is 168435241, minor one 0.

B dbmyclu : info : Time Reference is 1.12.2001 00:00:00h GMT.

B dbmyclu : info : my initial uuid is E32C171D83ED3FF18A0A000C2924C754.

B dbmyclu : info : current optimistic cluster level: 3

B dbmyclu : info : pessimistic reads set to 2.

G

G Thu Oct 03 11:32:55 2013

G GetWritePermissionForShm( pLocation = 283, pEnforce = 0 )

G RelWritePermissionForShm( pLocation = 277, pEnforce = 0 )

G GetWritePermissionForShm( pLocation = 283, pEnforce = 0 )

G RelWritePermissionForShm( pLocation = 277, pEnforce = 0 )

G GetWritePermissionForShm( pLocation = 281, pEnforce = 0 )

G RelWritePermissionForShm( pLocation = 277, pEnforce = 0 )

S

S Thu Oct 03 11:32:56 2013

S handle memory type is RSTSPROMMM

G GetWritePermissionForShm( pLocation = 283, pEnforce = 0 )

G RelWritePermissionForShm( pLocation = 277, pEnforce = 0 )

M

M Thu Oct 03 18:48:33 2013

M in_ThErrHandle: 1

M ThIErrHandle: new stat of W0 is WP_SHUTDOWN

M ThIErrHandle: I'm during shutdown

M PfStatDisconnect: disconnect statistics

M ThIErrHandle: entering ThSetStatError

C SlBreak

B db_sqlbreak() = 15

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

M ThIErrHandle: don't try rollback again

M ThShutDownServer: shutdown server

M PfWriteIntoFile: shared buffer is empty.

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

M Entering ThReadDetachMode

M call ThrShutDown (1)...

B Disconnecting from ALL connections:

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

B 000 000 R/3 000000000 INACTIVE NO NO NO YES NO NO 000 255 255 20131003 003113 PICES0401

B 000 001 R/3*MSS 000000014 DISCONNECTED NO NO NO NO NO NO 000 255 255 20131003 090130 PICES0401 CL_SQL_CONNECTION=============CP

B Disconnected from connection 0

B statistics db_con_commit (com_total=2286, com_tx=1515)

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

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

So, can you help me please to know what´s the problem here!?

Regards,

samid

Attachments

SNAG-0818.jpg (24.3 kB)