==================================================================================================== ========================================= Pod describe ========================================= ==================================================================================================== Name: am-7849cf7bdb-p4fns Namespace: xlou Priority: 0 Node: gke-xlou-cdm-default-pool-f05840a3-b4tr/10.142.0.102 Start Time: Sun, 11 Jun 2023 18:38:43 +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=7849cf7bdb tier=middle Annotations: cluster-autoscaler.kubernetes.io/safe-to-evict: true Status: Running IP: 10.106.45.140 IPs: IP: 10.106.45.140 Controlled By: ReplicaSet/am-7849cf7bdb Init Containers: fbc-init: Container ID: containerd://815e53cfe1198d06e754dccdd0637ce4ab9a3da7abdef4af409990574f40ec1d Image: gcr.io/engineeringpit/lodestar-images/am:xlou Image ID: gcr.io/engineeringpit/lodestar-images/am@sha256:58c365361d464d63fc67c532385bb52ec2d5c58825385cc563abb93bfbf8ebd4 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, 11 Jun 2023 18:38:44 +0000 Finished: Sun, 11 Jun 2023 18:38:44 +0000 Ready: True Restart Count: 0 Environment: Mounts: /fbc from fbc (rw) /var/run/secrets/kubernetes.io/serviceaccount from kube-api-access-h8pd8 (ro) truststore-init: Container ID: containerd://093ca11a6596973e44e2bb40d21f3756acceb69052cce17f91edab620d7d54e8 Image: gcr.io/engineeringpit/lodestar-images/am:xlou Image ID: gcr.io/engineeringpit/lodestar-images/am@sha256:58c365361d464d63fc67c532385bb52ec2d5c58825385cc563abb93bfbf8ebd4 Port: Host Port: Command: /home/forgerock/import-pem-certs.sh State: Terminated Reason: Completed Exit Code: 0 Started: Sun, 11 Jun 2023 18:38:45 +0000 Finished: Sun, 11 Jun 2023 18:38:45 +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-h8pd8 (ro) /var/run/secrets/truststore from truststore (rw) Containers: openam: Container ID: containerd://32defeb4e27371e8ee1e3ba5c5d8f0dc7b60545c0cb9a98664d784a97bde314b Image: gcr.io/engineeringpit/lodestar-images/am:xlou Image ID: gcr.io/engineeringpit/lodestar-images/am@sha256:58c365361d464d63fc67c532385bb52ec2d5c58825385cc563abb93bfbf8ebd4 Port: 8080/TCP Host Port: 0/TCP Command: bash /home/forgerock/docker-entrypoint.sh State: Running Started: Sun, 11 Jun 2023 18:38:46 +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-h8pd8 (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-h8pd8: 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 2m39s default-scheduler Successfully assigned xlou/am-7849cf7bdb-p4fns to gke-xlou-cdm-default-pool-f05840a3-b4tr Normal Pulling 2m38s kubelet Pulling image "gcr.io/engineeringpit/lodestar-images/am:xlou" Normal Pulled 2m38s kubelet Successfully pulled image "gcr.io/engineeringpit/lodestar-images/am:xlou" in 283.948641ms Normal Created 2m38s kubelet Created container fbc-init Normal Started 2m38s kubelet Started container fbc-init Normal Pulling 2m37s kubelet Pulling image "gcr.io/engineeringpit/lodestar-images/am:xlou" Normal Pulled 2m37s kubelet Successfully pulled image "gcr.io/engineeringpit/lodestar-images/am:xlou" in 226.47741ms Normal Created 2m37s kubelet Created container truststore-init Normal Started 2m37s kubelet Started container truststore-init Normal Pulling 2m36s kubelet Pulling image "gcr.io/engineeringpit/lodestar-images/am:xlou" Normal Pulled 2m36s kubelet Successfully pulled image "gcr.io/engineeringpit/lodestar-images/am:xlou" in 214.718666ms Normal Created 2m36s kubelet Created container openam Normal Started 2m36s kubelet Started container openam Warning Unhealthy 2m18s (x2 over 2m28s) kubelet Startup probe failed: Get "http://10.106.45.140: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 /opt/java/openjdk/lib/security/cacerts to /truststore/amtruststore Found (1) certificates in am_combined_truststore 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 11-Jun-2023 18:38:48.914 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version name: Apache Tomcat/9.0.75 11-Jun-2023 18:38:48.917 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server built: May 4 2023 13:04:05 UTC 11-Jun-2023 18:38:48.917 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version number: 9.0.75.0 11-Jun-2023 18:38:48.917 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Name: Linux 11-Jun-2023 18:38:48.917 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Version: 5.10.162+ 11-Jun-2023 18:38:48.917 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Architecture: amd64 11-Jun-2023 18:38:48.917 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Java Home: /opt/java/openjdk 11-Jun-2023 18:38:48.918 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Version: 11.0.19+7 11-Jun-2023 18:38:48.918 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Vendor: Eclipse Adoptium 11-Jun-2023 18:38:48.918 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_BASE: /usr/local/tomcat 11-Jun-2023 18:38:48.918 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_HOME: /usr/local/tomcat 11-Jun-2023 18:38:48.926 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.lang=ALL-UNNAMED 11-Jun-2023 18:38:48.926 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.io=ALL-UNNAMED 11-Jun-2023 18:38:48.926 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.util=ALL-UNNAMED 11-Jun-2023 18:38:48.927 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.util.concurrent=ALL-UNNAMED 11-Jun-2023 18:38:48.927 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.rmi/sun.rmi.transport=ALL-UNNAMED 11-Jun-2023 18:38:48.927 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.config.file=/usr/local/tomcat/conf/logging.properties 11-Jun-2023 18:38:48.927 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager 11-Jun-2023 18:38:48.927 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djdk.tls.ephemeralDHKeySize=2048 11-Jun-2023 18:38:48.927 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.protocol.handler.pkgs=org.apache.catalina.webresources 11-Jun-2023 18:38:48.927 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dorg.apache.catalina.security.SecurityListener.UMASK=0027 11-Jun-2023 18:38:48.927 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.services.debug.mergeall=on 11-Jun-2023 18:38:48.927 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.identity.configuration.directory=/home/forgerock/openam 11-Jun-2023 18:38:48.928 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.iplanet.services.stats.state=off 11-Jun-2023 18:38:48.928 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.identity.sm.sms_object_filebased_enabled=true 11-Jun-2023 18:38:48.928 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dorg.forgerock.donotupgrade=true 11-Jun-2023 18:38:48.928 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -DtomcatAccessLogDir=/proc/self/fd 11-Jun-2023 18:38:48.928 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -DtomcatAccessLogFile=1 11-Jun-2023 18:38:48.928 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -XX:MaxRAMPercentage=75 11-Jun-2023 18:38:48.928 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -XX:InitialRAMPercentage=75 11-Jun-2023 18:38:48.928 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -XX:MaxTenuringThreshold=1 11-Jun-2023 18:38:48.928 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.security.egd=file:/dev/urandom 11-Jun-2023 18:38:48.928 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dorg.forgerock.am.oauth2.consent.xui_path=/OAuth2_XUI 11-Jun-2023 18:38:48.928 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 11-Jun-2023 18:38:48.928 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djavax.net.ssl.trustStore=/home/forgerock/amtruststore 11-Jun-2023 18:38:48.928 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djavax.net.ssl.trustStorePassword=changeit 11-Jun-2023 18:38:48.929 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djavax.net.ssl.trustStoreType=jks 11-Jun-2023 18:38:48.929 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dignore.endorsed.dirs= 11-Jun-2023 18:38:48.929 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.base=/usr/local/tomcat 11-Jun-2023 18:38:48.929 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.home=/usr/local/tomcat 11-Jun-2023 18:38:48.929 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.io.tmpdir=/usr/local/tomcat/temp 11-Jun-2023 18:38:48.932 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [1.2.36] using APR version [1.7.0]. 11-Jun-2023 18:38:48.932 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true], UDS [true]. 11-Jun-2023 18:38:48.932 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR/OpenSSL configuration: useAprConnector [false], useOpenSSL [true] 11-Jun-2023 18:38:48.935 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.0.2 15 Mar 2022] 11-Jun-2023 18:38:49.137 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-8080"] 11-Jun-2023 18:38:49.154 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-8081"] 11-Jun-2023 18:38:49.154 INFO [main] org.apache.catalina.startup.Catalina.load Server initialization in [388] milliseconds 11-Jun-2023 18:38:49.197 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Catalina] 11-Jun-2023 18:38:49.197 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.75] 11-Jun-2023 18:38:49.201 INFO [main] org.apache.catalina.startup.HostConfig.deployDirectory Deploying web application directory [/usr/local/tomcat/webapps/am] 11-Jun-2023 18:38:56.055 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 (file:/usr/local/tomcat/webapps/am/WEB-INF/lib/guice-assistedinject-4.2.3.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 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 Jun 11, 2023, 6:38:58 PM {"timestamp":"2023-06-11T18:39:01.305Z","level":"WARN","thread":"LDAP SDK Default AsyncRx I/O Thread (0)","logger":"org.forgerock.opendj.ldap.LoadBalancerEventListener$1","message":"Connection factory 'ConnectionPool(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: Connection refused","context":"default"} {"timestamp":"2023-06-11T18:39:01.526Z","level":"WARN","thread":"LDAP SDK Default AsyncRx I/O Thread (2)","logger":"org.forgerock.opendj.ldap.LoadBalancerEventListener$1","message":"Connection factory 'ConnectionPool(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: Connection refused","context":"default"} {"timestamp":"2023-06-11T18:39:01.603Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-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-06-11T18:39:03.449Z","level":"WARN","thread":"RADIUS-RadiusServerManager","logger":"org.forgerock.openam.radius.server.config.RadiusServerManager","message":"RADIUS service is not enabled.","context":"default"} {"timestamp":"2023-06-11T18:39:03.663Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.monitoring.MonitoringConfig","message":"JDMK runtime not found - Legacy Monitoring disabled","context":"default"} {"timestamp":"2023-06-11T18:39:03.668Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2023-06-11T18:39:04.002Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2023-06-11T18:39:05.877Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"org.forgerock.opendj.ldap.LoadBalancerEventListener$1","message":"Connection factory 'ConnectionPool(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-06-11T18:39:05.930Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.sm.ldap.LDAPEventManager","message":"LDAPEventManager: received all entries changed event from EventService","context":"default"} {"timestamp":"2023-06-11T18:39:05.976Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.sm.ldap.SMSLdapObject","message":"SMSLDAPObject: got notifications, all objects changed","context":"default"} {"timestamp":"2023-06-11T18:39:06.529Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.sm.ldap.LDAPEventManager","message":"LDAPEventManager: received all entries changed event from EventService","context":"default"} {"timestamp":"2023-06-11T18:39:06.545Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.sm.ldap.SMSLdapObject","message":"SMSLDAPObject: got notifications, all objects changed","context":"default"} {"timestamp":"2023-06-11T18:39:07.008Z","level":"WARN","thread":"Thread-4","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-06-11T18:39:07.009Z","level":"WARN","thread":"Thread-4","logger":"org.forgerock.openam.services.push.PushNotificationService","message":"No Push Notification Delegate configured for realm /","context":"default"} {"timestamp":"2023-06-11T18:39:07.225Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.iplanet.services.naming.WebtopNaming","message":"WebtopNaming.configMonitoring: start generating ssoserverinfo\n Start time = 2023-06-11 18:39:07","context":"default"} {"timestamp":"2023-06-11T18:39:07.229Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-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-06-11T18:39:07.229Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.monitoring.MonitoringAdapters","message":"Agent.startAgent:Monitoring SNMP port not enabled or JDMK not present.","context":"default"} {"timestamp":"2023-06-11T18:39:07.229Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.monitoring.MonitoringAdapters","message":"Agent.startAgent:Monitoring RMI port not enabled.","context":"default"} {"timestamp":"2023-06-11T18:39:07.260Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-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-06-11T18:39:07.267Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-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-06-11T18:39:07.274Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2023-06-11T18:39:07.277Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.log.s1is.LogConfigReader","message":"LogConfigReader: DB password is null","context":"default"} {"timestamp":"2023-06-11T18:39:07.278Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.log.s1is.LogConfigReader","message":"LogConfigReader: Logfile prefix string is null","context":"default"} {"timestamp":"2023-06-11T18:39:07.278Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.log.s1is.LogConfigReader","message":"LogConfigReader: Filter class is null","context":"default"} {"timestamp":"2023-06-11T18:39:07.283Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2023-06-11T18:39:07.301Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2023-06-11T18:39:07.305Z","level":"WARN","thread":"main","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-0"},"logger":"com.sun.identity.monitoring.FederationMonitoringSetupImpl","message":"JDMK runtime not found - Federation SNMP disabled","context":"default"} 11-Jun-2023 18:39:10.050 INFO [main] org.apache.catalina.startup.HostConfig.deployDirectory Deployment of web application directory [/usr/local/tomcat/webapps/am] has finished in [20,847] ms 11-Jun-2023 18:39:10.054 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-8080"] 11-Jun-2023 18:39:10.063 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-8081"] 11-Jun-2023 18:39:10.065 INFO [main] org.apache.catalina.startup.Catalina.start Server startup in [20910] milliseconds {"timestamp":"2023-06-11T18:39:10.242Z","level":"WARN","thread":"http-nio-8081-exec-1","logger":"org.forgerock.openam.core.rest.docs.api.ApiDocsService","message":"API Descriptor has changed - regenerating docs","context":"default"} {"timestamp":"2023-06-11T18:39:15.825Z","level":"WARN","thread":"LDAP SDK Default AsyncRx I/O Thread (3)","logger":"org.forgerock.opendj.ldap.LoadBalancerEventListener$1","message":"Connection factory 'org.forgerock.openam.ldap.MonitoredLdapClient@2fda6e79' is no longer operational: Connect Error: Connection refused","context":"default"} {"timestamp":"2023-06-11T18:39:18.737Z","level":"WARN","thread":"http-nio-8081-exec-3","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-38"},"logger":"org.forgerock.openam.core.realms.impl.DefaultRealmLookup","message":"DefaultRealms:lookup Unable to find Org name for: authenticate","context":"default"} {"timestamp":"2023-06-11T18:39:18.738Z","level":"DEBUG","thread":"http-nio-8081-exec-3","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-38"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2023-06-11T18:39:18.738Z","level":"DEBUG","thread":"http-nio-8081-exec-3","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-38"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2023-06-11T18:39:18.799Z","level":"WARN","thread":"http-nio-8081-exec-3","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-38"},"logger":"com.sun.identity.authentication.config.AMAuthLevelManager","message":"No auth level for module OpenIdConnect","context":"default"} {"timestamp":"2023-06-11T18:39:18.812Z","level":"WARN","thread":"http-nio-8081-exec-3","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-38"},"logger":"com.sun.identity.authentication.config.AMAuthLevelManager","message":"No auth level for module AuthenticatorPushRegistration","context":"default"} {"timestamp":"2023-06-11T18:39:18.823Z","level":"WARN","thread":"http-nio-8081-exec-3","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-38"},"logger":"com.sun.identity.authentication.config.AMAuthLevelManager","message":"No auth level for module PersistentCookie","context":"default"} {"timestamp":"2023-06-11T18:39:18.963Z","eventName":"AM-ACCESS-OUTCOME","transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-38","trackingIds":["c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-41"],"client":{"ip":"10.106.46.36","port":58118},"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.17)"],"x-requested-with":["Amster"]},"queryParameters":{"authIndexType":["service"],"authIndexValue":["amsterService"]}}},"response":{"status":"SUCCESSFUL","statusCode":"200","elapsedTime":257,"elapsedTimeUnits":"MILLISECONDS"},"realm":"/","component":"Authentication","source":"audit","topic":"access","level":"INFO","_eventId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-43"} {"timestamp":"2023-06-11T18:39:19.076Z","level":"DEBUG","thread":"http-nio-8081-exec-4","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-44"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2023-06-11T18:39:19.076Z","level":"DEBUG","thread":"http-nio-8081-exec-4","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-44"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2023-06-11T18:39:19.095Z","level":"WARN","thread":"http-nio-8081-exec-4","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-44"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2023-06-11T18:39:19.184Z","level":"WARN","thread":"http-nio-8081-exec-4","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-44"},"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":"2023-06-11T18:39:19.229Z","eventName":"AM-LOGIN-MODULE-COMPLETED","transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-44","trackingIds":["c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-41"],"userId":"id=amadmin,ou=user,ou=am-config","principal":["amadmin"],"entries":[{"moduleId":"Amster","info":{"authIndex":"service","authControlFlag":"REQUIRED","moduleClass":"Amster","ipAddress":"10.106.46.36","authLevel":"0"}}],"result":"SUCCESSFUL","realm":"/","component":"Authentication","source":"audit","topic":"authentication","level":"INFO","_eventId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-48"} {"timestamp":"2023-06-11T18:39:19.411Z","level":"WARN","thread":"http-nio-8081-exec-4","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-44"},"logger":"com.sun.identity.monitoring.MonitoringServicesImpl","message":"JDMK runtime not found - Policy Monitoring disabled","context":"default"} {"timestamp":"2023-06-11T18:39:19.401Z","eventName":"AM-SESSION-CREATED","transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-44","trackingIds":["c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-41"],"userId":"id=amadmin,ou=user,ou=am-config","runAs":"id=amadmin,ou=user,ou=am-config","objectId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-41","operation":"CREATE","realm":"/","component":"Session","source":"audit","topic":"activity","level":"INFO","_eventId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-55"} {"timestamp":"2023-06-11T18:39:19.424Z","eventName":"AM-LOGIN-COMPLETED","transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-44","trackingIds":["c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-41"],"userId":"id=amadmin,ou=user,ou=am-config","principal":["amadmin"],"entries":[{"moduleId":"Amster","info":{"authIndex":"service","authIndexValue":"amsterService","ipAddress":"10.106.46.36","authLevel":"0"}}],"result":"SUCCESSFUL","realm":"/","component":"Authentication","source":"audit","topic":"authentication","level":"INFO","_eventId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-59"} {"timestamp":"2023-06-11T18:39:19.445Z","eventName":"AM-ACCESS-OUTCOME","transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-44","trackingIds":["c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-41"],"userId":"id=amadmin,ou=user,ou=am-config","client":{"ip":"10.106.46.36","port":58118},"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.17)"],"x-requested-with":["Amster"]},"queryParameters":{"authIndexType":["service"],"authIndexValue":["amsterService"]}}},"response":{"status":"SUCCESSFUL","statusCode":"200","elapsedTime":370,"elapsedTimeUnits":"MILLISECONDS"},"realm":"/","component":"Authentication","source":"audit","topic":"access","level":"INFO","_eventId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-65"} {"timestamp":"2023-06-11T18:39:19.455Z","level":"WARN","thread":"http-nio-8081-exec-5","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-66"},"logger":"org.forgerock.openam.core.realms.impl.DefaultRealmLookup","message":"DefaultRealms:lookup Unable to find Org name for: serverinfo","context":"default"} {"timestamp":"2023-06-11T18:39:19.456Z","level":"DEBUG","thread":"http-nio-8081-exec-5","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-66"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2023-06-11T18:39:19.456Z","level":"DEBUG","thread":"http-nio-8081-exec-5","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-66"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2023-06-11T18:39:19.493Z","eventName":"AM-ACCESS-OUTCOME","transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-66","client":{"ip":"10.106.46.36","port":58118},"server":{"ip":"10.106.45.140","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.17)"]}}},"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":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-70"} 10.106.45.129 - - [11/Jun/2023:18:39:10 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 681ms 10.106.45.129 - - [11/Jun/2023:18:39:10 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 681ms 10.106.46.148 - - [11/Jun/2023:18:39:10 +0000] "GET /am/json/metrics/prometheus HTTP/1.1" 200 198647 730ms 10.106.45.129 - - [11/Jun/2023:18:39:13 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 4ms 10.106.45.129 - - [11/Jun/2023:18:39:13 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.106.46.36 - - [11/Jun/2023:18:39:15 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.106.46.36 - - [11/Jun/2023:18:39:18 +0000] "POST /am/json/authenticate?authIndexType=service&authIndexValue=amsterService HTTP/1.1" 200 668 270ms 10.106.46.36 - - [11/Jun/2023:18:39:19 +0000] "POST /am/json/authenticate?authIndexType=service&authIndexValue=amsterService HTTP/1.1" 200 167 373ms 10.106.46.36 - - [11/Jun/2023:18:39:19 +0000] "GET /am/json/serverinfo/* HTTP/1.1" 200 544 51ms {"timestamp":"2023-06-11T18:39:29.128Z","level":"WARN","thread":"LDAP SDK Default AsyncRx I/O Thread (0)","logger":"org.forgerock.opendj.ldap.LoadBalancerEventListener$1","message":"Connection factory 'ConnectionPool(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: Connection refused","context":"default"} {"timestamp":"2023-06-11T18:39:29.130Z","level":"WARN","thread":"LDAP SDK Default AsyncRx I/O Thread (0)","logger":"org.forgerock.opendj.ldap.LoadBalancerEventListener$1","message":"Connection factory 'ConnectionPool(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: Connection refused","context":"default"} {"timestamp":"2023-06-11T18:39:29.146Z","level":"WARN","thread":"LDAP SDK Default AsyncRx I/O Thread (3)","logger":"org.forgerock.opendj.ldap.LoadBalancerEventListener$1","message":"Connection factory 'ConnectionPool(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: Connection refused","context":"default"} {"timestamp":"2023-06-11T18:39:29.148Z","level":"WARN","thread":"LDAP SDK Default AsyncRx I/O Thread (1)","logger":"org.forgerock.opendj.ldap.LoadBalancerEventListener$1","message":"Connection factory 'ConnectionPool(size=0[in:0 + out:0 + pending:0], maxSize=14, blocked=0, ldapClient=LdapClient(host=ds-idrepo-1.ds-idrepo, port=1636, protocol=LDAPS))' is no longer operational: Invalid Credentials","context":"default"} {"timestamp":"2023-06-11T18:39:29.159Z","level":"WARN","thread":"LDAP SDK Default AsyncRx I/O Thread (2)","logger":"org.forgerock.opendj.ldap.LoadBalancerEventListener$1","message":"Connection factory 'ConnectionPool(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: Invalid Credentials","context":"default"} {"timestamp":"2023-06-11T18:39:29.291Z","level":"WARN","thread":"LDAP SDK Default AsyncRx I/O Thread (0)","logger":"org.forgerock.opendj.ldap.LoadBalancerEventListener$1","message":"Connection factory 'org.forgerock.openam.ldap.MonitoredLdapClient@5855d606' is no longer operational: Connect Error: Connection refused","context":"default"} 10.106.45.129 - - [11/Jun/2023:18:39:23 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.106.45.129 - - [11/Jun/2023:18:39:33 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.106.46.148 - - [11/Jun/2023:18:39:35 +0000] "GET /am/json/metrics/prometheus HTTP/1.1" 200 356524 42ms 10.106.45.129 - - [11/Jun/2023:18:39:43 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 3ms 10.106.45.129 - - [11/Jun/2023:18:39:43 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 4ms 10.106.45.129 - - [11/Jun/2023:18:39:53 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.106.45.129 - - [11/Jun/2023:18:40:03 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.106.46.148 - - [11/Jun/2023:18:40:05 +0000] "GET /am/json/metrics/prometheus HTTP/1.1" 200 356505 37ms 10.106.45.129 - - [11/Jun/2023:18:40:13 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 2ms 10.106.45.129 - - [11/Jun/2023:18:40:13 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 4ms 10.106.45.129 - - [11/Jun/2023:18:40:23 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.106.45.129 - - [11/Jun/2023:18:40:33 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 4ms 10.106.46.148 - - [11/Jun/2023:18:40:35 +0000] "GET /am/json/metrics/prometheus HTTP/1.1" 200 356509 29ms 10.106.45.129 - - [11/Jun/2023:18:40:43 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 3ms 10.106.45.129 - - [11/Jun/2023:18:40:43 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms 10.106.45.129 - - [11/Jun/2023:18:40:53 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 5ms {"timestamp":"2023-06-11T18:41:01.015Z","level":"DEBUG","thread":"http-nio-8081-exec-4","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-123"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2023-06-11T18:41:01.015Z","level":"DEBUG","thread":"http-nio-8081-exec-4","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-123"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2023-06-11T18:41:01.084Z","eventName":"AM-LOGIN-MODULE-COMPLETED","transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-123","trackingIds":["c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-126"],"userId":"id=amadmin,ou=user,ou=am-config","principal":["amadmin"],"entries":[{"moduleId":"DataStore","info":{"authControlFlag":"REQUIRED","moduleClass":"DataStore","ipAddress":"10.106.46.135","authLevel":"0"}}],"result":"SUCCESSFUL","realm":"/","component":"Authentication","source":"audit","topic":"authentication","level":"INFO","_eventId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-128"} {"timestamp":"2023-06-11T18:41:01.099Z","eventName":"AM-SESSION-CREATED","transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-123","trackingIds":["c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-126"],"userId":"id=amadmin,ou=user,ou=am-config","runAs":"id=amadmin,ou=user,ou=am-config","objectId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-126","operation":"CREATE","realm":"/","component":"Session","source":"audit","topic":"activity","level":"INFO","_eventId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-131"} {"timestamp":"2023-06-11T18:41:01.100Z","eventName":"AM-LOGIN-COMPLETED","transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-123","trackingIds":["c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-126"],"userId":"id=amadmin,ou=user,ou=am-config","principal":["amadmin"],"entries":[{"moduleId":"DataStore","info":{"ipAddress":"10.106.46.135","authLevel":"0"}}],"result":"SUCCESSFUL","realm":"/","component":"Authentication","source":"audit","topic":"authentication","level":"INFO","_eventId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-133"} {"timestamp":"2023-06-11T18:41:01.102Z","eventName":"AM-ACCESS-OUTCOME","transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-123","trackingIds":["c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-126"],"userId":"id=amadmin,ou=user,ou=am-config","client":{"ip":"10.106.46.135","port":56964},"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.28.2"],"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":["7f9dbc1f1f9e26e30a8b39e97daad99b"],"x-scheme":["https"]}}},"response":{"status":"SUCCESSFUL","statusCode":"200","elapsedTime":91,"elapsedTimeUnits":"MILLISECONDS"},"realm":"/","component":"Authentication","source":"audit","topic":"access","level":"INFO","_eventId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-135"} {"timestamp":"2023-06-11T18:41:01.819Z","level":"DEBUG","thread":"http-nio-8081-exec-5","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-136"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2023-06-11T18:41:01.819Z","level":"DEBUG","thread":"http-nio-8081-exec-5","mdc":{"transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-136"},"logger":"org.forgerock.openam.cors.CorsFilter","message":"handling non-CORS request","context":"default"} {"timestamp":"2023-06-11T18:41:01.823Z","eventName":"AM-ACCESS-OUTCOME","transactionId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-136","trackingIds":["c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-126"],"userId":"id=amadmin,ou=user,ou=am-config","client":{"ip":"10.106.46.135","port":56974},"server":{"ip":"10.106.45.140","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.28.2"],"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":["d7017c4f483bbfa64361b8bd7d45b4a8"],"x-scheme":["https"]}}},"request":{"protocol":"CREST","operation":"READ"},"response":{"status":"SUCCESSFUL","statusCode":"","elapsedTime":26,"elapsedTimeUnits":"MILLISECONDS","detail":{"revision":"-1298399560"}},"realm":"/","component":"Server Info","source":"audit","topic":"access","level":"INFO","_eventId":"c1a62fc9-ecc6-4928-8dfe-32f4cd41cc42-140"} 10.106.46.135 - - [11/Jun/2023:18:41:01 +0000] "POST /am/json/authenticate?realm=/ HTTP/1.1" 200 167 94ms 10.106.46.135 - - [11/Jun/2023:18:41:01 +0000] "GET /am/json/serverinfo/version HTTP/1.1" 200 274 29ms 10.106.45.129 - - [11/Jun/2023:18:41:03 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 4ms 10.106.46.148 - - [11/Jun/2023:18:41:05 +0000] "GET /am/json/metrics/prometheus HTTP/1.1" 200 356841 31ms 10.106.45.129 - - [11/Jun/2023:18:41:13 +0000] "GET /am/json/health/live HTTP/1.1" 200 - 3ms 10.106.45.129 - - [11/Jun/2023:18:41:13 +0000] "GET /am/json/health/ready HTTP/1.1" 200 - 4ms