WSTOMSTC started task failed to start after IPL (EDC5112I for Tomcat ports)

Products

• Endevor

Issue/Introduction

After an IPL of the system following (ACF2 and CCS) maintenance, started task TOMCAT1 for CCS Tomcat instance started successfully but started task WSTOMSTC failed to start.

The respective STC logs show:
TOMCAT1:
 01.47.41 STC01700  IEF403I TOMCAT1 - STARTED - TIME=01.47.41
 01.47.42 STC01700  CATC0001I CA-CCS Tomcat is starting 
 01.47.43 STC01700  CATC0002I CA-CCS Tomcat started in 285 ms 

WSTOMSTC:
 01.47.10 STC01677  IEF403I WSTOMSTC - STARTED - TIME=01.47.10
 01.47.10 STC01677  CATC0001I CA-CCS Tomcat is starting 
 01.47.22 STC01677  CATC0002I CA-CCS Tomcat started in: 8477 ms 
 01.47.22 STC01677  CATC0003I CA-CCS Tomcat stopping 

Further down the WSTOMSTC log it is seen that it attempts to start the Tomcat instance using ports 4080, 4443 (and 4005 shutdown port) but that failed with messages "EDC5112I Resource temporarily unavailable" on all those ports i.e.

**********
 SEVERE: Failed to initialize connector [Connector[HTTP/1.1-4080]]
 org.apache.catalina.LifecycleException: Failed to initialize component [Connector[HTTP/1.1-4080]]
     at org.apache.catalina.util.LifecycleBase.init(LifecycleBase.java:112)
     at org.apache.catalina.core.StandardService.initInternal(StandardService.java:552)
     at org.apache.catalina.util.LifecycleBase.init(LifecycleBase.java:107)
     at org.apache.catalina.core.StandardServer.initInternal(StandardServer.java:875)
     at org.apache.catalina.util.LifecycleBase.init(LifecycleBase.java:107)
     at org.apache.catalina.startup.Catalina.load(Catalina.java:708)
     at org.apache.catalina.startup.Catalina.load(Catalina.java:731)
     at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
     at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:90)
     at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
     at java.lang.reflect.Method.invoke(Method.java:508)
     at org.apache.catalina.startup.Bootstrap.load(Bootstrap.java:309)
     at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:492)
 Caused by: org.apache.catalina.LifecycleException: Protocol handler initialization failed
     at org.apache.catalina.connector.Connector.initInternal(Connector.java:995)
     at org.apache.catalina.util.LifecycleBase.init(LifecycleBase.java:107)
     ... 12 more
 Caused by: java.net.SocketException: EDC5112I Resource temporarily unavailable.
 ...
 
 SEVERE: Failed to initialize connector [Connector[HTTP/1.1-4443]]
 org.apache.catalina.LifecycleException: Failed to initialize component [Connector[HTTP/1.1-4443]]
     at org.apache.catalina.util.LifecycleBase.init(LifecycleBase.java:112)
     at org.apache.catalina.core.StandardService.initInternal(StandardService.java:552)
     at org.apache.catalina.util.LifecycleBase.init(LifecycleBase.java:107)
     at org.apache.catalina.core.StandardServer.initInternal(StandardServer.java:875)
     at org.apache.catalina.util.LifecycleBase.init(LifecycleBase.java:107)
     at org.apache.catalina.startup.Catalina.load(Catalina.java:708)
     at org.apache.catalina.startup.Catalina.load(Catalina.java:731)
     at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
     at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:90)
     at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
     at java.lang.reflect.Method.invoke(Method.java:508)
     at org.apache.catalina.startup.Bootstrap.load(Bootstrap.java:309)
     at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:492)
 Caused by: org.apache.catalina.LifecycleException: Protocol handler initialization failed
     at org.apache.catalina.connector.Connector.initInternal(Connector.java:995)
     at org.apache.catalina.util.LifecycleBase.init(LifecycleBase.java:107)
     ... 12 more
 Caused by: java.net.SocketException: EDC5112I Resource temporarily unavailable.
 
 ...
 SEVERE: StandardServer.await: create[localhost:4005]: 
 java.net.SocketException: EDC5112I Resource temporarily unavailable.

*********

Environment

Eedevor Web services

Cause

From syslog this is seen:
N 4100000 ABCD     2025039 01:47:28.10 STC01681 00000090  EZAIN11I ALL TCPIP SERVICES FOR PROC TCPIP ARE AVAILABLE.

So that timestamp 01:47:28 is after WSTOMSTC Tomcat instance attempted start at 01.47.10 - 01.47.22 which failed.
However it is before TOMCAT1 CCS Tomcat instance start at 01.47.41 - 01.47.43 (STC01700) which was successful.
So TCPIP was not available when WSTOMSTC started which explains the failure and messages "EDC5112I Resource temporarily unavailable".
TCPIP must be available and operational for any port to function on a network.

Resolution

The advice is change the started task loading order at IPL time so that WSTOMSTC starts after TCPIP like TOMCAT1 currently does.