cancel
Showing results for 
Search instead for 
Did you mean: 

Reg: Upgrade ECC6.0 to EhP4 The Errors during start of shadow instance

former_member216430
Participant
0 Kudos

Hi Experts,

               I am doing upgrading ECC6.0 to Ehp4 while "steps 5"  I got the errors Below i mentioned and log file also. PLEASE explain "startsfi.log" I am new upgrade consultant, I you give good solution afterwards i will give  the points.

       "To analyse the errors during start of shadow instance,

       view files 'STARTSFI.LOG' and 'DEVTRACE.LOG'

       in directory 'E:\usr\sap\DMO\EHPI\abap\log'

       After fixing the error, repeat phase until shadow instance is

       started and you can log on instance number '03'."

STARTSFI.LOG file

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

1 ETQ201 Entering upgrade-phase "START_SHDI_FIRST" ("20120720213455")

4 ETQ399 Set environment for standard connect:

2 ETQ367 Connect variables are set for standard instance access

4 ETQ399 System-nr = '02', GwService = 'sapgw02'

4 ETQ399 Environment variables:

4 ETQ399   dbs_db6_schema=SAPDMO

4 ETQ399   auth_shadow_upgrade=0

1 ETQ200 Executing actual phase 'MAIN_SHADOW/START_SHDI_FIRST'.

1 ETQ399 Phase arguments:

2 ETQ399 Arg[0] = 'DEVTRACE.LOG'

4 ETQ399 Set environment for shadow connect:

4 ETQ399 Set RFC variables for shadow connect:

4 ETQ399 System-nr = '03', GwService = 'sapgw03'

4 ETQ380 computing toolpath for request "TP_SHADOW_CONNECT"

4 ETQ381 request "TP_SHADOW_CONNECT" means "tp needs to connect to shadow system"

4 ETQ382 translates to group "R3UP_TOOL_GROUP_NEW"

4 ETQ383 translates to path "exe"

4 ETQ383 translates to path "exe"

4 ETQ399 Set tool parameters for shadow connect:

4 ETQ399   default TPPARAM: SHADOW.TPP

4 ETQ380 computing toolpath for request "TP_ALWAYS_NEW"

4 ETQ381 request "TP_ALWAYS_NEW" means "always tp from DIR_PUT/exe, for phase KX_SWITCH"

4 ETQ382 translates to group "R3UP_TOOL_GROUP_NEW"

4 ETQ383 translates to path "exe"

4 ETQ383 translates to path "exe"

2 ETQ399 Starting shadow instance

4 ETQ359 RFC Login to: System="DMO", Nr="03", GwHost="dmoserver", GwService="sapgw03"

2 ETQ231 RFC Login failed

4 ETQ359 RFC Login to: System="DMO", Nr="03", GwHost="dmoserver", GwService="sapgw03"

2 ETQ231 RFC Login failed

2 ETQ353 Starting system

2EETQ399 Starting shadow instance failed

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

DEVTRACE.LOG

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

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

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

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

sysno      03

sid        DMO

systemid   562 (PC with Windows NT)

relno      7010

patchlevel 0

patchno    150

intno      20020600

make:      multithreaded, Unicode, 64 bit, optimized

pid        10436

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

length of sys_adm_ext is 576 bytes

*** SWITCH TRC-HIDE on ***

***LOG Q00=> DpSapEnvInit, DPStart (03 10436) [dpxxdisp.c   1311]

Fri Jul 20 21:35:05 2012

    shared lib "dw_xml.dll" version 150 successfully loaded

    shared lib "dw_xtc.dll" version 150 successfully loaded

    shared lib "dw_stl.dll" version 150 successfully loaded

    shared lib "dw_gui.dll" version 150 successfully loaded

    shared lib "dw_mdm.dll" version 150 successfully loaded

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

Fri Jul 20 21:35:18 2012

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

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

MtxInit: 30000 0 0

DpSysAdmExtInit: ABAP is active

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

DpIPCInit2: start server >dmoserver_DMO_03                        <

DpShMCreate: sizeof(wp_adm)        21024    (1752)

DpShMCreate: sizeof(tm_adm)        5912704    (29416)

