Error in phase SCEXEC_ALIAS in upgrade process(during preprocessing)

[Former Member]

Hi all experts,

i encountered error during upgrade from 4.7 to ecc 6

with message :

severe error during SCEXEC_ALIAS phases

file /usr/sap/<SID>/upg/abap/log/PTALDC00.LOG not found

below is some related log content for this error:

tail log of ULOG11_2

1. Phase SCEXEC_ALIAS:

<sid>adm 20110527220015 : /usr/sap/<SID>/upg/abap/exenew/tp pf=/usr/sap/<SID>/upg/abap/bin/EXDBNEW.TPP execdbscript <SID> -x PTALDC00.XQL DBEXECNONT DBEXECNOCHECK (pid=512002)

<sid>adm 20110527220016 : /usr/sap/<SID>/upg/abap/exenew/tp pf=/usr/sap/<SID>/upg/abap/bin/EXDBNEW.TPP execdbscript <SID> -x PTALDC01.XQL DBEXECNONT DBEXECNOCHECK (pid=1204298)

<sid>adm 20110527220017 :/usr/sap/<SID>/upg/abap/exenew/tp pf=/usr/sap/<SID>/upg/abap/bin/EXDBNEW.TPP execdbscript <SID> -x PTALDC02.XQL DBEXECNONT DBEXECNOCHECK (pid=675990)

tail log of SLOG701

1. Phase SCEXEC_ALIAS:

ERROR: Connect to <SID> failed (20110527190129, probably wrong environment).

ERROR: Connect to <SID> failed (20110527190130, probably wrong environment).

ERROR: Connect to <SID> failed (20110527190131, probably wrong environment).

my questions are:

1. where is the environment variable stored during this phase which is used by tp tool?

i have checked the profile EXDBNEW.TPP and compared it with other profile in the same directory which have been used by tp before(phases before this one), which resulted in no different for every environment related value.

2. i tried to emulate the execution of the command in ULOG11_2 with default environment of <sid>adm with adjustments(e.g db_ora_scheme=SHDTMP, DIR_LIBRARY= /usr/sap/<SID>/abap/exenew) it run with no error of wrong environment whatsoever >.<, so can i just point the environment scheme to <SID>SHD and executed it manually?

[Former Member · Accepted solution]

well, actually i did not looking at the right place at the error , my apologize for that.

there are another error messages at this log file SCEXEC_A.ECO

TRACE-INFO: 68:  [dev trc    ,00000]  -->oci_prepare_stmt(con_hdl=0, len=0, stmth_p=110b1b588)                          20  0.209414

TRACE-INFO: 69:  [dev trc    ,00000]        SELECT USERID,PASSWD FROM SAPUSER WHERE USERID IN (:A0,:A1)                                                            

TRACE-INFO: 70:                                                                                11  0.209425

TRACE-INFO: 71:  [dev trc    ,00000]  -  oci_bind  ( 0: SQLT_STR, l=256, con_hdl=0, stmth_p=110b1b588, vp=9001000a10b6ea2,ip=0,rlp=0,rcp=0)

TRACE-INFO: 72:                                                                                21  0.209446

TRACE-INFO: 73:  [dev trc    ,00000]  -  oci_bind  ( 1: SQLT_STR, l=256, con_hdl=0, stmth_p=110b1b588, vp=fffffffffffd978,ip=0,rlp=0,rcp=0)

TRACE-INFO: 74:                                                                                14  0.209460

TRACE-INFO: 75:  [dev trc    ,00000]  -->oci_define ( 0: SQLT_STR, l=256, con_hdl=0, stmth_p=110b1b588, vp=fffffffffffda78,ip=fffffffffffd7a0,rlp=0,rcp=0)

TRACE-INFO: 76:                                                                                13  0.209473

TRACE-INFO: 77:  [dev trc    ,00000]  -->oci_define ( 1: SQLT_AFC, l=256, con_hdl=0, stmth_p=110b1b588, vp=fffffffffffdb78,ip=fffffffffffd7a2,rlp=0,rcp=0)

TRACE-INFO: 78:                                                                                16  0.209489

TRACE-INFO: 79:  [dev trc    ,00000]  -->oci_execute_stmt(con_hdl=0, stmth_p=110b1b588, iters=1, rowoff=0, dml_batch_errors=0)

