==================================================================================================== ========================================= Pod describe ========================================= ==================================================================================================== Name: am-5d5df7bfb9-wbcws Namespace: xlou Priority: 0 Node: gke-xlou-cdm-default-pool-33cc2627-bq75/10.142.0.27 Start Time: Sun, 07 Aug 2022 02:28:25 +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=5d5df7bfb9 skaffold.dev/profile=medium skaffold.dev/run-id=xlou tier=middle Annotations: cluster-autoscaler.kubernetes.io/safe-to-evict: true Status: Running IP: 10.0.11.67 IPs: IP: 10.0.11.67 Controlled By: ReplicaSet/am-5d5df7bfb9 Init Containers: fbc-init: Container ID: containerd://bc0b2d082a8915b21e43783f8b445b53001d1ca58aa3af7c553d44e2481abb3e Image: gcr.io/engineeringpit/lodestar-images/am:xlou@sha256:e2be3b24f724e416b86384b94cb9d1636008c6b3248a5b6f65e5a88ac6c555b4 Image ID: gcr.io/engineeringpit/lodestar-images/am@sha256:e2be3b24f724e416b86384b94cb9d1636008c6b3248a5b6f65e5a88ac6c555b4 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: Sun, 07 Aug 2022 02:28:26 +0000 Finished: Sun, 07 Aug 2022 02:28:26 +0000 Ready: True Restart Count: 0 Environment: Mounts: /fbc from fbc (rw) /var/run/secrets/kubernetes.io/serviceaccount from kube-api-access-dtfkp (ro) truststore-init: Container ID: containerd://4c44f19bea422247180426d8de02bebb68798980390b42f96079c1b941f8ffef Image: gcr.io/engineeringpit/lodestar-images/am:xlou@sha256:e2be3b24f724e416b86384b94cb9d1636008c6b3248a5b6f65e5a88ac6c555b4 Image ID: gcr.io/engineeringpit/lodestar-images/am@sha256:e2be3b24f724e416b86384b94cb9d1636008c6b3248a5b6f65e5a88ac6c555b4 Port: Host Port: Command: /home/forgerock/import-pem-certs.sh State: Terminated Reason: Completed Exit Code: 0 Started: Sun, 07 Aug 2022 02:28:27 +0000 Finished: Sun, 07 Aug 2022 02:28:27 +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-dtfkp (ro) /var/run/secrets/truststore from truststore (rw) Containers: openam: Container ID: containerd://53c9634fb0ddb771aa34359ec52be46ba27fc1e74bd44d287847359968764fc0 Image: gcr.io/engineeringpit/lodestar-images/am:xlou@sha256:e2be3b24f724e416b86384b94cb9d1636008c6b3248a5b6f65e5a88ac6c555b4 Image ID: gcr.io/engineeringpit/lodestar-images/am@sha256:e2be3b24f724e416b86384b94cb9d1636008c6b3248a5b6f65e5a88ac6c555b4 Port: 8080/TCP Host Port: 0/TCP Command: bash /home/forgerock/docker-entrypoint.sh State: Running Started: Sun, 07 Aug 2022 02:28:28 +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-dtfkp (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-dtfkp: 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 3m21s default-scheduler Successfully assigned xlou/am-5d5df7bfb9-wbcws to gke-xlou-cdm-default-pool-33cc2627-bq75 Normal Pulling 3m21s kubelet Pulling image "gcr.io/engineeringpit/lodestar-images/am:xlou@sha256:e2be3b24f724e416b86384b94cb9d1636008c6b3248a5b6f65e5a88ac6c555b4" Normal Pulled 3m21s kubelet Successfully pulled image "gcr.io/engineeringpit/lodestar-images/am:xlou@sha256:e2be3b24f724e416b86384b94cb9d1636008c6b3248a5b6f65e5a88ac6c555b4" in 250.39207ms Normal Created 3m21s kubelet Created container fbc-init Normal Started 3m21s kubelet Started container fbc-init Normal Pulling 3m21s kubelet Pulling image "gcr.io/engineeringpit/lodestar-images/am:xlou@sha256:e2be3b24f724e416b86384b94cb9d1636008c6b3248a5b6f65e5a88ac6c555b4" Normal Pulled 3m21s kubelet Successfully pulled image "gcr.io/engineeringpit/lodestar-images/am:xlou@sha256:e2be3b24f724e416b86384b94cb9d1636008c6b3248a5b6f65e5a88ac6c555b4" in 219.309955ms Normal Created 3m20s kubelet Created container truststore-init Normal Started 3m20s kubelet Started container truststore-init Normal Pulling 3m20s kubelet Pulling image "gcr.io/engineeringpit/lodestar-images/am:xlou@sha256:e2be3b24f724e416b86384b94cb9d1636008c6b3248a5b6f65e5a88ac6c555b4" Normal Pulled 3m20s kubelet Successfully pulled image "gcr.io/engineeringpit/lodestar-images/am:xlou@sha256:e2be3b24f724e416b86384b94cb9d1636008c6b3248a5b6f65e5a88ac6c555b4" in 201.415525ms Normal Created 3m20s kubelet Created container openam Normal Started 3m19s kubelet Started container openam Warning Unhealthy 2m22s (x6 over 3m12s) kubelet Startup probe failed: Get "http://10.0.11.67:8080/am/json/health/live": dial tcp 10.0.11.67:8080: connect: connection refused Warning Unhealthy 2m1s (x2 over 2m11s) kubelet Startup probe failed: Get "http://10.0.11.67:8080/am/json/health/live": context deadline exceeded (Client.Timeout exceeded while awaiting headers) ==================================================================================================== =========================================== Pod logs =========================================== ==================================================================================================== 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 Trying ds-idrepo-1.ds-idrepo:8080/alive endpoint Trying ds-idrepo-2.ds-idrepo:8080/alive endpoint Trying ds-idrepo-0.ds-idrepo:8080/alive endpoint Trying ds-idrepo-1.ds-idrepo:8080/alive endpoint Trying ds-idrepo-2.ds-idrepo:8080/alive endpoint Trying ds-idrepo-0.ds-idrepo:8080/alive endpoint Trying ds-idrepo-1.ds-idrepo:8080/alive endpoint Trying ds-idrepo-2.ds-idrepo:8080/alive endpoint Trying ds-idrepo-0.ds-idrepo:8080/alive endpoint Trying ds-idrepo-1.ds-idrepo:8080/alive endpoint Trying ds-idrepo-2.ds-idrepo:8080/alive endpoint Trying ds-idrepo-0.ds-idrepo:8080/alive endpoint Trying ds-idrepo-1.ds-idrepo:8080/alive endpoint Trying ds-idrepo-2.ds-idrepo:8080/alive endpoint Trying ds-idrepo-0.ds-idrepo:8080/alive endpoint Trying ds-idrepo-1.ds-idrepo:8080/alive endpoint Trying ds-idrepo-2.ds-idrepo:8080/alive endpoint Trying ds-idrepo-0.ds-idrepo:8080/alive endpoint Trying ds-idrepo-1.ds-idrepo:8080/alive endpoint Trying ds-idrepo-2.ds-idrepo:8080/alive endpoint Trying ds-idrepo-0.ds-idrepo:8080/alive endpoint Trying ds-idrepo-1.ds-idrepo:8080/alive endpoint Trying ds-idrepo-2.ds-idrepo:8080/alive endpoint Trying ds-idrepo-0.ds-idrepo:8080/alive endpoint Trying ds-idrepo-1.ds-idrepo:8080/alive endpoint Trying ds-idrepo-2.ds-idrepo:8080/alive endpoint Trying ds-idrepo-0.ds-idrepo:8080/alive endpoint Trying ds-idrepo-1.ds-idrepo:8080/alive endpoint Trying ds-idrepo-2.ds-idrepo:8080/alive endpoint Trying ds-idrepo-0.ds-idrepo:8080/alive endpoint Trying ds-idrepo-1.ds-idrepo:8080/alive endpoint Trying ds-idrepo-2.ds-idrepo:8080/alive endpoint 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 07-Aug-2022 02:29:26.119 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version name: Apache Tomcat/9.0.65 07-Aug-2022 02:29:26.121 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server built: Jul 14 2022 12:28:53 UTC 07-Aug-2022 02:29:26.121 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version number: 9.0.65.0 07-Aug-2022 02:29:26.122 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Name: Linux 07-Aug-2022 02:29:26.122 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Version: 5.4.188+ 07-Aug-2022 02:29:26.122 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Architecture: amd64 07-Aug-2022 02:29:26.122 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Java Home: /usr/local/openjdk-11 07-Aug-2022 02:29:26.122 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Version: 11.0.16+8 07-Aug-2022 02:29:26.122 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Vendor: Oracle Corporation 07-Aug-2022 02:29:26.122 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_BASE: /usr/local/tomcat 07-Aug-2022 02:29:26.122 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_HOME: /usr/local/tomcat 07-Aug-2022 02:29:26.131 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.lang=ALL-UNNAMED 07-Aug-2022 02:29:26.131 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.io=ALL-UNNAMED 07-Aug-2022 02:29:26.131 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.util=ALL-UNNAMED 07-Aug-2022 02:29:26.131 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.util.concurrent=ALL-UNNAMED 07-Aug-2022 02:29:26.131 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.rmi/sun.rmi.transport=ALL-UNNAMED 07-Aug-2022 02:29:26.131 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.config.file=/usr/local/tomcat/conf/logging.properties 07-Aug-2022 02:29:26.131 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager 07-Aug-2022 02:29:26.131 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djdk.tls.ephemeralDHKeySize=2048 07-Aug-2022 02:29:26.131 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.protocol.handler.pkgs=org.apache.catalina.webresources 07-Aug-2022 02:29:26.132 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dorg.apache.catalina.security.SecurityListener.UMASK=0027 07-Aug-2022 02:29:26.132 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.services.debug.mergeall=on 07-Aug-2022 02:29:26.132 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.identity.configuration.directory=/home/forgerock/openam 07-Aug-2022 02:29:26.132 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.iplanet.services.stats.state=off 07-Aug-2022 02:29:26.132 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.identity.sm.sms_object_filebased_enabled=true 07-Aug-2022 02:29:26.132 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dorg.forgerock.donotupgrade=true 07-Aug-2022 02:29:26.132 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -DtomcatAccessLogDir=/proc/self/fd 07-Aug-2022 02:29:26.132 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -DtomcatAccessLogFile=1 07-Aug-2022 02:29:26.132 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -XX:MaxRAMPercentage=75 07-Aug-2022 02:29:26.132 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -XX:InitialRAMPercentage=75 07-Aug-2022 02:29:26.132 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -XX:MaxTenuringThreshold=1 07-Aug-2022 02:29:26.132 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.security.egd=file:/dev/urandom 07-Aug-2022 02:29:26.133 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dorg.forgerock.am.oauth2.consent.xui_path=/OAuth2_XUI 07-Aug-2022 02:29:26.133 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 07-Aug-2022 02:29:26.133 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djavax.net.ssl.trustStore=/home/forgerock/amtruststore 07-Aug-2022 02:29:26.133 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djavax.net.ssl.trustStorePassword=changeit 07-Aug-2022 02:29:26.133 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djavax.net.ssl.trustStoreType=jks 07-Aug-2022 02:29:26.133 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dignore.endorsed.dirs= 07-Aug-2022 02:29:26.133 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.base=/usr/local/tomcat 07-Aug-2022 02:29:26.133 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.home=/usr/local/tomcat 07-Aug-2022 02:29:26.133 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.io.tmpdir=/usr/local/tomcat/temp 07-Aug-2022 02:29:26.137 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [1.2.35] using APR version [1.7.0]. 07-Aug-2022 02:29:26.137 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true], UDS [true]. 07-Aug-2022 02:29:26.137 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR/OpenSSL configuration: useAprConnector [false], useOpenSSL [true] 07-Aug-2022 02:29:26.139 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 1.1.1n 15 Mar 2022] 07-Aug-2022 02:29:26.358 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-8080"] 07-Aug-2022 02:29:26.375 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-8081"] 07-Aug-2022 02:29:26.375 INFO [main] org.apache.catalina.startup.Catalina.load Server initialization in [406] milliseconds 07-Aug-2022 02:29:26.417 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Catalina] 07-Aug-2022 02:29:26.417 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.65] 07-Aug-2022 02:29:26.421 INFO [main] org.apache.catalina.startup.HostConfig.deployDirectory Deploying web application directory [/usr/local/tomcat/webapps/am] 07-Aug-2022 02:29:33.733 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. Starting up OpenAM at Aug 7, 2022, 2:29:35 AM {"timestamp":"2022-08-07T02:29:39.150Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"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=ds-idrepo-2.ds-idrepo, port=1636, protocol=LDAPS))' is no longer operational: Connect Error: Host 'ds-idrepo-2.ds-idrepo' cannot be resolved","context":"default"} {"timestamp":"2022-08-07T02:29:39.419Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"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=ds-idrepo-2.ds-idrepo, port=1636, protocol=LDAPS))' is no longer operational: Connect Error: Host 'ds-idrepo-2.ds-idrepo' cannot be resolved","context":"default"} {"timestamp":"2022-08-07T02:29:39.493Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"org.forgerock.openam.plugins.PluginLifecycle","message":"PluginTools#upgradePlugins: Encountered plugin org.forgerock.openam.auth.nodes.CloudOnlyNodesPlugin not configured in SMS","context":"default"} {"timestamp":"2022-08-07T02:29:40.558Z","level":"WARN","thread":"CTSWorkerPool-15","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"org.forgerock.opendj.ldap.LoadBalancer","message":"Connection factory 'CachedConnectionPool(size=0[in:0 + out:0 + pending:0], maxSize=66, blocked=0, ldapClient=LdapClient(host=ds-cts-2.ds-cts, port=1636, protocol=LDAPS))' is no longer operational: Connect Error: Host 'ds-cts-2.ds-cts' cannot be resolved","context":"default"} {"timestamp":"2022-08-07T02:29:41.594Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.monitoring.MonitoringConfig","message":"JDMK runtime not found - Legacy Monitoring disabled","context":"default"} {"timestamp":"2022-08-07T02:29:41.606Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2022-08-07T02:29:41.660Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2022-08-07T02:29:43.758Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"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":"2022-08-07T02:29:43.817Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.sm.ldap.LDAPEventManager","message":"LDAPEventManager: received all entries changed event from EventService","context":"default"} {"timestamp":"2022-08-07T02:29:43.865Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.sm.ldap.SMSLdapObject","message":"SMSLDAPObject: got notifications, all objects changed","context":"default"} {"timestamp":"2022-08-07T02:29:44.065Z","level":"WARN","thread":"LDAP SDK Default Scheduler","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=ds-idrepo-1.ds-idrepo, port=1636, protocol=LDAPS))' is no longer operational: Connect Error: Host 'ds-idrepo-1.ds-idrepo' cannot be resolved","context":"default"} {"timestamp":"2022-08-07T02:29:44.420Z","level":"WARN","thread":"LDAP SDK Default Scheduler","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=ds-idrepo-1.ds-idrepo, port=1636, protocol=LDAPS))' is no longer operational: Connect Error: Host 'ds-idrepo-1.ds-idrepo' cannot be resolved","context":"default"} {"timestamp":"2022-08-07T02:29:44.510Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.sm.ldap.LDAPEventManager","message":"LDAPEventManager: received all entries changed event from EventService","context":"default"} {"timestamp":"2022-08-07T02:29:44.532Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.sm.ldap.SMSLdapObject","message":"SMSLDAPObject: got notifications, all objects changed","context":"default"} {"timestamp":"2022-08-07T02:29:44.816Z","level":"WARN","thread":"RADIUS-RadiusServerManager","logger":"org.forgerock.openam.radius.server.config.RadiusServerManager","message":"RADIUS service is not enabled.","context":"default"} {"timestamp":"2022-08-07T02:29:45.275Z","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":"2022-08-07T02:29:45.275Z","level":"WARN","thread":"Thread-5","logger":"org.forgerock.openam.services.push.PushNotificationService","message":"No Push Notification Delegate configured for realm /","context":"default"} {"timestamp":"2022-08-07T02:29:45.531Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.iplanet.services.naming.WebtopNaming","message":"WebtopNaming.configMonitoring: start generating ssoserverinfo\n Start time = 2022-08-07 02:29:45","context":"default"} {"timestamp":"2022-08-07T02:29:45.534Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.monitoring.MonitoringAdapters","message":"Agent.startAgent:Monitoring HTML port not enabled in configuration or JDMK not present.","context":"default"} {"timestamp":"2022-08-07T02:29:45.534Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.monitoring.MonitoringAdapters","message":"Agent.startAgent:Monitoring SNMP port not enabled or JDMK not present.","context":"default"} {"timestamp":"2022-08-07T02:29:45.534Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.monitoring.MonitoringAdapters","message":"Agent.startAgent:Monitoring RMI port not enabled.","context":"default"} {"timestamp":"2022-08-07T02:29:45.568Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"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":"2022-08-07T02:29:45.576Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"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":"2022-08-07T02:29:45.583Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2022-08-07T02:29:45.587Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.log.s1is.LogConfigReader","message":"LogConfigReader: DB password is null","context":"default"} {"timestamp":"2022-08-07T02:29:45.587Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.log.s1is.LogConfigReader","message":"LogConfigReader: Logfile prefix string is null","context":"default"} {"timestamp":"2022-08-07T02:29:45.588Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.log.s1is.LogConfigReader","message":"LogConfigReader: Filter class is null","context":"default"} {"timestamp":"2022-08-07T02:29:45.592Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2022-08-07T02:29:45.610Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2022-08-07T02:29:45.613Z","level":"WARN","thread":"main","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-1"},"logger":"com.sun.identity.monitoring.FederationMonitoringSetupImpl","message":"JDMK runtime not found - Federation SNMP disabled","context":"default"} 07-Aug-2022 02:29:48.399 INFO [main] org.apache.catalina.startup.HostConfig.deployDirectory Deployment of web application directory [/usr/local/tomcat/webapps/am] has finished in [21,976] ms 07-Aug-2022 02:29:48.403 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-8080"] 07-Aug-2022 02:29:48.411 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-8081"] 07-Aug-2022 02:29:48.413 INFO [main] org.apache.catalina.startup.Catalina.start Server startup in [22037] milliseconds {"timestamp":"2022-08-07T02:29:48.575Z","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":"2022-08-07T02:29:53.718Z","level":"WARN","thread":"LDAP SDK Default Scheduler","logger":"org.forgerock.opendj.ldap.LoadBalancer","message":"Connection factory 'CachedConnectionPool(size=0[in:0 + out:0 + pending:0], maxSize=2, blocked=0, ldapClient=LdapClient(host=ds-idrepo-1.ds-idrepo, port=1636, protocol=LDAPS))' is no longer operational: Connect Error: Host 'ds-idrepo-1.ds-idrepo' cannot be resolved","context":"default"} {"timestamp":"2022-08-07T02:29:53.719Z","level":"WARN","thread":"LDAP SDK Default Scheduler","logger":"org.forgerock.opendj.ldap.LoadBalancer","message":"Connection factory 'CachedConnectionPool(size=0[in:0 + out:0 + pending:0], maxSize=2, blocked=0, ldapClient=LdapClient(host=ds-idrepo-2.ds-idrepo, port=1636, protocol=LDAPS))' is no longer operational: Connect Error: Host 'ds-idrepo-2.ds-idrepo' cannot be resolved","context":"default"} 10.0.11.1 - - [07/Aug/2022:02:29:49 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 605ms 10.0.11.1 - - [07/Aug/2022:02:29:49 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 605ms 10.0.6.22 - - [07/Aug/2022:02:29:53 +0000] "GET /am/json/metrics/prometheus HTTP/1.1" 200 193269 66ms 10.0.11.1 - - [07/Aug/2022:02:29:55 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 3ms 10.0.11.1 - - [07/Aug/2022:02:30:05 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 3ms {"timestamp":"2022-08-07T02:30:12.422Z","level":"WARN","thread":"http-nio-8081-exec-3","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-162"},"logger":"org.forgerock.openam.core.realms.impl.DefaultRealmLookup","message":"DefaultRealms:lookup Unable to find Org name for: authenticate","context":"default"} {"timestamp":"2022-08-07T02:30:12.422Z","level":"DEBUG","thread":"http-nio-8081-exec-3","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-162"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2022-08-07T02:30:12.422Z","level":"DEBUG","thread":"http-nio-8081-exec-3","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-162"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2022-08-07T02:30:12.599Z","level":"WARN","thread":"http-nio-8081-exec-3","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-162"},"logger":"com.sun.identity.authentication.config.AMAuthLevelManager","message":"No auth level for module OpenIdConnect","context":"default"} {"timestamp":"2022-08-07T02:30:12.600Z","level":"WARN","thread":"http-nio-8081-exec-3","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-162"},"logger":"com.sun.identity.authentication.config.AMAuthLevelManager","message":"No auth level for module AuthenticatorPushRegistration","context":"default"} {"timestamp":"2022-08-07T02:30:12.600Z","level":"WARN","thread":"http-nio-8081-exec-3","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-162"},"logger":"com.sun.identity.authentication.config.AMAuthLevelManager","message":"No auth level for module PersistentCookie","context":"default"} {"timestamp":"2022-08-07T02:30:12.657Z","eventName":"AM-ACCESS-OUTCOME","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-162","trackingIds":["0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-165"],"client":{"ip":"10.0.7.124","port":53800},"http":{"request":{"secure":true,"method":"POST","path":"https://am:80/am/json/authenticate","headers":{"accept-api-version":["protocol=2.1"],"content-type":["application/json; charset=UTF-8"],"host":["am:80"],"user-agent":["Apache-HttpAsyncClient/4.1.4 (Java/11.0.16)"],"x-requested-with":["Amster"]},"queryParameters":{"authIndexType":["service"],"authIndexValue":["amsterService"]}}},"response":{"status":"SUCCESSFUL","statusCode":"200","elapsedTime":286,"elapsedTimeUnits":"MILLISECONDS"},"realm":"/","component":"Authentication","source":"audit","topic":"access","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-167"} {"timestamp":"2022-08-07T02:30:12.780Z","level":"DEBUG","thread":"http-nio-8081-exec-4","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-168"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2022-08-07T02:30:12.780Z","level":"DEBUG","thread":"http-nio-8081-exec-4","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-168"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2022-08-07T02:30:12.802Z","level":"WARN","thread":"http-nio-8081-exec-4","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-168"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2022-08-07T02:30:12.934Z","level":"WARN","thread":"http-nio-8081-exec-4","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-168"},"logger":"com.sun.identity.idm.plugins.internal.AgentsRepo","message":"AgentsRepo.getAgentGroupConfig: Unable to get Agent Group Config due to The instance agentgroup does not exist","context":"default"} {"timestamp":"2022-08-07T02:30:12.984Z","eventName":"AM-LOGIN-MODULE-COMPLETED","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-168","trackingIds":["0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-165"],"userId":"id=amadmin,ou=user,ou=am-config","principal":["amadmin"],"entries":[{"moduleId":"Amster","info":{"authIndex":"service","authControlFlag":"REQUIRED","moduleClass":"Amster","ipAddress":"10.0.7.124","authLevel":"0"}}],"result":"SUCCESSFUL","realm":"/","component":"Authentication","source":"audit","topic":"authentication","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-172"} {"timestamp":"2022-08-07T02:30:13.157Z","level":"WARN","thread":"http-nio-8081-exec-4","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-168"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2022-08-07T02:30:13.147Z","eventName":"AM-SESSION-CREATED","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-168","trackingIds":["0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-165"],"userId":"id=amadmin,ou=user,ou=am-config","runAs":"id=amadmin,ou=user,ou=am-config","objectId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-165","operation":"CREATE","realm":"/","component":"Session","source":"audit","topic":"activity","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-179"} {"timestamp":"2022-08-07T02:30:13.169Z","eventName":"AM-LOGIN-COMPLETED","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-168","trackingIds":["0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-165"],"userId":"id=amadmin,ou=user,ou=am-config","principal":["amadmin"],"entries":[{"moduleId":"Amster","info":{"authIndex":"service","authIndexValue":"amsterService","ipAddress":"10.0.7.124","authLevel":"0"}}],"result":"SUCCESSFUL","realm":"/","component":"Authentication","source":"audit","topic":"authentication","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-183"} {"timestamp":"2022-08-07T02:30:13.190Z","eventName":"AM-ACCESS-OUTCOME","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-168","trackingIds":["0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-165"],"userId":"id=amadmin,ou=user,ou=am-config","client":{"ip":"10.0.7.124","port":53800},"http":{"request":{"secure":true,"method":"POST","path":"https://am:80/am/json/authenticate","headers":{"accept-api-version":["protocol=2.1"],"content-type":["application/json; charset=UTF-8"],"host":["am:80"],"user-agent":["Apache-HttpAsyncClient/4.1.4 (Java/11.0.16)"],"x-requested-with":["Amster"]},"queryParameters":{"authIndexType":["service"],"authIndexValue":["amsterService"]}}},"response":{"status":"SUCCESSFUL","statusCode":"200","elapsedTime":411,"elapsedTimeUnits":"MILLISECONDS"},"realm":"/","component":"Authentication","source":"audit","topic":"access","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-189"} {"timestamp":"2022-08-07T02:30:13.201Z","level":"WARN","thread":"http-nio-8081-exec-5","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-190"},"logger":"org.forgerock.openam.core.realms.impl.DefaultRealmLookup","message":"DefaultRealms:lookup Unable to find Org name for: serverinfo","context":"default"} {"timestamp":"2022-08-07T02:30:13.201Z","level":"DEBUG","thread":"http-nio-8081-exec-5","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-190"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2022-08-07T02:30:13.201Z","level":"DEBUG","thread":"http-nio-8081-exec-5","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-190"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2022-08-07T02:30:13.238Z","eventName":"AM-ACCESS-OUTCOME","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-190","client":{"ip":"10.0.7.124","port":53800},"server":{"ip":"10.0.11.67","port":8081},"http":{"request":{"secure":true,"method":"GET","path":"https://am:80/am/json/serverinfo/*","headers":{"accept-api-version":["protocol=2.1"],"host":["am:80"],"user-agent":["Apache-HttpAsyncClient/4.1.4 (Java/11.0.16)"]}}},"request":{"protocol":"CREST","operation":"READ"},"response":{"status":"SUCCESSFUL","statusCode":"","elapsedTime":43,"elapsedTimeUnits":"MILLISECONDS","detail":{"revision":"-485253810"}},"realm":"/","component":"Server Info","source":"audit","topic":"access","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-194"} 10.0.7.124 - - [07/Aug/2022:02:30:09 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 3ms 10.0.7.124 - - [07/Aug/2022:02:30:12 +0000] "POST /am/json/authenticate?authIndexType=service&authIndexValue=amsterService HTTP/1.1" 200 668 301ms 10.0.7.124 - - [07/Aug/2022:02:30:13 +0000] "POST /am/json/authenticate?authIndexType=service&authIndexValue=amsterService HTTP/1.1" 200 167 413ms 10.0.7.124 - - [07/Aug/2022:02:30:13 +0000] "GET /am/json/serverinfo/* HTTP/1.1" 200 544 54ms 10.0.11.1 - - [07/Aug/2022:02:30:15 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 2ms {"timestamp":"2022-08-07T02:30:22.886Z","level":"WARN","thread":"LDAP SDK Default Scheduler","logger":"org.forgerock.opendj.ldap.LoadBalancer","message":"Connection factory 'CachedConnectionPool(size=0[in:0 + out:0 + pending:0], maxSize=14, blocked=0, ldapClient=LdapClient(host=ds-idrepo-2.ds-idrepo, port=1636, protocol=LDAPS))' is no longer operational: Connect Error: Host 'ds-idrepo-2.ds-idrepo' cannot be resolved","context":"default"} {"timestamp":"2022-08-07T02:30:22.888Z","level":"WARN","thread":"LDAP SDK Default Scheduler","logger":"org.forgerock.opendj.ldap.LoadBalancer","message":"Connection factory 'CachedConnectionPool(size=0[in:0 + out:0 + pending:0], maxSize=14, blocked=0, ldapClient=LdapClient(host=ds-idrepo-2.ds-idrepo, port=1636, protocol=LDAPS))' is no longer operational: Connect Error: Host 'ds-idrepo-2.ds-idrepo' cannot be resolved","context":"default"} {"timestamp":"2022-08-07T02:30:22.892Z","level":"WARN","thread":"LDAP SDK Default Scheduler","logger":"org.forgerock.opendj.ldap.LoadBalancer","message":"Connection factory 'CachedConnectionPool(size=0[in:0 + out:0 + pending:0], maxSize=2, blocked=0, ldapClient=LdapClient(host=ds-idrepo-2.ds-idrepo, port=1636, protocol=LDAPS))' is no longer operational: Connect Error: Host 'ds-idrepo-2.ds-idrepo' cannot be resolved","context":"default"} 10.0.6.22 - - [07/Aug/2022:02:30:23 +0000] "GET /am/json/metrics/prometheus HTTP/1.1" 200 349774 60ms 10.0.11.1 - - [07/Aug/2022:02:30:25 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 2ms 10.0.11.1 - - [07/Aug/2022:02:30:25 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 3ms 10.0.11.1 - - [07/Aug/2022:02:30:35 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 2ms 10.0.11.1 - - [07/Aug/2022:02:30:45 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 2ms 10.0.6.22 - - [07/Aug/2022:02:30:53 +0000] "GET /am/json/metrics/prometheus HTTP/1.1" 200 349758 31ms 10.0.11.1 - - [07/Aug/2022:02:30:55 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 3ms 10.0.11.1 - - [07/Aug/2022:02:30:55 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 3ms 10.0.11.1 - - [07/Aug/2022:02:31:05 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 2ms {"timestamp":"2022-08-07T02:31:14.995Z","level":"DEBUG","thread":"http-nio-8081-exec-2","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-228"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2022-08-07T02:31:14.995Z","level":"DEBUG","thread":"http-nio-8081-exec-2","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-228"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2022-08-07T02:31:15.106Z","eventName":"AM-LOGIN-MODULE-COMPLETED","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-228","trackingIds":["0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-231"],"userId":"id=amadmin,ou=user,ou=am-config","principal":["amadmin"],"entries":[{"moduleId":"DataStore","info":{"authControlFlag":"REQUIRED","moduleClass":"DataStore","ipAddress":"10.0.6.14","authLevel":"0"}}],"result":"SUCCESSFUL","realm":"/","component":"Authentication","source":"audit","topic":"authentication","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-233"} {"timestamp":"2022-08-07T02:31:15.124Z","eventName":"AM-SESSION-CREATED","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-228","trackingIds":["0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-231"],"userId":"id=amadmin,ou=user,ou=am-config","runAs":"id=amadmin,ou=user,ou=am-config","objectId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-231","operation":"CREATE","realm":"/","component":"Session","source":"audit","topic":"activity","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-237"} {"timestamp":"2022-08-07T02:31:15.125Z","eventName":"AM-LOGIN-COMPLETED","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-228","trackingIds":["0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-231"],"userId":"id=amadmin,ou=user,ou=am-config","principal":["amadmin"],"entries":[{"moduleId":"DataStore","info":{"ipAddress":"10.0.6.14","authLevel":"0"}}],"result":"SUCCESSFUL","realm":"/","component":"Authentication","source":"audit","topic":"authentication","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-239"} {"timestamp":"2022-08-07T02:31:15.127Z","eventName":"AM-ACCESS-OUTCOME","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-228","trackingIds":["0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-231"],"userId":"id=amadmin,ou=user,ou=am-config","client":{"ip":"10.0.6.14","port":48632},"http":{"request":{"secure":true,"method":"POST","path":"https://xlou.iam.xlou-cdm.engineeringpit.com/am/json/authenticate","headers":{"accept":["*/*"],"accept-api-version":["protocol=1.0,resource=2.0"],"content-type":["application/json"],"host":["xlou.iam.xlou-cdm.engineeringpit.com"],"user-agent":["python-requests/2.26.0"],"x-forwarded-for":["35.212.145.225"],"x-forwarded-host":["xlou.iam.xlou-cdm.engineeringpit.com"],"x-forwarded-port":["443"],"x-forwarded-proto":["https"],"x-real-ip":["35.212.145.225"],"x-request-id":["48b858accc1f6947bdde1ce7dce775d0"],"x-scheme":["https"]}}},"response":{"status":"SUCCESSFUL","statusCode":"200","elapsedTime":136,"elapsedTimeUnits":"MILLISECONDS"},"realm":"/","component":"Authentication","source":"audit","topic":"access","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-241"} 10.0.6.14 - - [07/Aug/2022:02:31:15 +0000] "POST /am/json/authenticate?realm=/ HTTP/1.1" 200 167 140ms 10.0.11.1 - - [07/Aug/2022:02:31:15 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 2ms {"timestamp":"2022-08-07T02:31:28.230Z","level":"DEBUG","thread":"http-nio-8081-exec-4","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-254"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2022-08-07T02:31:28.230Z","level":"DEBUG","thread":"http-nio-8081-exec-4","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-254"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2022-08-07T02:31:28.234Z","eventName":"AM-LOGIN-MODULE-COMPLETED","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-254","trackingIds":["0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-257"],"userId":"id=amadmin,ou=user,ou=am-config","principal":["amadmin"],"entries":[{"moduleId":"DataStore","info":{"authControlFlag":"REQUIRED","moduleClass":"DataStore","ipAddress":"10.0.6.14","authLevel":"0"}}],"result":"SUCCESSFUL","realm":"/","component":"Authentication","source":"audit","topic":"authentication","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-259"} {"timestamp":"2022-08-07T02:31:28.251Z","eventName":"AM-SESSION-CREATED","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-254","trackingIds":["0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-257"],"userId":"id=amadmin,ou=user,ou=am-config","runAs":"id=amadmin,ou=user,ou=am-config","objectId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-257","operation":"CREATE","realm":"/","component":"Session","source":"audit","topic":"activity","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-263"} {"timestamp":"2022-08-07T02:31:28.252Z","eventName":"AM-LOGIN-COMPLETED","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-254","trackingIds":["0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-257"],"userId":"id=amadmin,ou=user,ou=am-config","principal":["amadmin"],"entries":[{"moduleId":"DataStore","info":{"ipAddress":"10.0.6.14","authLevel":"0"}}],"result":"SUCCESSFUL","realm":"/","component":"Authentication","source":"audit","topic":"authentication","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-265"} {"timestamp":"2022-08-07T02:31:28.254Z","eventName":"AM-ACCESS-OUTCOME","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-254","trackingIds":["0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-257"],"userId":"id=amadmin,ou=user,ou=am-config","client":{"ip":"10.0.6.14","port":48632},"http":{"request":{"secure":true,"method":"POST","path":"https://xlou.iam.xlou-cdm.engineeringpit.com/am/json/authenticate","headers":{"accept":["*/*"],"accept-api-version":["protocol=1.0,resource=2.0"],"content-type":["application/json"],"host":["xlou.iam.xlou-cdm.engineeringpit.com"],"user-agent":["python-requests/2.26.0"],"x-forwarded-for":["35.212.145.225"],"x-forwarded-host":["xlou.iam.xlou-cdm.engineeringpit.com"],"x-forwarded-port":["443"],"x-forwarded-proto":["https"],"x-real-ip":["35.212.145.225"],"x-request-id":["90bd73961f46cafc119f03128b1670ce"],"x-scheme":["https"]}}},"response":{"status":"SUCCESSFUL","statusCode":"200","elapsedTime":25,"elapsedTimeUnits":"MILLISECONDS"},"realm":"/","component":"Authentication","source":"audit","topic":"access","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-267"} 10.0.6.22 - - [07/Aug/2022:02:31:23 +0000] "GET /am/json/metrics/prometheus HTTP/1.1" 200 350061 31ms 10.0.11.1 - - [07/Aug/2022:02:31:25 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 2ms 10.0.11.1 - - [07/Aug/2022:02:31:25 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 2ms 10.0.6.14 - - [07/Aug/2022:02:31:28 +0000] "POST /am/json/authenticate?realm=/ HTTP/1.1" 200 167 27ms {"timestamp":"2022-08-07T02:31:28.494Z","level":"DEBUG","thread":"http-nio-8081-exec-5","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-268"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2022-08-07T02:31:28.494Z","level":"DEBUG","thread":"http-nio-8081-exec-5","mdc":{"transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-268"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2022-08-07T02:31:28.519Z","eventName":"AM-ACCESS-OUTCOME","transactionId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-268","trackingIds":["0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-257"],"userId":"id=amadmin,ou=user,ou=am-config","client":{"ip":"10.0.6.14","port":48756},"server":{"ip":"10.0.11.67","port":8081},"http":{"request":{"secure":true,"method":"GET","path":"https://xlou.iam.xlou-cdm.engineeringpit.com/am/json/serverinfo/version","headers":{"accept":["*/*"],"accept-api-version":["protocol=2.1"],"host":["xlou.iam.xlou-cdm.engineeringpit.com"],"user-agent":["python-requests/2.26.0"],"x-forwarded-for":["35.212.145.225"],"x-forwarded-host":["xlou.iam.xlou-cdm.engineeringpit.com"],"x-forwarded-port":["443"],"x-forwarded-proto":["https"],"x-real-ip":["35.212.145.225"],"x-request-id":["fda039b192cd7faae824cae032f7c069"],"x-scheme":["https"]}}},"request":{"protocol":"CREST","operation":"READ"},"response":{"status":"SUCCESSFUL","statusCode":"","elapsedTime":28,"elapsedTimeUnits":"MILLISECONDS","detail":{"revision":"-340041102"}},"realm":"/","component":"Server Info","source":"audit","topic":"access","level":"INFO","_eventId":"0b5c0c8f-9d3d-4dc7-b359-4c0b10f72f5e-272"} 10.0.6.14 - - [07/Aug/2022:02:31:28 +0000] "GET /am/json/serverinfo/version HTTP/1.1" 200 277 32ms 10.0.11.1 - - [07/Aug/2022:02:31:35 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 2ms Copying docker image configuration files to the shared volume