IBM webMethods Hybrid Integration

IBM webMethods Hybrid Integration

Join this online group to communicate across IBM product users and experts by sharing advice and best practices with peers and staying up to date regarding product enhancements.


#TechXchangePresenter
 View Only
Expand all | Collapse all

[ISS.0014.0054C] Error occurred while initializing server

  • 1.  [ISS.0014.0054C] Error occurred while initializing server

    Posted Wed September 02, 2020 10:49 AM

    Hello,

    i’m trying to start an Integration server in a docker container. This IS is a copy of an existing IS who work well.
    When I start my container I get the error message “[ISS.0014.0054C] Error occurred while initializing server”

    I’m in webMethods 10.5 on centos 7 OS.

    I’ve seen a post where the error is similar but there is no solution.

    here my server.log :

    2020-09-02 14:27:49 UTC [ISS.0025.0001I] Integration Server 10.5.0.0 Build 84
    2020-09-02 14:27:49 UTC [ISS.0025.0006I] License Manager started
    2020-09-02 14:27:49 UTC [ISS.0001.0008W] Microservices Functionality disabled due to license restrictions.
    2020-09-02 14:27:50 UTC [ISS.0025.0049I] The JCE Unlimited Strength Jurisdiction Policy File was found
    2020-09-02 14:27:50 UTC [ISS.0025.0041I] FIPS mode not initialized
    2020-09-02 14:27:52 UTC [ISS.0025.0024I] JDBC Connection Manager started
    2020-09-02 14:27:56 UTC [ISS.0095.0013I] Audit Logging initialized.
    2020-09-02 14:27:59 UTC [ISS.0033.0168I] Cluster Node Name: 5d6e56ec68b0.
    2020-09-02 14:28:00 UTC [ISS.0025.0017I] Repository Manager started
    2020-09-02 14:28:00 UTC [ISS.0025.0021I] ACL Manager started
    2020-09-02 14:28:00 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Users" to ACL "Anonymous" because group "My webMethods Users" is not found.
    2020-09-02 14:28:00 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Users" to ACL "Default" because group "My webMethods Users" is not found.
    2020-09-02 14:28:00 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Administrators" to ACL "Administrators" because group "My webMethods Administrators" is not found.
    2020-09-02 14:28:00 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Administrators" to ACL "Internal" because group "My webMethods Administrators" is not found.
    2020-09-02 14:28:00 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Administrators" to ACL "Developers" because group "My webMethods Administrators" is not found.
    2020-09-02 14:28:00 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Administrators" to ACL "Replicators" because group "My webMethods Administrators" is not found.
    2020-09-02 14:28:00 UTC [ISS.0025.0008I] State Manager started
    2020-09-02 14:28:00 UTC [ISS.0025.0010I] Service Manager started
    2020-09-02 14:28:00 UTC [ISS.0025.0020I] Validation Processor started
    2020-09-02 14:28:00 UTC [ISS.0025.0022I] Statistics Processor started
    2020-09-02 14:28:00 UTC [ISS.0025.0018I] Invoke Manager started
    2020-09-02 14:28:00 UTC [ISS.0025.0012I] Cache Manager started
    2020-09-02 14:28:01 UTC [ISS.0098.0026I] Document Store DefaultStore initialized
    2020-09-02 14:28:03 UTC [ISS.0098.0026I] Document Store VolatileTriggerStore initialized
    2020-09-02 14:28:03 UTC [ISS.0098.0026I] Document Store TriggerStore initialized
    2020-09-02 14:28:03 UTC [ISS.0098.0026I] Document Store ResubmitStore initialized
    2020-09-02 14:28:06 UTC [ISS.0153.0007I] webMethods Messaging connection alias IS_UM_CONNECTION started
    2020-09-02 14:28:06 UTC [ISS.0153.0007I] webMethods Messaging connection alias IS_DES_CONNECTION started
    2020-09-02 14:28:06 UTC [ISS.0153.0000I] webMethods Messaging subsystem started
    2020-09-02 14:28:06 UTC [ISS.0106.0001I] Join Manager initialized
    2020-09-02 14:28:06 UTC [ISS.0025.0032I] Dispatcher initialized
    2020-09-02 14:28:06 UTC [ISS.0134.0128I] JMS subsystem is starting.
    2020-09-02 14:28:07 UTC [ISS.0134.0998I] DEFAULT_IS_JMS_CONNECTION cache enabled :: true
    2020-09-02 14:28:07 UTC [ISS.0134.0998I] PE_NONTRANSACTIONAL_ALIAS cache enabled :: true
    2020-09-02 14:28:07 UTC [ISS.0134.0000I] JMS subsystem started
    2020-09-02 14:28:07 UTC [ISS.0173.0000I] Common Messaging subsystem started
    2020-09-02 14:28:08 UTC [SCC.0121.0093I] XA Recovery Store initialized
    2020-09-02 14:28:08 UTC [com.webmethods.fabric.agent.FabricAgent.null.load.startI] [agent.load.start] Loading registry config file /opt/softwareag/IntegrationServer/instances/pont/config/fabric-agent.xml
    2020-09-02 14:28:08 UTC [com.webmethods.fabric.agent.FabricAgent.null.startI] [agent.start] Starting Fabric Agent
    2020-09-02 14:28:08 UTC [ISS.0025.0055I] Lock Manager initialized
    2020-09-02 14:28:14 UTC [ISS.0014.0054C] Error occurred while initializing server: java.lang.ExceptionInInitializerError    at org.eclipse.jetty.http.pathmap.PathMappings.<clinit>(PathMappings.java:49)       at com.wm.app.b2b.server.websocket.WebSocketServerEndpointManager.<init>(WebSocketServerEndpointManager.java:34)    at com.wm.app.b2b.server.websocket.WebSocketServerEndpointManager.<clinit>(WebSocketServerEndpointManager.java:33)      at 
    2020-09-02 14:27:49 UTC [ISS.0025.0001I] Integration Server 10.5.0.0 Build 84
    2020-09-02 14:27:49 UTC [ISS.0025.0006I] License Manager started
    2020-09-02 14:27:49 UTC [ISS.0001.0008W] Microservices Functionality disabled due to license restrictions.
    2020-09-02 14:27:50 UTC [ISS.0025.0049I] The JCE Unlimited Strength Jurisdiction Policy File was found
    2020-09-02 14:27:50 UTC [ISS.0025.0041I] FIPS mode not initialized
    2020-09-02 14:27:52 UTC [ISS.0025.0024I] JDBC Connection Manager started
    2020-09-02 14:27:56 UTC [ISS.0095.0013I] Audit Logging initialized.
    2020-09-02 14:27:59 UTC [ISS.0033.0168I] Cluster Node Name: 5d6e56ec68b0.
    2020-09-02 14:28:00 UTC [ISS.0025.0017I] Repository Manager started
    2020-09-02 14:28:00 UTC [ISS.0025.0021I] ACL Manager started
    2020-09-02 14:28:00 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Users" to ACL "Anonymous" because group "My webMethods Users" is not found.
    2020-09-02 14:28:00 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Users" to ACL "Default" because group "My webMethods Users" is not found.
    2020-09-02 14:28:00 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Administrators" to ACL "Administrators" because group "My webMethods Administrators" is not found.
    2020-09-02 14:28:00 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Administrators" to ACL "Internal" because group "My webMethods Administrators" is not found.
    2020-09-02 14:28:00 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Administrators" to ACL "Developers" because group "My webMethods Administrators" is not found.
    2020-09-02 14:28:00 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Administrators" to ACL "Replicators" because group "My webMethods Administrators" is not found.
    2020-09-02 14:28:00 UTC [ISS.0025.0008I] State Manager started
    2020-09-02 14:28:00 UTC [ISS.0025.0010I] Service Manager started
    2020-09-02 14:28:00 UTC [ISS.0025.0020I] Validation Processor started
    2020-09-02 14:28:00 UTC [ISS.0025.0022I] Statistics Processor started
    2020-09-02 14:28:00 UTC [ISS.0025.0018I] Invoke Manager started
    2020-09-02 14:28:00 UTC [ISS.0025.0012I] Cache Manager started
    2020-09-02 14:28:01 UTC [ISS.0098.0026I] Document Store DefaultStore initialized
    2020-09-02 14:28:03 UTC [ISS.0098.0026I] Document Store VolatileTriggerStore initialized
    2020-09-02 14:28:03 UTC [ISS.0098.0026I] Document Store TriggerStore initialized
    2020-09-02 14:28:03 UTC [ISS.0098.0026I] Document Store ResubmitStore initialized
    2020-09-02 14:28:06 UTC [ISS.0153.0007I] webMethods Messaging connection alias IS_UM_CONNECTION started
    2020-09-02 14:28:06 UTC [ISS.0153.0007I] webMethods Messaging connection alias IS_DES_CONNECTION started
    2020-09-02 14:28:06 UTC [ISS.0153.0000I] webMethods Messaging subsystem started
    2020-09-02 14:28:06 UTC [ISS.0106.0001I] Join Manager initialized
    2020-09-02 14:28:06 UTC [ISS.0025.0032I] Dispatcher initialized
    2020-09-02 14:28:06 UTC [ISS.0134.0128I] JMS subsystem is starting.
    2020-09-02 14:28:07 UTC [ISS.0134.0998I] DEFAULT_IS_JMS_CONNECTION cache enabled :: true
    2020-09-02 14:28:07 UTC [ISS.0134.0998I] PE_NONTRANSACTIONAL_ALIAS cache enabled :: true
    2020-09-02 14:28:07 UTC [ISS.0134.0000I] JMS subsystem started
    2020-09-02 14:28:07 UTC [ISS.0173.0000I] Common Messaging subsystem started
    2020-09-02 14:28:08 UTC [SCC.0121.0093I] XA Recovery Store initialized
    2020-09-02 14:28:08 UTC [com.webmethods.fabric.agent.FabricAgent.null.load.startI] [agent.load.start] Loading registry config file /opt/softwareag/IntegrationServer/instances/pont/config/fabric-agent.xml
    2020-09-02 14:28:08 UTC [com.webmethods.fabric.agent.FabricAgent.null.startI] [agent.start] Starting Fabric Agent
    2020-09-02 14:28:08 UTC [ISS.0025.0055I] Lock Manager initialized
    2020-09-02 14:28:14 UTC [ISS.0014.0054C] Error occurred while initializing server: java.lang.ExceptionInInitializerError    at org.eclipse.jetty.http.pathmap.PathMappings.<clinit>(PathMappings.java:49)       at com.wm.app.b2b.server.websocket.WebSocketServerEndpointManager.<init>(WebSocketServerEndpointManager.java:34)    at com.wm.app.b2b.server.websocket.WebSocketServerEndpointManager.<clinit>(WebSocketServerEndpointManager.java:33)      at com.wm.app.b2b.server.Server.run(Server.java:665)
    
    

    Thank you in advance


    #webMethods
    #Integration-Server-and-ESB


  • 2.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Wed September 02, 2020 11:05 AM

    Hi,
    Can you please describe steps you used to create the Docker image?
    Thanks,
    -Kalpesh.


    #Integration-Server-and-ESB
    #webMethods


  • 3.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Wed September 02, 2020 11:33 AM

    Hi,
    We have a git where we upload all the source code of the IS except the instances in the “instances” directory and “profiles” directory.
    A Jenkins import the git project, compress the package and upload it on a nexus.
    Then we launch a script on our vm. The script download the package from the nexus and execute the dockerfile who build the image from a centos 7 image who is already on the vm. This image is our base for the next step.

    Then we have another git where we upload the instances and profiles.
    Another Jenkins import the git project, compress the package and upload it on another nexus.
    Finally the dockerfile build the image using the “base” image of the previous step. Then the ENTRYPOINT property starts the script : IntegrationServer/bin/StartContainer.sh


    #webMethods
    #Integration-Server-and-ESB


  • 4.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Thu September 03, 2020 10:29 AM

    Hi G LR,

    If the docker container itself is up and running, then login into that container and try to start the IS manually within it and see the error.

    I’m not sure if some network/proxy issue is causing this problem by the last exception in the error log you shared.

    Regards,
    Firoz N


    #Integration-Server-and-ESB
    #webMethods


  • 5.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Fri September 04, 2020 11:40 AM

    Hi,

    when i start the IS with the "server.sh’ it’s working well, but when I use the “startcontainer.sh” it causes the error above.
    But if I use the “server.sh” as the entrypoint the container stop after the end of the sript “server.sh”.

    So I thinks the problem is more in the script “startcontainer.sh” but i don’t see why this specific script dosen’t work


    #webMethods
    #Integration-Server-and-ESB


  • 6.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Fri September 04, 2020 02:45 PM

    Hi,

    Are there any other errors reported in wrapper.log file?

    Thanks,
    -Kalpesh.


    #webMethods
    #Integration-Server-and-ESB


  • 7.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Wed September 09, 2020 08:58 AM

    Hi,

    here’s the wrapper.log files, I have checked the jar and it seems to bug on an object “logger” or “log”, maybe it’s a problem of an absolute path to a log file location.

    Is there a file where an absolute path for a log file is configured ?

    STATUS | wrapper  | 2020/09/09 12:27:46 | Base configuration file is /opt/softwareag/profiles/IS_pont/configuration/wrapper.conf
    STATUS | wrapper  | 2020/09/09 12:27:46 | Found #include file in /opt/softwareag/profiles/IS_pont/configuration/wrapper.conf: %OSGI_INSTALL_AREA%/configuration/wrapper-license.conf
    STATUS | wrapper  | 2020/09/09 12:27:46 |   After environment variable replacements: /opt/softwareag/profiles/IS_pont/configuration/wrapper-license.conf
    STATUS | wrapper  | 2020/09/09 12:27:46 |   Reading included configuration file, /opt/softwareag/profiles/IS_pont/configuration/wrapper-license.conf
    STATUS | wrapper  | 2020/09/09 12:27:46 | Found #include file in /opt/softwareag/profiles/IS_pont/configuration/wrapper.conf: %OSGI_INSTALL_AREA%/configuration/custom_wrapper.conf
    STATUS | wrapper  | 2020/09/09 12:27:46 |   After environment variable replacements: /opt/softwareag/profiles/IS_pont/configuration/custom_wrapper.conf
    STATUS | wrapper  | 2020/09/09 12:27:46 |   Reading included configuration file, /opt/softwareag/profiles/IS_pont/configuration/custom_wrapper.conf
    STATUS | wrapper  | 2020/09/09 12:27:46 | --> Wrapper Started as Console
    STATUS | wrapper  | 2020/09/09 12:27:46 | Java Service Wrapper Standard Edition 64-bit 3.5.37
    STATUS | wrapper  | 2020/09/09 12:27:46 |   Copyright (C) 1999-2018 Tanuki Software, Ltd. All Rights Reserved.
    STATUS | wrapper  | 2020/09/09 12:27:46 |     http://wrapper.tanukisoftware.com
    STATUS | wrapper  | 2020/09/09 12:27:46 |   Licensed to Software AG USA, Inc. for Software AG Integration Server
    STATUS | wrapper  | 2020/09/09 12:27:46 |
    STATUS | wrapper  | 2020/09/09 12:27:47 | Launching a JVM...
    INFO   | jvm 1    | 2020/09/09 12:27:47 | WrapperManager: Initializing...
    INFO   | jvm 1    | 2020/09/09 12:27:47 | [ProxyLogManager] Taking over JUL
    INFO   | jvm 1    | 2020/09/09 12:27:47 | [ProxyLogManager] readConfiguration() -> com.softwareag.platform.jul.proxy.DefaultLogManager@3a71f4dd
    INFO   | jvm 1    | 2020/09/09 12:27:47 | Debug options:
    INFO   | jvm 1    | 2020/09/09 12:27:47 |     file:/opt/softwareag/IntegrationServer/instances/../../profiles/IS_pont/bin/.options not found
    INFO   | jvm 1    | 2020/09/09 12:27:47 | !SESSION 2020-09-09 12:27:47.823 -----------------------------------------------
    INFO   | jvm 1    | 2020/09/09 12:27:47 | eclipse.buildId=unknown
    INFO   | jvm 1    | 2020/09/09 12:27:47 | java.version=1.8.0_222
    INFO   | jvm 1    | 2020/09/09 12:27:47 | java.vendor=Azul Systems, Inc.
    INFO   | jvm 1    | 2020/09/09 12:27:47 | BootLoader constants: OS=linux, ARCH=x86_64, WS=gtk, NL=en_US
    INFO   | jvm 1    | 2020/09/09 12:27:47 |
    INFO   | jvm 1    | 2020/09/09 12:27:47 | !ENTRY com.softwareag.platform.hook.locations 1 0 2020-09-09 12:27:47.963
    INFO   | jvm 1    | 2020/09/09 12:27:47 | !MESSAGE Registering the location resolver hooks.
    INFO   | jvm 1    | 2020/09/09 12:27:47 |
    INFO   | jvm 1    | 2020/09/09 12:27:47 | !ENTRY com.softwareag.platform.hook.mirrors 1 0 2020-09-09 12:27:47.967
    INFO   | jvm 1    | 2020/09/09 12:27:47 | !MESSAGE Registering the mirror bundle management hooks.
    INFO   | jvm 1    | 2020/09/09 12:27:48 |
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !ENTRY com.softwareag.platform.hook.shutdown 1 0 2020-09-09 12:27:47.978
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !MESSAGE Registering the shutdown hook.
    INFO   | jvm 1    | 2020/09/09 12:27:48 |
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !ENTRY com.softwareag.platform.hook.locations 1 0 2020-09-09 12:27:48.324
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !MESSAGE Created java temp directory /opt/softwareag/profiles/IS_pont/workspace/temp
    INFO   | jvm 1    | 2020/09/09 12:27:48 |
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !ENTRY com.softwareag.platform.hook.locations 1 0 2020-09-09 12:27:48.332
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !MESSAGE Discovered location: osgi.user.area=file:/opt/softwareag/user/
    INFO   | jvm 1    | 2020/09/09 12:27:48 |
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !ENTRY com.softwareag.platform.hook.locations 1 0 2020-09-09 12:27:48.332
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !MESSAGE Discovered location: osgi.instance.area=file:/opt/softwareag/profiles/IS_pont/workspace/
    INFO   | jvm 1    | 2020/09/09 12:27:48 |
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !ENTRY com.softwareag.platform.hook.locations 1 0 2020-09-09 12:27:48.333
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !MESSAGE Discovered location: osgi.configuration.area=file:/opt/softwareag/profiles/IS_pont/configuration/
    INFO   | jvm 1    | 2020/09/09 12:27:48 |
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !ENTRY com.softwareag.platform.hook.locations 1 0 2020-09-09 12:27:48.333
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !MESSAGE Discovered location: osgi.install.area=file:/opt/softwareag/profiles/IS_pont/
    INFO   | jvm 1    | 2020/09/09 12:27:48 |
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !ENTRY com.softwareag.platform.hook.locations 1 0 2020-09-09 12:27:48.333
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !MESSAGE Discovered location: eclipse.home.location=file:/opt/softwareag/profiles/IS_pont/
    INFO   | jvm 1    | 2020/09/09 12:27:48 |
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !ENTRY com.softwareag.platform.hook.locations 1 0 2020-09-09 12:27:48.349
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !MESSAGE Replacing system property sag.install.area->@url:osgi.install.area/../.. with sag.install.area->file:/opt/softwareag/
    INFO   | jvm 1    | 2020/09/09 12:27:48 |
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !ENTRY com.softwareag.platform.hook.locations 1 0 2020-09-09 12:27:48.354
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !MESSAGE Discovered location: sag.install.area=file:/opt/softwareag/
    INFO   | jvm 1    | 2020/09/09 12:27:48 |
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !ENTRY com.softwareag.platform.hook.locations 1 0 2020-09-09 12:27:48.354
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !MESSAGE Registered location sag.install.area=file:/opt/softwareag/
    INFO   | jvm 1    | 2020/09/09 12:27:48 | [Wed Sep 09 12:27:48 UTC 2020] Bootstrap: Initialized shutdown handler to com.softwareag.platform.hook.shutdown.HookConfiguratorImpl$$Lambda$1/887889012@73d11a4c
    INFO   | jvm 1    | 2020/09/09 12:27:48 |
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !ENTRY com.softwareag.platform.hook.shutdown 1 0 2020-09-09 12:27:48.515
    INFO   | jvm 1    | 2020/09/09 12:27:48 | !MESSAGE Initialized graceful shutdown handler.
    INFO   | jvm 1    | 2020/09/09 12:27:51 | [ProxyLogManager] setDelegate: com.softwareag.platform.jul.proxy.DefaultLogManager@3a71f4dd -> org.apache.logging.log4j.jul.LogManager@9248f73
    INFO   | jvm 1    | 2020/09/09 12:27:54 | SecurityConfiguration for ESAPI.Logger not found in ESAPI.properties. Using default: org.owasp.esapi.reference.JavaLogFactory
    INFO   | jvm 1    | 2020/09/09 12:27:54 | SecurityConfiguration for ESAPI.Logger not found in ESAPI.properties. Using default: org.owasp.esapi.reference.JavaLogFactory
    INFO   | jvm 1    | 2020/09/09 12:27:54 | SecurityConfiguration for ESAPI.Logger not found in ESAPI.properties. Using default: org.owasp.esapi.reference.JavaLogFactory
    INFO   | jvm 1    | 2020/09/09 12:27:54 | SecurityConfiguration for ESAPI.Logger not found in ESAPI.properties. Using default: org.owasp.esapi.reference.JavaLogFactory
    INFO   | jvm 1    | 2020/09/09 12:28:02 |
    INFO   | jvm 1    | 2020/09/09 12:28:02 | !ENTRY com.softwareag.platform.hook.mirrors 1 0 2020-09-09 12:28:02.433
    INFO   | jvm 1    | 2020/09/09 12:28:02 | !MESSAGE Overriding ClassLoader of com.softwareag.osgi.is.proxy_10.5.0.0000-0084 with tracker (service.pid=com.softwareag.osgi.is.classloader)
    INFO   | jvm 1    | 2020/09/09 12:28:09 | INFO: Getting audit  config from it's default location.
    INFO   | jvm 1    | 2020/09/09 12:28:09 | WARNING: Audit configuration neither exists, nor could be found on the classpath. Auditing will not work.
    INFO   | jvm 1    | 2020/09/09 12:28:09 | INFO: Using dummy audit implementation.
    INFO   | jvm 1    | 2020/09/09 12:28:10 | 2020-09-09 12:28:10 UTC [ISS.0028.9999I] Validating License file for Microservices
    INFO   | jvm 1    | 2020/09/09 12:28:10 | 2020-09-09 12:28:10 UTC [ISS.0028.0103C] License file /opt/softwareag/IntegrationServer/instances/pont/config/licenseKey.xml is not enabled for the Microservices functionality.
    INFO   | jvm 1    | 2020/09/09 12:28:10 | 2020-09-09 12:28:10 UTC [ISS.0028.0104C] Unable to perform configuration variables processing because license is not valid.
    INFO   | jvm 1    | 2020/09/09 12:28:12 | ISSERVER|| 2020-09-09 12:28:12 UTC [ISS.0025.0001I] Integration Server 10.5.0.0 Build 84
    INFO   | jvm 1    | 2020/09/09 12:28:12 | ISSERVER|| 2020-09-09 12:28:12 UTC [ISS.0025.0006I] License Manager started
    INFO   | jvm 1    | 2020/09/09 12:28:12 | ISSERVER|| 2020-09-09 12:28:12 UTC [ISS.0001.0008W] Microservices Functionality disabled due to license restrictions.
    INFO   | jvm 1    | 2020/09/09 12:28:12 | ISSERVER|| 2020-09-09 12:28:12 UTC [ISS.0025.0049I] The JCE Unlimited Strength Jurisdiction Policy File was found
    INFO   | jvm 1    | 2020/09/09 12:28:12 | ISSERVER|| 2020-09-09 12:28:12 UTC [ISS.0025.0041I] FIPS mode not initialized
    INFO   | jvm 1    | 2020/09/09 12:28:15 | ISSERVER|| 2020-09-09 12:28:15 UTC [ISS.0025.0024I] JDBC Connection Manager started
    INFO   | jvm 1    | 2020/09/09 12:28:19 | ISSERVER|| 2020-09-09 12:28:19 UTC [ISS.0095.0013I] Audit Logging initialized.
    INFO   | jvm 1    | 2020/09/09 12:28:21 | ISSERVER|| 2020-09-09 12:28:21 UTC [ISS.0033.0168I] Cluster Node Name: 2e47862a24a0.
    INFO   | jvm 1    | 2020/09/09 12:28:22 | ISSERVER|| 2020-09-09 12:28:22 UTC [ISS.0025.0017I] Repository Manager started
    INFO   | jvm 1    | 2020/09/09 12:28:23 | ISSERVER|| 2020-09-09 12:28:23 UTC [ISS.0025.0021I] ACL Manager started
    INFO   | jvm 1    | 2020/09/09 12:28:23 | ISSERVER|| 2020-09-09 12:28:23 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Users" to ACL "Anonymous" because group "My webMethods Users" is not found.
    INFO   | jvm 1    | 2020/09/09 12:28:23 | ISSERVER|| 2020-09-09 12:28:23 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Users" to ACL "Default" because group "My webMethods Users" is not found.
    INFO   | jvm 1    | 2020/09/09 12:28:23 | ISSERVER|| 2020-09-09 12:28:23 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Administrators" to ACL "Administrators" because group "My webMethods Administrators" is not found.
    INFO   | jvm 1    | 2020/09/09 12:28:23 | ISSERVER|| 2020-09-09 12:28:23 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Administrators" to ACL "Internal" because group "My webMethods Administrators" is not found.
    INFO   | jvm 1    | 2020/09/09 12:28:23 | ISSERVER|| 2020-09-09 12:28:23 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Administrators" to ACL "Developers" because group "My webMethods Administrators" is not found.
    INFO   | jvm 1    | 2020/09/09 12:28:23 | ISSERVER|| 2020-09-09 12:28:23 UTC [ISS.0024.0015E] Integration Server cannot add group "My webMethods Administrators" to ACL "Replicators" because group "My webMethods Administrators" is not found.
    INFO   | jvm 1    | 2020/09/09 12:28:23 | ISSERVER|| 2020-09-09 12:28:23 UTC [ISS.0025.0008I] State Manager started
    INFO   | jvm 1    | 2020/09/09 12:28:23 | ISSERVER|| 2020-09-09 12:28:23 UTC [ISS.0025.0010I] Service Manager started
    INFO   | jvm 1    | 2020/09/09 12:28:23 | ISSERVER|| 2020-09-09 12:28:23 UTC [ISS.0025.0020I] Validation Processor started
    INFO   | jvm 1    | 2020/09/09 12:28:23 | ISSERVER|| 2020-09-09 12:28:23 UTC [ISS.0025.0022I] Statistics Processor started
    INFO   | jvm 1    | 2020/09/09 12:28:23 | ISSERVER|| 2020-09-09 12:28:23 UTC [ISS.0025.0018I] Invoke Manager started
    INFO   | jvm 1    | 2020/09/09 12:28:23 | ISSERVER|| 2020-09-09 12:28:23 UTC [ISS.0025.0012I] Cache Manager started
    INFO   | jvm 1    | 2020/09/09 12:28:24 | ISSERVER|| 2020-09-09 12:28:24 UTC [ISS.0098.0026I] Document Store DefaultStore initialized
    INFO   | jvm 1    | 2020/09/09 12:28:25 | ISSERVER|| 2020-09-09 12:28:25 UTC [ISS.0098.0026I] Document Store VolatileTriggerStore initialized
    INFO   | jvm 1    | 2020/09/09 12:28:25 | ISSERVER|| 2020-09-09 12:28:25 UTC [ISS.0098.0026I] Document Store TriggerStore initialized
    INFO   | jvm 1    | 2020/09/09 12:28:26 | ISSERVER|| 2020-09-09 12:28:26 UTC [ISS.0098.0026I] Document Store ResubmitStore initialized
    INFO   | jvm 1    | 2020/09/09 12:28:26 | [Wed Sep 09 12:28:26.154 UTC 2020] [webMethods Integration Server] Setting log level to ERROR
    INFO   | jvm 1    | 2020/09/09 12:28:26 | --------- Log File Closed ---------
    INFO   | jvm 1    | 2020/09/09 12:28:26 |
    INFO   | jvm 1    | 2020/09/09 12:28:26 |
    INFO   | jvm 1    | 2020/09/09 12:28:27 | ISSERVER|| 2020-09-09 12:28:27 UTC [ISS.0153.0007I] webMethods Messaging connection alias IS_UM_CONNECTION started
    INFO   | jvm 1    | 2020/09/09 12:28:27 | ISSERVER|| 2020-09-09 12:28:27 UTC [ISS.0153.0007I] webMethods Messaging connection alias IS_DES_CONNECTION started
    INFO   | jvm 1    | 2020/09/09 12:28:27 | ISSERVER|| 2020-09-09 12:28:27 UTC [ISS.0153.0000I] webMethods Messaging subsystem started
    INFO   | jvm 1    | 2020/09/09 12:28:28 | ISSERVER|| 2020-09-09 12:28:27 UTC [ISS.0106.0001I] Join Manager initialized
    INFO   | jvm 1    | 2020/09/09 12:28:28 | ISSERVER|| 2020-09-09 12:28:27 UTC [ISS.0025.0032I] Dispatcher initialized
    INFO   | jvm 1    | 2020/09/09 12:28:28 | ISSERVER|| 2020-09-09 12:28:28 UTC [ISS.0134.0128I] JMS subsystem is starting.
    INFO   | jvm 1    | 2020/09/09 12:28:28 | ISSERVER|| 2020-09-09 12:28:28 UTC [ISS.0134.0998I] DEFAULT_IS_JMS_CONNECTION cache enabled :: true
    INFO   | jvm 1    | 2020/09/09 12:28:28 | ISSERVER|| 2020-09-09 12:28:28 UTC [ISS.0134.0998I] PE_NONTRANSACTIONAL_ALIAS cache enabled :: true
    INFO   | jvm 1    | 2020/09/09 12:28:28 | ISSERVER|| 2020-09-09 12:28:28 UTC [ISS.0134.0000I] JMS subsystem started
    INFO   | jvm 1    | 2020/09/09 12:28:28 | ISSERVER|| 2020-09-09 12:28:28 UTC [ISS.0173.0000I] Common Messaging subsystem started
    INFO   | jvm 1    | 2020/09/09 12:28:29 | ISSERVER|| 2020-09-09 12:28:29 UTC [SCC.0121.0093I] XA Recovery Store initialized
    INFO   | jvm 1    | 2020/09/09 12:28:29 | ISSERVER|| 2020-09-09 12:28:29 UTC [com.webmethods.fabric.agent.FabricAgent.null.load.startI] [agent.load.start] Loading registry config file /opt/softwareag/IntegrationServer/instances/pont/config/fabric-agent.xml
    INFO   | jvm 1    | 2020/09/09 12:28:29 | ISSERVER|| 2020-09-09 12:28:29 UTC [com.webmethods.fabric.agent.FabricAgent.null.startI] [agent.start] Starting Fabric Agent
    INFO   | jvm 1    | 2020/09/09 12:28:29 | ISSERVER|| 2020-09-09 12:28:29 UTC [ISS.0025.0055I] Lock Manager initialized
    INFO   | jvm 1    | 2020/09/09 12:28:30 | SLF4J: Class path contains multiple SLF4J bindings.
    INFO   | jvm 1    | 2020/09/09 12:28:30 | SLF4J: Found binding in [jar:file:/opt/softwareag/common/lib/ext/log4j/log4j-slf4j-impl.jar!/org/slf4j/impl/StaticLoggerBinder.class]
    INFO   | jvm 1    | 2020/09/09 12:28:30 | SLF4J: Found binding in [jar:file:/opt/softwareag/common/lib/ext/slf4j-log4j.jar!/org/slf4j/impl/StaticLoggerBinder.class]
    INFO   | jvm 1    | 2020/09/09 12:28:30 | SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
    INFO   | jvm 1    | 2020/09/09 12:28:30 | SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory]
    INFO   | jvm 1    | 2020/09/09 12:28:35 | ISSERVER|| 2020-09-09 12:28:35 UTC [ISS.0014.0054C] Error occurred while initializing server: java.lang.ExceptionInInitializerError        at org.eclipse.jetty.http.pathmap.PathMappings.<clinit>(PathMappings.java:49)        at com.wm.app.b2b.server.websocket.WebSocketServerEndpointManager.<init>(WebSocketServerEndpointManager.java:34)     at com.wm.app.b2b.server.websocket.WebSocketServerEndpointManager.<clinit>(WebSocketServerEndpointManager.java:33)   at com.wm.app.b2b.server.Server.run(Server.java:665)
    INFO   | jvm 1    | 2020/09/09 12:28:35 | check the server.log for more details
    INFO   | jvm 1    | 2020/09/09 12:28:36 | [ProxyLogManager] reset() -> org.apache.logging.log4j.jul.LogManager@9248f73
    INFO   | jvm 1    | 2020/09/09 12:28:37 | [Wed Sep 09 12:28:37 UTC 2020] Bootstrap: Stopping...
    INFO   | jvm 1    | 2020/09/09 12:28:37 |
    INFO   | jvm 1    | 2020/09/09 12:28:37 | !ENTRY com.softwareag.platform.hook.shutdown 1 0 2020-09-09 12:28:37.796
    INFO   | jvm 1    | 2020/09/09 12:28:37 | !MESSAGE Stopping OSGi framework.
    INFO   | jvm 1    | 2020/09/09 12:28:37 |
    INFO   | jvm 1    | 2020/09/09 12:28:37 | !ENTRY com.softwareag.platform.hook.shutdown 1 0 2020-09-09 12:28:37.802
    INFO   | jvm 1    | 2020/09/09 12:28:37 | !MESSAGE Framework shutdown timeout set to 120 seconds. Please also check tanuki-wrapper shutdown property, if specified.
    

    #webMethods
    #Integration-Server-and-ESB


  • 8.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Wed September 09, 2020 10:11 AM

    Is the Integration Server using any external database in JDBC Pools, Just check if we are having connectivity from within the container as well. Not sure if something related to this is blocking the IS to come up.


    #Integration-Server-and-ESB
    #webMethods


  • 9.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Wed September 09, 2020 10:22 AM

    Hi,
    yes the server uses external JDBC Pools, also the JDBC doesn’t seem to cause the error :

    2020-09-02 14:27:52 UTC [ISS.0025.0024I] JDBC Connection Manager started
    

    I looked the logs of the normal IS and the next logs that should appear are :

    [178]2020-09-09 15:34:54 CEST [ISS.0158.0000I] OData Server module is initialized.
    [179]2020-09-09 15:34:54 CEST [ISS.0048.9999I] Successfully initialized module "odata-server" by com.softwareag.is.odata.core.Init
    [180]2020-09-09 15:34:54 CEST [ISS.0048.9999I] Successfully initialized module "websocket-server" by com.softwareag.is.websocket.server.Init
    [181]2020-09-09 15:34:54 CEST [ISS.0048.9999I] Successfully initialized module "graphql-server" by com.softwareag.is.graphql.Init
    [182]2020-09-09 15:34:54 CEST [ISS.0139.9999I] Initializing ISKeyStoreManager using watt.server.homeDir:/FsSUP_env_dev/opt/application/efbsup/G12R00C00/is/IntegrationServer/instances/pont/config/security/keystore
    [183]2020-09-09 15:34:54 CEST [ISS.0139.9999I] ISKeyStoreManager initialized successfully.
    

    combined with the error logs, it’s seems that it’s the module “websocket-server” who don’t initialize correctly.


    #webMethods
    #Integration-Server-and-ESB


  • 10.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Wed September 09, 2020 10:34 AM

    Can you please check what files exists under IntegrationServer/lib/jars directory in your Docker image? Please make sure that jetty related jars that exists in installed folder of IntegrationServer/lib/jars directory are also present in the Docker image that you create.

    Regards,
    -Kalpesh.


    #Integration-Server-and-ESB
    #webMethods


  • 11.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Wed September 09, 2020 10:48 AM

    Hi,
    in my IntegrationServer/lib :

    agentInstall.jar       is-json-schema-parser.jar  is-websocket-api.jar     jcode.tmpl
    dir.html               is-odata-api.jar           is-websocket-client.jar  mime.types
    flow.tmpl              is-odata-client.jar        is-websocket-common.jar  wm-is-osgi-profile.jar
    is-graphql-client.jar  is-odata-impl-v2.jar       is-websocket-server.jar  wm-isproxy.jar
    is-graphql-server.jar  is-odata-server.jar        jars                     wm-isserver.jar
    

    and in my IntegrationServer/lib/jars :

    antlr4-runtime-4.7.1.jar       jetty-server-9.4.8.jar           postgresql-42.2.6.jar
    btf-1.2.jar                    jetty-servlet-9.4.8.jar          reactive-streams-1.0.2.jar
    commons-validator-1.6.0.jar    jetty-util-9.4.8.jar             rhino-1.7.7.1.jar
    graphql-java-9.4.0.jar         jnpserver.jar                    scribe-1.3.0.jar
    handy-uri-templates-2.1.6.jar  json-schema-core-1.2.5.jar       slf4j-api-1.7.25.jar
    jackson-coreutils-1.8.jar      json-schema-validator-2.2.6.jar  spring-boot-actuator-1.5.7.RELEASE.jar.old
    jackson-databind-2.6.5.jar     json-smart-1.1.1.jar             uri-template-0.9.jar
    java-dataloader-2.0.2.jar      libphonenumber-6.2.jar           websocket-api-9.4.8.jar
    jboss-common-core.jar          metrics-core-3.1.0.jar           websocket-client-9.4.8.jar
    jboss-logging.jar              msg-simple-1.1.jar               websocket-common-9.4.8.jar
    jetty-client-9.4.8.jar         nimbus-jose-jwt-5.1.jar          websocket-server-9.4.8.jar
    jetty-http-9.4.8.jar           ojdbc6.jar                       websocket-servlet-9.4.8.jar
    jetty-io-9.4.8.jar             olingo-odata2-api-2.0.10.jar     wm-fabric-agent.jar
    jetty-security-9.4.8.jar       olingo-odata2-core-2.0.10.jar    xerces-parser-conf.jar
    
    

    the only difference with my normal IS is an empty directory in IntegrationServer/lib and IntegrationServer/lib/jars, “classes” and “custom” respectively.


    #webMethods
    #Integration-Server-and-ESB


  • 12.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Wed September 09, 2020 11:18 AM

    Hi Leroux,

    I am wondering about the invalid license file message in the wrapper.log.
    Did you check that?

    Additionally from the IntegrationServer/lib/jars directory I see an ojdbc6.jar which is usually not part of the default installation.
    This one should be moved to lib/jars/custom/ and should be replaced with an ojdbc8.jar from a more recent version of the driver available from Oracle.

    Is IntegrationServer/ the working directory or IntegrationServer/instances/pont/?
    Please check the lib-directory and subdirectories for the pont instance as well.

    Regards,
    Holger


    #webMethods
    #Integration-Server-and-ESB


  • 13.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Wed September 09, 2020 12:01 PM

    Hi,

    the license is the same used by the normal IS and should not create problems.

    I will move the ojdbc.jar on the next restart of the normal IS and update the git.

    What do you mean exactly by “working directory” ? I try to run the script “IntegrationServer/bin/startContainer.sh” with only one instance (pont).

    The lib directory of “IntegrationServer/instances/pont/” is the same on my normal IS and my docker IS minus the empty directory.

    “IntegrationServer/instances/pont/lib” :

    classes  dir.html  flow.tmpl  jcode.tmpl  mime.types
    

    “IntegrationServer/instances/pont/lib/classes” :

    datasup.properties  log4j.properties  refalim.properties  refihm.properties
    

    Do I have to copy my “IntegrationServer/lib” inside my “IntegrationServer/instances/pont/lib” ?


    #Integration-Server-and-ESB
    #webMethods


  • 14.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Wed September 09, 2020 02:03 PM

    Hi Leroux,

    I have never used Docker-Image until now as we are still migrating from 9.5 to 9.12.
    Eventually we might use it later on.

    Therefore I cannot tell which directories the Docker-Image is using.

    Regards,
    Holger


    #webMethods
    #Integration-Server-and-ESB


  • 15.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Wed September 09, 2020 03:16 PM

    No, you don’t need to copy content under pont/lib directory. Did this work okay anytime in the past?
    Can you try follow simple steps below and see if this works i.e. to remove any of the other steps in your setup.

    From IntegrationServer/docker directory,

    ./is_container.sh createDockerfile -Dinstance.name=pont
    ./is_container.sh build
    ./is_container.sh createPackageDockerfile -Dinstance.name=pont
    ./is_container.sh buildPackage

    Once the above steps are successful, you will see a Docker image is:micro in your env. Use docker run command to start the container and see if you see the similar failure?

    Thanks,
    -Kalpesh.


    #Integration-Server-and-ESB
    #webMethods


  • 16.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Wed September 16, 2020 08:01 AM

    Hi,

    the I have create the is:micro image with the steps provided by Kalpesh, then i have compared the dockerfile of the generate image with my own dockerfile and fixed some difference. Now it’s work, but I have strange logs approximately each minute. I will work on it, but the main bug is fixed, so thank you for your precious help.

    Regards


    #Integration-Server-and-ESB
    #webMethods


  • 17.  RE: [ISS.0014.0054C] Error occurred while initializing server

    Posted Wed September 16, 2020 09:51 AM

    Hi Leroux,

    would you mind to share the strange logs with us, please?

    Eventually someone from the community knows what they mean and how to get rid of them.

    Regards,
    Holger


    #Integration-Server-and-ESB
    #webMethods