Register Login

Startup of Instance Service Failed

Updated May 18, 2018

Dear Gurus,

I am facing issues while starting the sap server. After command startsup all the below error message is coming. Please help to resolve the issues.

mtldev:mtdadm 51> startsap
Checking syb Database
Database is not available via R3trans
----------------
startdb completed successfully
Starting Startup Agent sapstartsrv
FAIL: Timeout
Startup of Instance Service failed
See /home/mtdadm/startsap_DVEBMGS00.log for details

----------
mtldev:mtdadm 52> more /home/mtdadm/startsap_DVEBMGS00.log
Trace of system startup/check of SAP System MTD on Mon Jul 22 22:27:02 IST 2013

Called command: /usr/sap/MTD/SYS/exe/run/startsap start

------------
22:27:03
Starting Startup Agent sapstartsrv

-------------
22:29:09
Startup of Instance Service failed

------------
22:29:09
See /home/mtdadm/startsap_DVEBMGS00.log for details

mtldev:mtdadm 53>


Comments

  • 23 Jul 2013 7:05 am Sushma
    Hi,

    Go to the work directory of --->/usr/sap/MTD/DVEBMGS00/work and provide us the trace files for further investigation.
  • 23 Jul 2013 8:33 am amit butola
    Thanks Ram,

    For your prompt reply.

    mtldev:mtdadm 66> more sapstart0.trc
    (8567) New Child Process created.
    (8567) Starting local Command:
    Command: ms.sapMTD_DVEBMGS00
    pf=/usr/sap/MTD/SYS/profile/MTD_DVEBMGS00_mtldev
    mtldev:mtdadm 67>

    mtldev:mtdadm 65> more sapstartsrv.log

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

    [Thr 140737353885536] Tue Jul 23 00:08:15 2013
    No halib defined => HA support disabled
    CCMS agent initialization for instance type ABAP: return code 0.
    CCMS agent start: return code 0.
    Initializing SAPControl Webservice
    Starting AutoRestart thread
    [Thr 140737275516672] Tue Jul 23 00:08:16 2013
    AutoRestart thread started
    SapSSLInit failed => https support disabled
    Starting WebService thread
    Webservice thread started, listening on port 50013
    Trusted http connect via Unix domain socket '/tmp/.sapstream50013' enabled.

    mtldev:mtdadm 70> more sapstart.log

    SAP-R/3-Startup Program Rel 720 V2.0 (2008/11/15)
    ---------

    Starting at 2013/06/25 06:54:37
    Startup Profile: "/usr/sap/MTD/SYS/profile/START_DVEBMGS00_mtld ev"

    Setup Environment Variables
    -----------
    (8538) SETENV DIR_LIBRARY=/usr/sap/MTD/DVEBMGS00/exe
    (8538) SETENV LD_LIBRARY_PATH=/usr/sap/MTD/DVEBMGS00/exe:/usr/sa p/MTD/DVEBMGS00/
    exe:/usr/sap/MTD/SYS/global/syb/linuxx86_64/sybodb c:/sybase/MTD/ASE-15_0/lib:/sy
    base/MTD/OCS-15_0/lib:/sybase/MTD/OCS-15_0/lib3p64:/sybase/MTD/OCS-15_0/lib3p:/u
    sr/sap/MTD/SYS/exe/run:/usr/sap/MTD/SYS/exe/uc/lin uxx86_64
    (8538) SETENV SHLIB_PATH=/usr/sap/MTD/DVEBMGS00/exe:
    (8538) SETENV LIBPATH=/usr/sap/MTD/DVEBMGS00/exe:
    (8538) SETENV PATH=/usr/sap/MTD/DVEBMGS00/exe:/sybase/MTD/ASE-15_0/jobscheduler/
    bin:/sybase/MTD/ASE-15_0/bin:/sybase/MTD/ASE-15_0/install:/sybase/MTD/ASEP/bin:/
    sybase/MTD/DBISQL/bin:/sybase/MTD/OCS-15_0/bin:/home/mtdadm/bin:/usr/local/bin:/
    bin:/usr/bin:/usr/bin/X11:/usr/X11R6/bin:/usr/game s:/usr/lib/mit/bin:/usr/lib/mi
    t/sbin:/usr/sap/MTD/SYS/exe/uc/linuxx86_64:/usr/sa p/MTD/SYS/exe/run:/home/mtdadm
    :.
    (8538) SETENV SECUDIR=/usr/sap/MTD/DVEBMGS00/sec

    Execute Pre-Startup Commands
    -------------
    (8539) Local: /usr/sap/MTD/SYS/exe/run/sapcpe pf=/usr/sap/MTD/SYS/profile/MTD_DV
    EBMGS00_mtldev
    (8538) system(/usr/sap/MTD/SYS/exe/run/sapcpe pf=/usr/sap/MTD/SYS/profile/MTD_DV
    EBMGS00_mtldev) returns 255
    (8543) Local: /usr/sap/MTD/SYS/exe/run/sapcpe pf=/usr/sap/MTD/SYS/profile/MTD_DV
    EBMGS00_mtldev list:/usr/sap/MTD/SYS/global/syb/linuxx86_64/cpe_s ybodbc.lst sour
    ce:/usr/sap/MTD/SYS/global/syb/linuxx86_64/sybodbc
    (8547) Local: /usr/sap/MTD/SYS/exe/run/sapcpe pf=/usr/sap/MTD/SYS/profile/MTD_DV
    EBMGS00_mtldev list:/usr/sap/MTD/SYS/global/syb/linuxx86_64/cpe_s ybjdbc.lst sour
    ce:/usr/sap/MTD/SYS/global/syb/linuxx86_64
    (8551) Local: /usr/sap/MTD/SYS/exe/run/sapcpe pf=/usr/sap/MTD/SYS/profile/MTD_DV
    EBMGS00_mtldev list:/usr/sap/MTD/SYS/exe/run/sapcrypto.lst
    (8555) Local: /usr/sap/MTD/DVEBMGS00/exe/sapmscsa pf=/usr/sap/MTD/SYS/profile/MT
    D_DVEBMGS00_mtldev -n
    (8558) Local: rm -f ms.sapMTD_DVEBMGS00
    (8559) Local: ln -s -f /usr/sap/MTD/DVEBMGS00/exe/msg_server ms.sapMTD_DVEBMGS00
    (8560) Local: rm -f dw.sapMTD_DVEBMGS00
    (8561) Local: ln -s -f /usr/sap/MTD/DVEBMGS00/exe/disp+work dw.sapMTD_DVEBMGS00
    (8562) Local: rm -f ig.sapMTD_DVEBMGS00
    (8563) Local: ln -s -f /usr/sap/MTD/DVEBMGS00/exe/igswd_mt ig.sapMTD_DVEBMGS00

    Starting Programs
    -----------
    (8567) Starting: local ms.sapMTD_DVEBMGS00 pf=/usr/sap/MTD/SYS/profile/MTD_DVEBM
    GS00_mtldev
    (8568) Starting: local dw.sapMTD_DVEBMGS00 pf=/usr/sap/MTD/SYS/profile/MTD_DVEBMGS00_mtldev
    (8569) Starting: local ig.sapMTD_DVEBMGS00 -mode=profile pf=/usr/sap/MTD/SYS/profile/MTD_DVEBMGS00_mtldev
    (8567) New Child Process created.
    (8569) New Child Process created.
    (8567) Starting local Command:
    Command: ms.sapMTD_DVEBMGS00
    pf=/usr/sap/MTD/SYS/profile/MTD_DVEBMGS00_mtldev
    (8569) Starting local Command:
    Command: ig.sapMTD_DVEBMGS00
    -mode=profile
    pf=/usr/sap/MTD/SYS/profile/MTD_DVEBMGS00_mtldev
    (8538) Waiting for Child Processes to terminate.
    (8568) New Child Process created.
    (8568) Starting local Command:
    Command: dw.sapMTD_DVEBMGS00
    pf=/usr/sap/MTD/SYS/profile/MTD_DVEBMGS00_mtldev

    (8538) **** 2013/07/21 22:46:19 Caught Signal to Stop all Programs. ****

    (8538) Parent Shutdown at 2013/07/21 22:46:21
    (8538) Stop Child Process: 8569
    (8538) Wait 300 sec for Process 8569 terminating...
    (8538) Stop Child Process: 8568
    (8538) Wait 300 sec for Process 8568 terminating...
    (8538) Stop Child Process: 8567
    (8538) Wait 300 sec for Process 8567 terminating...

    Execute Post-Shutdown Commands
    -------
    (8538) Exiting with Return-Code 0. (Ok)
    mtldev:mtdadm 71>
  • 23 Jul 2013 8:34 am Sushma
    Hello,
    cd /usr/sap/MTD/DVEBMGS00/work
    provide the trace files:
    dev_ms
    dev_w0

    Also execute R3trans -d as mtdadm user and check the contents trans.log file.
  • 23 Jul 2013 8:34 am amit butola
    Thanks for the reply,
    Please find the DEV_MS details.

    mtldev:mtdadm 75> more dev_ms

    ------------
    trc file: "dev_ms.new", trc level: 1, release: "720"
    ------------

    [Thr 140737353893728] Tue Jun 25 06:54:39 2013
    [Thr 140737353893728] ms/http_max_clients = 500 -> 500
    [Thr 140737353893728] MsSSetTrcLog: trc logging active, max size = 52428800 byte
    s
    systemid 390 (AMD/Intel x86_64 with Linux)
    relno 7200
    patchlevel 0
    patchno 413
    intno 20020600
    make multithreaded, Unicode, 64 bit, optimized
    pid 8567

    [Thr 140737353893728] ***LOG Q01=> MsSInit, MSStart (Msg Server 1 8567) [msxxser
    v_mt. 2280]
    [Thr 140737353893728] SigISetDefaultAction : default handling for signal SIGCHLD
    [Thr 140737353893728] load acl file = /usr/sap/MTD/SYS/global/ms_acl_info
    [Thr 140737353893728] MsGetOwnIpAddr: my host addresses are :
    [Thr 140737353893728] 1 : [192.168.32.20] MTLDEV (HOSTNAME)
    [Thr 140737353893728] 2 : [127.0.0.1] localhost (LOCALHOST)

    [Thr 140737353893728] Tue Jun 25 06:54:49 2013
    [Thr 140737353893728] 3 : [127.0.0.2] 127.0.0.2 (NILIST)
    [Thr 140737353893728] MsHttpInit: full qualified hostname = MTLDEV
    [Thr 140737353893728] HTTP logging is switch off
    [Thr 140737353893728] set HTTP state to LISTEN
    [Thr 140737353893728] *** HTTP port 8100 state LISTEN ***
    [Thr 140737353893728] *** I listen to port sapmsMTD (3600) ***
    [Thr 140737353893728] *** I listen to internal port 3900 (3900) ***
    [Thr 140737353893728] *** HTTP port 8100 state LISTEN ***
    [Thr 140737353893728] CUSTOMER KEY: >H1970485433<
    [Thr 140737353893728] build version=720.2013.01.17

    [Thr 140737353893728] Sun Jul 21 22:46:52 2013
    [Thr 140737353893728] MsSExit: received SIGINT (2)
    [Thr 140737353893728] set HTTP state to CLOSED
    [Thr 140737353893728] *** HTTP port 8100 state CLOSED ***
    [Thr 140737353893728] ***LOG Q02=> MsSHalt, MSStop (Msg Server 8567) [msxxserv_mt. 7631]
    mtldev:mtdadm 76>
    mtldev:mtdadm 76>
  • 23 Jul 2013 8:35 am amit butola
    mtldev:mtdadm 76> more dev_w0

    ------------
    trc file: "dev_w0", trc level: 1, release: "720"
    ----------
    *
    * ACTIVE TRACE LEVEL 1
    * ACTIVE TRACE COMPONENTS all, MJ
    *
    M sysno 00
    M sid MTD
    M systemid 390 (AMD/Intel x86_64 with Linux)
    M relno 7200
    M patchlevel 0
    M patchno 401
    M intno 20020600
    M make single threaded, Unicode, 64 bit, optimized
    M profile /usr/sap/MTD/SYS/profile/MTD_DVEBMGS00_mtldev
    M pid 9086
    M
    M
    M Tue Jun 25 06:55:14 2013
    M kernel runs with dp version 138000(ext=119000) (@(#) DPLIB-INT-VERSION-138000-UC)
    M length of sys_adm_ext is 588 bytes
    M ThStart: taskhandler started
    M ThInit: initializing DIA work process W0
    M ***LOG Q01=> ThInit, WPStart (Workp. 0 1 9086) [thxxhead.c 1315]
    M
    M Tue Jun 25 06:55:19 2013
    M ThInit: running on host mtldev
    M calling db_connect ...
    B Loading DB library '/usr/sap/MTD/DVEBMGS00/exe/dbsybslib.so' ...
    B Library '/usr/sap/MTD/DVEBMGS00/exe/dbsybslib.so' loaded
    B Version of '/usr/sap/MTD/DVEBMGS00/exe/dbsybslib.so' is "720.00", patchlevel (0.324)
    C trace file set
    C Callback functions for dynamic profile parameter registered
    B con_info_ext_support(): DBSL supports extended connect protocol
    B ==> connect info for default DB will be read from ssfs
    C database is local: connect_timeout: 3
    C lib_dbsl 720 10/31/2012 09:43:00
    C 720_EXT build
    C dbsybslib.dll patch info
    C SAP patchlevel 0
    C SAP patchno 401
    C Last SYBASE DBSL patchlevel 0
    C Last SYBASE DBSL patchno 324
    C Last SYBASE DBSL patchcomment Sybase IQ: enable CESU-8 (1781296)
    C
    C Tue Jun 25 06:55:22 2013
    C spid 46 comm rd ODBC
    C spid 49 unc rd ODBC
    C Driver: Adaptive Server Enterprise (ANSI) Driver release: 15.7.0.105
    C Driver full version: Sybase ASE ODBC Driver/15.7.0/ESD#1/P/x86_64/Linux/drvmain/Build 105/64-bit/Normal/Wed Feb 15 UTC 17:32:19 2012
    C GetServerInfo version: Adaptive Server Enterprise/15.7.0/EBF 20075 SMP ESD#01 Refresh#1/P/x86_64/Enterprise Linux/aseasap/2926/64-bit/FBO/Thu May 24 08:18:46 2012
    C GetServerInfo release: 15.7.0.012
    C GetServerInfo architecture: x86_64
    C GetServerInfo edition: P
    C GetServerInfo byte width: 64 bit
    C
    C Tue Jun 25 06:55:23 2013
    C DbSlConnect hdl: 0
    C trace file set
    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,*.b z2,*.iso,*.sda,*.sar,*.gif,*.png,*.s
    wc,*.swf
    I
    I Tue Jun 25 06:55:35 2013
    I MtxInit: 0 0 0
    M SHM_PRES_BUF (addr: 7fffe5f83000, size: 4400128)
    M SHM_ROLL_AREA (addr: 7ffec8c4d000, size: 268435456)
    M SHM_PAGING_AREA (addr: 7ffeb8c4d000, size: 268435456)
    M SHM_ROLL_ADM (addr: 7fffe63b7000, size: 11142696)
    M SHM_PAGING_ADM (addr: 7ffeb892c000, size: 3277856)
    M ThCreateNoBuffer allocated 564152 bytes for 1000 entries at 7ffeb1e5e000
    M ThCreateNoBuffer index size: 3000 elems
    M ThCreateVBAdm allocated 31072 bytes (50 server) at 7ffff7e17000
    X EmInit: MmSetImplementation( 2 ).
    X MM global diagnostic options set: 0
    X client 0 initializing ....
    X Using implementation std
    X Linux: Kernel supports shared memory disclaiming
    X Linux: using madvise(, , 9).
    X Linux: disclaiming for shared memory enabled
    X ES initialized.
    X mm.dump: set maximum dump mem to 96 MB
    I *** INFO SHM 45 in POOL 40 4728 KB estimated 3625 KB real ( -1103 KB -24 %)
    B db_con_shm_ini: WP_ID = 0, WP_CNT = 45, CON_ID = -1
    B dbtbxbuf: Buffer TABL (addr: 7ffead53d100, size: 30000128, end: 7ffeaf1d9500)
    B dbtbxbuf: Buffer TABLP (addr: 7ffeacb79100, size: 10240000, end: 7ffead53d100)
    B dbsync[db_syinit]: successfully attached to shared memory, sync_adm_p = 7ffeb4e59000
    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 = 5178351
    B oldest_gap = (2147483647,00000000000000)
    B time_of_last_sync = 20130625065529
    B MySysId = 'mtldev 00'
    B dbexpbuf[EXP_SHB]: buffer EIBUF installed with
    B semkey = 35
    B shmkey = 54
    B wp_n = 45
    B sclass = 0
    B block_length = 256
    B max_objects = 2000
    B max_obj_size = 843616
    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 = 13184
    B free_blocks = 13184
    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 dbexpbuf[EXP_SHM]: buffer ESM installed with
    B semkey = 56
    B shmkey = 65
    B wp_n = 45
    B sclass = 0
    B block_length = 256
    B max_objects = 2000
    B max_obj_size = 843616
    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 = 13184
    B free_blocks = 13184
    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 dbexpbuf[EXP_CUA]: buffer CUA installed with
    B semkey = 30
    B shmkey = 47
    B wp_n = 45
    B sclass = 10
    B block_length = 512
    B max_objects = 1500
    B max_obj_size = 613728
    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 = 4796
    B free_blocks = 4796
    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 dbexpbuf[EXP_OTR]: buffer OTR installed with
    B semkey = 55
    B shmkey = 64
    B wp_n = 45
    B sclass = 13
    B block_length = 256
    B max_objects = 2000
    B max_obj_size = 843552
    B pref_obj_size = 0
    B est_large_obj_size = 20480
    B free_vec_lg = 81
    B sclass = 0
    B block_length = 256
    B max_objects = 2000
    B max_obj_size = 843616
    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 = 13184
    B free_blocks = 13184
    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 dbexpbuf[EXP_SHM]: buffer ESM installed with
    B semkey = 56
    B shmkey = 65
    B wp_n = 45
    B sclass = 0
    B block_length = 256
    B max_objects = 2000
    B max_obj_size = 843616
    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 = 13184
    B free_blocks = 13184
    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 dbexpbuf[EXP_CUA]: buffer CUA installed with
    B semkey = 30
    B shmkey = 47
    B wp_n = 45
    B sclass = 10
    B block_length = 512
    B max_objects = 1500
    B max_obj_size = 613728
    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 = 4796
    B free_blocks = 4796
    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 dbexpbuf[EXP_OTR]: buffer OTR installed with
    B semkey = 55
    B shmkey = 64
    B wp_n = 45
    B sclass = 13
    B block_length = 256
    B max_objects = 2000
    B max_obj_size = 843552
    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 = 13183
    B free_blocks = 13183
    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
    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
    G Tue Jun 25 06:55:37 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 66b50a0
    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
    I *** INFO SHM 49 in POOL 40 2898 KB estimated 1632 KB real ( -1266 KB -44 %)
    S found processing queue enabled
    S found spool memory service RSPO-RCLOCKS at 7ffeb514a070
    S doing lock recovery
    S setting server cache root
    S found spool memory service RSPO-SERVERCACHE at 7ffeb514b040
    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 Tue Jun 25 06:55:40 2013
    A ***GENER* Trace switched on ***
    A
    A ---PXA-------
    A PXA INITIALIZATION
    A PXA: Locked PXA-Semaphore.
    A PXA: max_map_count = 1000000: ok
    A System page size: 4kb, total admin_size: 25184kb, dir_size: 24216kb.
    A Attached to PXA (address 7ffe95e8f000, size 300000K, 1 fragments of 274816K )
    A PXA allocated (address 7ffe95e8f000, size 300000K)
    A abap/pxa = shared protect gen_remote
    A PXA: checking structure sizes: 752|272|8
    A PXA INITIALIZATION FINISHED
    A ---PXA----
    A
    A ATRA: pfclock execution time = 0
    A ABAP ShmAdm attached (addr=7ffedf9c3000 leng
    955136 end=7ffee0dbf000)
    A >> Shm MMADM area (addr=7ffedfec5eb0 leng=241472 end=7ffedff00df0)
    A >> Shm MMDAT area (addr=7ffedff01000 leng=15454208 end=7ffee0dbe000)
    A RFC Destination> destination mtldev_MTD_00 host mtldev system MTD systnr 0 (mtldev_MTD_00)
    A RFC Options> H=mtldev,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
    B dbtran INFO (init_connection '' [SYBASE:720.00]):
    B max_blocking_factor = 50, min_blocking_factor = 1,
    B max_in_blocking_factor = 128, min_in_blocking_factor = 1,
    B max_union_blocking_factor = 50, min_union_blocking_factor = 1,
    B prefer_union_all = 0, prefer_join = 0,
    B prefer_fix_blocking = 0, prefer_in_itab_opt = 1,
    B convert AVG = 1, alias table FUPD = 0,
    B escape_as_literal = 0,
    B select * =0x0f, character encoding = STD / []:X,
    B use_hints = abap->1, dbif->0x1, upto->0
    M
    M Tue Jun 25 06:55:41 2013
    M ThrCreateShObjects allocated 93542 bytes at 7ffff7e00000
    Y dyWpInit
    Y ztta/dynpro_ara 800000
    Y ztta/cua_ara 500000
    Y ztta/diag_ara 250000
    N SsfSapSecin: getenv(SECUDIR)=="/usr/sap/MTD/DVEBMGS00/sec quot;
    N
    N =======
    N === SSF INITIALIZATION:
    N ===...SSF Security Toolkit name SAPSECULIB .
    N ===...SSF library is /usr/sap/MTD/DVEBMGS00/exe/libsapcrypto.so .
    N ===...SSF default hash algorithm is SHA1 .
    N ===...SSF default symmetric encryption algorithm is DES-CBC .
    N ===...SECUDIR="/usr/sap/MTD/DVEBMGS00/sec"
    N ===...loading of Security Toolkit successfully completed.
    N === SAPCRYPTOLIB 5.5.5C pl32 (Apr 2 2011) MT-safe
    N ======
    N
    N Tue Jun 25 06:55:53 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 Tue Jun 25 06:55:54 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 Tue Jun 25 06:56:05 2013
    M rdisp/thsend_order : -1 -> 0
    M ThISend: set thsend_order to 0
    M
    M Sun Jul 21 22:46:37 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 -> SybBreak
    C SybBreak 0
    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 20130625 065519 mtldev
    C DbSlDisconnect hdl: 0
    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 ***LOG Q02=> wp_halt, WPStop (Workp. 0 9086) [dpuxtool.c 327]
  • 23 Jul 2013 8:36 am amit butola
    mtldev:mtdadm 80> more trans.log
    4 ETW000 R3trans version 6.23 (release 720 - 31.10.12 - 20:12:06).
    4 ETW000 unicode enabled version
    4 ETW000 =====
    4 ETW000
    4 ETW000 date&time : 23.07.2013 - 01:08:01
    4 ETW000 control file:
    4 ETW000 R3trans was called as follows: R3trans -d
    4 ETW000 trace at level 2 opened for a given file pointer
    4 ETW000 [ dev trc,00000] Tue Jul 23 01:08:01 2013 113 0.000113
    4 ETW000 [ dev trc,00000] db_con_init called 27 0.000140
    4 ETW000 [ dev trc,00000] set_use_ext_con_info(): ssfs will be used to get connect information
    4 ETW000 45 0.000185
    4 ETW000 [ dev trc,00000] determine_block_commit: no con_hdl found as blocked for con_name = R/3
    4 ETW000 37 0.000222
    4 ETW000 [ dev trc,00000] create_con (con_name=R/3) 23 0.000245
    4 ETW000 [ dev trc,00000] Loading DB library '/usr/sap/MTD/SYS/exe/run/dbsybslib.so' ... 54 0.000299
    4 ETW000 [ dev trc,00000] DlLoadLib() success: dlopen("/usr/sap/MTD/SYS/exe/run/dbsybslib.so" ;), hdl 0
    4 ETW000 1180 0.001479
    4 ETW000 [ dev trc,00000] Library '/usr/sap/MTD/SYS/exe/run/dbsybslib.so' loaded 28 0.001507
    4 ETW000 [ dev trc,00000] function DbSlExpFuns loaded from library /usr/sap/MTD/SYS/exe/run/dbsybslib.so
    4 ETW000 36 0.001543
    4 ETW000 [ dev trc,00000] Version of '/usr/sap/MTD/SYS/exe/run/dbsybslib.so' is "720.00", patchlevel (0.324)
    4 ETW000 1859 0.003402
    4 ETW000 [ dev trc,00000] function dsql_db_init loaded from library /usr/sap/MTD/SYS/exe/run/dbsybslib.so
    4 ETW000 46 0.003448
    4 ETW000 [ dev trc,00000] function dbdd_exp_funs loaded from library /usr/sap/MTD/SYS/exe/run/dbsybslib.so
    4 ETW000 33 0.003481
    4 ETW000 [ dev trc,00000] New connection 0 created 34 0.003515
    4 ETW000 [ dev trc,00000] 0: name = R/3, con_id = -000000001, state = DISCONNECTED, tx = NO , bc = NO , hc = NO , perm = YES, reco = NO , frco = NO , timeout = 00
    0, con_max = 255, con_opt = 255, occ = NO , prog =
    4 ETW000 47 0.003562
    4 ETW000 [ dev trc,00000] db_con_connect (con_name=R/3) 30 0.003592
    4 ETW000 [ dev trc,00000] determine_block_commit: no con_hdl found as blocked for con_name = R/3
    4 ETW000 30 0.003622
    4 ETW000 [ dev trc,00000] find_con_by_name found the following connection: 20 0.003642
    4 ETW000 [ dev trc,00000] 0: name = R/3, con_id = 000000000, state = DISCONNECTED, tx = NO , bc = NO , hc = NO , perm = YES, reco = NO , frco = NO , timeout = 000
    , con_max = 255, con_opt = 255, occ = NO , prog =
    4 ETW000 38 0.003680
    4 ETW000 [ dev trc,00000] read_con_info_ssfs(): reading connect info for connection R/3 22 0.003702
    4 ETW000 [ dev trc,00000] con_info_ext_support(): DBSL supports extended connect protocol 29 0.003731
    4 ETW000 ==> connect info for default DB will be read from ssfs
    4 ETW000 [ dev trc,00000] con_info_ext_support(): auth/shadow_upgrade = undefined 71 0.003802
    4 ETW000 ==> Using default key set to get connect info from ssfs
    4 ETW000 [ dev trc,00000] read_ssfs_record(): register callback ssfs_dbi_trace and max level 2
    4 ETW000 39 0.003841
    4 ETW000 [ dev trc,00000] RSecSSFs: Entering function "RSecSSFsGetRecord" [rsecssfs.c 858] 50 0.003891
    4 ETW000 [ dev trc,00000] RSecSSFs: Configuration data read from environment parameters [rsecssfs.c 3998]
    4 ETW000 24843 0.028734
    4 ETW000 [ dev trc,00000] RSecSSFs: Data file "/usr/sap/MTD/SYS/global/security/rsecssfs/dat a/SSFS_MTD.DAT" opened for read [rsecssfs.c 2359]
    4 ETW000 94 0.028828
    4 ETW000 [ dev trc,00000] RSecSSFs: Key file "/usr/sap/MTD/SYS/global/security/rsecssfs/key /SSFS_MTD.KEY" not found, using default key [rsecssfs.c 1279]
    4 ETW000 57 0.028885
    4 ETW000 [ dev trc,00000] RSecSSFs: Exiting function "RSecSSFsGetRecord" with return code 0 (message: ) [rsecssfs.c 919]
    4 ETW000 313 0.029198
    4 ETW000 [ dev trc,00000] read_ssfs_record(): DB_CONNECT/DEFAULT_DB_USER read successfully from ssfs
    4 ETW000 33 0.029231
    4 ETW000 [ dev trc,00000] read_ssfs_record(): deregister callback ssfs_dbi_trace 23 0.029254
    4 ETW000 [ dev trc,00000] read_ssfs_record(): register callback ssfs_dbi_trace and max level 2
    4 ETW000 30 0.029284
    4 ETW000 [ dev trc,00000] RSecSSFs: Entering function "RSecSSFsGetRecord" [rsecssfs.c 858] 26 0.029310
    4 ETW000 [ dev trc,00000] RSecSSFs: Configuration data read from environment parameters [rsecssfs.c 3998]
    4 ETW000 62 0.029372
    4 ETW000 [ dev trc,00000] RSecSSFs: Data file "/usr/sap/MTD/SYS/global/security/rsecssfs/dat a/SSFS_MTD.DAT" opened for read [rsecssfs.c 2359]
    4 ETW000 68 0.029440
    4 ETW000 [ dev trc,00000] RSecSSFs: Key file "/usr/sap/MTD/SYS/global/security/rsecssfs/key /SSFS_MTD.KEY" not found, using default key [rsecssfs.c 1279]
    4 ETW000 47 0.029487
    4 ETW000 [ dev trc,00000] RSecSSFs: Exiting function "RSecSSFsGetRecord" with return code 0 (message: ) [rsecssfs.c 919]
    4 ETW000 239 0.029726
    4 ETW000 [ dev trc,00000] read_ssfs_record(): DB_CONNECT/DEFAULT_DB_PASSWORD read successfully from ssfs
    4 ETW000 44 0.029770
    4 ETW000 [ dev trc,00000] read_ssfs_record(): deregister callback ssfs_dbi_trace 21 0.029791
    4 ETW000 [ dev trc,00000] read_ssfs_record(): register callback ssfs_dbi_trace and max level 2
    4 ETW000 29 0.029820
    4 ETW000 [ dev trc,00000] RSecSSFs: Entering function "RSecSSFsGetRecord" [rsecssfs.c 858] 28 0.029848
    4 ETW000 [ dev trc,00000] RSecSSFs: Configuration data read from environment parameters [rsecssfs.c 3998]
    4 ETW000 125 0.029973
    4 ETW000 [ dev trc,00000] RSecSSFs: Data file "/usr/sap/MTD/SYS/global/security/rsecssfs/dat a/SSFS_MTD.DAT" opened for read [rsecssfs.c 2359]
    4 ETW000 69 0.030042
    4 ETW000 [ dev trc,00000] RSecSSFs: Key file "/usr/sap/MTD/SYS/global/security/rsecssfs/key /SSFS_MTD.KEY" not found, using default key [rsecssfs.c 1279]
    4 ETW000 48 0.030090
    4 ETW000 [ dev trc,00000] RSecSSFs: Record with key "DB_CONNECT/DEFAULT_DB_CON_ENV" not found in secure storage [rsecssfs.c 2381]
    4 ETW000 61 0.030151
    4 ETW000 [ dev trc,00000] RSecSSFs: Exiting function "RSecSSFsGetRecord" with return code 1 (message: Record with key "DB_CONNECT/DEFAULT_DB_CON_ENV" not found in
    secure storage) [rsecssfs.c 919]
    4 ETW000 58 0.030209
    4 ETW000 [ dev trc,00000] read_ssfs_record(): not found is accepted, RSecSSFsGetRecord(DB_CONNECT/DEFAULT_DB_CON_ENV)=1 : Record with key "DB_CONNECT/DEFAULT_DB_C
    ON_ENV" not found in secure storage
    4 ETW000 34 0.030243
    4 ETW000 [ dev trc,00000] read_ssfs_record(): deregister callback ssfs_dbi_trace 20 0.030263
    4 ETW000 [ dev trc,00000] database is local: connect_timeout: 3 7758 0.038021
    4 ETW000 [ dev trc,00000] lib_dbsl 720 10/31/2012 09:43:00 57 0.038078
    4 ETW000 [ dev trc,00000] 720_EXT build 25 0.038103
    4 ETW000 [ dev trc,00000] dbsybslib.dll patch info 103 0.038206
    4 ETW000 [ dev trc,00000] SAP patchlevel 0 23 0.038229
    4 ETW000 [ dev trc,00000] SAP patchno 401 24 0.038253
    4 ETW000 [ dev trc,00000] Last SYBASE DBSL patchlevel 0 25 0.038278
    4 ETW000 [ dev trc,00000] Last SYBASE DBSL patchno 324 25 0.038303
    4 ETW000 [ dev trc,00000] Last SYBASE DBSL patchcomment Sybase IQ: enable CESU-8 (1781296) 29 0.038332
    4 ETW000 [ dev trc,00000] spid 40 comm rd ODBC 121225 0.159557
    4 ETW000 [ dev trc,00000] spid 41 unc rd ODBC 518 0.160075
    4 ETW000 [ dev trc,00000] Driver: Adaptive Server Enterprise (ANSI) Driver release: 15.7.0.105
    4 ETW000 1374 0.161449
    4 ETW000 [ dev trc,00000] Driver full version: Sybase ASE ODBC Driver/15.7.0/ESD#1/P/x86_64/Linux/drvmain/Build 105/64-bit/Normal/Wed Feb 15 UTC 17:32:19 2012
    4 ETW000 66 0.161515
    4 ETW000 [ dev trc,00000] GetServerInfo version: Adaptive Server Enterprise/15.7.0/EBF 20075 SMP ESD#01 Refresh#1/P/x86_64/Enterprise Linux/aseasap/2926/64-bit/FB
    O/Thu May 24 08:18:46 2012
    4 ETW000 560 0.162075
    4 ETW000 [ dev trc,00000] GetServerInfo release: 15.7.0.012 469 0.162544
    4 ETW000 [ dev trc,00000] GetServerInfo architecture: x86_64 43 0.162587
    4 ETW000 [ dev trc,00000] GetServerInfo edition: P 85 0.162672
    4 ETW000 [ dev trc,00000] GetServerInfo byte width: 64 bit 36 0.162708
    4 ETW000 [ dev trc,00000] DbSlConnect hdl: 0 1493 0.164201
    4 ETW000 [ dev trc,00000] trace file set 56 0.164257
    4 ETW000 [ dev trc,00000] Connection 0 opened (DBSL handle 0) 40 0.164297
    4 ETW000 [ dev trc,00000] NTAB: Structure of NTAB on DB is VERS_B 3734 0.168031
    4 ETW000 [ dev trc,00000] NTAB: unicodelg of executable is 2 57 0.168088
    4 ETW000 [ dev trc,00000] NTAB: unicodelg of SVERS in nametab is 2 22 0.168110
    4 ETW000 [ dev trc,00000] NTAB: standalone processing 63 0.168173
    4 ETW000 [ dev trc,00000] NTAB: ntprofile(), read profile 22 0.168195
    4 ETW000 [ dev trc,00000] NTAB: rsdb/ntab/entrycount 1000. 20 0.168215
    4 ETW000 [ dev trc,00000] NTAB: rsdb/ntab/ftabsize 500. 20 0.168235
    4 ETW000 [ dev trc,00000] NTAB: rsdb/ntab/irbdsize 100. 18 0.168253
    4 ETW000 [ dev trc,00000] NTAB: rsdb/ntab/sntabsize 100. 19 0.168272
    4 ETW000 [ dev trc,00000] NTAB: compute_hash_card: 2003. 29 0.168301
    4 ETW000 [ dev trc,00000] NTAB: maxcnt 1000. 22 0.168323
    4 ETW000 [ dev trc,00000] NTAB: hfactor 2003. 18 0.168341
    4 ETW000 [ dev trc,00000] NTAB: mem_protocol_size 104 19 0.168360
    4 ETW000 [ dev trc,00000] NTAB: hdr_backpack_offset 0 18 0.168378
    4 ETW000 [ dev trc,00000] NTAB: hdr_backpack_size 0 20 0.168398
    4 ETW000 [ dev trc,00000] NTAB: FTAB: header_size 88. 19 0.168417
    4 ETW000 [ dev trc,00000] NTAB: FTAB: item_size 64. 20 0.168437
    4 ETW000 [ dev trc,00000] NTAB: FTAB: item_cnt 1000. 19 0.168456
    4 ETW000 [ dev trc,00000] NTAB: FTAB: unit_size 4 22 0.168478
    4 ETW000 [ dev trc,00000] NTAB: FTAB: unit_cnt 128000. 21 0.168499
    4 ETW000 [ dev trc,00000] NTAB: FTAB: data_size 512000. 19 0.168518
    4 ETW000 [ dev trc,00000] NTAB: IREC: header_size 88. 20 0.168538
    4 ETW000 [ dev trc,00000] NTAB: IREC: item_size 64. 19 0.168557
    4 ETW000 [ dev trc,00000] NTAB: IREC: item_cnt 250. 20 0.168577
    4 ETW000 [ dev trc,00000] NTAB: IREC: unit_size 8 19 0.168596
    4 ETW000 [ dev trc,00000] NTAB: IREC: unit_cnt 12800. 20 0.168616
    4 ETW000 [ dev trc,00000] NTAB: IREC: data_size 102400. 20 0.168636
    4 ETW000 [ dev trc,00000] NTAB: STAB: header_size 88. 19 0.168655
    4 ETW000 [ dev trc,00000] NTAB: STAB: item_size 64. 18 0.168673
    4 ETW000 [ dev trc,00000] NTAB: STAB: item_cnt 250. 21 0.168694
    4 ETW000 [ dev trc,00000] NTAB: STAB: unit_size 4 51 0.168745
    4 ETW000 [ dev trc,00000] NTAB: STAB: unit_cnt 25600. 20 0.168765
    4 ETW000 [ dev trc,00000] NTAB: STAB: data_size 102400. 19 0.168784
    4 ETW000 [ dev trc,00000] NTAB: TTAB: header_size 192. 21 0.168805
    4 ETW000 [ dev trc,00000] NTAB: TTAB: item_size 40. 18 0.168823
    4 ETW000 [ dev trc,00000] NTAB: TTAB: item_cnt 1000. 20 0.168843
    4 ETW000 [ dev trc,00000] NTAB: TTAB: unit_size 256 19 0.168862
    4 ETW000 [ dev trc,00000] NTAB: TTAB: unit_cnt 1000. 19 0.168881
    4 ETW000 [ dev trc,00000] NTAB: TTAB: data_size 256000. 19 0.168900
    4 ETW000 [ dev trc,00000] NTAB: FTAB: hh_p 2f4a140, hh_len 88 480 0.169380
    4 ETW000 [ dev trc,00000] NTAB: FTAB: aa_p 2f6c2f0, aa_len 16024 22 0.169402
    4 ETW000 [ dev trc,00000] NTAB: FTAB: ia_p 2f70190, ia_len 64000 20 0.169422
    4 ETW000 [ dev trc,00000] NTAB: FTAB: dat_p 7ffff7e1e010, dat_len 512000 20 0.169442
    4 ETW000 [ dev trc,00000] NTAB: IREC: hh_p 2f46800, hh_len 88 21 0.169463
    4 ETW000 [ dev trc,00000] NTAB: IREC: aa_p 2f7fba0, aa_len 16024 20 0.169483
    4 ETW000 [ dev trc,00000] NTAB: IREC: ia_p 2f83a40, ia_len 16000 21 0.169504
    4 ETW000 [ dev trc,00000] NTAB: IREC: dat_p 2f878d0, dat_len 102400 19 0.169523
    4 ETW000 [ dev trc,00000] NTAB: STAB: hh_p 2f65a20, hh_len 88 21 0.169544
    4 ETW000 [ dev trc,00000] NTAB: STAB: aa_p 2fa08e0, aa_len 16024 19 0.169563
    4 ETW000 [ dev trc,00000] NTAB: STAB: ia_p 2fa4780, ia_len 16000 20 0.169583
    4 ETW000 [ dev trc,00000] NTAB: STAB: dat_p 2fa8610, dat_len 102400 19 0.169602
    4 ETW000 [ dev trc,00000] NTAB: TTAB: hh_p 2f455e0, hh_len 192 21 0.169623
    4 ETW000 [ dev trc,00000] NTAB: TTAB: aa_p 2fc1620, aa_len 16024 19 0.169642
    4 ETW000 [ dev trc,00000] NTAB: TTAB: ia_p 2fc54c0, ia_len 40000 20 0.169662
    4 ETW000 [ dev trc,00000] NTAB: TTAB: dat_p 7ffff45b1010, dat_len 256000 52 0.169714
    4 ETW000 [ dev trc,00000] NTAB: ntab_mem_protocol 2f455e0, ntab_mp_p 2f455e0, ntab_proc_id 0 23 0.169737
    4 ETW000 [ dev trc,00000] NTAB: FTAB: hh_p 2f4a140, ha_list 2f6c2f0, hi_list 2f70190, buffer 7ffff7e1e010
    4 ETW000 92 0.169829
    4 ETW000 [ dev trc,00000] NTAB: IREC: hh_p 2f46800, ha_list 2f7fba0, hi_list 2f83a40, buffer 2f878d0
    4 ETW000 31 0.169860
    4 ETW000 [ dev trc,00000] NTAB: STAB: hh_p 2f65a20, ha_list 2fa08e0, hi_list 2fa4780, buffer 2fa8610
    4 ETW000 31 0.169891
    4 ETW000 [ dev trc,00000] NTAB: TTAB: hh_p 2f45648, ha_list 2fc1620, hi_list 2fc54c0, buffer 7ffff45b1010
    4 ETW000 30 0.169921
    4 ETW000 [ dev trc,00000] NTAB: mem_handler: alloc for 500 elems, task 0, art 0 31 0.169952
    4 ETW000 [ dev trc,00000] NTAB: mem_handler: alloc for 500 elems, task 0, art 1 50 0.170002
    4 ETW000 [ dev trc,00000] NTAB: mem_handler: alloc for 500 elems, task 0, art 2 29 0.170031
    4 ETW000 [ dev trc,00000] NTAB: mem_handler: alloc for 500 elems, task 0, art 3 29 0.170060
    4 ETW000 [ dev trc,00000] { db_rtab( fcode = 'RT_READ_ONLY', tname = 'TADIR' ) {twdbcall.c:764}
    4 ETW000 4803 0.174863
    4 ETW000 [ dev trc,00000] } db_rtab( fcode = 'RT_READ_ONLY', retcode = 0 ) 3067 0.177930
    4 ETW000 [ dev trc,00000] { db_rtab( fcode = 'RT_READ_ONLY', tname = 'MTSETTINGS' ) {twdbcall.c:764}
    4 ETW000 111 0.178041
    4 ETW000 [ dbcrtab ,00000] ***LOG BZ9=>table MTSETTINGS does not exist in nametab 482 0.178523
    4 ETW000 [ dev trc,00000] } db_rtab( fcode = 'RT_READ_ONLY', retcode = 32 ) 47 0.178570
    4 ETW000 Connected to DBMS = SYBASE --- --- SYSTEM = 'MTD'.
    4 ETW000 [ dev trc,00000] { db_rtab( fcode = 'RT_INSERT', tname = 'PATCHHIST' ) {saprel.c:1436}
    4 ETW000 290 0.178860
    4 ETW000 [ dev trc,00000] } db_rtab( fcode = 'RT_INSERT', retcode = 0 ) 2136 0.180996
    4 ETW000 [ dev trc,00000] { dsql_open (con_da=(0,R/3),#binds=0,#input=0, 107 0.181103
    4 ETW000 name=UNKNOWN, stmtid=NULL,
    4 ETW000 stmt="SELECT EXECUTABLE,SAPRELEASE,HOSTNAME,PLATFORM,DBVENDOR,T IMESTAMP,PATCHNO,DBSLPATCHN FROM ...")
    4 ETW000 [ dev trc,00000] } dsql_open()=0, *cu_id_p=1 2035 0.183138
    4 ETW000 [ dev trc,00000] { dsql_fetch (con_da=(0,R/3),cu_id=1,#output=8) 57 0.183195
    4 ETW000 [ dev trc,00000] } dsql_fetch()=0, rec_cnt=1, mod_cnt=1 204 0.183399
    4 ETW000 [ dev trc,00000] { dsql_close (con_da=(0,R/3),cu_id=1) 36 0.183435
    4 ETW000 [ dev trc,00000] } dsql_close()=0 46 0.183481
    4 ETW000 [ dev trc,00000] { db_rtab( fcode = 'RT_DELETE', tname = 'PATCHHIST' ) {saprel.c:1548}
    4 ETW000 36 0.183517
    4 ETW000 [ dev trc,00000] } db_rtab( fcode = 'RT_DELETE', retcode = 0 ) 1388 0.184905
    4 ETW690 COMMIT "0" "0"
    4 ETW000 [ dev trc,00000] db_con_commit (con_da={R/3,0,0},th_commit=1,tx=1,hold_cursor=0) 100 0.185005
    4 ETW000 [ dev trc,00000] dbsync[db_syflush]: to_be_committed = 1 41 0.185046
    4 ETW000 trace to file pointer closed
    4 ETW000 trace at level 1 opened for a given file pointer
    4 ETW000
    4 ETW000 === === STEP 1 =====
    4 ETW000 date&time : 23.07.2013 - 01:08:01
    4 ETW000 function : CONNECT
    4 ETW000 buffersync : YES
    4 ETW000 clients : default
    4 ETW000 commit : 100000
    4 ETW000 table cache : dynamic
    4 ETW000
    4 ETW000 [ dev trc,00000] Disconnecting from ALL connections: 360 0.000360
    4 ETW000 [ dev trc,00000] DbSlDisconnect hdl: 0 53 0.000413
    4 ETW000 [ dev trc,00000] Disconnected from connection 0 2836 0.003249
    4 ETW000 [ dev trc,00000] statistics db_con_commit (com_total=1, com_tx=1) 49 0.003298
    4 ETW000 [ dev trc,00000] statistics db_con_rollback (roll_total=0, roll_tx=0) 27 0.003325
    4 ETW000 Disconnected from database.
    4 ETW000 End of Transport (0000).
    4 ETW000 date&time: 23.07.2013 - 01:08:01
  • 23 Jul 2013 8:36 am Sushma
    Please paste contents of dev_w0.
  • 23 Jul 2013 8:37 am Sushma
    Hi,

    The Developer trace file dev_w0 looks strange:

    M Tue Jun 25 06:56:05 2013
    M rdisp/thsend_order : -1 -> 0
    M ThISend: set thsend_order to 0
    M
    M Sun Jul 21 22:46:37 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

    Please try to restart the system again and paste the contents of the new dev_w0 file.
  • 23 Jul 2013 9:18 am Sushma
    Just check whether there is enough space in the file system and also at
    table space level.

    Once run the rdtrans -d
    and check whether it is fine or not.
    Result should be 0000 if not find the trace file in same directory and read
    it.
  • 23 Jul 2013 12:05 pm Sushma
    Hello
    M Tue Jun 25 06:55:14 2013

    The dev_w0 trace file you have provided is not recent.
    Provide the latest trace files.
  • 23 Jul 2013 12:05 pm amit butola
    Thanks,

    DEV_w0 file is what i have in my system, my server is down since yesterday, I don't have any other system logs now.
  • 23 Jul 2013 12:06 pm Sushma
    So, Try a restart and send the new dev_w0 file.
  • 23 Jul 2013 12:06 pm amit butola
    Thanks,

    I have already restarted the system 3 times but there is DEV_w0 gets generated.
  • 24 Jul 2013 7:57 am Sushma
    Hello,

    Like I have mentioned above the dev_w0 and dev_ms are from the last month.
    Provide the latest trace files to find the root cause.
  • 24 Jul 2013 7:58 am amit butola
    I don't know why but theses files are not getting generated dev_w0 , dev_ms and dev_disp. Only the below mentioned files are got generated during the time since server is down.

    sapstartsrv.log
    logsave.bin
    dev_tp
    trans.log

    Please find the sapstartsrv.log file details

    mtldev:/usr/sap/MTD/DVEBMGS00/work # more sapstartsrv.log
  • 24 Jul 2013 7:58 am amit butola
    Thanks to all your reply, my issues gets sorted out with the help of below solution.

    Solution
    Upgrade the instance agent. For more information: refer SAP note 877795.
    Shutdown the instance agent, delete the UDS file and restart the instance agent that re-creates the UDS file with the correct ownership and permissions.
    Proceed as follows:
    Log on with the adm user
    Shutdown the instance agent by executing the following command:
    sapcontrol -nr -function StopService -user adm
    Change to the root user and remove the UDS file. The file is located in the /tmp directory and the file name convention is ".sapstream513"
    Change back to the adm user and start the instance agent for example, with the following command:
    sapcontrol -nr -function StartService
  • 24 Jul 2013 7:59 am Sushma
    Thank you for posting the solution.
    This will assist others who might experience the same problems.
  • 24 Jul 2013 7:59 am amit butola
    Thanks to all of you who always there for us to help and support.

×