SSO after startup is failing after update

0
We tried to update our environments this evening and suddenly get an after startup error on those environments that have SSO in place. SSO has not been touched so I am totally mistified why this is happening. Running locally is no problem. This is the stacktrace: Jan 24 18:43:38.858 - INFO - Core: Running after-startup-action... Jan 24 18:43:38.868 - INFO - AutoLogin: Starting up AutoLogin Request Handler... Jan 24 18:43:38.872 - INFO - AutoLogin: Starting up AutoLogin Request Handler.....DONE Jan 24 18:43:42.236 - INFO - SAML_SSO: Loading urn:oasis:names:tc:SAML:2.0:protocol metadata from /srv/cloud/slots/tr10000/deploy/data/tmp/saml_IdPFile1548351822223.xml Jan 24 18:43:42.291 - INFO - SAML_SSO: Loading urn:oasis:names:tc:SAML:2.0:protocol metadata from /srv/cloud/slots/tr10000/deploy/data/tmp/saml_IdPFile1548351822275.xml Jan 24 18:43:42.343 - INFO - SAML_SSO: Loading urn:oasis:names:tc:SAML:2.0:protocol metadata from /srv/cloud/slots/tr10000/deploy/data/tmp/saml_IdPFile1548351822312.xml Jan 24 18:43:42.377 - INFO - SAML_SSO: Loading urn:oasis:names:tc:SAML:2.0:protocol metadata from /srv/cloud/slots/tr10000/deploy/data/tmp/saml_IdPFile1548351822372.xml Jan 24 18:43:42.773 - CRITICAL - ActionManager: Error in execution of monitored action '{"name":"Basis.AfterStartup_MultiTenant","type":"Microflow"}' (execution id: cf8845a7-af36-48ba-ab6e-993959604622, execution type: CUSTOM) Jan 24 18:43:42.774 - CRITICAL - ActionManager: (1/75) java.lang.NoSuchMethodError: org.apache.commons.codec.digest.DigestUtils.sha1Hex([B)Ljava/lang/String; Jan 24 18:43:42.774 - CRITICAL - ActionManager: (2/75) #011at saml20.implementation.security.SecurityHelper.addAllToKeyStore(SecurityHelper.java:273) Jan 24 18:43:42.774 - CRITICAL - ActionManager: (3/75) #011at saml20.implementation.security.SecurityHelper.appendToIdPKeyStore(SecurityHelper.java:254) Jan 24 18:43:42.774 - CRITICAL - ActionManager: (4/75) #011at saml20.implementation.security.CredentialRepository.setupTrustStore(CredentialRepository.java:180) Jan 24 18:43:42.774 - CRITICAL - ActionManager: (5/75) #011at saml20.implementation.security.CredentialRepository.updateConfiguration(CredentialRepository.java:95) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (6/75) #011at saml20.implementation.SAMLRequestHandler.initServlet(SAMLRequestHandler.java:103) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (7/75) #011at saml20.implementation.SAMLRequestHandler.<init>(SAMLRequestHandler.java:67) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (8/75) #011at saml20.implementation.SAMLRequestHandler.getInstance(SAMLRequestHandler.java:59) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (9/75) #011at saml20.implementation.SSOServerConfiguration.start(SSOServerConfiguration.java:18) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (10/75) #011at saml20.actions.StartSSO.executeAction(StartSSO.java:27) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (11/75) #011at saml20.actions.StartSSO.executeAction(StartSSO.java:16) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (12/75) #011at com.mendix.systemwideinterfaces.core.UserAction.execute(UserAction.java:46) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (13/75) #011at com.mendix.basis.actionmanagement.CoreActionHandlerImpl.doCall(CoreActionHandlerImpl.scala:79) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (14/75) #011at com.mendix.basis.actionmanagement.CoreActionHandlerImpl.call(CoreActionHandlerImpl.scala:57) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (15/75) #011at com.mendix.core.actionmanagement.CoreAction.call(CoreAction.java:55) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (16/75) #011at com.mendix.basis.actionmanagement.ActionManagerBase$1.execute(ActionManagerBase.java:150) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (17/75) #011at com.mendix.util.classloading.Runner.doRunUsingClassLoaderOf(Runner.java:32) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (18/75) #011at com.mendix.basis.actionmanagement.ActionManagerBase.executeSync(ActionManagerBase.java:155) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (19/75) #011at com.mendix.basis.component.InternalCoreBase.execute(InternalCoreBase.java:414) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (20/75) #011at com.mendix.modules.microflowengine.actions.actioncall.JavaAction.execute(JavaAction.scala:56) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (21/75) #011at com.mendix.modules.microflowengine.microflow.impl.MicroflowObject.execute(MicroflowObject.java:47) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (22/75) #011at com.mendix.modules.microflowengine.microflow.impl.MicroflowImpl.executeAfterBreakingIfNecessary(MicroflowImpl.java:201) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (23/75) #011at com.mendix.modules.microflowengine.microflow.impl.MicroflowImpl.executeAction(MicroflowImpl.java:157) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (24/75) #011at com.mendix.systemwideinterfaces.core.UserAction.execute(UserAction.java:46) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (25/75) #011at com.mendix.basis.actionmanagement.CoreActionHandlerImpl.doCall(CoreActionHandlerImpl.scala:79) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (26/75) #011at com.mendix.basis.actionmanagement.CoreActionHandlerImpl.call(CoreActionHandlerImpl.scala:57) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (27/75) #011at com.mendix.core.actionmanagement.CoreAction.call(CoreAction.java:55) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (28/75) #011at com.mendix.basis.actionmanagement.ActionManagerBase$1.execute(ActionManagerBase.java:150) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (29/75) #011at com.mendix.util.classloading.Runner.doRunUsingClassLoaderOf(Runner.java:32) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (30/75) #011at com.mendix.basis.actionmanagement.ActionManagerBase.executeSync(ActionManagerBase.java:155) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (31/75) #011at com.mendix.basis.component.InternalCoreBase.executeSync(InternalCoreBase.java:492) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (32/75) #011at com.mendix.modules.microflowengine.actions.SubMicroflowAction.execute(SubMicroflowAction.scala:51) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (33/75) #011at com.mendix.modules.microflowengine.microflow.impl.MicroflowObject.execute(MicroflowObject.java:47) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (34/75) #011at com.mendix.modules.microflowengine.microflow.impl.MicroflowImpl.executeAfterBreakingIfNecessary(MicroflowImpl.java:201) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (35/75) #011at com.mendix.modules.microflowengine.microflow.impl.MicroflowImpl.executeAction(MicroflowImpl.java:157) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (36/75) #011at com.mendix.systemwideinterfaces.core.UserAction.execute(UserAction.java:46) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (37/75) #011at com.mendix.basis.actionmanagement.CoreActionHandlerImpl.doCall(CoreActionHandlerImpl.scala:79) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (38/75) #011at com.mendix.basis.actionmanagement.CoreActionHandlerImpl.call(CoreActionHandlerImpl.scala:57) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (39/75) #011at com.mendix.core.actionmanagement.CoreAction.call(CoreAction.java:55) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (40/75) #011at com.mendix.basis.actionmanagement.DefaultActionMonitor$.$anonfun$run$1(CustomMonitoredAction.scala:18) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (41/75) #011at com.mendix.basis.actionmanagement.IMonitoredAction$$anon$1.execute(IMonitoredAction.scala:47) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (42/75) #011at com.mendix.util.classloading.Runner.doRunUsingClassLoaderOf(Runner.java:32) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (43/75) #011at com.mendix.basis.actionmanagement.IMonitoredAction.monitor(IMonitoredAction.scala:49) Jan 24 18:43:42.775 - CRITICAL - ActionManager: (44/75) #011at com.mendix.basis.actionmanagement.IMonitoredAction.monitor$(IMonitoredAction.scala:25) Jan 24 18:43:42.776 - CRITICAL - ActionManager: (45/75) #011at com.mendix.basis.actionmanagement.CustomMonitoredAction.monitor(CustomMonitoredAction.scala:22) Jan 24 18:43:42.776 - CRITICAL - ActionManager: (46/75) #011at com.mendix.basis.actionmanagement.DefaultActionMonitor$.run(CustomMonitoredAction.scala:18) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (47/75) #011at com.mendix.basis.actionmanagement.CoreActionHandlerImpl.runMonitoredAction(CoreActionHandlerImpl.scala:68) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (48/75) #011at com.mendix.basis.actionmanagement.CoreActionHandlerImpl.call(CoreActionHandlerImpl.scala:55) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (49/75) #011at com.mendix.core.actionmanagement.CoreAction.call(CoreAction.java:55) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (50/75) #011at com.mendix.basis.actionmanagement.ActionManagerBase$1.execute(ActionManagerBase.java:150) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (51/75) #011at com.mendix.util.classloading.Runner.doRunUsingClassLoaderOf(Runner.java:32) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (52/75) #011at com.mendix.basis.actionmanagement.ActionManagerBase.executeSync(ActionManagerBase.java:155) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (53/75) #011at com.mendix.basis.component.InternalCoreBase.execute(InternalCoreBase.java:383) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (54/75) #011at com.mendix.basis.component.InternalCoreBase.execute(InternalCoreBase.java:398) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (55/75) #011at com.mendix.basis.impl.MxRuntimeImpl.doFire(MxRuntimeImpl.java:583) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (56/75) #011at com.mendix.basis.impl.MxRuntimeImpl.fireZeMissiles(MxRuntimeImpl.java:541) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (57/75) #011at com.mendix.basis.impl.MxRuntimeImpl.start(MxRuntimeImpl.java:326) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (58/75) #011at com.mendix.m2ee.appcontainer.actions.StartAction.startRuntime(StartAction.java:49) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (59/75) #011at com.mendix.m2ee.appcontainer.actions.StartAction.execute(StartAction.java:30) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (60/75) #011at com.mendix.m2ee.appcontainer.server.handler.HttpAdminHandler.handle(HttpAdminHandler.java:129) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (61/75) #011at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (62/75) #011at org.eclipse.jetty.server.Server.handle(Server.java:502) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (63/75) #011at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:364) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (64/75) #011at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (65/75) #011at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:305) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (66/75) #011at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (67/75) #011at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (68/75) #011at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:333) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (69/75) #011at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:310) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (70/75) #011at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:168) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (71/75) #011at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:126) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (72/75) #011at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:366) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (73/75) #011at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:765) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (74/75) #011at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:683) Jan 24 18:43:42.778 - CRITICAL - ActionManager: (75/75) #011at java.lang.Thread.run(Thread.java:748) Jan 24 18:43:42.778 - CRITICAL - M2EE: org.apache.commons.codec.digest.DigestUtils.sha1Hex([B)Ljava/lang/String; Regards, Ronald [EDIT] Found the problem. Double commons-codec jars. Versions commons-codec-1.10.jar and commons-codec-1.11.jar were in the userlib. [EDIT2] Userlib cleanup did not help. Problem is still there.
asked
1 answers
0

Not sure if this helps but the method indeed exists in 1.11 Apache commons although DigestUtils is deprecated ( https://commons.apache.org/proper/commons-codec/apidocs/org/apache/commons/codec/digest/DigestUtils.html#sha1Hex-java.lang.String- ) .

I would think there’s probably another library conflicting and building before Apache commons 1.11.

answered