cancel
Showing results for 
Search instead for 
Did you mean: 

Database is not available via R3trans - Cannot START SAP !!

Former Member
0 Kudos

Product Info : SAP ERP6 EHP6 ( IDES )

DB : Oracle 11.0.2.0

OS : Linux

Dear Basis Admins,

I'm logged in as sidADM and when I execute startsap this is the error I get :

zieadm 223> startsap

Checking ZIE Database

Database is not available via R3trans

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

Trying to start ZIE database ...

Log file: /usr/sap/ZIE/startdb.log

Starting Startup Agent sapstartsrv

Could not open the ICU common library.

    The following files must be in the path described by

    the environment variable "LD_LIBRARY_PATH":

    libicuuc.so.40, libicudata.so.40, libicui18n.so.40 [nlsui0_mt.c 1544] pid = 23826

LD_LIBRARY_PATH is currently set to /usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient  [nlsui0_mt.c 1547] pid = 23826

Startup of Instance Service failed

See /usr/sap/ZIE/startsap_DVEBMGS76.log for details--------------------------------------------------------------------------------

-------

Now I've done the first level of troubleshooting here ..

1.) I've checked to see if the files libicuuc.so.40, libicudata.so.40, libicui18n.so.40 are available in the path set by the ENV VARIABLE

     LD_LIBRARY_PATH":

zieadm 228> pwd

/sapmnt/ZIE/exe/uc/linuxx86_64

pdeluh0001636:zieadm 229> ls -lrt *.40

-rwxr-xr-x 1 zieadm sapsys  1761119 Jan 15  2013 libicuuc.so.40

-rwxr-xr-x 1 zieadm sapsys  2183345 Jan 15  2013 libicui18n.so.40

-rwxr-xr-x 1 zieadm sapsys 13915412 Jan 15  2013 libicudata.so.40

They are available !!

2.) I've tried executing R3trans -d from sidADM user

CORRECT>R3trans -d (y|n|e|a)? yes

This is R3trans version 6.24 (release 720 - 08.07.13 - 20:13:05 ).

unicode enabled version

R3trans finished (0000).

3.) logs of trans.log

zieadm 236> more trans.log

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

4 ETW000 R3trans version 6.24 (release 720 - 08.07.13 - 20:13:05 ).

4 ETW000 unicode enabled version

4 ETW000 ===============================================

4 ETW000

4 ETW000 date&time   : 21.11.2013 - 17:39:24

4 ETW000 control file: <no ctrlfile>

4 ETW000 R3trans was called as follows: R3trans -x

4 ETW000  trace at level 2 opened for a given file pointer

4 ETW000  [     dev trc,00000]  Thu Nov 21 17:39:24 2013                                                  42  0.000042

4 ETW000  [     dev trc,00000]  db_con_init called                                                        15  0.000057

4 ETW000  [     dev trc,00000]  set_use_ext_con_info(): rsdb/ssfs_connect not set => ssfs not used        11  0.000068

4 ETW000  [     dev trc,00000]  determine_block_commit: no con_hdl found as blocked for con_name = R/3

4 ETW000                                                                                                  14  0.000082

4 ETW000  [     dev trc,00000]  create_con (con_name=R/3)                                                  9  0.000091

4 ETW000  [     dev trc,00000]  Loading DB library '/usr/sap/ZIE/SYS/exe/uc/linuxx86_64/dboraslib.so' ...

4 ETW000                                                                                                  29  0.000120

4 ETW000  [     dev trc,00000]  DlLoadLib() success: dlopen("/usr/sap/ZIE/SYS/exe/uc/linuxx86_64/dboraslib.so"), hdl 0

4 ETW000                                                                                                6093  0.006213

4 ETW000  [     dev trc,00000]  Library '/usr/sap/ZIE/SYS/exe/uc/linuxx86_64/dboraslib.so' loaded         12  0.006225

4 ETW000  [     dev trc,00000]  function DbSlExpFuns loaded from library /usr/sap/ZIE/SYS/exe/uc/linuxx86_64/dboraslib.so

4 ETW000                                                                                                  18  0.006243

4 ETW000  [     dev trc,00000]  Version of '/usr/sap/ZIE/SYS/exe/uc/linuxx86_64/dboraslib.so' is "720.00", patchlevel (0.425)

4 ETW000                                                                                                  73  0.006316

4 ETW000  [     dev trc,00000]  function dsql_db_init loaded from library /usr/sap/ZIE/SYS/exe/uc/linuxx86_64/dboraslib.so

4 ETW000                                                                                                  15  0.006331

4 ETW000  [     dev trc,00000]  function dbdd_exp_funs loaded from library /usr/sap/ZIE/SYS/exe/uc/linuxx86_64/dboraslib.so

4 ETW000                                                                                                  26  0.006357

4 ETW000  [     dev trc,00000]  function sapic_get_instant_client_version loaded from library /usr/sap/ZIE/SYS/exe/uc/linuxx86_64/dboraslib.so

4 ETW000                                                                                                  15  0.006372

4 ETW000  [     dev trc,00000]  function sapic_get_instant_client_flavor loaded from library /usr/sap/ZIE/SYS/exe/uc/linuxx86_64/dboraslib.so

4 ETW000                                                                                                  16  0.006388

4 ETW000  [     dev trc,00000]  function sapic_get_patchset_version loaded from library /usr/sap/ZIE/SYS/exe/uc/linuxx86_64/dboraslib.so

4 ETW000                                                                                                  13  0.006401

4 ETW000  [     dev trc,00000]  function sapic_get_ls_inventory loaded from library /usr/sap/ZIE/SYS/exe/uc/linuxx86_64/dboraslib.so

4 ETW000                                                                                                  14  0.006415

4 ETW000  [     dev trc,00000]  -->DbSlControl(con=-1,cmd=47=DBSL_CMD_IMP_FUNS_SET) -> changed=30, tagset=1

4 ETW000                                                                                                  20  0.006435

4 ETW000  [     dev trc,00000]  -->DbSlControl(con=-1,cmd=39=DBSL_CMD_SET_SINGLETASK)                     10  0.006445

4 ETW000  [     dev trc,00000]  -->DbSlControl(con=-1,cmd=10=DBSL_CMD_DBCA_PTR_GET)                       13  0.006458

4 ETW000  [     dev trc,00000]  New connection 0 created                                                  24  0.006482

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                                                                                                  20  0.006502

--More--(13%)

4 ETW000  [     dev trc,00000]  -->DbSlControl(con=-1,cmd=10=DBSL_CMD_DBCA_PTR_GET)                       11  0.006513

4 ETW000  [     dev trc,00000]  db_con_connect (con_name=R/3)                                              9  0.006522

4 ETW000  [     dev trc,00000]  determine_block_commit: no con_hdl found as blocked for con_name = R/3

4 ETW000                                                                                                  11  0.006533

4 ETW000  [     dev trc,00000]  find_con_by_name found the following connection:                           7  0.006540

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                                                                                                  16  0.006556

4 ETW000  [     dev trc,00000]  -->DbSlConnect(vers=-1, type=0, env='[default env]', usr='[default usr]', kernel dbsl='720')

4 ETW000                                                                                                  36  0.006592

4 ETW000  [     dev trc,00000]  Register application info.                                               161  0.006753

4 ETW000  [     dev trc,00000]  Oracle client version: 11.2.0.3.0, V1, default build, (dbsl 720 260713, UNICODE[2])

4 ETW000                                                                                                 107  0.006860

4 ETW000  [     dev trc,00000]  Installed Oracle client patches:                                          23  0.006883

4 ETW000  [     dev trc,00000]  # Patch  13508485     : Created on 21 Dec 2011, 13:23:38 hrs PST8PDT

4 ETW000                                                                                                  14  0.006897