DpShMCreate: sizeof(wp_ca_adm)        24064    (80)

DpShMCreate: sizeof(appc_ca_adm)    8000    (80)

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

DpShMCreate: sizeof(comm_adm)        552080    (1088)

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

DpShMCreate: sizeof(slock_adm)        0    (104)

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

DpShMCreate: sizeof(file_adm)        0    (72)

DpShMCreate: sizeof(vmc_adm)        0    (1864)

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

DpShMCreate: sizeof(gw_adm)    48

DpShMCreate: SHM_DP_ADM_KEY        (addr: 000000000BC70050, size: 6605520)

DpShMCreate: allocated sys_adm at 000000000BC70050

DpShMCreate: allocated wp_adm at 000000000BC722A0

DpShMCreate: allocated tm_adm_list at 000000000BC774C0

DpShMCreate: allocated tm_adm at 000000000BC77520

DpShMCreate: allocated wp_ca_adm at 000000000C21ADA0

DpShMCreate: allocated appc_ca_adm at 000000000C220BA0

DpShMCreate: allocated comm_adm at 000000000C222AE0

DpShMCreate: system runs without slock table

DpShMCreate: system runs without file table

DpShMCreate: allocated vmc_adm_list at 000000000C2A9770

DpShMCreate: allocated gw_adm at 000000000C2A97F0

DpShMCreate: system runs without vmc_adm

DpShMCreate: allocated ca_info at 000000000C2A9820

DpShMCreate: allocated wall_adm at 000000000C2A9890

Fri Jul 20 21:35:19 2012

MBUF state OFF

DpCommInitTable: init table for 500 entries

DpRqQInit: Parameter rdisp/queue_lock_level = 2

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

ThTaskStatus: rdisp/reset_online_during_debug 0

EmInit: MmSetImplementation( 2 ).

MM global diagnostic options set: 0

<ES> client 0 initializing ....

<ES> InitFreeList

<ES> block size is 4096 kByte.

Using implementation view

<EsNT> Using memory model view.

<EsNT> Memory Reset disabled as NT default

*** ERROR => <EsNT> CreateFileMapping name=Global\ES_SEG_03_000 ,size=2044 MB, error=1455 [esnti.c      1276]

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

* Memory diagnostic                                 *

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

Systeminformation

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

Processor-Typ             : Processor-Count           : 2

Operating System          : NT 6.1, Build 7601

Service Pack              : Service Pack 1

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

NT Pagefile Informations

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

Config. minimum size      : 11288576 K

Config. maximum size      : 16482304 K

Avail.  maximum size      : 16482304 K

| Num|Pagefile                      |  Min.Size|  Max.Size| Avail.Max| Curr.Size|

|----|------------------------------|----------|----------|----------|----------|

|   1|c:\pagefile.sys               | 1048576 K| 4194304 K| 4194304 K| 2723900 K|

|   2|e:\pagefile.sys               |10240000 K|12288000 K|12288000 K|10240000 K|

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

NT Task Manager Informations

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

Total Handles             : 639678778

Total Threads             :        0

Total Processes           : 1962318984

Commit Charge Total       :    26335 K

Commit Charge Limit       :  3276849 K

Commit Charge Peak        :  3538999 K

Phys.Memory Total         :        0 K

Phys.Memory Available     :        0 K

File Cache                : 1962318984 K

Kernel Memory Total       :        0 K

Kernel Memory Paged       :        0 K

Kernel Memory Nonpaged    :        0 K

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

Memory usage of current process

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

Total virt.address space  : 0000008589934464 K

Avail.virt.address space  : 0000008589104392 K

Private Pages             :        0 K

Total heap size           :    44472 K

Virtual memory regions    :       39 K

Uncommitted heap memory   :    37364 K

Allocated heap memory     :     5839 K

Moveable heap memory      :        0 K

DDE shared heap memory    :     3125 K

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

Memory usage of all processes

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

| PID|Image               |Instance   |  Work.Set|   WS Peak|Priv.Pages|   PP Peak|Pg Fault|

|----|--------------------|-----------|----------|----------|----------|----------|--------|

