Skip to Content

SAP Netweaver Java 7.5 installation Java engine not start

Hello,


Im installing the Netweaver 7.5 Java Server.


However during the installation in Provisioning Manager when Java engine is starting I get an error. I tried the installation many times, Upgrade SAP kernel after the error, changing the /etc/hosts file like in the note 1713021 but the error is still the same:

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

stdout/stderr redirection

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

node name : server0

host name : sap-netweaver

system name : MII

system nr. : 00

started at : Fri Jul 8 11:21:59 2016

JVMX version - Nov 13 2015 10:11:59 - 81_REL - optU - linux amd64 - 6 - bas2:257478 (mixed mode)

(CompilerOracle read from file /usr/sap/MII/J00/exe/sapjvm_8/jre/.hotspot_compiler)

The active factory is : com.sap.engine.boot.loader.StandardClassLoaderFactory

Class loading cache information loaded from package index [/usr/sap/MII/J00/j2ee/cluster/bin/index.list]

Reading manager properties from [kernelProperties.bin] file

Checked the data for [10] ms

Objects read for [108] ms

Substituted the values for [75] ms

Finished reading kernel objects for [183] ms

Startup mode [NORMAL] and action [NONE] read

AS Java version [7.50.3301.382056.20150709124709 SP 00] is starting server process [ID5621950] on host xxx ...

Loading [LogManager]... [72] ms

Loading [PoolManager]... [3] ms

Loading [ApplicationThreadManager]... 1,875: [GC (Allocation Failure) 1,875: [ParNew: 1027405K->4447K(1223040K), 0,0251419 secs] 1027405K->4447K(4019584K), 0,0253897 secs] [Times: user=0,08 sys=0,01, real=0,02 secs]

[199] ms

Loading [ThreadManager]... [27] ms

Loading [ClassLoaderManager]... [18] ms

Loading [ClusterManager]... [1337] ms

Loading [LockingManager]... [47] ms

Loading [ConfigurationManager]... [1527] ms

Loading [CacheManager]... [125] ms

Loading [DatabaseManager]... [348] ms

Loading [SessionManager]... [319] ms

Loading [LicensingManager]... [41] ms

Loading [ServiceManager]...

Initialize components for : 122 ms.

5,901: [GC (CMS Initial Mark) 5,901: [GC (CMS Initial Mark) 5,901: [ParNew: 403005K->18674K(1223040K), 0,0351900 secs] 403005K->18674K(4019584K), 0,0353602 secs] [Times: user=0,12 sys=0,02, real=0,04 secs]

[1 CMS-initial-mark: 0K(2796544K)] 18674K(4019584K), 0,0409253 secs] [Times: user=0,14 sys=0,02, real=0,05 secs]

5,942: [CMS-concurrent-mark-start]

5,972: [CMS-concurrent-mark: 0,030/0,030 secs] [Times: user=0,06 sys=0,02, real=0,02 secs]

5,972: [CMS-concurrent-preclean-start]

5,980: [CMS-concurrent-preclean: 0,008/0,008 secs] [Times: user=0,02 sys=0,00, real=0,01 secs]

5,981: [CMS-concurrent-abortable-preclean-start]

Resolve components for : 32 ms.

Load components for 1027 ms.

Loading services.

Calculate startup service set for 282 ms.

Service [tc~je~security~api] started. [16] ms / [0] CPU ms

Service [engine.dsr.facade] started. [16] ms / [0] CPU ms

Service [tc~je~cross~api] started. [16] ms / [0] CPU ms

Service [tc~je~mngt_model~srv] started. [16] ms / [0] CPU ms

Service [r3startup] started. [20] ms / [0] CPU ms

Service [security.destination.facade] started. [21] ms / [0] CPU ms

Service [webservices] started. [21] ms / [0] CPU ms

Service [engine.lm.log.facade] started. [21] ms / [0] CPU ms

Service [tc~je~content~classification~handler] started. [22] ms / [0] CPU ms

Service [tc~esi~uddi~content~handler] started. [30] ms / [0] CPU ms

Service [tc~je~sca~ws.plugin] started. [26] ms / [0] CPU ms

Service [runtimeinfo] started. [100] ms / [8] CPU ms