4 ETW000  [     dev trc,00000]  # Patch Description: Created on  3 Jan 2012, 02:50:27 hrs PST8PDT         21  0.006918

4 ETW000  [     dev trc,00000]  # Patch  11742262     : Created on  7 Mar 2012, 12:22:41 hrs CET          21  0.006939

4 ETW000  [     dev trc,00000]    Default connection: tnsname ='ZIE'                                      11  0.006950

4 ETW000  [     dev trc,00000]  -->oci_initialize(con=0, char='UTF16', nchar='AL16UTF16', nls=-1),uc_ln=2

4 ETW000                                                                                                  19  0.006969

4 ETW000  [     dev trc,00000]  OCIEnvCreate(mode=16384=OCI_UTF16) returned 0 (for default NLS handle)

4 ETW000                                                                                                7238  0.014207

4 ETW000  [     dev trc,00000]     OCIHandleAlloc(OCI_HTYPE_ERROR, con=0, ErrHp=2f5ec68)                  29  0.014236

4 ETW000  [     dev trc,00000]     OCIHandleAlloc(OCI_HTYPE_ERROR, con=0, ErrBt=2f5fef8)                  17  0.014253

4 ETW000  [     dev trc,00000]  NLS env. settings: lang=41004D00450052004900430041004E00                  73  0.014326

4 ETW000  [     dev trc,00000]                     terr=41004D0045005200490043004100                      18  0.014344

4 ETW000  [     dev trc,00000]                     char=55005400460031003600                              17  0.014361

4 ETW000  [     dev trc,00000]  Client NLS setting (by OCINlsGetInfo(con=0)): 'AMERICAN_AMERICA.UTF16'

4 ETW000                                                                                                  15  0.014376

4 ETW000  [     dev trc,00000]  charset='UTF16', ncharset='AL16UTF16', UNI_ASC=FALSE                      10  0.014386

4 ETW000  [     dev trc,00000]  Logon as OPS$-user to get SAPSR3's password                               11  0.014397

4 ETW000  [     dev trc,00000]  Connecting as /@ZIE on connection 0 (nls 0) ... (dbsl 720 260713, UNICODE[2])

4 ETW000                                                                                                  28  0.014425

4 ETW000  [     dev trc,00000]     OCIHandleAlloc(OCI_HTYPE_SVCCTX, con=0, svchp=2f5fe18)                 16  0.014441

4 ETW000  [     dev trc,00000]  Allocating server context handle                                          12  0.014453

4 ETW000  [     dev trc,00000]  Attaching to database server ZIE (con=0, svchp=2f5fe18, srvhp=2f64f40)

4 ETW000                                                                                                  36  0.014489

4 ETW000  [     dev trc,00000]  Assigning server context 2f64f40 to service context 2f5fe18            22460  0.036949

4 ETW000  [     dev trc,00000]     OCIHandleAlloc(OCI_HTYPE_SESSION, con=0, usrhp=2f941d0)                34  0.036983

4 ETW000  [     dev trc,00000]  Starting user session: OCISessionBegin(con=0, usr='/', svc=2f5fe18, srv=2f64f40, usr=2f941d0)

4 ETW000                                                                                                  38  0.037021

4 ETW000  [     dev trc,00000]  Assigning user session usrhp=2f941d0 to service context svchp=2f5fe18

4 ETW000                                                                                                5666  0.042687

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected                          35  0.042722

4 ETW000  [     dev trc,00000]  -->oci_prepare_stmt(con=0,len=39,stp=2f74138)                             13  0.042735

4 ETW000  [     dev trc,00000]         SELECT SID FROM V$MYSTAT WHERE ROWNUM<2

4 ETW000                                                                                                  15  0.042750