|1628|conhost.exe         |           |     308 K|    2700 K|    1008 K|    6284 K|       0|

|1728|msg_server.EXE      |[MS] DMO_02|    7196 K|   12592 K|   14636 K|   14864 K|       3|

|2768|disp+work.EXE       |[DP] DMO_02|   64424 K|  114392 K|   87584 K|   91784 K|      28|

|6140|conhost.exe         |           |     368 K|    2704 K|    1004 K|    1004 K|       0|

|5368|igswd.EXE           |[GS02\data] DMO_E:\usr\sap\DMO\DVEBMGS02\data|    3236 K|    5772 K|    3956 K|    7292 K|       1|

|8840|conhost.exe         |           |     420 K|    2884 K|    1016 K|    1016 K|       2|

|4796|conhost.exe         |           |     376 K|    2760 K|    1008 K|    1008 K|       0|

|6568|igsmux.exe          |           |    4164 K|   15576 K|   19876 K|   20052 K|       4|

|6692|igspw.exe           |           |    3620 K|   37160 K|   39032 K|   39272 K|      45|

|6440|igspw.exe           |           |    3572 K|   37044 K|   38852 K|   39236 K|      43|

|8260|gwrd.EXE            |[GW] DMO_02|    5796 K|   16400 K|   14588 K|   20624 K|       5|

|8080|icman.EXE           |[**] DMO_02|    7728 K|   94392 K|   97156 K|   98940 K|      24|

|8724|disp+work.EXE       |[WP] DMO_02|  315184 K|  734920 K|  180612 K|  364128 K|   29684|

|4248|disp+work.EXE       |[WP] DMO_02|  177232 K|  229428 K|  127336 K|  127512 K|    1619|

| 672|disp+work.EXE       |[WP] DMO_02|  103432 K|  136572 K|  112868 K|  117144 K|     324|

|6200|disp+work.EXE       |[WP] DMO_02|   28168 K|   70648 K|  103620 K|  103704 K|      81|

|7012|disp+work.EXE       |[WP] DMO_02|   19296 K|   87560 K|  104616 K|  104764 K|      83|

|6724|disp+work.EXE       |[WP] DMO_02|    8464 K|   63896 K|  101700 K|  101976 K|      56|

|5340|disp+work.EXE       |[WP] DMO_02|   10940 K|   93276 K|  103564 K|  103648 K|      41|

|8452|disp+work.EXE       |[WP] DMO_02|    5640 K|   43164 K|   98660 K|   98756 K|      20|

|3296|disp+work.EXE       |[WP] DMO_02|    3096 K|   63064 K|   98080 K|   98340 K|      15|

| 820|disp+work.EXE       |[WP] DMO_02|   13336 K|  152876 K|  104604 K|  104864 K|      63|

|9184|disp+work.EXE       |[WP] DMO_02|   30780 K|   74900 K|  100248 K|  100296 K|      40|

|7460|disp+work.EXE       |[WP] DMO_02|    2428 K|   41136 K|   95236 K|   95496 K|      10|

|4948|disp+work.EXE       |[WP] DMO_02|  238008 K|  681552 K|  169416 K|  348600 K|    1850|

|9136|disp+work.EXE       |[WP] DMO_02|  174772 K|  278520 K|  107096 K|  153860 K|     591|

|9180|disp+work.EXE       |[WP] DMO_02|  191532 K|  326452 K|  110112 K|  156876 K|    1466|

|7316|disp+work.EXE       |[WP] DMO_02|   23628 K|   54776 K|   98156 K|   98424 K|     415|

|3952|disp+work.EXE       |[WP] DMO_02|    2820 K|   56616 K|   97876 K|   97876 K|      13|

|11600|sapstartsrv.exe     |           |   14864 K|   19436 K|   23028 K|   81800 K|       5|

|8264|conhost.exe         |           |    2704 K|    2704 K|    1008 K|    6472 K|       0|

|9024|msg_server.EXE      |[MS] DMO_03|   12164 K|   12164 K|   14612 K|   14616 K|       3|

|10436|disp+work.EXE       |           |   42236 K|   42236 K|   75904 K|   83800 K|      10|