Service [tc~je~sca~jco.plugin] started. [131] ms / [2] CPU ms

Service [cluster] started. [139] ms / [4] CPU ms

Service [memory] started. [367] ms / [19] CPU ms

Service [jmx_notification] started. [351] ms / [22] CPU ms

Service [timeout] started. [370] ms / [30] CPU ms

Service [userstore] started. [373] ms / [19] CPU ms

Service [tc~com.sap.service.jco] started. [388] ms / [142] CPU ms

Service [tc~sec~destinations~provider] started. [436] ms / [37] CPU ms

Service [cross] started. [426] ms / [52] CPU ms

Service [log_configurator] started. [504] ms / [53] CPU ms

Service [locking] started. [43] ms / [7] CPU ms

Service [tc~bl~accounting_infra~srv] started. [712] ms / [121] CPU ms

Service [p4] started. [376] ms / [80] CPU ms

Service [classload] started. [15] ms / [1] CPU ms

Service [msp] started. [15] ms / [3] CPU ms

Service [classload.facade] started. [0] ms / [0] CPU ms

Service [classpath_resolver] started. [53] ms / [15] CPU ms

Service [naming] started. [443] ms / [230] CPU ms

Service [file] started. [3] ms / [2] CPU ms

Service [tc~je~sca~ejb.plugin] started. [40] ms / [1] CPU ms

Service [objectanalyzing] started. [49] ms / [10] CPU ms

Service [javamail] started. [176] ms / [52] CPU ms

Service [connector] started. [211] ms / [55] CPU ms

Service [library_container] started. [29] ms / [12] CPU ms

Service [schemaprocessor~srv] started. [1869] ms / [899] CPU ms

Service [tc~je~sca~integration] started. [1662] ms / [1273] CPU ms

Service [http] started. [2777] ms / [223] CPU ms

CMS: abort preclean due to time 11,164: [CMS-concurrent-abortable-preclean: 3,956/5,183 secs] [Times: user=15,59 sys=0,93, real=5,19 secs]

11,164: [GC (CMS Final Remark) [YG occupancy: 378535 K (1223040 K)]11,164: [Rescan (parallel) , 0,0631602 secs]11,228: [weak refs processing, 0,0005210 secs]11,228: [class unloading, 0,0083460 secs]11,237: [scrub symbol table, 0,0167750 secs]11,253: [scrub string table, 0,0028361 secs][1 CMS-remark: 0K(2796544K)] 378535K(4019584K), 0,0936930 secs] [Times: user=0,30 sys=0,00, real=0,09 secs]

11,258: [CMS-concurrent-sweep-start]

11,259: [CMS-concurrent-sweep: 0,000/0,000 secs] [Times: user=0,00 sys=0,00, real=0,00 secs]

11,259: [CMS-concurrent-reset-start]

11,320: [CMS-concurrent-reset: 0,062/0,062 secs] [Times: user=0,13 sys=0,04, real=0,06 secs]

Service [deploy] started. [10104] ms / [429] CPU ms

Service [deploy.facade] started. [0] ms / [0] CPU ms

Service [MigrationService] started. [30] ms / [14] CPU ms

Service [orpersistence] started. [36] ms / [17] CPU ms

Service [metadatarepository] started. [40] ms / [8] CPU ms

Service [engine.migration.facade] started. [0] ms / [0] CPU ms

Service [engine.migservice.facade] started. [0] ms / [0] CPU ms

Service [dbpool] started. [1308] ms / [260] CPU ms

Service [dbpool.facade] started. [0] ms / [0] CPU ms

Service [tc~je~dbcontainer~srv] started. [145] ms / [28] CPU ms

Service [ts] started. [278] ms / [47] CPU ms

Service [licensing] started. [6] ms / [3] CPU ms

Service [engine.license.facade] started. [0] ms / [0] CPU ms

Service [tc~lm~nzdm~crrsrv] start ================= ERROR =================

CSN Component [BC-UPG-DTM-TLJ], DC Name [sap.com/tc~lm~nzdm~crrsrv]

java.lang.RuntimeException: Unable to look up data source jdbc/SAP/BC_NZDM

at com.sap.tc.lm.nzdm.crr.srv.core.NZDMServiceFrame.start(NZDMServiceFrame.java:105)

at com.sap.engine.frame.ApplicationFrameAdaptor.start(ApplicationFrameAdaptor.java:31)

at com.sap.engine.core.service630.container.ServiceRunner.startFrame(ServiceRunner.java:165)

at com.sap.engine.core.service630.container.ServiceRunner.startService(ServiceRunner.java:118)

at com.sap.engine.core.service630.container.ServiceRunner.run(ServiceRunner.java:65)

at com.sap.engine.frame.core.thread.Task.run(Task.java:73)

at com.sap.engine.core.thread.impl5.SingleThread.execute(SingleThread.java:178)

at com.sap.engine.core.thread.impl5.SingleThread.run(SingleThread.java:316)

FATAL: Critical shutdown with exit code [2150] was requested due to [AS Java cannot be started; core service [tc~lm~nzdm~crrsrv] failed to start]

Heap

par new generation reserved 1397760K, committed 1397760K, used 652460K [0x00000006f0000000, 0x0000000745500000, 0x0000000745500000)

eden space 1048320K, 60% used [0x00000006f0000000, 0x0000000716aee7c0, 0x000000072ffc0000)

from space 174720K, 10% used [0x000000072ffc0000, 0x00000007311fc908, 0x000000073aa60000)

to space 174720K, 0% used [0x000000073aa60000, 0x000000073aa60000, 0x0000000745500000)

concurrent mark-sweep generation reserved 2796544K, committed 2796544K, used 0K [0x0000000745500000, 0x00000007f0000000, 0x00000007f0000000)

Metaspace used 52168K, capacity 55368K, committed 55512K, reserved 311296K

class space used 5673K, capacity 6643K, committed 6720K, reserved 262144K

java.lang.RuntimeException: Unable to look up data source jdbc/SAP/BC_NZDM

I tried to update the kernel files after the error but it doesnt help. The data source jdbc/SAP/BC_NZDM cannot be found.



I changed this file etc/hosts, uncommented IPv6 but it didnt help too ( I uncommented everything up to 127.0.0.1).


# IP-Address Full-Qualified-Hostname Short-Hostname

#

127.0.0.1 localhost

# special IPv6 addresses

#::1 localhost ipv6-localhost ipv6-loopback

#fe00::0 ipv6-localnet

#ff00::0 ipv6-mcastprefix

#ff02::1 ipv6-allnodes

#ff02::2 ipv6-allrouters

#ff02::3 ipv6-allhosts


Add a comment
10|10000 characters needed characters exceeded

Related questions

2 Answers

  • Best Answer
    author's profile photo Former Member
    Former Member
    Posted on Jul 11, 2016 at 10:05 AM

    Dear Michal,

    According to the exception and the description of the scenario, note 2311562 seems to be applicable.

    Please check and advise if applying the note solved your problem.

    2311562 - Nzdm Service fails to start due to failure of creation of DataSources or Aliases

    Regards,

    Emoke

    Add a comment
    10|10000 characters needed characters exceeded

    • Former Member

      Dear Emoke,

      I follow your instrction SAP NETWEAVER >> SAP NETWEAVER 7.5 >> APPLICATION SERVER JAVA >> ENGINEAPI 7.50 .under the ENGINEAPI 7.50.there are packages with different version.may I have to download all of them and relate SCAs?

  • Posted on Jul 11, 2016 at 02:03 PM

    Dear Emoke,

    I created a list of components, start the deploying and get mutex error. No idea what the problem is...I tried to start with user root and [SID]ADM but no difference.

    SHELL:

    ./batchdeployer.sh comp_list.txt

    INFO: Loading tool launcher...

    INFO: [OS: Linux] [VM vendor: SAP AG] [VM version: 1.8.0_66] [VM type: SAP Java Server VM]

    INFO: Main class to start: "com.sap.engine.extramile.BatchDeployer"

    INFO: Loading 22 JAR files: [/usr/sap/MII/SYS/global/security/lib/tools/iaik_ssl.jar, /usr/sap/MII/SYS/global/security/lib/tools/iaik_jsse.jar, /usr/sap/MII/SYS/global/security/lib/tools/iaik_jce.jar, /usr/sap/MII/SYS/global/security/lib/tools/w3c_http.jar, /usr/sap/MII/SYS/global/security/lib/tools/iaik_smime.jar, ./bootstrap/sap.com~tc~je~datacollector.jar, ./bootstrap/sap.com~tc~je~cfs~container~standalone_impl.jar, ./bootstrap/sap.com~tc~bl~opensql~implStandalone.jar, ./bootstrap/sap.com~tc~bl~offline_launcher~impl.jar, ./bootstrap/sap.com~tc~exception~impl.jar, ./bootstrap/sap.com~tc~bl~deploy~offline~impl.jar, ./bootstrap/sap.com~tc~bl~iqlib~impl.jar, ./bootstrap/sap.com~tc~bl~jdsr~jdsr.jar, ./bootstrap/sap.com~tc~je~extramile.jar, ./bootstrap/sap.com~tc~bl~config~impl.jar, ./bootstrap/sap.com~tc~je~bootstrap~impl.jar, ./bootstrap/sap.com~tc~logging~java~impl.jar, ./bootstrap/jperflib.jar, ./bootstrap/sap.com~tc~sec~secstorefs~java~core.jar, ./bootstrap/sap.com~tc~je~offlineconfiguration~impl.jar, ./bootstrap/jdbc.jar, /sapdb/clients/MII/runtime/jar/sapdbc.jar]

    INFO: Start

    Jul 11, 2016 3:53:54 PM [Error] Incorrect input parameters! Process exited with code 4.

    Usage: BatchDeployer ((-list {deployListFile_UTF-8} [-rd {componentsRootDir}])|(-sdu {sduFile} {sduFile}*)) (-subst_vars {substVarsFile})

    \nNOTE: This output is taken from log file [/usr/sap/MII/J00/j2ee/cluster/bootstrap/scripts/../../../../work/jvm_recoverer.out]

    \nERROR: JStart exit code [1], see details in log file [/usr/sap/MII/J00/j2ee/cluster/bootstrap/scripts/dev_recoverer]

    DEV_RECOVERER

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

    trc file: "dev_recoverer", trc level: 1, release: "745"

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

    sysno 00

    sid MII

    systemid 390 (AMD/Intel x86_64 with Linux)

    relno 7450

    patchlevel 0

    patchno 100

    intno 20151301

    make multithreaded, Unicode, 64 bit, optimized

    profile /usr/sap/MII/SYS/profile/MII_J00_sap-netweaver

    pid 12260

    *

    * ACTIVE TRACE LEVEL 1

    * ACTIVE TRACE COMPONENTS All, egi

    *

    Mon Jul 11 15:53:50 2016

    *

    * trace logging activated, max size = 52428800 bytes, 2 versions

    *

    arguments :

    arg[ 0] : /usr/sap/MII/J00/j2ee/cluster/bootstrap/scripts/../../../../exe/jstart

    arg[ 1] : -launch

    arg[ 2] : -nodename=recoverer

    arg[ 3] : -file=/usr/sap/MII/J00/j2ee/cluster/bootstrap/scripts/recoverer.jstart

    arg[ 4] : pf=/usr/sap/MII/SYS/profile/MII_J00_sap-netweaver

    arg[ 5] : comp_list.txt

    M

    M [Thr 140166646245216] Mon Jul 11 15:53:51 2016

    M [Thr 140166646245216] ***LOG Q0I=> NiBufIConnect: connection pending after 500ms: connect (115: Operation now in progress) [/bas/745_REL/src/base/ni/nibuf.cpp 4587]

    M [Thr 140166646245216] *** ERROR => NiBufIConnect: non-buffered connect pending after 500ms (hdl 1;xxx:80) [nibuf.cpp 4598]

    F [Thr 140166646245216] *** ERROR => Could not establish connection xxxx 80 NiRc=-10 [virtinfoxx.c 144]

    F ********************************************************************************

    F Java environment properties (/usr/sap/MII/J00/work/recoverer.jvm)

    F root directory : /usr/sap/MII/J00/exe/sapjvm_8

    F vendor : SAP AG

    F version : 1.8.0_66

    F cpu : amd64

    F java vm type : server

    F java vm version : 8.1.013 25.51-b02

    F jvm library name : libjvm.so

    F library path : /usr/sap/MII/J00/exe/sapjvm_8/jre/lib/amd64/server:/usr/sap/MII/J00/exe/sapjvm_8/jre/lib/amd64

    F executable path : /usr/sap/MII/J00/exe/sapjvm_8/bin

    F ********************************************************************************

    F SAP extensions : available

    F ********************************************************************************

    M [Thr 140166646245216] NiInit3: NI already initialized; param 'maxHandles' ignored (init=1;par=65536;cur=2048)

    F ********************************************************************************

    F Java process [recoverer] properties:

    F section name : recoverer

    F config file : /usr/sap/MII/J00/j2ee/cluster/bootstrap/scripts/recoverer.jstart

    F node name : recoverer

    F home directory : /usr/sap/MII/J00/j2ee/cluster

    F shutdown timeout : 136000 ms

    F exit timeout : 7000 ms

    F debuggable : false

    F debugger active : false

    F ********************************************************************************

    F ********************************************************************************

    F Starting process: /usr/sap/MII/J00/j2ee/cluster/bootstrap/scripts/../../../../exe/jstart

    F arg[ 1] = -connId=9

    F arg[ 2] = pf=/usr/sap/MII/SYS/profile/MII_J00_sap-netweaver

    F arg[ 3] = -hostvm

    F arg[ 4] = -nodeName=recoverer

    F arg[ 5] = -file=/usr/sap/MII/J00/j2ee/cluster/bootstrap/scripts/recoverer.jstart

    F arg[ 6] = -jvmFile=/usr/sap/MII/J00/work/recoverer.jvm

    F arg[ 7] = -traceFile=/usr/sap/MII/J00/work/dev_recoverer.cld

    F arg[ 8] = -javaOutFile=/usr/sap/MII/J00/work/jvm_recoverer.out

    F arg[ 9] = comp_list.txt

    F exePath : PATH=/usr/sap/MII/J00/exe/sapjvm_8/bin:/sbin:/usr/sbin:/usr/local/sbin:/root/bin:/usr/local/bin:/usr/bin:/bin:/usr/bin/X11:/usr/X11R6/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin

    F libPath : LD_LIBRARY_PATH=/usr/sap/MII/J00/exe/sapjvm_8/jre/lib/amd64/server:/usr/sap/MII/J00/exe/sapjvm_8/jre/lib/amd64:/usr/sap/MII/J00/j2ee/os_libs:/usr/sap/MII/J00/exe

    F stdout : /usr/sap/MII/J00/work/std_recoverer.out

    F stderr : /usr/sap/MII/J00/work/std_recoverer.out

    F console : no

    F debugger: no

    F nice : no

    F ********************************************************************************

    F Process recoverer started with pid 12261

    F ********************************************************************************

    F [Thr 140166646245216] *** LOG => Process recoverer started (pid 12261).

    F

    F [Thr 140166646245216] Mon Jul 11 15:53:54 2016

    F [Thr 140166646245216] *** LOG => Process recoverer stopping (pid 12261).

    F [Thr 140166646245216] *** LOG => Signal 17 SIGCHLD.

    F [Thr 140166646245216] *** LOG => Process recoverer stopped (pid 12261).

    F

    F ********************************************************************************

    F *** ERROR => Mutex initialization failed.

    F ***

    F *** Please see section 'Launcher initialization issues'

    F *** in SAP Note 1316652 for additional information and trouble shooting advice.

    F ********************************************************************************

    F

    F [Thr 140166646245216] *** LOG => exiting (exitcode 4, retcode 1).

    Add a comment
    10|10000 characters needed characters exceeded

Before answering

You should only submit an answer when you are proposing a solution to the poster's problem. If you want the poster to clarify the question or provide more information, please leave a comment instead, requesting additional details. When answering, please include specifics, such as step-by-step instructions, context for the solution, and links to useful resources. Also, please make sure that you answer complies with our Rules of Engagement.
You must be Logged in to submit an answer.

Up to 10 attachments (including images) can be used with a maximum of 1.0 MB each and 10.5 MB total.