4 ETW000  [     dev trc,00000]  -  oci_define  ( 0: SQLT_INT , l=  4, con=0, stp=2f74138, pv=7fffb723c938, in=7fffb723c93e,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  56  0.042806

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected, new transaction         29  0.042835

4 ETW000  [     dev trc,00000]  -->oci_execute_stmt(#1: con=0,stp=2f74138,itr=1,off=0,bat=0)              13  0.042848

4 ETW000  [     dev trc,00000]  before OCIStmtExecute(svchp=2f5fe18, errhp=2f5ec68): [dur. 0,000s]        13  0.042861

4 ETW000  [     dev trc,00000]  after  OCIStmtExecute(rpc=0): [dur. 0,001s]                              531  0.043392

4 ETW000  [     dev trc,00000]  <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,001s]               20  0.043412

4 ETW000  [     dev trc,00000]  Now '/@ZIE' is connected: con=0, nls=0, session=1, time='2013-11-21 17:39:24'

4 ETW000                                                                                                  33  0.043445

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected                          19  0.043464

4 ETW000  [     dev trc,00000]  -->oci_prepare_stmt(con=0,len=33,stp=2f74138)                             15  0.043479

4 ETW000  [     dev trc,00000]         ALTER SESSION SET NLS_SORT=BINARY

4 ETW000                                                                                                  14  0.043493

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected, new transaction         23  0.043516

4 ETW000  [     dev trc,00000]  -->oci_execute_stmt(#2: con=0,stp=2f74138,itr=1,off=0,bat=0)              13  0.043529

4 ETW000  [     dev trc,00000]  before OCIStmtExecute(svchp=2f5fe18, errhp=2f5ec68): [dur. 0,000s]        12  0.043541

4 ETW000  [     dev trc,00000]  after  OCIStmtExecute(rpc=0): [dur. 0,000s]                              270  0.043811

4 ETW000  [     dev trc,00000]  <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,000s]               18  0.043829

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected                          42  0.043871

4 ETW000  [     dev trc,00000]  -->oci_prepare_stmt(con=0,len=59,stp=2f74138)                             13  0.043884

4 ETW000  [     dev trc,00000]         SELECT USERID,PASSWD FROM SAPUSER WHERE USERID IN (:A0,:A1)

4 ETW000                                                                                                  14  0.043898

4 ETW000  [     dev trc,00000]  -  oci_bind    ( 0: SQLT_STR , l=256, con=0, stp=2f74138, pv=7fffb723da60, in=0000NULL,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  41  0.043939

4 ETW000  [     dev trc,00000]  -  oci_bind    ( 1: SQLT_STR , l=256, con=0, stp=2f74138, pv=7fffb723c4b0, in=0000NULL,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  33  0.043972

4 ETW000  [     dev trc,00000]  -  oci_define  ( 0: SQLT_STR , l=514, con=0, stp=2f74138, pv=7fffb723c2a0, in=7fffb723c93e,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  21  0.043993

4 ETW000  [     dev trc,00000]  -  oci_define  ( 1: SQLT_AFC , l=514, con=0, stp=2f74138, pv=7fffb723c090, in=7fffb723c93c,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  21  0.044014

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected, new transaction         17  0.044031

4 ETW000  [     dev trc,00000]  -->oci_execute_stmt(#3: con=0,stp=2f74138,itr=1,off=0,bat=0)              15  0.044046

4 ETW000  [     dev trc,00000]  before OCIStmtExecute(svchp=2f5fe18, errhp=2f5ec68): [dur. 0,000s]        12  0.044058

4 ETW000  [     dev trc,00000]  after  OCIStmtExecute(rpc=0): [dur. 0,000s]                              327  0.044385

4 ETW000  [     dev trc,00000]  <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,000s]               23  0.044408

4 ETW000  [     dev trc,00000]  Got SAPSR3's password from OPS$-user                                     143  0.044551

4 ETW000  [     dev trc,00000]  Disconnecting from connection 0 ...                                       12  0.044563

4 ETW000  [     dev trc,00000]  Rolling back transaction                                                  11  0.044574

4 ETW000  [     dev trc,00000]  Closing user session (con=0, svc=2f5fe18, usr=2f941d0)                   180  0.044754

4 ETW000  [     dev trc,00000]  Disconnected (con=0) from ORACLE.                                        451  0.045205

4 ETW000  [     dev trc,00000]  Connect as 'SAPSR3' with password from table SAPUSER                      23  0.045228

4 ETW000  [     dev trc,00000]  Connecting as SAPSR3/<pwd>@ZIE on connection 0 (nls 0) ... (dbsl 720 260713, UNICODE[2])

4 ETW000                                                                                                  21  0.045249

4 ETW000  [     dev trc,00000]  Assigning username to user session: con=0, usrhp=2f941d0                  13  0.045262

4 ETW000  [     dev trc,00000]  Assigning password to user session: con=0, usrhp=2f941d0                  22  0.045284

4 ETW000  [     dev trc,00000]  Starting user session: OCISessionBegin(con=0, usr='SAPSR3', svc=2f5fe18, srv=2f64f40, usr=2f941d0)

4 ETW000                                                                                                 120  0.045404

4 ETW000  [     dev trc,00000]  Assigning user session usrhp=2f941d0 to service context svchp=2f5fe18

4 ETW000                                                                                                1835  0.047239

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected                          27  0.047266

4 ETW000  [     dev trc,00000]  -->oci_prepare_stmt(con=0,len=39,stp=2f74138)                             13  0.047279

4 ETW000  [     dev trc,00000]         SELECT SID FROM V$MYSTAT WHERE ROWNUM<2

4 ETW000                                                                                                  25  0.047304

4 ETW000  [     dev trc,00000]  -  oci_define  ( 0: SQLT_INT , l=  4, con=0, stp=2f74138, pv=7fffb723c938, in=7fffb723c93e,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  35  0.047339

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected, new transaction         18  0.047357

4 ETW000  [     dev trc,00000]  -->oci_execute_stmt(#4: con=0,stp=2f74138,itr=1,off=0,bat=0)              12  0.047369

4 ETW000  [     dev trc,00000]  before OCIStmtExecute(svchp=2f5fe18, errhp=2f5ec68): [dur. 0,000s]        13  0.047382

4 ETW000  [     dev trc,00000]  after  OCIStmtExecute(rpc=0): [dur. 0,000s]                              323  0.047705

4 ETW000  [     dev trc,00000]  <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,000s]               17  0.047722

4 ETW000  [     dev trc,00000]  Now 'SAPSR3/<pwd>@ZIE' is connected: con=0, nls=0, session=1, time='2013-11-21 17:39:24'

4 ETW000                                                                                                  26  0.047748

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected                          18  0.047766

4 ETW000  [     dev trc,00000]  -->oci_prepare_stmt(con=0,len=33,stp=2f74138)                             11  0.047777

4 ETW000  [     dev trc,00000]         ALTER SESSION SET NLS_SORT=BINARY

4 ETW000                                                                                                  14  0.047791

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected, new transaction         22  0.047813

4 ETW000  [     dev trc,00000]  -->oci_execute_stmt(#5: con=0,stp=2f74138,itr=1,off=0,bat=0)              13  0.047826

4 ETW000  [     dev trc,00000]  before OCIStmtExecute(svchp=2f5fe18, errhp=2f5ec68): [dur. 0,000s]        18  0.047844

4 ETW000  [     dev trc,00000]  after  OCIStmtExecute(rpc=0): [dur. 0,000s]                              264  0.048108

4 ETW000  [     dev trc,00000]  <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,000s]               17  0.048125

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected                          27  0.048152

4 ETW000  [     dev trc,00000]  -->oci_prepare_stmt(con=0,len=110,stp=2f74138)                            12  0.048164

4 ETW000  [     dev trc,00000]         SELECT UPPER(INSTANCE_NAME),HOST_NAME,VERSION,TO_CHAR(STARTUP_TIME,'MON DD, YYYY, HH24:MI:SS') FROM V$INSTANCE

4 ETW000                                                                                                  14  0.048178

4 ETW000  [     dev trc,00000]  -  oci_define  ( 0: SQLT_STR , l= 66, con=0, stp=2f74138, pv=7f9a49e4dd20, in=7fffb723c93e,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  34  0.048212

4 ETW000  [     dev trc,00000]  -  oci_define  ( 1: SQLT_STR , l=130, con=0, stp=2f74138, pv=7f9a49e4df68, in=7fffb723c93e,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  20  0.048232

4 ETW000  [     dev trc,00000]  -  oci_define  ( 2: SQLT_STR , l= 66, con=0, stp=2f74138, pv=7f9a49e4dcde, in=7fffb723c93e,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  24  0.048256

4 ETW000  [     dev trc,00000]  -  oci_define  ( 3: SQLT_STR , l= 60, con=0, stp=2f74138, pv=7fffb723c900, in=7fffb723c93e,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  23  0.048279

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected, new transaction         25  0.048304

4 ETW000  [     dev trc,00000]  -->oci_execute_stmt(#6: con=0,stp=2f74138,itr=1,off=0,bat=0)              14  0.048318

4 ETW000  [     dev trc,00000]  before OCIStmtExecute(svchp=2f5fe18, errhp=2f5ec68): [dur. 0,000s]        12  0.048330

4 ETW000  [     dev trc,00000]  after  OCIStmtExecute(rpc=0): [dur. 0,000s]                              300  0.048630

4 ETW000  [     dev trc,00000]  <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,000s]               20  0.048650

4 ETW000  [     dev trc,00000]  DB instance ZIE is running on pdeluh0001636 with ORACLE version 11.2.0.2.0 since NOV 21, 2013, 16:56:58.

4 ETW000                                                                                                  22  0.048672

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected                          22  0.048694

4 ETW000  [     dev trc,00000]  -->oci_prepare_stmt(con=0,len=74,stp=2f74138)                             12  0.048706

4 ETW000  [     dev trc,00000]         SELECT SUBSTR(NAME,1,3), TO_CHAR(CREATED,'YYYYMMDDHHMMSS') FROM V$DATABASE

4 ETW000                                                                                                  15  0.048721

4 ETW000  [     dev trc,00000]  -  oci_define  ( 0: SQLT_CHR , l=  6, con=0, stp=2f74138, pv=7fffb723c740, in=7fffb723c93e,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  38  0.048759

4 ETW000  [     dev trc,00000]  -  oci_define  ( 1: SQLT_STR , l= 30, con=0, stp=2f74138, pv=7fffb723c920, in=7fffb723c93e,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  22  0.048781

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected, new transaction         17  0.048798

4 ETW000  [     dev trc,00000]  -->oci_execute_stmt(#7: con=0,stp=2f74138,itr=1,off=0,bat=0)              13  0.048811

4 ETW000  [     dev trc,00000]  before OCIStmtExecute(svchp=2f5fe18, errhp=2f5ec68): [dur. 0,000s]        12  0.048823

4 ETW000  [     dev trc,00000]  after  OCIStmtExecute(rpc=0): [dur. 0,002s]                             2126  0.050949

4 ETW000  [     dev trc,00000]  <--oci_execute_stmt(rc=0, iters-errors = 1-0) [dur. 0,002s]               23  0.050972

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected                          27  0.050999

4 ETW000  [     dev trc,00000]  -->oci_prepare_stmt(con=0,len=172,stp=2f74138)                            12  0.051011

4 ETW000  [     dev trc,00000]         SELECT VALUE FROM V$NLS_PARAMETERS WHERE PARAMETER IN ('NLS_LANGUAGE','NLS_TERRITORY','NLS_CHARACTERSET','NLS_NCHAR_CHARAC

4 ETW000                                                                                                  15  0.051026

4 ETW000  [     dev trc,00000]         TERSET','NLS_LENGTH_SEMANTICS') ORDER BY PARAMETER

4 ETW000                                                                                                  13  0.051039

4 ETW000  [     dev trc,00000]  -  oci_define  ( 0: SQLT_STR , l=202, con=0, stp=2f74138, pv=7fffb723ca20, in=7fffb723daf0,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  35  0.051074

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 not connected, new transaction         18  0.051092

4 ETW000  [     dev trc,00000]  -->oci_execute_stmt(#8: con=0,stp=2f74138,itr=5,off=0,bat=0)              12  0.051104

4 ETW000  [     dev trc,00000]  before OCIStmtExecute(svchp=2f5fe18, errhp=2f5ec68): [dur. 0,000s]        12  0.051116

4 ETW000  [     dev trc,00000]  after  OCIStmtExecute(rpc=0): [dur. 0,000s]                              334  0.051450

4 ETW000  [     dev trc,00000]  <--oci_execute_stmt(rc=0, iters-errors = 5-0) [dur. 0,000s]               27  0.051477

4 ETW000  [     dev trc,00000]  con=0, V$NLS_PARAMETERS: NLS_LANG=AMERICAN_AMERICA.UTF8, NLS_NCHAR=UTF8

4 ETW000                                                                                                  20  0.051497

4 ETW000  [     dev trc,00000]  V$NLS_PARAMETERS: NLS_LENGTH_SEMANTICS='BYTE'                             13  0.051510

4 ETW000  [     dev trc,00000]  Nls CharacterSet                      NationalCharSet                   EnvHp            ErrHp            ErrBt

4 ETW000                                                                                                  19  0.051529

4 ETW000  [     dev trc,00000]    0 UTF16                             AL16UTF16                         2f52340          2f5ec68          2f5fef8

4 ETW000                                                                                                  16  0.051545

4 ETW000  [     dev trc,00000]     DbSlConnect(con=0) -> orc=0, 0=DBSL_ERR_OK                             11  0.051556

4 ETW000  [     dev trc,00000]  -->DbSlControl(con=0,cmd=21=DBSL_CMD_DBHOST_NAME_GET)                     12  0.051568

4 ETW000  [     dev trc,00000]  Connection 0 opened (DBSL handle 0)                                       10  0.051578

4 ETW000  [     dev trc,00000]  -->DbSlControl(con=0,cmd=7=DBSL_CMD_DBNAME_GET)                           14  0.051592

4 ETW000  [     dev trc,00000]  -->DbSlControl(con=0,cmd=63=DBSL_CMD_DBSID_GET)                           12  0.051604

4 ETW000  [     dev trc,00000]  -->DbSlControl(con=0,cmd=21=DBSL_CMD_DBHOST_NAME_GET)                  15571  0.067175

4 ETW000  [     dev trc,00000]  -->DbSlControl(con=0,cmd=11=DBSL_CMD_USERID_GET) -> USERID='SAPSR3'       50  0.067225

4 ETW000  [     dev trc,00000]  -->DbSlControl(con=0,cmd=22=DBSL_CMD_OWNERID_GET) -> OWNERID='SAPSR3'

4 ETW000                                                                                                  27  0.067252

4 ETW000  [     dev trc,00000]  -->DbSlControl(con=0,cmd=13=DBSL_CMD_VENDOR_NAME_GET)                     19  0.067271

4 ETW000  [     dev trc,00000]  -->DbSlControl(con=0,cmd=24=DBSL_CMD_DBVERSION_GET)                       22  0.067293

4 ETW000  [     dev trc,00000]  -->DbSlControl(con=0,cmd=51=DBSL_CMD_NLS_CHARACTERSET_GET)                19  0.067312

4 ETW000  [     dev trc,00000]  -->DbSlPrepare(DBSL_SELECT, con=0, ss_p=7fffb723e050, da_p=7fffb723dfb0), stp=7fffb723e070, stid=0000NULL

4 ETW000                                                                                                  43  0.067355

4 ETW000  [     dev trc,00000]  AppInf(210)->1; mod='DBSL: con=0, no ABAP',act='0',usr='DBSL: con=0, no client_id',ta='',mp=''

4 ETW000                                                                                                 155  0.067510

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 connected                              25  0.067535

4 ETW000  [     dev trc,00000]  -->oci_prepare_stmt(con=0,len=26,stp=2f74138); AI=DBSL: con=0, no ABAP.0.DBSL: con=0, no client_id.DBSL: con=0, no client_info

4 ETW000                                                                                                  29  0.067564

4 ETW000  [     dev trc,00000]         SELECT VERSION FROM SVERS

4 ETW000                                                                                                  27  0.067591

4 ETW000  [     dev trc,00000]     DbSlPrepare(lit=0, lob=0, fae=0, col=0, mrk=0,sch=2ef4c90, scp=2efe120, tab='SVERS') -> 0=DBSL_ERR_OK

4 ETW000                                                                                                  61  0.067652

4 ETW000  [     dev trc,00000]  -->DbSlRead(con=0, ssp=7fffb723e050, dap=7fffb723dfb0), sch=2ef4c90, scp=2efe120, tab='SVERS'

4 ETW000                                                                                                  39  0.067691

4 ETW000  [     dev trc,00000]    stmt=SELECT VERSION FROM SVERS

4 ETW000                                                                                                  49  0.067740

4 ETW000  [     dev trc,00000]  STID: ssp=7fffb723e050->stmtid_ptr=0000NULL                               21  0.067761

4 ETW000  [     dev trc,00000]   Out  00: DBSL_DATA_SHORT_CHAR        (len=144, max=144, dec=0)           22  0.067783

4 ETW000  [     dev trc,00000]  bind_type_and_length(): 0 input variables, col=0                          23  0.067806

4 ETW000  [     dev trc,00000]  bind_type_and_length(): 1 output variables                                19  0.067825

4 ETW000  [     dev trc,00000]   0: DBSL_DATA_SHORT_CHAR        , len=144, max=144, dec=0                 22  0.067847

4 ETW000  [     dev trc,00000]     bind_ind_and_values(OUT,con=0,arr=890,col=1,rc=0,rl=0,flt=0,int=0,sh=0,uc=72)

4 ETW000                                                                                                  47  0.067894

4 ETW000  [     dev trc,00000]  -  oci_define  ( 0: SQLT_CHR , l=144, con=0, stp=2f74138, pv=2fd4a34, in=2fd4340,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  34  0.067928

4 ETW000  [     dev trc,00000]  AppInf(5)->1; mod='',act='',usr='DBSL: con=0, no client_id',ta='',mp=''

4 ETW000                                                                                                  67  0.067995

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 connected, new transaction             28  0.068023

4 ETW000  [     dev trc,00000]  -->oci_execute_stmt(#9: con=0,stp=2f74138,itr=1,off=0,bat=0); AI='..DBSL: con=0, no client_id.'

4 ETW000                                                                                                  29  0.068052

4 ETW000  [     dev trc,00000]  before OCIStmtExecute(svchp=2f5fe18, errhp=2f5ec68): [dur. 0,000s]        22  0.068074

4 ETW000  [     dev trc,00000]  after  OCIStmtExecute(rpc=1): [dur. 0,001s]                              728  0.068802

4 ETW000  [     dev trc,00000]  <--oci_execute_stmt(rc=0, rows processed 1, iters-errors = 1-0) [dur. 0,001s]

4 ETW000  [     dev trc,00000]  -->DbSlRead(con=0, ssp=7fffb723e050, dap=7fffb723dfb0), sch=2ef4c90, scp=2efe120, tab='SVERS'

4 ETW000                                                                                                  39  0.067691

4 ETW000  [     dev trc,00000]    stmt=SELECT VERSION FROM SVERS

4 ETW000                                                                                                  49  0.067740

4 ETW000  [     dev trc,00000]  STID: ssp=7fffb723e050->stmtid_ptr=0000NULL                               21  0.067761

4 ETW000  [     dev trc,00000]   Out  00: DBSL_DATA_SHORT_CHAR        (len=144, max=144, dec=0)           22  0.067783

4 ETW000  [     dev trc,00000]  bind_type_and_length(): 0 input variables, col=0                          23  0.067806

4 ETW000  [     dev trc,00000]  bind_type_and_length(): 1 output variables                                19  0.067825

4 ETW000  [     dev trc,00000]   0: DBSL_DATA_SHORT_CHAR        , len=144, max=144, dec=0                 22  0.067847

4 ETW000  [     dev trc,00000]     bind_ind_and_values(OUT,con=0,arr=890,col=1,rc=0,rl=0,flt=0,int=0,sh=0,uc=72)

4 ETW000                                                                                                  47  0.067894

4 ETW000  [     dev trc,00000]  -  oci_define  ( 0: SQLT_CHR , l=144, con=0, stp=2f74138, pv=2fd4a34, in=2fd4340,rl=0000NULL,rc=0000NULL)

4 ETW000                                                                                                  34  0.067928

4 ETW000  [     dev trc,00000]  AppInf(5)->1; mod='',act='',usr='DBSL: con=0, no client_id',ta='',mp=''

4 ETW000                                                                                                  67  0.067995

4 ETW000  [     dev trc,00000]     time 2013-11-21 17:39:24, con=0 connected, new transaction             28  0.068023

4 ETW000  [     dev trc,00000]  -->oci_execute_stmt(#9: con=0,stp=2f74138,itr=1,off=0,bat=0); AI='..DBSL: con=0, no client_id.'

4 ETW000                                                                                                  29  0.068052

4 ETW000  [     dev trc,00000]  before OCIStmtExecute(svchp=2f5fe18, errhp=2f5ec68): [dur. 0,000s]        22  0.068074

4 ETW000  [     dev trc,00000]  after  OCIStmtExecute(rpc=1): [dur. 0,001s]                              728  0.068802

4 ETW000  [     dev trc,00000]  <--oci_execute_stmt(rc=0, rows processed 1, iters-errors = 1-0) [dur. 0,001s]

4 ETW000                                                                                                  38  0.068840

4 ETW000  [     dev trc,00000]     stmt_fetch() -> orc=0, 0=DBSL_ERR_OK                                   23  0.068863

4 ETW000  [     dev trc,00000]     DbSlRead() --> 0=DBSL_ERR_OK                                           26  0.068889

4 ETW000  [     dev trc,00000]  -->DbSlControl(con=0,cmd=43=DBSL_CMD_SAPRELEASE_SET)                      24  0.068913

4 ETW000  [     dev trc,00000]     DbSlControl(DBSL_CMD_SAPRELEASE_SET,abap='731')                        19  0.068932

4 ETW000 Connected to database.

4 ETW000  [     dev trc,00000]  Disconnecting from ALL connections:                                       29  0.068961

4 ETW000  [     dev trc,00000]  Disconnecting from connection 0 ...                                       43  0.069004

4 ETW000  [     dev trc,00000]  Rolling back transaction                                                  40  0.069044

4 ETW000  [     dev trc,00000]  Closing user session (con=0, svc=2f5fe18, usr=2f941d0)                   301  0.069345

4 ETW000  [     dev trc,00000]  Deallocating user session handle 2f941d0 for con=0                       534  0.069879

4 ETW000  [     dev trc,00000]  server_detach(con=0,stale=0,srvhp=2f64f40)                                35  0.069914

4 ETW000  [     dev trc,00000]  Server handle (con=0,svchp=2f5fe18,srvhp=2f64f40) detached               312  0.070226

4 ETW000  [     dev trc,00000]  Free server handle srvhp=2f64f40 of con=0                                 24  0.070250

4 ETW000  [     dev trc,00000]  Deallocating service context handle 2f5fe18 for con=0                     24  0.070274

4 ETW000  [     dev trc,00000]  Disconnected (con=0) from ORACLE.                                         19  0.070293

4 ETW000  [     dev trc,00000]  Disconnected from connection 0                                            29  0.070322

4 ETW000  [     dev trc,00000]  statistics db_con_commit (com_total=0, com_tx=0)                          16  0.070338

4 ETW000  [     dev trc,00000]  statistics db_con_rollback (roll_total=0, roll_tx=0)                      16  0.070354

4 ETW000 Disconnected from database.

4 ETW000 End of Transport (0000).

4 ETW000 date&time: 21.11.2013 - 17:39:24

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

5.) STARTSAP .trc

     {17:24:54 ## restore_path() start
      LD_LBRARY_PATH=/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
     }17:24:54 ## restore_path() done

     EXEDIR=/usr/sap/ZIE/DVEBMGS76/exe
     EXECMD=/usr/sap/ZIE/DVEBMGS76/exe/sappfpar
    }17:24:54 ## getExePath() done: 0

    _INST_PROFILE=ZIE_DVEBMGS76_zieci
    /usr/sap/ZIE/DVEBMGS76/exe/sappfpar pf=/usr/sap/ZIE/SYS/profile/ZIE_DVEBMGS76_zieci DIR_HOME
    DIR_HOME=
    KILLSAP=/kill.sap
   }17:24:54 ## get_killsap(DVEBMGS76) done

  }17:24:54 ## save_tplog() done

  instance: INST=DVEBMGS76

  {17:24:54 ## getExePath() start: @=sapcontrol DVEBMGS76

   {17:24:54 ## set_path() start: @=/usr/sap/ZIE/DVEBMGS76/exe
    N_PATH=/usr/sap/ZIE/DVEBMGS76/exe
    LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
    O_LD_LIBRARY_PATH=/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
   }17:24:54 ## set_path() done

   _DIR_EXECUTABLE=

   {17:24:54 ## restore_path() start
    LD_LBRARY_PATH=/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
   }17:24:54 ## restore_path() done

   EXEDIR=/usr/sap/ZIE/DVEBMGS76/exe
   EXECMD=/usr/sap/ZIE/DVEBMGS76/exe/sapcontrol
  }17:24:54 ## getExePath() done: 0

  {17:24:54 ## instance_do() start: @=start DVEBMGS76

   {17:24:54 ## save_old_logs() start: @=/usr/sap/ZIE/startsap_DVEBMGS76.log
    cp /usr/sap/ZIE/startsap_DVEBMGS76.log.8 /usr/sap/ZIE/startsap_DVEBMGS76.log.9
    cp /usr/sap/ZIE/startsap_DVEBMGS76.log.7 /usr/sap/ZIE/startsap_DVEBMGS76.log.8
    cp /usr/sap/ZIE/startsap_DVEBMGS76.log.6 /usr/sap/ZIE/startsap_DVEBMGS76.log.7
    cp /usr/sap/ZIE/startsap_DVEBMGS76.log.5 /usr/sap/ZIE/startsap_DVEBMGS76.log.6
    cp /usr/sap/ZIE/startsap_DVEBMGS76.log.4 /usr/sap/ZIE/startsap_DVEBMGS76.log.5
    cp /usr/sap/ZIE/startsap_DVEBMGS76.log.3 /usr/sap/ZIE/startsap_DVEBMGS76.log.4
    cp /usr/sap/ZIE/startsap_DVEBMGS76.log.2 /usr/sap/ZIE/startsap_DVEBMGS76.log.3
    cp /usr/sap/ZIE/startsap_DVEBMGS76.log.1 /usr/sap/ZIE/startsap_DVEBMGS76.log.2
    cp /usr/sap/ZIE/startsap_DVEBMGS76.log /usr/sap/ZIE/startsap_DVEBMGS76.log.1
   }17:24:54 ## save_old_logs() done

   {17:24:54 ## init_log() start
    LOGFILE=/usr/sap/ZIE/startsap_DVEBMGS76.log
    init_log /usr/sap/ZIE/SYS/exe/uc/linuxx86_64/startsap /usr/sap/ZIE/SYS/exe/uc/linuxx86_64/startsap start DVEBMGS76
   }17:24:54 ## init_log() done

   {17:24:54 ## getExePath() start: @=sapcontrol DVEBMGS76

    {17:24:54 ## set_path() start: @=/usr/sap/ZIE/DVEBMGS76/exe
     N_PATH=/usr/sap/ZIE/DVEBMGS76/exe
     LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
     O_LD_LIBRARY_PATH=/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
    }17:24:54 ## set_path() done

    _DIR_EXECUTABLE=

    {17:24:54 ## restore_path() start
     LD_LBRARY_PATH=/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
    }17:24:54 ## restore_path() done

    EXEDIR=/usr/sap/ZIE/DVEBMGS76/exe
    EXECMD=/usr/sap/ZIE/DVEBMGS76/exe/sapcontrol
   }17:24:54 ## getExePath() done: 0

   _SAPCONTROL=/usr/sap/ZIE/DVEBMGS76/exe/sapcontrol

   {17:24:54 ## set_path() start: @=/usr/sap/ZIE/DVEBMGS76/exe
    N_PATH=/usr/sap/ZIE/DVEBMGS76/exe
    LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
    O_LD_LIBRARY_PATH=/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
   }17:24:54 ## set_path() done

   {17:24:54 ## getSapsystemNr() start: @=DVEBMGS76

    {17:24:54 ## getExePath() start: @=sappfpar DVEBMGS76

     {17:24:55 ## set_path() start: @=/usr/sap/ZIE/DVEBMGS76/exe
      N_PATH=/usr/sap/ZIE/DVEBMGS76/exe
      LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/clien
t/11x_64/instantclient
      O_LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
     }17:24:55 ## set_path() done

     _DIR_EXECUTABLE=

     {17:24:55 ## restore_path() start
      LD_LBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
     }17:24:55 ## restore_path() done

     EXEDIR=/usr/sap/ZIE/DVEBMGS76/exe
     EXECMD=/usr/sap/ZIE/DVEBMGS76/exe/sappfpar
    }17:24:55 ## getExePath() done: 0

    _SAPPFPAR=/usr/sap/ZIE/DVEBMGS76/exe/sappfpar

    {17:24:55 ## set_path() start: @=/usr/sap/ZIE/DVEBMGS76/exe
     N_PATH=/usr/sap/ZIE/DVEBMGS76/exe
     LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client
/11x_64/instantclient
     O_LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
    }17:24:55 ## set_path() done

    _INST_PROFILE=ZIE_DVEBMGS76_zieci

    {17:24:55 ## restore_path() start
     LD_LBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
    }17:24:55 ## restore_path() done

    NR=76
   }17:24:55 ## getSapsystemNr() done

   _NR=76

   {17:24:55 ## sapstartsrv_do() start: @=start DVEBMGS76

    {17:24:55 ## getExePath() start: @=sapcontrol DVEBMGS76

     {17:24:55 ## set_path() start: @=/usr/sap/ZIE/DVEBMGS76/exe
      N_PATH=/usr/sap/ZIE/DVEBMGS76/exe
      LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/clien
t/11x_64/instantclient
      O_LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
     }17:24:55 ## set_path() done

     _DIR_EXECUTABLE=

     {17:24:55 ## restore_path() start
      LD_LBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
     }17:24:55 ## restore_path() done

     EXEDIR=/usr/sap/ZIE/DVEBMGS76/exe
     EXECMD=/usr/sap/ZIE/DVEBMGS76/exe/sapcontrol
    }17:24:55 ## getExePath() done: 0

    _SAPCONTROL=/usr/sap/ZIE/DVEBMGS76/exe/sapcontrol

    {17:24:55 ## set_path() start: @=/usr/sap/ZIE/DVEBMGS76/exe
     N_PATH=/usr/sap/ZIE/DVEBMGS76/exe
     LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client
/11x_64/instantclient
     O_LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client/11x_64/instantclient
    }17:24:55 ## set_path() done

    {17:24:55 ## getSapsystemNr() start: @=DVEBMGS76

     {17:24:55 ## getExePath() start: @=sappfpar DVEBMGS76

      {17:24:55 ## set_path() start: @=/usr/sap/ZIE/DVEBMGS76/exe
       N_PATH=/usr/sap/ZIE/DVEBMGS76/exe
       LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapd
b/programs/lib:/oracle/client/11x_64/instantclient
       O_LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/cl
ient/11x_64/instantclient
      }17:24:55 ## set_path() done

      _DIR_EXECUTABLE=

      {17:24:55 ## restore_path() start
       LD_LBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/clien
t/11x_64/instantclient
      }17:24:55 ## restore_path() done

      EXEDIR=/usr/sap/ZIE/DVEBMGS76/exe
      EXECMD=/usr/sap/ZIE/DVEBMGS76/exe/sappfpar
     }17:24:55 ## getExePath() done: 0

     _SAPPFPAR=/usr/sap/ZIE/DVEBMGS76/exe/sappfpar

     {17:24:55 ## set_path() start: @=/usr/sap/ZIE/DVEBMGS76/exe
      N_PATH=/usr/sap/ZIE/DVEBMGS76/exe
      LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb
/programs/lib:/oracle/client/11x_64/instantclient
      O_LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/cli
ent/11x_64/instantclient
     }17:24:55 ## set_path() done

     _INST_PROFILE=ZIE_DVEBMGS76_zieci

     {17:24:55 ## restore_path() start
      LD_LBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client
/11x_64/instantclient
     }17:24:55 ## restore_path() done

     NR=76
    }17:24:55 ## getSapsystemNr() done

    Starting Startup Agent sapstartsrv

    {17:24:55 ## getExePath() start: @=sapstartsrv DVEBMGS76

     {17:24:55 ## set_path() start: @=/usr/sap/ZIE/DVEBMGS76/exe
      N_PATH=/usr/sap/ZIE/DVEBMGS76/exe
      LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb
/programs/lib:/oracle/client/11x_64/instantclient
      O_LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/cli
ent/11x_64/instantclient
     }17:24:55 ## set_path() done

     _DIR_EXECUTABLE=

     {17:24:55 ## restore_path() start
      LD_LBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/client
/11x_64/instantclient
     }17:24:55 ## restore_path() done

     EXEDIR=/usr/sap/ZIE/DVEBMGS76/exe
     EXECMD=/usr/sap/ZIE/DVEBMGS76/exe/sapstartsrv
    }17:24:55 ## getExePath() done: 0

    _SAPSTARTSRV=/usr/sap/ZIE/DVEBMGS76/exe/sapstartsrv
    _START_PROFILE=/usr/sap/ZIE/SYS/profile/START_DVEBMGS76_zieci
    _INSTANCE_PROFILE=/usr/sap/ZIE/SYS/profile/ZIE_DVEBMGS76_zieci

    {17:24:55 ## set_path() start: @=/usr/sap/ZIE/DVEBMGS76/exe
     N_PATH=/usr/sap/ZIE/DVEBMGS76/exe
     LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/
programs/lib:/oracle/client/11x_64/instantclient
     O_LD_LIBRARY_PATH=/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/DVEBMGS76/exe:/usr/sap/ZIE/SYS/exe/uc/linuxx86_64:/usr/sap/ZIE/hdbclient:/sapdb/programs/lib:/oracle/clie
nt/11x_64/instantclient
    }17:24:55 ## set_path() done

    /usr/sap/ZIE/DVEBMGS76/exe/sapstartsrv pf=/usr/sap/ZIE/SYS/profile/START_DVEBMGS76_zieci -D
    ask sapcontrol when service is started
    /usr/sap/ZIE/DVEBMGS76/exe/sapcontrol -nr 76 -function WaitforServiceStarted 120 10
    Startup of Instance Service failed
    See /usr/sap/ZIE/startsap_DVEBMGS76.log for details

    _returncode=255
   }17:24:55 ## sapstartsrv_do() done: 255

  }17:24:55 ## instance_do() done

Exit code 255

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

6.) STARTDB Log :

     

more startdb.log

------------------------------ Thu Nov 21 17:24:51 UTC 2013
LOGFILE FOR STARTING ORACLE

Trying to start ZIE database ...

------------------------------ Thu Nov 21 17:24:51 UTC 2013
checking required environment variables

ORACLE_HOME  is >/oracle/ZIE/112_64<
ORACLE_SID   is >ZIE<

------------------------------ Thu Nov 21 17:24:51 UTC 2013
check initora

------------------------------ Thu Nov 21 17:24:51 UTC 2013
check initora

------------------------------ Thu Nov 21 17:24:51 UTC 2013
checking V2 connect

TNS Ping Utility for Linux: Version 11.2.0.2.0 - Production on 21-NOV-2013 17:24:51

Copyright (c) 1997, 2010, Oracle.  All rights reserved.

Used parameter files:
/usr/sap/ZIE/SYS/profile/oracle/sqlnet.ora

Used TNSNAMES adapter to resolve the alias
Attempting to contact (DESCRIPTION = (ADDRESS_LIST = (ADDRESS = (COMMUNITY = SAP.WORLD) (PROTOCOL = TCP) (HOST = ziedb) (PORT = 1576))) (CONNECT_DATA = (SID = ZIE) (GLO
BAL_NAME = ZIE.WORLD)))
OK (0 msec)
tnsping: V2 connect to ZIE

------------------------------ Thu Nov 21 17:24:51 UTC 2013
Connect to the database to check the database state:

R3trans: connect check finished with return code: 0
Database already running

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

7.) Listner

lnrctl status

CORRECT>lsnrctl status (y|n|e|a)? yes

LSNRCTL for Linux: Version 11.2.0.2.0 - Production on 21-NOV-2013 17:49:08

Copyright (c) 1991, 2010, Oracle.  All rights reserved.

Connecting to (ADDRESS=(PROTOCOL=tcp)(HOST=)(PORT=1521))
TNS-12541: TNS:no listener
TNS-12560: TNS:protocol adapter error
  TNS-00511: No listener
   Linux Error: 111: Connection refused

START LISTNER

TNSLSNR for Linux: Version 11.2.0.2.0 - Production
System parameter file is /oracle/ZIE/112_64/network/admin/listener.ora
Log messages written to /oracle/ZIE/112_64/network/log/liszie.log
Listening on: (DESCRIPTION=(ADDRESS=(PROTOCOL=ipc)(KEY=ZIE)))
Listening on: (DESCRIPTION=(ADDRESS=(PROTOCOL=tcp)(HOST=10.5.0.11)(PORT=1576)))

Connecting to (ADDRESS=(PROTOCOL=IPC)(KEY=ZIE))
STATUS of the LISTENER
------------------------
Alias                     liszie
Version                   TNSLSNR for Linux: Version 11.2.0.2.0 - Production
Start Date                21-NOV-2013 18:24:48
Uptime                    0 days 0 hr. 0 min. 0 sec
Trace Level               off
Security                  ON: Local OS Authentication
SNMP                      OFF
Listener Parameter File   /oracle/ZIE/112_64/network/admin/listener.ora
Listener Log File         /oracle/ZIE/112_64/network/log/liszie.log
Listening Endpoints Summary...
  (DESCRIPTION=(ADDRESS=(PROTOCOL=ipc)(KEY=ZIE)))
  (DESCRIPTION=(ADDRESS=(PROTOCOL=tcp)(HOST=10.5.0.11)(PORT=1576)))
Services Summary...
Service "ZIE" has 1 instance(s).
  Instance "ZIE", status UNKNOWN, has 1 handler(s) for this service...
The command completed successfully

zieadm 241> lsnrctl start liszie

LSNRCTL for Linux: Version 11.2.0.2.0 - Production on 21-NOV-2013 17:50:14

Copyright (c) 1991, 2010, Oracle.  All rights reserved.

TNS-01106: Listener using listener name liszie has already been started

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

Database is up and running, listener is up and running ... but I can't start SAP !!

Please help people !!

Regards

Msat

Accepted Solutions (1)

Accepted Solutions (1)

ashish_mishra2
Contributor
0 Kudos

Hi,

To me it looks like the issue is there with the kernel contents. Lib files are not updated with the current executable.

The question to you is -"Was there any kernel upgrade activity happened recently??"

If yes, then check if all the files are up to date.

libicuuc.so.40, libicudata.so.40, libicui18n.so.40  - here 40 indicates the lib files version.

you can check the kernel version using disp+work and then check / compare in other systems of landscape having same kernel version.

If lib files versions are ok, then please check below solution.

It might seems bit weird to you but this has resolved the same issue many times.

SAP TECH patching (SAP note#1652660) resolved the issue with missing ICU libraries.

and here is the note which states same error message and solution to this-

SAP Note # 1737528 - AS JAVA doesn't start with 7.2x kernel

Hope this helps..

Cheers !!!

Ashish

Former Member
0 Kudos

Hi Ashish,

Like I've explained before yes I did attempt a kernel and Brtools upgrade .. I've given the details in my previous comment to Manish.

The Lib files available in my system are as follows ..

:zieadm 53> pwd

/usr/sap/ZIE/DVEBMGS76/exe

pdeluh0001636:zieadm 54> ls -lrt *.40

-r-xr--r-x 1 zieadm sapsys 0 Nov 21 13:43 libicuuc.so.40

-r-xr--r-x 1 zieadm sapsys 0 Nov 21 13:43 libicui18n.so.40

-r-xr--r-x 1 zieadm sapsys 0 Nov 21 13:43 libicudata.so.40

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

zieadm 228> pwd

/sapmnt/ZIE/exe/uc/linuxx86_64

pdeluh0001636:zieadm 229> ls -lrt *.40

-rwxr-xr-x 1 zieadm sapsys  1761119 Jan 15  2013 libicuuc.so.40

-rwxr-xr-x 1 zieadm sapsys  2183345 Jan 15  2013 libicui18n.so.40

-rwxr-xr-x 1 zieadm sapsys 13915412 Jan 15  2013 libicudata.so.40

They are available !! So according to your comment they are the latest ones updated .. has the .40 extention.

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

People I need your help and support this is serious ... I have to bring my system up ... what could be the issue ?

Is it the environment variables ?

Is the kernel files ? If Yes, why is not working when I revert back to the old kernel ... the old kernel ..

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

ashish_mishra2
Contributor
0 Kudos
:zieadm 53> pwd

/usr/sap/ZIE/DVEBMGS76/exe

pdeluh0001636:zieadm 54> ls -lrt *.40

-r-xr--r-x 1 zieadm sapsys 0 Nov 21 13:43 libicuuc.so.40

-r-xr--r-x 1 zieadm sapsys 0 Nov 21 13:43 libicui18n.so.40

-r-xr--r-x 1 zieadm sapsys 0 Nov 21 13:43 libicudata.so.40

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

zieadm 228> pwd

/sapmnt/ZIE/exe/uc/linuxx86_64

pdeluh0001636:zieadm 229> ls -lrt *.40

-rwxr-xr-x 1 zieadm sapsys  1761119 Jan 15  2013 libicuuc.so.40

-rwxr-xr-x 1 zieadm sapsys  2183345 Jan 15  2013 libicui18n.so.40

-rwxr-xr-x 1 zieadm sapsys 13915412 Jan 15  2013 libicudata.so.40

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

Hi,

Did you notice any difference in contents of both the locations ??

Files present in /usr/sap/ZIE/DVEBMGS76/exe are of 0KB and  of different dates which means there these files are corrupted and could not extracted properly.

Please copy these lib files from /sapmnt/ZIE/exe/uc/linuxx86_64 to /usr/sap/ZIE/DVEBMGS76/exe

and also perform clean restart with clearing semaphores using cleanipc command.

Hope this helps..

cheers !!!

Ashish

Former Member
0 Kudos

How silly of me ... I didn't notice the file sizes !!

I kept breaking my head over the error :

Database not available via R3trans !!

Now I understand why they say .. always think with a cool head !!

My SAP is up and running all healthy !!

Thanks a ton Ashish !!

Answers (6)

Answers (6)

former_member185239
Active Contributor
0 Kudos

Hi MSAT,

Database is getting connected , try to run the script

1. saproot.sh with root user.

2. sapcpe pf=<instance profile>

and then start the sap system.

Also paste the env for <sid>adm and also revert it to the old kernel and then start the sap.

Then download the fresh kernel start it.

With Regards

Ashutosh Chaturvedi

Reagan
Advisor
Advisor
0 Kudos

One are you able to start Oracle and SAP separately ? means first start database on the Oracle server and SAP on the SAP system ?

Regards

RB

Former Member
0 Kudos

more startdb.log

According to my startdb.log .. R3trans is able to connect to DB .. it even finishes with a RC=0

saying that DB is already running.. !!

Then why the error Database is not available via R3trans ? Hmmmm ...

------------------------------ Fri Nov 22 07:32:40 UTC 2013
LOGFILE FOR STARTING ORACLE

Trying to start ZIE database ...

------------------------------ Fri Nov 22 07:32:40 UTC 2013
checking required environment variables

ORACLE_HOME  is >/oracle/ZIE/112_64<
ORACLE_SID   is >ZIE<

------------------------------ Fri Nov 22 07:32:40 UTC 2013
check initora

------------------------------ Fri Nov 22 07:32:40 UTC 2013
check initora

------------------------------ Fri Nov 22 07:32:40 UTC 2013
checking V2 connect

TNS Ping Utility for Linux: Version 11.2.0.2.0 - Production on 22-NOV-2013 07:32:40

Copyright (c) 1997, 2010, Oracle.  All rights reserved.

Used parameter files:
/usr/sap/ZIE/SYS/profile/oracle/sqlnet.ora

Used TNSNAMES adapter to resolve the alias
Attempting to contact (DESCRIPTION = (ADDRESS_LIST = (ADDRESS = (COMMUNITY = SAP.WORLD) (PROTO
COL = TCP) (HOST = ziedb) (PORT = 1576))) (CONNECT_DATA = (SID = ZIE) (GLOBAL_NAME = ZIE.WORLD
)))
OK (0 msec)
tnsping: V2 connect to ZIE

------------------------------ Fri Nov 22 07:32:40 UTC 2013
Connect to the database to check the database state:

R3trans: connect check finished with return code: 0
Database already running

Sriram2009
Active Contributor
0 Kudos
manish_singh13
Active Contributor
0 Kudos

Hi,

Could you please confirm two points:

1. Your LD_LIBRARY_PATH is set for /usr/sap/ZIE/DVEBMGS76/exe while you checked the lib* files in /sapmnt/ZIE/exe/uc/linuxx86_64. Are these paths mapped?

2. Did you upgraded your kernel after installation?

Thanks,

Manish Singh

Former Member
0 Kudos

Hi Manish,

1.) The path LD_LIBRARY_PATH: has both  /usr/sap/ZIE/DVEBMGS76/exe, and /sapmnt/ZIE/exe/uc/linuxx86_64 mapped to it . both the paths are accessible. 

:zieadm 53> pwd

/usr/sap/ZIE/DVEBMGS76/exe

pdeluh0001636:zieadm 54> ls -lrt *.40

-r-xr--r-x 1 zieadm sapsys 0 Nov 21 13:43 libicuuc.so.40

-r-xr--r-x 1 zieadm sapsys 0 Nov 21 13:43 libicui18n.so.40

-r-xr--r-x 1 zieadm sapsys 0 Nov 21 13:43 libicudata.so.40

2.) Now the most important question :

Yes after installation and all post installation activities I did upgrade the kernel and BRtools.

Before upgradation :

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

--------------------
disp+work information
--------------------

kernel release                720

kernel make variant           720_EXT_REL

compiled on                   Linux GNU SLES-11 x86_64 cc4.3.4 use-pr101110 for linuxx86_64

compiled for                  64 BIT

compilation mode              UNICODE

compile time                  Aug 15 2011 20:19:20

update level                  0

patch number                  100

source id                     0.100

operating system
Linux 2.6

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

This is R3trans version 6.22 (release 720 - 03.06.11 - 17:57:00).
unicode enabled version
R3trans finished (0000).

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

This is tp version 380.03.41 (release 720, unicode enabled)

--------------------
tp information
--------------------

kernel release                720

kernel make variant           720_EXT_REL

DBMS client library           OCI_112,

DBSL shared library version   720.00

compiled on                   Linux GNU SLES-11 x86_64 cc4.3.4 use-pr101110 for linuxx86_64

compiled for                  64 BIT

compilation mode              UNICODE

compile time                  Aug 12 2011 21:04:51

update level                  0

patch number                  100

source id                     0.100

After Upgradation :

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

--------------------
disp+work information
--------------------

kernel release                720

kernel make variant           720_EXT_REL

compiled on                   Linux GNU SLES-11 x86_64 cc4.3.4 use-pr130419 for linuxx86_64

compiled for                  64 BIT

compilation mode              UNICODE

compile time                  Aug  4 2013 19:24:53

update level                  0

patch number                  440

source id                     0.440


---------------------
supported environment
---------------------

database (SAP, table SVERS)   700
                              710
                              701
                              702
                              703
                              711
                              720
                              730
                              731
                              732

operating system
Linux 2.6
Linux 3

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

This is R3trans version 6.24 (release 720 - 08.07.13 - 20:13:05 ).

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

zieadm 57> tp -v
This is tp version 380.08.41 (release 720, unicode enabled)

--------------------
tp information
--------------------

kernel release                720

kernel make variant           720_EXT_REL

DBMS client library           OCI_112,

DBSL shared library version   720.00

compiled on                   Linux GNU SLES-11 x86_64 cc4.3.4 use-pr130419 for linuxx86_64

compiled for                  64 BIT

compilation mode              UNICODE

compile time                  Jul 16 2013 19:11:10

update level                  0

patch number                  437

source id                     0.437


---------------------
supported environment
---------------------

database (SAP, table SVERS)   700
                              710
                              701
                              702
                              703
                              711
                              720
                              730
                              731
                              732

DBMS server
   ORACLE 10.1.0.*.*
   ORACLE 10.2.0.*.*
   ORACLE 11.2.*.*.*

operating system
Linux 2.6
Linux 3

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

The problem here is ... like always I did take the backup of the old kernel that was present at :

/sapmnt/ZIE/exe/uc/linuxx86_64

I did try switching the kernel back here in the patch mentioned above .. after that I checked for the disp+work, R3trans, TP versions etc .. all were old one .. again when I try starting SAP

It gives the same error ... DATABASE IS NOT AVAILABLE THROUGH R3trans ... etc etc !!

Reagan
Advisor
Advisor
0 Kudos

You need to provide more information about the system setup.

Is SAP supposed to run on the same machine where Oracle is running ? or is this a distributed setup ?

Regards

RB

Former Member
0 Kudos

@ Hi Benjamin,

This is a distributed setup, yes DB and SAP is on the same host.