TRACE-INFO: 80:                                                                                13  0.209502

TRACE-INFO: 81:  [dev trc    ,00000]  OCIStmtExecute() completed, rc=100=OCI_NO_DATA, no further data                  8738  0.218240

TRACE-INFO: 82:  [dev trc    ,00000]    -> rc=1403=OCI_ERR_NOT_FOUND                                                    18  0.218258

TRACE-INFO: 83:  [dev trc    ,00000]  <--oci_execute_stmt(rc=1403, iters-errors = 1-0) [time 0,009s]                    11  0.218269

TRACE-INFO: 84:  [dbsloci.    ,00000]  *** ERROR => ORA-1403 when accessing table SAPUSER                                15  0.218284

TRACE-INFO: 85:  [dev trc    ,00000]    set_ocica() -> SQL code 1403                                                    8  0.218292

TRACE-INFO: 86:  [dev trc    ,00000]  -->oci_get_errmsg (con_hdl=0, rc=1403)                                              7  0.218299

TRACE-INFO: 87:  [dev trc    ,00000]    OCIErrorGet -> SQL error code: 1403                                            20  0.218319

TRACE-INFO: 88:  [dev trc    ,00000]    ORA-01403: no data found      

TRACE-INFO: 101:  [dev trc    ,00000]  Assigning username to user session: con_hdl=0, usrhp=110c09428                      8  0.219570

TRACE-INFO: 102:  [dev trc    ,00000]  Assigning password to user session: con_hdl=0, usrhp=110c09428                    12  0.219582

TRACE-INFO: 103:  [dev trc    ,00000]  Starting user session: OCISessionBegin(con_hdl=0, usr=SAPR3SHD/<pwd>, svchp=110b045e0, srvhp=110b05e88, usrhp=110c09428)

TRACE-INFO: 104:                                                                                133  0.219715

TRACE-INFO: 105:  [dev trc    ,00000]    OCISessionBegin(OCI_DEFAULT) failed with -1=OCI_ERROR                        6298  0.226013

TRACE-INFO: 106:  [dev trc    ,00000]    OCISessionBegin(OCI_DEFAULT) failed with SQL error 28000:                      11  0.226024

TRACE-INFO: 107:  [dev trc    ,00000]    ORA-28000: the account is locked                                                                              

TRACE-INFO: 108:                                                                                10  0.226034

TRACE-INFO: 109:  [dev trc    ,00000]  server_detach(con_hdl=0,stale=1,svrhp=110b05e88)                                    8  0.226042

TRACE-INFO: 110:  [dev trc    ,00000]  Detaching from DB Server (con_hdl=0,svchp=110b045e0,srvhp=110b05e88)                9  0.226051

TRACE-INFO: 111:  [dev trc    ,00000]  Deallocating server context handle 110b05e88 from con_hdl=0                      176  0.226227

TRACE-INFO: 112:  [dbsloci.    ,00000]  *** ERROR => CONNECT failed with sql error '28000'                                14  0.226241

TRACE-INFO: 113:  [dev trc    ,00000]    set_ocica() -> SQL error code 28000                                              7  0.226248

TRACE-INFO: 114:  [dev trc    ,00000]  -->oci_get_errmsg (con_hdl=0, rc=28000)                                            7  0.226255

TRACE-INFO: 115:  [dev trc    ,00000]    OCIErrorGet -> SQL error code: 28000                                            8  0.226263

TRACE-INFO: 116:  [dev trc    ,00000]    ORA-28000: the account is locked                                                                              

TRACE-INFO: 117:                                                                                10  0.226273

TRACE-INFO: 118:  [dblink      ,00433]  ***LOG BY2=>sql error 28000  performing CON [dblink#4 @ 433]                      22  0.226295

TRACE-INFO: 119:  [dblink      ,00433]  ***LOG BY0=>ORA-28000: the account is locked [dblink#4 @ 433]                      8  0.226303

From the log, the problem actually lies in authorization for ops$user + locked shadow user account. After corrected these problems, the process continued. But this still bother me how this error came up since other tp processes(phases before this one) run successfully. But i will mark this question as answered. Thanks for all the attention and hope this will help others too ^^.