==================================================================================================== ========================================= Pod describe ========================================= ==================================================================================================== Name: am-685d4f4864-kgqpx Namespace: xlou Priority: 0 Node: gke-xlou-bsln-default-pool-4e9598c8-ldlt/10.142.0.114 Start Time: Tue, 21 Feb 2023 00:44:57 +0000 Labels: app=am app.kubernetes.io/component=am app.kubernetes.io/instance=am app.kubernetes.io/name=am app.kubernetes.io/part-of=forgerock pod-template-hash=685d4f4864 tier=middle Annotations: cluster-autoscaler.kubernetes.io/safe-to-evict: true Status: Running IP: 10.56.49.63 IPs: IP: 10.56.49.63 Controlled By: ReplicaSet/am-685d4f4864 Init Containers: fbc-init: Container ID: containerd://bbd4c1a95a05c89fe32b57932414e7ca11c94a9f0c9952a8756b967a230c9010 Image: gcr.io/engineeringpit/lodestar-images/am:xlou Image ID: gcr.io/engineeringpit/lodestar-images/am@sha256:928eda365ef1cead91d586bbc0a893158d095d3444455ddb4bfe6b2b910358b5 Port: Host Port: Command: /bin/bash -c if [ -d /fbc/config ]; then echo "Existing openam configuration found. Skipping copy" else echo "Copying docker image configuration files to the shared volume" cd /home/forgerock/openam cp -r .homeVersion * /fbc fi State: Terminated Reason: Completed Exit Code: 0 Started: Tue, 21 Feb 2023 00:45:00 +0000 Finished: Tue, 21 Feb 2023 00:45:00 +0000 Ready: True Restart Count: 0 Environment: Mounts: /fbc from fbc (rw) /var/run/secrets/kubernetes.io/serviceaccount from kube-api-access-j2zss (ro) truststore-init: Container ID: containerd://851589069d8fe97b0cc4c6e9f4ad3dd0b61eeb1a59486b12e317d4de7921b31e Image: gcr.io/engineeringpit/lodestar-images/am:xlou Image ID: gcr.io/engineeringpit/lodestar-images/am@sha256:928eda365ef1cead91d586bbc0a893158d095d3444455ddb4bfe6b2b910358b5 Port: Host Port: Command: /home/forgerock/import-pem-certs.sh State: Terminated Reason: Completed Exit Code: 0 Started: Tue, 21 Feb 2023 00:45:00 +0000 Finished: Tue, 21 Feb 2023 00:45:00 +0000 Ready: True Restart Count: 0 Environment: TRUSTSTORE_PATH: /truststore/amtruststore TRUSTSTORE_PASSWORD: changeit AM_PEM_TRUSTSTORE: /var/run/secrets/truststore/cacerts Mounts: /truststore from new-truststore (rw) /var/run/secrets/kubernetes.io/serviceaccount from kube-api-access-j2zss (ro) /var/run/secrets/truststore from truststore (rw) Containers: openam: Container ID: containerd://65d9faa1109e007f18943f2c659085b4772c9b6d07870db12768c84be8e91226 Image: gcr.io/engineeringpit/lodestar-images/am:xlou Image ID: gcr.io/engineeringpit/lodestar-images/am@sha256:928eda365ef1cead91d586bbc0a893158d095d3444455ddb4bfe6b2b910358b5 Port: 8080/TCP Host Port: 0/TCP Command: bash /home/forgerock/docker-entrypoint.sh State: Running Started: Tue, 21 Feb 2023 00:45:01 +0000 Ready: True Restart Count: 0 Limits: memory: 10Gi Requests: cpu: 11 memory: 10Gi Liveness: http-get http://:8080/am/json/health/live delay=30s timeout=5s period=30s #success=1 #failure=3 Readiness: http-get http://:8080/am/json/health/ready delay=20s timeout=5s period=10s #success=1 #failure=3 Startup: http-get http://:8080/am/json/health/live delay=0s timeout=1s period=10s #success=1 #failure=40 Environment Variables from: am-env-secrets Secret Optional: false platform-config ConfigMap Optional: false amster-env-secrets Secret Optional: false ds-env-secrets Secret Optional: false Environment: NAMESPACE: xlou (v1:metadata.namespace) AM_STORES_SSL_ENABLED: true TRUSTSTORE_PATH: /home/forgerock/amtruststore TRUSTSTORE_PASSWORD: changeit AM_STORES_USER_TYPE: LDAPv3ForForgeRockIAM Mounts: /home/forgerock/amtruststore from new-truststore (ro,path="amtruststore") /home/forgerock/openam from fbc (rw) /var/run/secrets/am from am-secrets (rw) /var/run/secrets/amster from amster-key (rw) /var/run/secrets/kubernetes.io/serviceaccount from kube-api-access-j2zss (ro) Conditions: Type Status Initialized True Ready True ContainersReady True PodScheduled True Volumes: fbc: Type: EmptyDir (a temporary directory that shares a pod's lifetime) Medium: SizeLimit: am-secrets: Type: Projected (a volume that contains injected data from multiple sources) SecretName: am-passwords SecretOptionalName: SecretName: am-keystore SecretOptionalName: amster-key: Type: Secret (a volume populated by a Secret) SecretName: amster Optional: false truststore: Type: Secret (a volume populated by a Secret) SecretName: truststore-pem Optional: false new-truststore: Type: EmptyDir (a temporary directory that shares a pod's lifetime) Medium: SizeLimit: kube-api-access-j2zss: Type: Projected (a volume that contains injected data from multiple sources) TokenExpirationSeconds: 3607 ConfigMapName: kube-root-ca.crt ConfigMapOptional: DownwardAPI: true QoS Class: Burstable Node-Selectors: Tolerations: node.kubernetes.io/not-ready:NoExecute op=Exists for 300s node.kubernetes.io/unreachable:NoExecute op=Exists for 300s Events: Type Reason Age From Message ---- ------ ---- ---- ------- Normal Scheduled 2m10s default-scheduler Successfully assigned xlou/am-685d4f4864-kgqpx to gke-xlou-bsln-default-pool-4e9598c8-ldlt Warning FailedMount 2m9s kubelet MountVolume.SetUp failed for volume "am-secrets" : failed to sync secret cache: timed out waiting for the condition Normal Pulling 2m8s kubelet Pulling image "gcr.io/engineeringpit/lodestar-images/am:xlou" Normal Pulled 2m7s kubelet Successfully pulled image "gcr.io/engineeringpit/lodestar-images/am:xlou" in 197.577774ms Normal Created 2m7s kubelet Created container fbc-init Normal Started 2m7s kubelet Started container fbc-init Normal Pulling 2m7s kubelet Pulling image "gcr.io/engineeringpit/lodestar-images/am:xlou" Normal Pulled 2m7s kubelet Successfully pulled image "gcr.io/engineeringpit/lodestar-images/am:xlou" in 213.891311ms Normal Created 2m7s kubelet Created container truststore-init Normal Started 2m7s kubelet Started container truststore-init Normal Pulling 2m6s kubelet Pulling image "gcr.io/engineeringpit/lodestar-images/am:xlou" Normal Pulled 2m6s kubelet Successfully pulled image "gcr.io/engineeringpit/lodestar-images/am:xlou" in 198.107931ms Normal Created 2m6s kubelet Created container openam Normal Started 2m6s kubelet Started container openam Warning Unhealthy 107s (x2 over 117s) kubelet Startup probe failed: Get "http://10.56.49.63:8080/am/json/health/live": context deadline exceeded (Client.Timeout exceeded while awaiting headers) ==================================================================================================== =========================================== Pod logs =========================================== ==================================================================================================== Copying docker image configuration files to the shared volume Copying /usr/local/openjdk-11/lib/security/cacerts to /truststore/amtruststore Found (1) certificates in /var/run/secrets/truststore/cacerts Importing (1) certificates into /truststore/amtruststore Certificate was added to keystore Import complete! Copying bootstrap files for legacy AMKeyProvider Waiting for User Store to be available Trying ds-idrepo-0.ds-idrepo:8080/alive endpoint User Store is responding Waiting for CTS to be available Trying ds-cts-0.ds-cts:8080/alive endpoint CTS is responding Waiting for Application Store to be available Trying ds-idrepo-0.ds-idrepo:8080/alive endpoint Application Store is responding Waiting for Policy Store to be available Trying ds-idrepo-0.ds-idrepo:8080/alive endpoint Policy Store is responding Waiting for UMA Store to be available Trying ds-idrepo-0.ds-idrepo:8080/alive endpoint UMA Store is responding Starting tomcat with opts: -server -Dcom.sun.services.debug.mergeall=on -Dcom.sun.identity.configuration.directory=/home/forgerock/openam -Dcom.iplanet.services.stats.state=off -Dcom.sun.identity.sm.sms_object_filebased_enabled=true -Dorg.forgerock.donotupgrade=true -DtomcatAccessLogDir=/proc/self/fd -DtomcatAccessLogFile=1 -XX:MaxRAMPercentage=75 -XX:InitialRAMPercentage=75 -XX:MaxTenuringThreshold=1 -Djava.security.egd=file:/dev/urandom -Dorg.forgerock.am.oauth2.consent.xui_path=/OAuth2_XUI -Dcom.forgerock.am.fileconfig.basepaths=/home/forgerock/base/config/services,/home/forgerock/cdk/config/services -Djavax.net.ssl.trustStore=/home/forgerock/amtruststore -Djavax.net.ssl.trustStorePassword=changeit -Djavax.net.ssl.trustStoreType=jks NOTE: Picked up JDK_JAVA_OPTIONS: --add-opens=java.base/java.lang=ALL-UNNAMED --add-opens=java.base/java.io=ALL-UNNAMED --add-opens=java.base/java.util=ALL-UNNAMED --add-opens=java.base/java.util.concurrent=ALL-UNNAMED --add-opens=java.rmi/sun.rmi.transport=ALL-UNNAMED 21-Feb-2023 00:45:03.712 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version name: Apache Tomcat/9.0.65 21-Feb-2023 00:45:03.714 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server built: Jul 14 2022 12:28:53 UTC 21-Feb-2023 00:45:03.714 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version number: 9.0.65.0 21-Feb-2023 00:45:03.715 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Name: Linux 21-Feb-2023 00:45:03.715 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Version: 5.10.147+ 21-Feb-2023 00:45:03.715 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Architecture: amd64 21-Feb-2023 00:45:03.715 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Java Home: /usr/local/openjdk-11 21-Feb-2023 00:45:03.715 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Version: 11.0.16+8 21-Feb-2023 00:45:03.715 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Vendor: Oracle Corporation 21-Feb-2023 00:45:03.715 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_BASE: /usr/local/tomcat 21-Feb-2023 00:45:03.715 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_HOME: /usr/local/tomcat 21-Feb-2023 00:45:03.724 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.lang=ALL-UNNAMED 21-Feb-2023 00:45:03.724 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.io=ALL-UNNAMED 21-Feb-2023 00:45:03.724 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.util=ALL-UNNAMED 21-Feb-2023 00:45:03.724 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.util.concurrent=ALL-UNNAMED 21-Feb-2023 00:45:03.724 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.rmi/sun.rmi.transport=ALL-UNNAMED 21-Feb-2023 00:45:03.724 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.config.file=/usr/local/tomcat/conf/logging.properties 21-Feb-2023 00:45:03.724 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager 21-Feb-2023 00:45:03.724 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djdk.tls.ephemeralDHKeySize=2048 21-Feb-2023 00:45:03.724 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.protocol.handler.pkgs=org.apache.catalina.webresources 21-Feb-2023 00:45:03.724 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dorg.apache.catalina.security.SecurityListener.UMASK=0027 21-Feb-2023 00:45:03.725 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.services.debug.mergeall=on 21-Feb-2023 00:45:03.725 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.identity.configuration.directory=/home/forgerock/openam 21-Feb-2023 00:45:03.725 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.iplanet.services.stats.state=off 21-Feb-2023 00:45:03.725 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.identity.sm.sms_object_filebased_enabled=true 21-Feb-2023 00:45:03.725 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dorg.forgerock.donotupgrade=true 21-Feb-2023 00:45:03.725 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -DtomcatAccessLogDir=/proc/self/fd 21-Feb-2023 00:45:03.725 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -DtomcatAccessLogFile=1 21-Feb-2023 00:45:03.725 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -XX:MaxRAMPercentage=75 21-Feb-2023 00:45:03.725 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -XX:InitialRAMPercentage=75 21-Feb-2023 00:45:03.725 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -XX:MaxTenuringThreshold=1 21-Feb-2023 00:45:03.725 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.security.egd=file:/dev/urandom 21-Feb-2023 00:45:03.725 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dorg.forgerock.am.oauth2.consent.xui_path=/OAuth2_XUI 21-Feb-2023 00:45:03.725 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.forgerock.am.fileconfig.basepaths=/home/forgerock/base/config/services,/home/forgerock/cdk/config/services 21-Feb-2023 00:45:03.726 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djavax.net.ssl.trustStore=/home/forgerock/amtruststore 21-Feb-2023 00:45:03.726 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djavax.net.ssl.trustStorePassword=changeit 21-Feb-2023 00:45:03.726 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djavax.net.ssl.trustStoreType=jks 21-Feb-2023 00:45:03.726 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dignore.endorsed.dirs= 21-Feb-2023 00:45:03.726 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.base=/usr/local/tomcat 21-Feb-2023 00:45:03.726 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.home=/usr/local/tomcat 21-Feb-2023 00:45:03.726 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.io.tmpdir=/usr/local/tomcat/temp 21-Feb-2023 00:45:03.729 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [1.2.35] using APR version [1.7.0]. 21-Feb-2023 00:45:03.729 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true], UDS [true]. 21-Feb-2023 00:45:03.729 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR/OpenSSL configuration: useAprConnector [false], useOpenSSL [true] 21-Feb-2023 00:45:03.732 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 1.1.1n 15 Mar 2022] 21-Feb-2023 00:45:03.948 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-8080"] 21-Feb-2023 00:45:03.965 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-8081"] 21-Feb-2023 00:45:03.965 INFO [main] org.apache.catalina.startup.Catalina.load Server initialization in [402] milliseconds 21-Feb-2023 00:45:04.006 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Catalina] 21-Feb-2023 00:45:04.006 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.65] 21-Feb-2023 00:45:04.011 INFO [main] org.apache.catalina.startup.HostConfig.deployDirectory Deploying web application directory [/usr/local/tomcat/webapps/am] 21-Feb-2023 00:45:11.429 INFO [main] org.apache.jasper.servlet.TldScanner.scanJars At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time. WARNING: An illegal reflective access operation has occurred WARNING: Illegal reflective access by com.google.inject.assistedinject.FactoryProvider2$MethodHandleWrapper (file:/usr/local/tomcat/webapps/am/WEB-INF/lib/guice-assistedinject-4.2.1.jar) to constructor java.lang.invoke.MethodHandles$Lookup(java.lang.Class,int) WARNING: Please consider reporting this to the maintainers of com.google.inject.assistedinject.FactoryProvider2$MethodHandleWrapper WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations WARNING: All illegal access operations will be denied in a future release Starting up OpenAM at Feb 21, 2023, 12:45:13 AM {"timestamp":"2023-02-21T00:45:17.453Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"org.forgerock.openam.plugins.PluginLifecycle","message":"PluginTools#upgradePlugins: Encountered plugin org.forgerock.openam.auth.nodes.CloudOnlyNodesPlugin not configured in SMS","context":"default"} {"timestamp":"2023-02-21T00:45:19.409Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.monitoring.MonitoringConfig","message":"JDMK runtime not found - Legacy Monitoring disabled","context":"default"} {"timestamp":"2023-02-21T00:45:19.422Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2023-02-21T00:45:19.951Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2023-02-21T00:45:21.535Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"org.forgerock.opendj.ldap.LoadBalancer","message":"Connection factory 'CachedConnectionPool(size=0[in:0 + out:0 + pending:0], maxSize=10, blocked=0, ldapClient=LdapClient(host=UNUSED.IN.FBC, port=9999, protocol=LDAP (clear-text)))' is no longer operational: Connect Error: Host 'UNUSED.IN.FBC' cannot be resolved","context":"default"} {"timestamp":"2023-02-21T00:45:21.594Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.sm.ldap.LDAPEventManager","message":"LDAPEventManager: received all entries changed event from EventService","context":"default"} {"timestamp":"2023-02-21T00:45:21.632Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.sm.ldap.SMSLdapObject","message":"SMSLDAPObject: got notifications, all objects changed","context":"default"} {"timestamp":"2023-02-21T00:45:22.120Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.sm.ldap.LDAPEventManager","message":"LDAPEventManager: received all entries changed event from EventService","context":"default"} {"timestamp":"2023-02-21T00:45:22.136Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.sm.ldap.SMSLdapObject","message":"SMSLDAPObject: got notifications, all objects changed","context":"default"} {"timestamp":"2023-02-21T00:45:22.564Z","level":"WARN","thread":"RADIUS-RadiusServerManager","logger":"org.forgerock.openam.radius.server.config.RadiusServerManager","message":"RADIUS service is not enabled.","context":"default"} {"timestamp":"2023-02-21T00:45:22.617Z","level":"WARN","thread":"Thread-5","logger":"org.forgerock.openam.services.push.PushNotificationService","message":"No Push Notification Service Config found for realm /","context":"default","exception":"java.util.NoSuchElementException: No value present\n\tat java.base/java.util.Optional.get(Optional.java:148)\n\tat org.forgerock.openam.services.push.PushNotificationServiceConfigHelperFactory.getConfigHelperFor(PushNotificationServiceConfigHelperFactory.java:58)\n\tat org.forgerock.openam.services.push.PushNotificationService.getConfigHelper(PushNotificationService.java:280)\n\tat org.forgerock.openam.services.push.PushNotificationService.updatePreferences(PushNotificationService.java:242)\n\tat org.forgerock.openam.services.push.PushNotificationService.init(PushNotificationService.java:157)\n\tat org.forgerock.openam.services.push.PushNotificationServiceSetupListener$1.run(PushNotificationServiceSetupListener.java:48)\n\tat java.base/java.lang.Thread.run(Thread.java:829)\n"} {"timestamp":"2023-02-21T00:45:22.617Z","level":"WARN","thread":"Thread-5","logger":"org.forgerock.openam.services.push.PushNotificationService","message":"No Push Notification Delegate configured for realm /","context":"default"} {"timestamp":"2023-02-21T00:45:22.850Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.iplanet.services.naming.WebtopNaming","message":"WebtopNaming.configMonitoring: start generating ssoserverinfo\n Start time = 2023-02-21 00:45:22","context":"default"} {"timestamp":"2023-02-21T00:45:22.854Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.monitoring.MonitoringAdapters","message":"Agent.startAgent:Monitoring HTML port not enabled in configuration or JDMK not present.","context":"default"} {"timestamp":"2023-02-21T00:45:22.854Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.monitoring.MonitoringAdapters","message":"Agent.startAgent:Monitoring SNMP port not enabled or JDMK not present.","context":"default"} {"timestamp":"2023-02-21T00:45:22.854Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.monitoring.MonitoringAdapters","message":"Agent.startAgent:Monitoring RMI port not enabled.","context":"default"} {"timestamp":"2023-02-21T00:45:22.880Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.sm.ldap.SMSLdapObject","message":"SMSLdapObject:entryExists: LdapSmsEntryUid{dn='ou=default,ou=OrganizationConfig,ou=1.0,ou=sunFMCOTConfigService,ou=services,ou=am-config', dataStoreId=DataStoreId{id='application-store'}} does not exist","context":"default"} {"timestamp":"2023-02-21T00:45:22.889Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.sm.ldap.SMSLdapObject","message":"SMSLdapObject:entryExists: LdapSmsEntryUid{dn='ou=default,ou=OrganizationConfig,ou=1.0,ou=sunFMWSFederationMetadataService,ou=services,ou=am-config', dataStoreId=DataStoreId{id='application-store'}} does not exist","context":"default"} {"timestamp":"2023-02-21T00:45:22.897Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2023-02-21T00:45:22.901Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.log.s1is.LogConfigReader","message":"LogConfigReader: DB password is null","context":"default"} {"timestamp":"2023-02-21T00:45:22.901Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.log.s1is.LogConfigReader","message":"LogConfigReader: Logfile prefix string is null","context":"default"} {"timestamp":"2023-02-21T00:45:22.902Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.log.s1is.LogConfigReader","message":"LogConfigReader: Filter class is null","context":"default"} {"timestamp":"2023-02-21T00:45:22.907Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2023-02-21T00:45:22.926Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2023-02-21T00:45:22.929Z","level":"WARN","thread":"main","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-0"},"logger":"com.sun.identity.monitoring.FederationMonitoringSetupImpl","message":"JDMK runtime not found - Federation SNMP disabled","context":"default"} 21-Feb-2023 00:45:25.892 INFO [main] org.apache.catalina.startup.HostConfig.deployDirectory Deployment of web application directory [/usr/local/tomcat/webapps/am] has finished in [21,880] ms 21-Feb-2023 00:45:25.896 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-8080"] 21-Feb-2023 00:45:25.905 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-8081"] 21-Feb-2023 00:45:25.906 INFO [main] org.apache.catalina.startup.Catalina.start Server startup in [21940] milliseconds {"timestamp":"2023-02-21T00:45:26.049Z","level":"WARN","thread":"http-nio-8080-exec-1","logger":"org.forgerock.openam.core.rest.docs.api.ApiDocsService","message":"API Descriptor has changed - regenerating docs","context":"default"} {"timestamp":"2023-02-21T00:45:26.627Z","level":"ERROR","thread":"http-nio-8081-exec-1","mdc":{"transactionId":"2aff4828-0083-4b3c-abf0-bf8bb7d41213-20"},"logger":"org.forgerock.http.servlet.HttpFrameworkServlet","message":"Failed to write response - rootId:2aff4828-0083-4b3c-abf0-bf8bb7d41213-23","context":"default","exception":"org.apache.catalina.connector.ClientAbortException: java.io.IOException: Broken pipe\n\tat org.apache.catalina.connector.OutputBuffer.realWriteBytes(OutputBuffer.java:353)\n\tat org.apache.catalina.connector.OutputBuffer.flushByteBuffer(OutputBuffer.java:784)\n\tat org.apache.catalina.connector.OutputBuffer.append(OutputBuffer.java:689)\n\tat org.apache.catalina.connector.OutputBuffer.writeBytes(OutputBuffer.java:388)\n\tat org.apache.catalina.connector.OutputBuffer.write(OutputBuffer.java:366)\n\tat org.apache.catalina.connector.CoyoteOutputStream.write(CoyoteOutputStream.java:96)\n\tat org.forgerock.http.io.IO.stream(IO.java:290)\n\tat org.forgerock.http.servlet.HttpFrameworkServlet.writeChfResponse(HttpFrameworkServlet.java:397)\n\tat org.forgerock.http.servlet.HttpFrameworkServlet.lambda$writeAndCloseChfResponse$2(HttpFrameworkServlet.java:359)\n\tat org.forgerock.http.servlet.Servlet3Adapter$SynchronousServletSynchronizer.runIfNotCompleted(Servlet3Adapter.java:151)\n\tat org.forgerock.http.servlet.HttpFrameworkServlet.writeAndCloseChfResponse(HttpFrameworkServlet.java:359)\n\tat org.forgerock.http.servlet.HttpFrameworkServlet.lambda$service$0(HttpFrameworkServlet.java:284)\n\tat org.forgerock.util.promise.Promises$CompletedPromise.thenOnResult(Promises.java:131)\n\tat org.forgerock.http.servlet.HttpFrameworkServlet.service(HttpFrameworkServlet.java:284)\n\tat javax.servlet.http.HttpServlet.service(HttpServlet.java:764)\n\tat org.forgerock.openam.http.OpenAMHttpFrameworkServlet.service(OpenAMHttpFrameworkServlet.java:47)\n\tat javax.servlet.http.HttpServlet.service(HttpServlet.java:764)\n\tat org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:227)\n\tat org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162)\n\tat org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:53)\n\tat org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189)\n\tat org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162)\n\tat org.forgerock.openam.services.datastore.DataStoreConsistencyFilter.lambda$doFilter$0(DataStoreConsistencyFilter.java:46)\n\tat org.forgerock.openam.service.datastore.ReentrantVolatileActionConsistencyController.safeExecute(ReentrantVolatileActionConsistencyController.java:37)\n\tat org.forgerock.openam.services.datastore.DataStoreConsistencyFilter.doFilter(DataStoreConsistencyFilter.java:46)\n\tat org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189)\n\tat org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162)\n\tat org.forgerock.openam.rest.ProtocolVersionFilter.doFilter(ProtocolVersionFilter.java:63)\n\tat org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189)\n\tat org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162)\n\tat org.forgerock.openam.headers.SecureCookieFilter.doFilter(SecureCookieFilter.java:63)\n\tat org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189)\n\tat org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162)\n\tat org.forgerock.openam.headers.DisableSameSiteCookiesFilter.doFilter(DisableSameSiteCookiesFilter.java:106)\n\tat org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189)\n\tat org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162)\n\tat org.forgerock.openam.validation.ResponseValidationFilter.doFilter(ResponseValidationFilter.java:59)\n\tat org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189)\n\tat org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162)\n\tat org.forgerock.openam.headers.SetHeadersFilter.doFilter(SetHeadersFilter.java:110)\n\tat org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189)\n\tat org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162)\n\tat org.forgerock.openam.headers.SetHeadersFilter.doFilter(SetHeadersFilter.java:110)\n\tat org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189)\n\tat org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162)\n\tat org.forgerock.openam.headers.SetHeadersFilter.doFilter(SetHeadersFilter.java:110)\n\tat org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189)\n\tat org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162)\n\tat com.sun.identity.setup.AMSetupFilter.doFilter(AMSetupFilter.java:116)\n\tat org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189)\n\tat org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162)\n\tat org.forgerock.openam.validation.RequestEntitySizeVerificationFilter.doFilter(RequestEntitySizeVerificationFilter.java:64)\n\tat org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189)\n\tat org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162)\n\tat org.forgerock.openam.audit.context.AuditContextFilter.doFilter(AuditContextFilter.java:47)\n\tat org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189)\n\tat org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162)\n\tat org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:197)\n\tat org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:97)\n\tat org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:541)\n\tat org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:135)\n\tat org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:92)\n\tat org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:687)\n\tat org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:78)\n\tat org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:360)\n\tat org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:399)\n\tat org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:65)\n\tat org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:890)\n\tat org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1789)\n\tat org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)\n\tat org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1191)\n\tat org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659)\n\tat org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)\n\tat java.base/java.lang.Thread.run(Thread.java:829)\nCaused by: java.io.IOException: Broken pipe\n\tat java.base/sun.nio.ch.FileDispatcherImpl.write0(Native Method)\n\tat java.base/sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:47)\n\tat java.base/sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:113)\n\tat java.base/sun.nio.ch.IOUtil.write(IOUtil.java:79)\n\tat java.base/sun.nio.ch.IOUtil.write(IOUtil.java:50)\n\tat java.base/sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:462)\n\tat org.apache.tomcat.util.net.NioChannel.write(NioChannel.java:135)\n\tat org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper.doWrite(NioEndpoint.java:1424)\n\tat org.apache.tomcat.util.net.SocketWrapperBase.doWrite(SocketWrapperBase.java:768)\n\tat org.apache.tomcat.util.net.SocketWrapperBase.writeBlocking(SocketWrapperBase.java:593)\n\tat org.apache.tomcat.util.net.SocketWrapperBase.write(SocketWrapperBase.java:537)\n\tat org.apache.coyote.http11.Http11OutputBuffer$SocketOutputBuffer.doWrite(Http11OutputBuffer.java:547)\n\tat org.apache.coyote.http11.filters.IdentityOutputFilter.doWrite(IdentityOutputFilter.java:73)\n\tat org.apache.coyote.http11.Http11OutputBuffer.doWrite(Http11OutputBuffer.java:194)\n\tat org.apache.coyote.Response.doWrite(Response.java:615)\n\tat org.apache.catalina.connector.OutputBuffer.realWriteBytes(OutputBuffer.java:340)\n\t... 73 common frames omitted\n"} 10.56.49.1 - - [21/Feb/2023:00:45:26 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 630ms 10.56.49.1 - - [21/Feb/2023:00:45:26 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 630ms 10.56.48.23 - - [21/Feb/2023:00:45:26 +0000] "GET /am/json/metrics/prometheus HTTP/1.1" 200 98304 698ms 10.56.49.1 - - [21/Feb/2023:00:45:29 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 4ms 10.56.49.1 - - [21/Feb/2023:00:45:29 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 8ms 10.56.49.1 - - [21/Feb/2023:00:45:39 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.56.48.23 - - [21/Feb/2023:00:45:39 +0000] "GET /am/json/metrics/prometheus HTTP/1.1" 200 199811 33ms 10.56.49.1 - - [21/Feb/2023:00:45:49 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.56.49.1 - - [21/Feb/2023:00:45:59 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 3ms 10.56.49.1 - - [21/Feb/2023:00:45:59 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.56.49.1 - - [21/Feb/2023:00:46:09 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.56.48.23 - - [21/Feb/2023:00:46:09 +0000] "GET /am/json/metrics/prometheus HTTP/1.1" 200 199824 20ms 10.56.49.1 - - [21/Feb/2023:00:46:19 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.56.49.1 - - [21/Feb/2023:00:46:29 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 3ms 10.56.49.1 - - [21/Feb/2023:00:46:29 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.56.49.1 - - [21/Feb/2023:00:46:39 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.56.48.23 - - [21/Feb/2023:00:46:39 +0000] "GET /am/json/metrics/prometheus HTTP/1.1" 200 199804 19ms 10.56.49.1 - - [21/Feb/2023:00:46:49 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 4ms 10.56.49.1 - - [21/Feb/2023:00:46:59 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 3ms 10.56.49.1 - - [21/Feb/2023:00:46:59 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms