Unable to start IS 9.12

Hi ,

I am not able to start my Integration Server 9.12 . No server logs if I start the server in normal mode by ./startup.sh

But when I start in safe mode by running the command ./startup.sh -safemode.

I am getting the below two logs . Any one faced this issue. Can you please help me on this.

//IntegrationServer/instances/default/bin/logs/server.out

//IntegrationServer/instances/default/bin/…/…/…//…/profiles/IS_default/bin/setenv.sh: line 58: syntax error: unexpected end of file
Starting as an application using Java because it is not set to use Tanuki Wrapper.

//IntegrationServer/instances/default/logs/server.sh.out

[Sat May 12 10:53:19 BST 2018] Bootstrap: Starting…
[Sat May 12 10:53:19 BST 2018] Bootstrap: Forced framework parrent class loader setting current over null
Debug options:
file://profiles/IS_default/bin/.options not found
!SESSION 2018-05-12 10:53:19.691 -----------------------------------------------
eclipse.buildId=unknown
java.version=1.8.0_101
java.vendor=Oracle Corporation
BootLoader constants: OS=linux, ARCH=x86_64, WS=gtk, NL=en_GB

!ENTRY com.softwareag.platform.hook.locations 1 0 2018-05-12 10:53:20.494
!MESSAGE Registering the location resolver hooks.

!ENTRY com.softwareag.platform.hook.mirrors 1 0 2018-05-12 10:53:20.508
!MESSAGE Registering the mirror bundle management hooks.

!ENTRY com.softwareag.platform.hook.shutdown 32 0 2018-05-12 10:53:20.515
!MESSAGE Registering the shutdown hook.

!ENTRY com.softwareag.platform.hook.locations 1 0 2018-05-12 10:53:22.182
!MESSAGE Discovered location: osgi.user.area=file:/apps/webmethods/user/

!ENTRY com.softwareag.platform.hook.locations 1 0 2018-05-12 10:53:22.183
!MESSAGE Discovered location: osgi.instance.area=file://profiles/IS_default/workspace/

!ENTRY com.softwareag.platform.hook.locations 1 0 2018-05-12 10:53:22.184
!MESSAGE Discovered location: osgi.configuration.area=file://profiles/IS_default/configuration/

!ENTRY com.softwareag.platform.hook.locations 1 0 2018-05-12 10:53:22.185
!MESSAGE Discovered location: osgi.install.area=file://profiles/IS_default/

!ENTRY com.softwareag.platform.hook.locations 1 0 2018-05-12 10:53:22.186
!MESSAGE Discovered location: eclipse.home.location=file://profiles/IS_default/

!ENTRY com.softwareag.platform.hook.locations 1 0 2018-05-12 10:53:22.198
!MESSAGE Replacing system property catalina.base->@path:osgi.configuration.area/tomcat with catalina.base->//profiles/IS_default/configuration/tomcat

!ENTRY com.softwareag.platform.hook.locations 1 0 2018-05-12 10:53:22.201
!MESSAGE Replacing system property tomcat.home->@path:osgi.configuration.area/tomcat with tomcat.home->///profiles/IS_default/configuration/tomcat

!ENTRY com.softwareag.platform.hook.locations 1 0 2018-05-12 10:53:22.203
!MESSAGE Replacing system property sag.install.area->@url:osgi.install.area/…/… with sag.install.area->file:/

!ENTRY com.softwareag.platform.hook.locations 1 0 2018-05-12 10:53:22.211
!MESSAGE Replacing system property org.eclipse.gemini.web.tomcat.config.path->@path:osgi.configuration.area/tomcat/conf/server.xml with org.eclipse.gemini.web.tomcat.config.path->//profiles/IS_default/configuration/tomcat/conf/server.xml

!ENTRY com.softwareag.platform.hook.locations 1 0 2018-05-12 10:53:22.221
!MESSAGE Discovered location: sag.install.area=file:/

!ENTRY com.softwareag.platform.hook.locations 1 0 2018-05-12 10:53:22.222
!MESSAGE Registered location sag.install.area=file:/
[Sat May 12 10:53:22 BST 2018] Bootstrap: Initialized shutdown handler to com.softwareag.platform.hook.shutdown.HookConfiguratorImpl$$Lambda$1/1387671967@16a9a4f1

!ENTRY com.softwareag.platform.hook.shutdown 32 0 2018-05-12 10:53:22.495
!MESSAGE Initialized graceful shutdown handler.
log4j:WARN No appenders could be found for logger (com.softwareag.platform.blueprint.ca.plugins.TokenFilterInitializer).
log4j:WARN Please initialize the log4j system properly.
log4j:WARN See http://logging.apache.org/log4j/1.2/faq.html#noconfig for more info.
May 12, 2018 10:53:24 AM com.softwareag.platform.console.internal.LocalConsoleManager open
INFO: Local JLine console flag: com.softwareag.platform.console.local.enabled=auto
May 12, 2018 10:53:24 AM com.softwareag.platform.console.internal.LocalConsoleManager open
INFO: Local JLine console disabled: JVM not attached to a terminal.
May 12, 2018 10:53:24 AM com.softwareag.platform.logging.init.internal.Activator start
INFO: Setting configuration directory to /apps/webmethods/EESOA_912/eebpo_int10_is_19194/profiles/IS_default/configuration
May 12, 2018 10:53:24 AM com.webmethods.sc.config.ConfigurationLogger log
INFO: Out-of-band file changes will be monitored every ‘60000’ milliseconds
May 12, 2018 10:53:24 AM com.softwareag.platform.logging.init.internal.Activator start
INFO: Initializing Journal Logger with the greedy JUL bridge

!ENTRY com.softwareag.platform.hook.mirrors 1 0 2018-05-12 10:53:25.823
!MESSAGE Overriding ClassLoader of com.softwareag.osgi.is.proxy_9.12.0.0000-0091 with tracker (service.pid=com.softwareag.osgi.is.classloader)

!ENTRY org.eclipse.equinox.ds 1 0 2018-05-12 10:53:31.805
!MESSAGE Could not bind a reference of component com.softwareag.platform.bundle.watchdog.internal.FrameworkRefresher. The reference is: Reference[name = com.softwareag.platform.bundle.watchdog.BundleWatchdog, interface = com.softwareag.platform.bundle.watchdog.BundleWatchdog, policy = dynamic, policy-option = reluctant, cardinality = 0…n, target = null, bind = addWatchdog, unbind = removeWatchdog, updated = null]
SecurityConfiguration for ESAPI.Logger not found in ESAPI.properties. Using default: org.owasp.esapi.reference.JavaLogFactory
SecurityConfiguration for ESAPI.Logger not found in ESAPI.properties. Using default: org.owasp.esapi.reference.JavaLogFactory
SecurityConfiguration for ESAPI.Logger not found in ESAPI.properties. Using default: org.owasp.esapi.reference.JavaLogFactory
SecurityConfiguration for ESAPI.Logger not found in ESAPI.properties. Using default: org.owasp.esapi.reference.JavaLogFactory

!ENTRY org.eclipse.equinox.ds 1 0 2018-05-12 10:53:50.608
!MESSAGE Could not bind a reference of component evpServiceTypeConfigurationService. The reference is: Reference[name = JmxConnectorFactoryService, interface = com.softwareag.platform.management.core.jmx.JmxConnectorFactoryService, policy = dynamic, cardinality = 0…1, target = null, bind = setJMXConnectorService, unbind = unsetJMXConnectorService]

!ENTRY org.eclipse.equinox.ds 1 0 2018-05-12 10:53:50.617
!MESSAGE Could not bind a reference of component evpServiceTypeConfigurationService. The reference is: Reference[name = InventoryExService, interface = com.softwareag.platform.management.inventory.spi.InventoryExService, policy = dynamic, cardinality = 0…1, target = null, bind = setInventoryService, unbind = unsetInventoryService]
Registered WSS for Spring Board!

!ENTRY com.softwareag.ext.org.eclipse.equinox.compendium.cm 4 0 2018-05-12 10:54:36.370
!MESSAGE Failed to create bean jmxConnector
!STACK 0
java.lang.RuntimeException: Failed to create bean jmxConnector
at com.softwareag.platform.blueprint.ca.internal.AbstractManagedService.create(AbstractManagedService.java:235)
at com.softwareag.platform.blueprint.ca.ManagedServiceFactory.updated(ManagedServiceFactory.java:49)
at org.eclipse.equinox.internal.cm.ManagedServiceFactoryTracker$2.run(ManagedServiceFactoryTracker.java:279)
at org.eclipse.equinox.internal.cm.SerializedTaskQueue$1.run(SerializedTaskQueue.java:36)
Caused by: java.lang.reflect.InvocationTargetException
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.softwareag.platform.blueprint.ca.internal.BeanLifecycle.create(BeanLifecycle.java:143)
at com.softwareag.platform.blueprint.ca.internal.BeanLifecycle.open(BeanLifecycle.java:78)
at com.softwareag.platform.blueprint.ca.internal.AbstractManagedService.create(AbstractManagedService.java:233)
… 3 more
Caused by: java.io.IOException: JMX Server on 0.0.0.0:8079 failed to create an RMI registry RMIServerSocketFactory
at com.softwareag.platform.jmx.internal.JmxConnectorImpl.createRegistry(JmxConnectorImpl.java:223)
at com.softwareag.platform.jmx.internal.JmxConnectorImpl.openImpl(JmxConnectorImpl.java:150)
at com.softwareag.platform.jmx.internal.JmxConnectorImpl.open(JmxConnectorImpl.java:113)
… 10 more
Caused by: java.rmi.server.ExportException: Port already in use: 8079; nested exception is:
java.net.BindException: Address already in use
at sun.rmi.transport.tcp.TCPTransport.listen(TCPTransport.java:341)
at sun.rmi.transport.tcp.TCPTransport.exportObject(TCPTransport.java:249)
at sun.rmi.transport.tcp.TCPEndpoint.exportObject(TCPEndpoint.java:411)
at sun.rmi.transport.LiveRef.exportObject(LiveRef.java:147)
at sun.rmi.server.UnicastServerRef.exportObject(UnicastServerRef.java:212)
at sun.rmi.registry.RegistryImpl.setup(RegistryImpl.java:152)
at sun.rmi.registry.RegistryImpl.(RegistryImpl.java:112)
at java.rmi.registry.LocateRegistry.createRegistry(LocateRegistry.java:239)
at com.softwareag.platform.jmx.internal.JmxConnectorImpl.createRegistry(JmxConnectorImpl.java:220)
… 12 more
Caused by: java.net.BindException: Address already in use
at java.net.PlainSocketImpl.socketBind(Native Method)
at java.net.AbstractPlainSocketImpl.bind(AbstractPlainSocketImpl.java:387)
at java.net.ServerSocket.bind(ServerSocket.java:375)
at java.net.ServerSocket.(ServerSocket.java:237)
at javax.net.DefaultServerSocketFactory.createServerSocket(ServerSocketFactory.java:231)
at com.softwareag.platform.jmx.internal.PlainRMIServerSocketFactory.createServerSocket(PlainRMIServerSocketFactory.java:18)
at sun.rmi.transport.tcp.TCPEndpoint.newServerSocket(TCPEndpoint.java:666)
at sun.rmi.transport.tcp.TCPTransport.listen(TCPTransport.java:330)
… 20 more

IS_912_Safemode_Logs.txt (9.94 KB)

Hi,

What is the IS port ? I can see some errors for 8079 port in the logs.

Also please attached default.log and platform.log files which are under /profile/IS_/logs directory.

Thanks
Yogesh

Also please check your setenv.sh file. As per log there is an extra “/” in path.

//IntegrationServer/instances/default/bin/…/…/…//…/profiles/IS_default/bin/setenv.sh

Hi Yogesh,

Thanks

Please find attached default.log and platform.log files from /profile/IS_/logs directory

Regards
Saravanan G
platform.log (255 KB)
default.log (52.1 KB)

The IS port is 19194

Hi Sarvanan,

From the logs, i can see below error message only.

failed to create an RMI registry RMIServerSocketFactory

Please try to change the JMX port from 8079 to another one and then start the server. Looks like port 8079 is already in use.

Thanks,
Yogesh

Hi Yogesh,

As per the above log,the issue is due to /profiles/IS_default/bin/setenv.sh.

I have noticed there is a syntax error in this file. Somebody had edited this file for changing the JAVA_MIN_MEM.

I have fixed this issue by solving the syntax error.

Regards
Saravanan G

Extra “/” ?

The below line caused the issue
if [ “x$JAVA_MIN_MEM” = “x” ]; then
JAVA_MIN_MEM=256Mfi

Corrected as below
if [ “x$JAVA_MIN_MEM” = “x” ]; then
JAVA_MIN_MEM=256M
fi

1 Like

What number did you set in JAVA_MIN_MEM? I have encountered the same issue.