|12480|conhost.exe         |           |    2696 K|    2696 K|    1004 K|    1004 K|       0|

|9824|conhost.exe         |           |    2728 K|    2728 K|    1024 K|    1024 K|       0|

|----|--------------------|-----------|----------|----------|----------|----------|--------|

|    |Sum                 |           | 1527356 K|**********| 2350096 K|**********|********|

Fri Jul 20 21:35:21 2012

*** Error 11 while initializing OS dependent part.

*** ERROR => DpEmInit: EmInit (1) [dpxxdisp.c   10467]

*** ERROR => DpMemInit: DpEmInit (-1) [dpxxdisp.c   10392]

*** DP_FATAL_ERROR => DpSapEnvInit: DpMemInit

*** DISPATCHER EMERGENCY SHUTDOWN ***

increase tracelevel of WPs

NiWait: sleep (10000ms) ...

NiISelect: timeout 10000ms

NiISelect: maximum fd=1

NiISelect: read-mask is NULL

NiISelect: write-mask is NULL

Fri Jul 20 21:35:31 2012

NiISelect: TIMEOUT occured (10000ms)

dump system status

Workprocess Table (long)            Fri Jul 20 16:05:31 2012

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

No Ty. Pid      Status  Cause Start Err Sem CPU    Time  Program          Cl  User         Action                    Table

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

*** ERROR => DpRqTxt: bad rqtype -1 [dpxxrq.c     786]

0 ?         -1 Free          no      0   0        0                                                                         

*** ERROR => DpRqTxt: bad rqtype -1 [dpxxrq.c     786]

1 ?         -1 Free          no      0   0        0                                                                         

*** ERROR => DpRqTxt: bad rqtype -1 [dpxxrq.c     786]

2 ?         -1 Free          no      0   0        0                                                                         

*** ERROR => DpRqTxt: bad rqtype -1 [dpxxrq.c     786]

3 ?         -1 Free          no      0   0        0                                                                         

*** ERROR => DpRqTxt: bad rqtype -1 [dpxxrq.c     786]

4 ?         -1 Free          no      0   0        0                                                                         

*** ERROR => DpRqTxt: bad rqtype -1 [dpxxrq.c     786]

5 ?         -1 Free          no      0   0        0                                                                         

*** ERROR => DpRqTxt: bad rqtype -1 [dpxxrq.c     786]

6 ?         -1 Free          no      0   0        0                                                                         

*** ERROR => DpRqTxt: bad rqtype -1 [dpxxrq.c     786]

7 ?         -1 Free          no      0   0        0                                                                         

*** ERROR => DpRqTxt: bad rqtype -1 [dpxxrq.c     786]

8 ?         -1 Free          no      0   0        0                                                                         

*** ERROR => DpRqTxt: bad rqtype -1 [dpxxrq.c     786]

9 ?         -1 Free          no      0   0        0                                                                         

*** ERROR => DpRqTxt: bad rqtype -1 [dpxxrq.c     786]

10 ?         -1 Free          no      0   0        0                                                                         

*** ERROR => DpRqTxt: bad rqtype -1 [dpxxrq.c     786]

11 ?         -1 Free          no      0   0        0                                                                         

Dispatcher Queue Statistics            Fri Jul 20 16:05:31 2012

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

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

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

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

| NOWP |      0 |      0 |   2000 |      0 |      0 |

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

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

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

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

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

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

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

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

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

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

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

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

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

max_rq_id        0

wake_evt_udp_now    0

wake events          total     0,  udp     0 (  0%),  shm     0 (  0%)

since last update    total     0,  udp     0 (  0%),  shm     0 (  0%)

Dump of tm_adm structure:            Fri Jul 20 16:05:31 2012

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

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

Workprocess Comm. Area Blocks            Fri Jul 20 16:05:31 2012

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

Slots: 300, Used: 0, Max: 0

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

|   id | owner        |   pid    | eyecatcher  |

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

NiWait: sleep (5000ms) ...

NiISelect: timeout 5000ms

NiISelect: maximum fd=1

NiISelect: read-mask is NULL

NiISelect: write-mask is NULL

Fri Jul 20 21:35:36 2012

NiISelect: TIMEOUT occured (5000ms)

DpHalt: shutdown server >dmoserver_DMO_03                        < (normal)

DpJ2eeDisableRestart

Switch off Shared memory profiling

ShmProtect( 57, 3 )

ShmProtect(SHM_PROFILE, SHM_PROT_RW

ShmProtect( 57, 1 )

ShmProtect(SHM_PROFILE, SHM_PROT_RD

DpWakeUpWps: wake up all wp's

Stop work processes

Terminate gui connections

wait for end of work processes

not attached to the message server

cleanup EM

EsCleanup ....

EmCleanup() -> 0

Es2Cleanup: Cleanup ES2

***LOG Q05=> DpHalt, DPStop ( 10436) [dpxxdisp.c   11298]

Good Bye .....

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

trc file: "dev_ms", trc level: 1, release: "701"

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

[Thr 5264] Fri Jul 20 21:35:02 2012

[Thr 5264] MsSSetTrcLog: trc logging active, max size = 20971520 bytes

systemid   562 (PC with Windows NT)

relno      7010

patchlevel 0

patchno    143

intno      20020600

make:      multithreaded, Unicode, 64 bit, optimized

pid        9024

[Thr 5264] Fri Jul 20 21:35:03 2012

[Thr 5264] ***LOG Q01=> MsSInit, MSStart (Msg Server 1 9024) [msxxserv.c   1853]

[Thr 5264] MsInitAclInfo: acl file E:\usr\sap\DMO\EHPI\abap\DMO\SYS\global\ms_acl_info.DAT not found, unrestricted access

[Thr 5264] MsGetOwnIpAddr: my host addresses are :

[Thr 5264]   1 : [192.168.1.120] dmoserver.myiteanz.com (HOSTNAME)

[Thr 5264]   2 : [127.0.0.1] dmoserver (LOCALHOST)

[Thr 5264] MsHttpInit: full qualified hostname = dmoserver

[Thr 5264] HTTP logging is switch off

[Thr 5264] ms/icf_info_server : deleted

[Thr 5264] *** I listen to port 3603 (3603) ***

[Thr 5264] CUSTOMER KEY: >B0035282027<

[Thr 5264] build version=701.2009.12.02

Accepted Solutions (0)

Answers (2)

Answers (2)

paul_power
Active Contributor
0 Kudos

Dear Selva,

For the error in the devtrace.log

*** ERROR => <EsNT> CreateFileMapping name=Global\ES_SEG_03_000 ,size=2044 MB, error=1455 [esnti.c      1276]

In fact this is a memory-specific problem. The NT pagefile did not have
enough contiguous space to allocate 2044 MB and the system could not
startup.

Solution:

Rebooting or allocating more space for the pagefile would be the
two immediate solutions.

Please try increasing the pagefile even more at least as a test purpose
and try to start the SAP system again. This error happens because the
paging file too small. In order to solve this issue, you should increase
this value.

You can run program sappfpar (see SAP Note 166551), in order to check
the memory settings.

This should also fix the errors of

DpRqTxt: bad rqtype -1

but if these persist, update us with the latest logs.

Also, you should also can check note 88416.

88416      Zero administration memory management from 4.0A/NT
129813     Windows: Problems due to address space fragmentatio
110172     Windows: Transactions with large memory requirement

Best regards,

Paul

former_member216430
Participant
0 Kudos

Thanks Power,

Before i solved. But again i got same error "Downtime" 6th Steps. our server could not started. i increase paging file also. but still same error there.

former_member189725
Active Contributor
0 Kudos

can you paste the trace files dev_disp and dev_w0 ?

What is the value of PHYS_MEMSIZE (instance profile parameter) and the total physical memory and swap space configured?

Regards

Ratnajit

former_member189725
Active Contributor
0 Kudos

What is total memory of the server ?

What is value of PHYS_MEMSIZE SAP profile parameter for the main instance ?

I suggest you reduce the value of the above parameter for the main instance and restart the main instance . Also  increase the swap space .

Then retry the upgrade.

Regards

Ratnajit