--Task-- name: CheckReplication_ds-cts enabled: True class_name: CheckReplicationTask source_name: ds-cts source_namespace: >default< target_name: ds-cts target_namespace: >default< start: 0 stop: None timeout: not yet initialized for this Task as timeout was not explicitly defined, see updates bellow loop: False interval: None dependencies: [] wait_for: [] options: {} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [12/Aug/2023 14:34:18] CheckReplication_ds-cts pre : N/A ________________________________________________________________________________ max_time: 1h 59m sleep_interval: 10 [12/Aug/2023 14:34:18] - INFO: Timeout for this Task has changed to 4h (14400 seconds) [12/Aug/2023 14:34:18] - INFO: timeout was set to Task default (2x global_duration or 300 seconds (whatever is higher)), because it was unset ________________________________________________________________________________ [12/Aug/2023 14:34:18] CheckReplication_ds-cts step1 : Check number of entries ________________________________________________________________________________ loop 1 : ERROR : Pod "ds-cts-0" has 11 entries but pod "ds-cts-1" has 13 entries (should have same number of entries) loop 1 : ERROR : Pod "ds-cts-0" has 11 entries but pod "ds-cts-2" has 14 entries (should have same number of entries) loop 1 : ERROR : Pod "ds-cts-1" has 13 entries but pod "ds-cts-2" has 14 entries (should have same number of entries) loop 1 : Sleep 10 and retry loop 2 : SUCCESS: Pods "ds-cts-0" and "ds-cts-1" are in sync (both have 16 entries) loop 2 : SUCCESS: Pods "ds-cts-0" and "ds-cts-2" are in sync (both have 16 entries) loop 2 : SUCCESS: Pods "ds-cts-1" and "ds-cts-2" are in sync (both have 16 entries) [check_number_of_entries] SUCCESS : replication is synchronised after 15s ________________________________________________________________________________ [12/Aug/2023 14:34:38] CheckReplication_ds-cts step2 : Monitor replication attributes in cn=monitor ________________________________________________________________________________ loop 1 : SUCCESS: ds-cts-0 : ds-mon-current-delay = 0 loop 1 : SUCCESS: ds-cts-0 : ds-mon-updates-inbound-queue = 0 loop 1 : SUCCESS: ds-cts-1 : ds-mon-current-delay = 0 loop 1 : SUCCESS: ds-cts-1 : ds-mon-updates-inbound-queue = 0 loop 1 : SUCCESS: ds-cts-2 : ds-mon-current-delay = 0 loop 1 : SUCCESS: ds-cts-2 : ds-mon-updates-inbound-queue = 0 [check_monitoring_replication] final status : { "ds-cts-0": { "status": true, "ds-mon-current-delay": 0, "ds-mon-updates-inbound-queue": 0 }, "ds-cts-1": { "status": true, "ds-mon-current-delay": 0, "ds-mon-updates-inbound-queue": 0 }, "ds-cts-2": { "status": true, "ds-mon-current-delay": 0, "ds-mon-updates-inbound-queue": 0 } } [check_monitoring_replication] SUCCESS : replication data in cn=monitor is synchronised after 0s ________________________________________________________________________________ [12/Aug/2023 14:34:43] CheckReplication_ds-cts step3 : Temporary step for PERF-1831 : Dump cn=monitor replication attributes ________________________________________________________________________________ ---------------- Pod ds-cts-0 ---------------- [run_command]: kubectl --namespace=xlou exec ds-cts-0 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "QPvBZVHWObekI0iJPLbNDrTOLDzxA6ZL" --baseDn "cn=replicas,cn=replication,cn=monitor" "objectclass=*" [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- dn: cn=replicas,cn=replication,cn=monitor objectclass: top objectclass: ds-monitor objectclass: ds-monitor-branch cn: replicas dn: ds-mon-domain-name=ou=tokens,cn=replicas,cn=replication,cn=monitor objectClass: top objectClass: ds-monitor objectClass: ds-monitor-replica ds-mon-connected-to-server-hostport: 10.106.42.12:8989 ds-mon-connected-to-server-id: ds-cts-0 ds-mon-current-receive-window: 2147483639 ds-mon-domain-generation-id: 69125 ds-mon-domain-name: ou=tokens ds-mon-entries-awaiting-updates-count: 0 ds-mon-lost-connections: 0 ds-mon-receive-delay: 0 ds-mon-replay-delay: 0 ds-mon-replayed-internal-updates: 0 ds-mon-replayed-updates: {"count":12,"total":67.388,"mean_rate":0.004,"m1_rate":0.095,"m5_rate":0.026,"m15_rate":0.010,"mean":5.616,"min":2.523,"max":16.908,"stddev":3.654,"p50":4.817,"p75":5.865,"p95":16.908,"p98":16.908,"p99":16.908,"p999":16.908,"p9999":16.908,"p99999":16.908} ds-mon-replayed-updates-conflicts-resolved: 0 ds-mon-replayed-updates-conflicts-unresolved: 0 ds-mon-sent-updates: 8 ds-mon-server-id: ds-cts-0 ds-mon-server-state: 01080189ea2b767200001632ds-cts-0 ds-mon-server-state: 01080189ea2b74c300001603ds-cts-1 ds-mon-ssl-encryption: true ds-mon-status: Normal ds-mon-status-last-changed: 20230812134706.106Z ds-mon-total-update-entry-count: 0 ds-mon-total-update-entry-left: 0 ds-mon-updates-already-in-progress: 0 ds-mon-updates-inbound-queue: 0 ds-mon-updates-outbound-queue: 0 ds-mon-updates-totals-per-replay-thread: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 0, 1, 0, 2, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 1, 0, 3, 0, 0, 1] dn: cn=remote replicas,ds-mon-domain-name=ou=tokens,cn=replicas,cn=replication,cn=monitor objectclass: top objectclass: ds-monitor objectclass: ds-monitor-branch cn: remote replicas dn: ds-mon-server-id=ds-cts-1,cn=remote replicas,ds-mon-domain-name=ou=tokens,cn=replicas,cn=replication,cn=monitor objectClass: top objectClass: ds-monitor objectClass: ds-monitor-remote-replica ds-mon-domain-name: ou=tokens ds-mon-receive-delay: 0 ds-mon-replay-delay: 0 ds-mon-replayed-updates: {"count":12,"total":67.388,"mean_rate":0.014,"m1_rate":0.093,"m5_rate":0.059,"m15_rate":0.239,"mean":5.616,"min":2.523,"max":16.908,"stddev":3.654,"p50":4.817,"p75":5.865,"p95":16.908,"p98":16.908,"p99":16.908,"p999":16.908,"p9999":16.908,"p99999":16.908} ds-mon-server-id: ds-cts-1 dn: ds-mon-domain-name=uid=monitor,cn=replicas,cn=replication,cn=monitor objectClass: top objectClass: ds-monitor objectClass: ds-monitor-replica ds-mon-connected-to-server-hostport: 10.106.42.12:8989 ds-mon-connected-to-server-id: ds-cts-0 ds-mon-current-receive-window: 2147483647 ds-mon-domain-generation-id: 48 ds-mon-domain-name: uid=monitor ds-mon-entries-awaiting-updates-count: 0 ds-mon-lost-connections: 0 ds-mon-receive-delay: 0 ds-mon-replay-delay: 0 ds-mon-replayed-internal-updates: 0 ds-mon-replayed-updates: {"count":0,"total":0.000,"mean_rate":0.000,"m1_rate":0.000,"m5_rate":0.000,"m15_rate":0.000,"mean":0.000,"min":0.000,"max":0.000,"stddev":0.000,"p50":0.000,"p75":0.000,"p95":0.000,"p98":0.000,"p99":0.000,"p999":0.000,"p9999":0.000,"p99999":0.000} ds-mon-replayed-updates-conflicts-resolved: 0 ds-mon-replayed-updates-conflicts-unresolved: 0 ds-mon-sent-updates: 0 ds-mon-server-id: ds-cts-0 ds-mon-ssl-encryption: true ds-mon-status: Normal ds-mon-status-last-changed: 20230812134706.029Z ds-mon-total-update-entry-count: 0 ds-mon-total-update-entry-left: 0 ds-mon-updates-already-in-progress: 0 ds-mon-updates-inbound-queue: 0 ds-mon-updates-outbound-queue: 0 ds-mon-updates-totals-per-replay-thread: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 0, 1, 0, 2, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 1, 0, 3, 0, 0, 1] --- stderr --- ---------------- Pod ds-cts-1 ---------------- [run_command]: kubectl --namespace=xlou exec ds-cts-1 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "QPvBZVHWObekI0iJPLbNDrTOLDzxA6ZL" --baseDn "cn=replicas,cn=replication,cn=monitor" "objectclass=*" [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- dn: cn=replicas,cn=replication,cn=monitor objectclass: top objectclass: ds-monitor objectclass: ds-monitor-branch cn: replicas dn: ds-mon-domain-name=ou=tokens,cn=replicas,cn=replication,cn=monitor objectClass: top objectClass: ds-monitor objectClass: ds-monitor-replica ds-mon-connected-to-server-hostport: 10.106.43.12:8989 ds-mon-connected-to-server-id: ds-cts-1 ds-mon-current-receive-window: 2147483642 ds-mon-domain-generation-id: 69125 ds-mon-domain-name: ou=tokens ds-mon-entries-awaiting-updates-count: 0 ds-mon-lost-connections: 0 ds-mon-receive-delay: 0 ds-mon-replay-delay: 0 ds-mon-replayed-internal-updates: 0 ds-mon-replayed-updates: {"count":8,"total":38.791,"mean_rate":0.003,"m1_rate":0.056,"m5_rate":0.016,"m15_rate":0.006,"mean":4.849,"min":1.802,"max":13.763,"stddev":3.460,"p50":3.670,"p75":3.752,"p95":13.763,"p98":13.763,"p99":13.763,"p999":13.763,"p9999":13.763,"p99999":13.763} ds-mon-replayed-updates-conflicts-resolved: 0 ds-mon-replayed-updates-conflicts-unresolved: 0 ds-mon-sent-updates: 12 ds-mon-server-id: ds-cts-1 ds-mon-server-state: 01080189ea2b74c300001603ds-cts-1 ds-mon-server-state: 01080189ea2b767200001632ds-cts-0 ds-mon-ssl-encryption: true ds-mon-status: Normal ds-mon-status-last-changed: 20230812134730.472Z ds-mon-total-update-entry-count: 0 ds-mon-total-update-entry-left: 0 ds-mon-updates-already-in-progress: 0 ds-mon-updates-inbound-queue: 0 ds-mon-updates-outbound-queue: 0 ds-mon-updates-totals-per-replay-thread: [0, 0, 0, 0, 0, 0, 2, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 2, 0, 0, 0, 0] dn: cn=remote replicas,ds-mon-domain-name=ou=tokens,cn=replicas,cn=replication,cn=monitor objectclass: top objectclass: ds-monitor objectclass: ds-monitor-branch cn: remote replicas dn: ds-mon-server-id=ds-cts-0,cn=remote replicas,ds-mon-domain-name=ou=tokens,cn=replicas,cn=replication,cn=monitor objectClass: top objectClass: ds-monitor objectClass: ds-monitor-remote-replica ds-mon-domain-name: ou=tokens ds-mon-receive-delay: 0 ds-mon-replay-delay: 0 ds-mon-replayed-updates: {"count":8,"total":38.791,"mean_rate":0.004,"m1_rate":0.058,"m5_rate":0.017,"m15_rate":0.061,"mean":4.849,"min":1.802,"max":13.763,"stddev":3.460,"p50":3.670,"p75":3.752,"p95":13.763,"p98":13.763,"p99":13.763,"p999":13.763,"p9999":13.763,"p99999":13.763} ds-mon-server-id: ds-cts-0 dn: ds-mon-domain-name=uid=monitor,cn=replicas,cn=replication,cn=monitor objectClass: top objectClass: ds-monitor objectClass: ds-monitor-replica ds-mon-connected-to-server-hostport: 10.106.43.12:8989 ds-mon-connected-to-server-id: ds-cts-1 ds-mon-current-receive-window: 2147483647 ds-mon-domain-generation-id: 48 ds-mon-domain-name: uid=monitor ds-mon-entries-awaiting-updates-count: 0 ds-mon-lost-connections: 0 ds-mon-receive-delay: 0 ds-mon-replay-delay: 0 ds-mon-replayed-internal-updates: 0 ds-mon-replayed-updates: {"count":0,"total":0.000,"mean_rate":0.000,"m1_rate":0.000,"m5_rate":0.000,"m15_rate":0.000,"mean":0.000,"min":0.000,"max":0.000,"stddev":0.000,"p50":0.000,"p75":0.000,"p95":0.000,"p98":0.000,"p99":0.000,"p999":0.000,"p9999":0.000,"p99999":0.000} ds-mon-replayed-updates-conflicts-resolved: 0 ds-mon-replayed-updates-conflicts-unresolved: 0 ds-mon-sent-updates: 0 ds-mon-server-id: ds-cts-1 ds-mon-ssl-encryption: true ds-mon-status: Normal ds-mon-status-last-changed: 20230812134730.360Z ds-mon-total-update-entry-count: 0 ds-mon-total-update-entry-left: 0 ds-mon-updates-already-in-progress: 0 ds-mon-updates-inbound-queue: 0 ds-mon-updates-outbound-queue: 0 ds-mon-updates-totals-per-replay-thread: [0, 0, 0, 0, 0, 0, 2, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 2, 0, 0, 0, 0] --- stderr --- ---------------- Pod ds-cts-2 ---------------- [run_command]: kubectl --namespace=xlou exec ds-cts-2 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "QPvBZVHWObekI0iJPLbNDrTOLDzxA6ZL" --baseDn "cn=replicas,cn=replication,cn=monitor" "objectclass=*" [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- dn: cn=replicas,cn=replication,cn=monitor objectclass: top objectclass: ds-monitor objectclass: ds-monitor-branch cn: replicas dn: ds-mon-domain-name=ou=tokens,cn=replicas,cn=replication,cn=monitor objectClass: top objectClass: ds-monitor objectClass: ds-monitor-replica ds-mon-connected-to-server-hostport: 10.106.42.140:8989 ds-mon-connected-to-server-id: ds-cts-2 ds-mon-current-receive-window: 2147483634 ds-mon-domain-generation-id: 69125 ds-mon-domain-name: ou=tokens ds-mon-entries-awaiting-updates-count: 0 ds-mon-lost-connections: 0 ds-mon-receive-delay: 0 ds-mon-replay-delay: 0 ds-mon-replayed-internal-updates: 0 ds-mon-replayed-updates: {"count":20,"total":96.289,"mean_rate":0.007,"m1_rate":0.151,"m5_rate":0.042,"m15_rate":0.017,"mean":4.813,"min":1.122,"max":15.925,"stddev":3.487,"p50":3.801,"p75":4.686,"p95":13.042,"p98":15.925,"p99":15.925,"p999":15.925,"p9999":15.925,"p99999":15.925} ds-mon-replayed-updates-conflicts-resolved: 0 ds-mon-replayed-updates-conflicts-unresolved: 0 ds-mon-sent-updates: 0 ds-mon-server-id: ds-cts-2 ds-mon-server-state: 01080189ea2b74c300001603ds-cts-1 ds-mon-server-state: 01080189ea2b767200001632ds-cts-0 ds-mon-ssl-encryption: true ds-mon-status: Normal ds-mon-status-last-changed: 20230812134753.232Z ds-mon-total-update-entry-count: 0 ds-mon-total-update-entry-left: 0 ds-mon-updates-already-in-progress: 0 ds-mon-updates-inbound-queue: 0 ds-mon-updates-outbound-queue: 0 ds-mon-updates-totals-per-replay-thread: [0, 0, 0, 0, 0, 0, 2, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 2, 0, 0, 0, 0, 0, 1, 0, 0, 0, 0, 1, 0, 2, 0, 0, 0, 0, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 1, 2, 3, 0, 0, 1] dn: cn=remote replicas,ds-mon-domain-name=ou=tokens,cn=replicas,cn=replication,cn=monitor objectclass: top objectclass: ds-monitor objectclass: ds-monitor-branch cn: remote replicas dn: ds-mon-server-id=ds-cts-0,cn=remote replicas,ds-mon-domain-name=ou=tokens,cn=replicas,cn=replication,cn=monitor objectClass: top objectClass: ds-monitor objectClass: ds-monitor-remote-replica ds-mon-domain-name: ou=tokens ds-mon-receive-delay: 0 ds-mon-replay-delay: 0 ds-mon-replayed-updates: {"count":8,"total":35.275,"mean_rate":0.004,"m1_rate":0.058,"m5_rate":0.017,"m15_rate":0.061,"mean":4.412,"min":1.122,"max":13.042,"stddev":3.376,"p50":3.441,"p75":3.686,"p95":13.042,"p98":13.042,"p99":13.042,"p999":13.042,"p9999":13.042,"p99999":13.042} ds-mon-server-id: ds-cts-0 dn: ds-mon-server-id=ds-cts-1,cn=remote replicas,ds-mon-domain-name=ou=tokens,cn=replicas,cn=replication,cn=monitor objectClass: top objectClass: ds-monitor objectClass: ds-monitor-remote-replica ds-mon-domain-name: ou=tokens ds-mon-receive-delay: 0 ds-mon-replay-delay: 0 ds-mon-replayed-updates: {"count":12,"total":61.014,"mean_rate":0.014,"m1_rate":0.093,"m5_rate":0.059,"m15_rate":0.239,"mean":5.081,"min":1.745,"max":15.925,"stddev":3.534,"p50":4.293,"p75":5.145,"p95":15.925,"p98":15.925,"p99":15.925,"p999":15.925,"p9999":15.925,"p99999":15.925} ds-mon-server-id: ds-cts-1 dn: ds-mon-domain-name=uid=monitor,cn=replicas,cn=replication,cn=monitor objectClass: top objectClass: ds-monitor objectClass: ds-monitor-replica ds-mon-connected-to-server-hostport: 10.106.42.140:8989 ds-mon-connected-to-server-id: ds-cts-2 ds-mon-current-receive-window: 2147483647 ds-mon-domain-generation-id: 48 ds-mon-domain-name: uid=monitor ds-mon-entries-awaiting-updates-count: 0 ds-mon-lost-connections: 0 ds-mon-receive-delay: 0 ds-mon-replay-delay: 0 ds-mon-replayed-internal-updates: 0 ds-mon-replayed-updates: {"count":0,"total":0.000,"mean_rate":0.000,"m1_rate":0.000,"m5_rate":0.000,"m15_rate":0.000,"mean":0.000,"min":0.000,"max":0.000,"stddev":0.000,"p50":0.000,"p75":0.000,"p95":0.000,"p98":0.000,"p99":0.000,"p999":0.000,"p9999":0.000,"p99999":0.000} ds-mon-replayed-updates-conflicts-resolved: 0 ds-mon-replayed-updates-conflicts-unresolved: 0 ds-mon-sent-updates: 0 ds-mon-server-id: ds-cts-2 ds-mon-ssl-encryption: true ds-mon-status: Normal ds-mon-status-last-changed: 20230812134753.142Z ds-mon-total-update-entry-count: 0 ds-mon-total-update-entry-left: 0 ds-mon-updates-already-in-progress: 0 ds-mon-updates-inbound-queue: 0 ds-mon-updates-outbound-queue: 0 ds-mon-updates-totals-per-replay-thread: [0, 0, 0, 0, 0, 0, 2, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 2, 0, 0, 0, 0, 0, 1, 0, 0, 0, 0, 1, 0, 2, 0, 0, 0, 0, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 1, 2, 3, 0, 0, 1] --- stderr --- ________________________________________________________________________________ [12/Aug/2023 14:34:48] CheckReplication_ds-cts step4 : Temporary step for PERF-1831 : checks logs ________________________________________________________________________________ ---------------- Pod ds-cts-0 ---------------- [loop_until]: kubectl --namespace=xlou logs ds-cts-0 [loop_until]: (max_time=180, interval=5, expected_rc=[0] [loop_until]: OK (rc = 0) --- stdout --- Initializing "data/changelogDb" from Docker image Initializing "data/import-tmp" from Docker image Upgrading configuration and data... * OpenDJ data has already been upgraded to version 7.4.0.e46808a022da759ebe0ee43bf6f422fe91a4e54b Rebuilding degraded indexes for base DN "ou=tokens"... Server configured with: Group ID : default Server ID : ds-cts-0 Advertised listen address : ds-cts-0.ds-cts.xlou.svc.cluster.local Bootstrap replication server(s) : ds-cts-0.ds-cts.xlou.svc.cluster.local:8989,ds-cts-1.ds-cts.xlou.svc.cluster.local:8989 {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:04.730Z","category":"JVM","severity":"NOTICE","msgId":134,"message":"ForgeRock Directory Services 7.4.0-20230804090409-e46808a022da759ebe0ee43bf6f422fe91a4e54b (build 20230804100405, revision number e46808a022da759ebe0ee43bf6f422fe91a4e54b) starting up"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:04.730Z","category":"JVM","severity":"NOTICE","msgId":21,"message":"Installation Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:04.730Z","category":"JVM","severity":"NOTICE","msgId":23,"message":"Instance Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:04.730Z","category":"JVM","severity":"NOTICE","msgId":17,"message":"JVM Information: 17.0.8+7-LTS by Azul Systems, Inc., 64-bit architecture, 11274289152 bytes heap size"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:04.730Z","category":"JVM","severity":"NOTICE","msgId":20,"message":"JVM Host: ds-cts-0.ds-cts.xlou.svc.cluster.local default/ds-cts-0, running Linux 5.10.162+ amd64, unknown physical memory size, number of processors available 16"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:04.730Z","category":"JVM","severity":"NOTICE","msgId":19,"message":"JVM Arguments: \"-XX:+UseG1GC\", \"-XX:MaxRAMPercentage=75\", \"-XX:MaxTenuringThreshold=1\", \"-Djava.security.egd=file:/dev/urandom\", \"-Dorg.opends.server.scriptName=start-ds\""} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:04.730Z","category":"CORE","severity":"WARNING","msgId":779,"message":"'External Access Log Publisher' is DEPRECATED for removal since 7.2.0. Its usage is highly discouraged."} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:05.331Z","category":"BACKEND","severity":"NOTICE","msgId":513,"message":"The database backend amCts containing 5 entries has started"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:05.731Z","category":"SYNC.PURGE","severity":"INFORMATION","msgId":394,"message":"The purge delay has been set to: 12 h"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:05.731Z","category":"SYNC.LIFECYCLE","severity":"NOTICE","msgId":204,"message":"Replication server RS(ds-cts-0) started listening for new connections on address 0.0.0.0 port 8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:05.731Z","category":"SYNC.CONNECTIONS","severity":"WARNING","msgId":387,"message":"Directory server DS(ds-cts-0) was unable to connect to replication server at ds-cts-1.ds-cts.xlou.svc.cluster.local:8989 for domain 'uid=monitor': unknown host"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:05.931Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":207,"message":"Replication server RS(ds-cts-0) has accepted a connection from directory server DS(ds-cts-0) for domain \"uid=monitor\" at /10.106.42.12:54550"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:05.931Z","category":"SYNC.CONNECTIONS","severity":"NOTICE","msgId":62,"message":"Directory server DS(ds-cts-0) has connected to replication server RS(ds-cts-0) for domain \"uid=monitor\" at 10.106.42.12:8989 with generation ID 48"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:05.931Z","category":"SYNC.STATE","severity":"NOTICE","msgId":388,"message":"Directory server DS(ds-cts-0) did not find a generation ID for domain 'ou=tokens'. A new generation ID will be computed by exporting the first 5 entries in the domain."} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:05.931Z","category":"BACKEND","severity":"NOTICE","msgId":515,"message":"Exported 5 entries and skipped 0 in 0 seconds (average rate 357.1/sec)"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:05.931Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":207,"message":"Replication server RS(ds-cts-0) has accepted a connection from directory server DS(ds-cts-0) for domain \"ou=tokens\" at /10.106.42.12:54558"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:05.931Z","category":"SYNC.CONNECTIONS","severity":"NOTICE","msgId":62,"message":"Directory server DS(ds-cts-0) has connected to replication server RS(ds-cts-0) for domain \"ou=tokens\" at 10.106.42.12:8989 with generation ID 69125"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:05.931Z","category":"CORE","severity":"NOTICE","msgId":818,"message":"Registered 0 static groups, 0 dynamic groups and 0 virtual static groups. The static group cache is using 0 bytes of memory"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:06.132Z","category":"PROTOCOL.LDAP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on Administration Connector 0.0.0.0:4444"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:06.132Z","category":"PROTOCOL.LDAP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on LDAP 0.0.0.0:1389"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:06.132Z","category":"PROTOCOL.HTTP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on HTTP 0.0.0.0:8080"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:06.132Z","category":"PROTOCOL.HTTP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on HTTPS 0.0.0.0:8443"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:06.132Z","category":"PROTOCOL.LDAP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on LDAPS 0.0.0.0:1636"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:06.132Z","category":"CORE","severity":"NOTICE","msgId":135,"message":"The Directory Server has started successfully"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:06.132Z","category":"CORE","severity":"NOTICE","msgId":139,"message":"The Directory Server has sent an alert notification generated by class org.opends.server.core.DirectoryServer (alert type org.opends.server.DirectoryServerStarted, alert ID org.opends.messages.core-135): The Directory Server has started successfully"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.160Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":206,"message":"Replication server RS(ds-cts-0) has accepted a connection from replication server RS(ds-cts-1) for domain \"uid=monitor\" at /10.106.43.12:39520"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.360Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":206,"message":"Replication server RS(ds-cts-0) has accepted a connection from replication server RS(ds-cts-1) for domain \"ou=tokens\" at /10.106.43.12:39538"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:52.981Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":206,"message":"Replication server RS(ds-cts-0) has accepted a connection from replication server RS(ds-cts-2) for domain \"uid=monitor\" at /10.106.42.140:54840"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:52.981Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":205,"message":"Replication server RS(ds-cts-0) has connected to replication server RS(ds-cts-2) for domain \"ou=tokens\" at ds-cts-2.ds-cts.xlou.svc.cluster.local/10.106.42.140:8989"} {"_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-3","timestamp":"2023-08-12T14:04:48.195Z","eventName":"DJ-HTTP","transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-2","client":{"ip":"10.106.43.138","port":43908},"server":{"ip":"10.106.42.12","port":8080},"http":{"request":{"secure":false,"method":"GET","path":"http://ds-cts-0.ds-cts.xlou.svc.cluster.local:8080/alive","headers":{"accept":["*/*"],"host":["ds-cts-0.ds-cts:8080"],"user-agent":["curl/7.74.0"]}}},"response":{"status":"SUCCESSFUL","statusCode":"200","elapsedTime":27,"elapsedTimeUnits":"MILLISECONDS"},"source":"audit","topic":"http-access","level":"INFO"} {"_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-13","timestamp":"2023-08-12T14:19:42.705Z","eventName":"DJ-HTTP","transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-12","client":{"ip":"10.106.46.147","port":51268},"server":{"ip":"10.106.42.12","port":8080},"http":{"request":{"secure":false,"method":"GET","path":"http://ds-cts-0.ds-cts.xlou.svc.cluster.local:8080/alive","headers":{"accept":["*/*"],"host":["ds-cts-0.ds-cts:8080"],"user-agent":["curl/7.81.0"]}}},"response":{"status":"SUCCESSFUL","statusCode":"200","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS"},"source":"audit","topic":"http-access","level":"INFO"} {"_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-17","timestamp":"2023-08-12T14:19:42.851Z","eventName":"DJ-HTTP","transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-16","client":{"ip":"10.106.44.11","port":49060},"server":{"ip":"10.106.42.12","port":8080},"http":{"request":{"secure":false,"method":"GET","path":"http://ds-cts-0.ds-cts.xlou.svc.cluster.local:8080/alive","headers":{"accept":["*/*"],"host":["ds-cts-0.ds-cts:8080"],"user-agent":["curl/7.81.0"]}}},"response":{"status":"SUCCESSFUL","statusCode":"200","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS"},"source":"audit","topic":"http-access","level":"INFO"} {"_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-21","timestamp":"2023-08-12T14:19:44.452Z","eventName":"DJ-HTTP","transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-20","client":{"ip":"10.106.43.139","port":33916},"server":{"ip":"10.106.42.12","port":8080},"http":{"request":{"secure":false,"method":"GET","path":"http://ds-cts-0.ds-cts.xlou.svc.cluster.local:8080/alive","headers":{"accept":["*/*"],"host":["ds-cts-0.ds-cts:8080"],"user-agent":["curl/7.81.0"]}}},"response":{"status":"SUCCESSFUL","statusCode":"200","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS"},"source":"audit","topic":"http-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.12","port":45632},"server":{"ip":"10.106.42.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":10,"msgId":4,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-424","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:44.585Z","_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-426","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.12","port":45632},"server":{"ip":"10.106.42.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":10,"msgId":5,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-427","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:44.588Z","_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-429","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.12","port":45632},"server":{"ip":"10.106.42.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":10,"msgId":6,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["ds-cfg-time-limit","ds-cfg-default-password-policy","ds-cfg-etime-resolution","ds-cfg-allowed-task","ds-cfg-invalid-attribute-syntax-behavior","ds-cfg-max-psearches","ds-cfg-group-id","ds-cfg-check-schema","ds-cfg-add-missing-rdn-attributes","ds-cfg-max-candidate-set-size","ds-cfg-max-internal-buffer-size","ds-cfg-restricted-client","ds-cfg-single-structural-objectclass-behavior","ds-cfg-size-limit","ds-cfg-trust-transaction-ids","ds-cfg-proxy-protocol-enabled","ds-cfg-subordinate-base-dn","ds-cfg-denied-client","ds-cfg-bind-with-dn-requires-password","ds-cfg-advertised-listen-address","ds-cfg-allowed-client","ds-cfg-server-id","ds-cfg-max-allowed-client-connections","ds-cfg-listen-address","ds-cfg-writability-mode","ds-cfg-save-config-on-successful-startup","ds-cfg-proxy-protocol-allowed-client","ds-cfg-disabled-privilege","ds-cfg-return-bind-error-messages","ds-cfg-je-backend-shared-cache-enabled","ds-cfg-unauthenticated-requests-policy","ds-cfg-idle-time-limit","ds-cfg-proxied-authorization-identity-mapper","ds-cfg-restricted-client-connection-limit","ds-cfg-group-id-failover-order","ds-cfg-notify-abandoned-operations","ds-cfg-allow-attribute-name-exceptions"]},"transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-430","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:44.593Z","_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-432","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.12","port":45632},"server":{"ip":"10.106.42.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":10,"msgId":8,"dn":"cn=Default Password Policy,cn=Password Policies,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-434","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:44.616Z","_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-436","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.12","port":45632},"server":{"ip":"10.106.42.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":10,"msgId":9,"dn":"cn=Default Password Policy,cn=Password Policies,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-437","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:44.617Z","_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-439","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.12","port":45632},"server":{"ip":"10.106.42.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":10,"msgId":10,"dn":"cn=Default Password Policy,cn=Password Policies,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["ds-cfg-java-class","ds-cfg-min-password-age","ds-cfg-require-change-by-time","ds-cfg-password-validator","ds-cfg-password-generator","ds-cfg-password-history-count","ds-cfg-default-password-storage-scheme","ds-cfg-allow-expired-password-changes","ds-cfg-lockout-duration","ds-cfg-allow-pre-encoded-passwords","ds-cfg-password-change-requires-current-password","ds-cfg-allow-multiple-password-values","ds-cfg-max-password-reset-age","ds-cfg-skip-validation-for-administrators","ds-cfg-last-login-time-attribute","ds-cfg-require-secure-password-changes","ds-cfg-require-secure-authentication","ds-cfg-state-update-failure-policy","ds-cfg-grace-login-count","ds-cfg-lockout-failure-expiration-interval","ds-cfg-password-expiration-warning-interval","ds-cfg-allow-user-password-changes","ds-cfg-force-change-on-reset","ds-cfg-lockout-failure-count","ds-cfg-password-history-duration","ds-cfg-expire-passwords-without-warning","ds-cfg-max-password-age","ds-cfg-last-login-time-format","ds-cfg-previous-last-login-time-format","ds-cfg-deprecated-password-storage-scheme","ds-cfg-account-status-notification-handler","ds-cfg-idle-lockout-interval","ds-cfg-password-attribute","ds-cfg-force-change-on-add"]},"transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-440","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:44.620Z","_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-442","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.12","port":45632},"server":{"ip":"10.106.42.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":10,"msgId":12,"dn":"cn=Exact Match,cn=Identity Mappers,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-444","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:44.627Z","_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-446","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.12","port":45632},"server":{"ip":"10.106.42.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":10,"msgId":13,"dn":"cn=Exact Match,cn=Identity Mappers,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-447","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:44.629Z","_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-449","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.12","port":45632},"server":{"ip":"10.106.42.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":10,"msgId":14,"dn":"cn=Exact Match,cn=Identity Mappers,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["ds-cfg-java-class","ds-cfg-match-base-dn","ds-cfg-match-attribute","ds-cfg-enabled"]},"transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-450","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:44.631Z","_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-452","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.12","port":45632},"server":{"ip":"10.106.42.12","port":4444},"request":{"protocol":"LDAPS","operation":"MODIFY","connId":10,"msgId":15,"dn":"cn=config"},"transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-453","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":35,"elapsedTimeUnits":"MILLISECONDS"},"userId":"uid=admin","timestamp":"2023-08-12T14:29:44.672Z","_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-455","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.12","port":46458},"server":{"ip":"10.106.42.12","port":1389},"request":{"protocol":"LDAP","operation":"SEARCH","connId":11,"msgId":3,"dn":"cn=Filtering Criteria,cn=Console LDAP Access Logger,cn=Loggers,cn=config","scope":"sub","filter":"(objectClass=*)","attrs":["ALL"]},"transactionId":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-465","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":2,"elapsedTimeUnits":"MILLISECONDS","nentries":7},"userId":"uid=admin","timestamp":"2023-08-12T14:29:50.488Z","_id":"4ecf2547-e3c5-4a3d-b247-49ff4539457e-467","source":"audit","topic":"ldap-access","level":"INFO"} --- stderr --- Defaulted container "ds" out of: ds, initialize (init) - Looking for string "heart" - Looking for string "publish" ---------------- Pod ds-cts-1 ---------------- [loop_until]: kubectl --namespace=xlou logs ds-cts-1 [loop_until]: (max_time=180, interval=5, expected_rc=[0] [loop_until]: OK (rc = 0) --- stdout --- Initializing "data/changelogDb" from Docker image Initializing "data/import-tmp" from Docker image Upgrading configuration and data... * OpenDJ data has already been upgraded to version 7.4.0.e46808a022da759ebe0ee43bf6f422fe91a4e54b Rebuilding degraded indexes for base DN "ou=tokens"... Server configured with: Group ID : default Server ID : ds-cts-1 Advertised listen address : ds-cts-1.ds-cts.xlou.svc.cluster.local Bootstrap replication server(s) : ds-cts-0.ds-cts.xlou.svc.cluster.local:8989,ds-cts-1.ds-cts.xlou.svc.cluster.local:8989 {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:28.953Z","category":"JVM","severity":"NOTICE","msgId":134,"message":"ForgeRock Directory Services 7.4.0-20230804090409-e46808a022da759ebe0ee43bf6f422fe91a4e54b (build 20230804100405, revision number e46808a022da759ebe0ee43bf6f422fe91a4e54b) starting up"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:28.953Z","category":"JVM","severity":"NOTICE","msgId":21,"message":"Installation Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:28.953Z","category":"JVM","severity":"NOTICE","msgId":23,"message":"Instance Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:28.953Z","category":"JVM","severity":"NOTICE","msgId":17,"message":"JVM Information: 17.0.8+7-LTS by Azul Systems, Inc., 64-bit architecture, 11274289152 bytes heap size"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:28.953Z","category":"JVM","severity":"NOTICE","msgId":20,"message":"JVM Host: ds-cts-1.ds-cts.xlou.svc.cluster.local default/ds-cts-1, running Linux 5.10.162+ amd64, unknown physical memory size, number of processors available 16"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:28.953Z","category":"JVM","severity":"NOTICE","msgId":19,"message":"JVM Arguments: \"-XX:+UseG1GC\", \"-XX:MaxRAMPercentage=75\", \"-XX:MaxTenuringThreshold=1\", \"-Djava.security.egd=file:/dev/urandom\", \"-Dorg.opends.server.scriptName=start-ds\""} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:29.153Z","category":"CORE","severity":"WARNING","msgId":779,"message":"'External Access Log Publisher' is DEPRECATED for removal since 7.2.0. Its usage is highly discouraged."} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:29.554Z","category":"BACKEND","severity":"NOTICE","msgId":513,"message":"The database backend amCts containing 5 entries has started"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:29.954Z","category":"SYNC.PURGE","severity":"INFORMATION","msgId":394,"message":"The purge delay has been set to: 12 h"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:29.954Z","category":"SYNC.LIFECYCLE","severity":"NOTICE","msgId":204,"message":"Replication server RS(ds-cts-1) started listening for new connections on address 0.0.0.0 port 8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.154Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":205,"message":"Replication server RS(ds-cts-1) has connected to replication server RS(ds-cts-0) for domain \"uid=monitor\" at ds-cts-0.ds-cts.xlou.svc.cluster.local/10.106.42.12:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":207,"message":"Replication server RS(ds-cts-1) has accepted a connection from directory server DS(ds-cts-1) for domain \"uid=monitor\" at /10.106.43.12:55892"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"SYNC.CONNECTIONS","severity":"NOTICE","msgId":62,"message":"Directory server DS(ds-cts-1) has connected to replication server RS(ds-cts-1) for domain \"uid=monitor\" at 10.106.43.12:8989 with generation ID 48"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"SYNC.STATE","severity":"NOTICE","msgId":388,"message":"Directory server DS(ds-cts-1) did not find a generation ID for domain 'ou=tokens'. A new generation ID will be computed by exporting the first 5 entries in the domain."} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"BACKEND","severity":"NOTICE","msgId":515,"message":"Exported 5 entries and skipped 0 in 0 seconds (average rate 384.6/sec)"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":205,"message":"Replication server RS(ds-cts-1) has connected to replication server RS(ds-cts-0) for domain \"ou=tokens\" at ds-cts-0.ds-cts.xlou.svc.cluster.local/10.106.42.12:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":207,"message":"Replication server RS(ds-cts-1) has accepted a connection from directory server DS(ds-cts-1) for domain \"ou=tokens\" at /10.106.43.12:55916"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"SYNC.CONNECTIONS","severity":"NOTICE","msgId":62,"message":"Directory server DS(ds-cts-1) has connected to replication server RS(ds-cts-1) for domain \"ou=tokens\" at 10.106.43.12:8989 with generation ID 69125"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"CORE","severity":"NOTICE","msgId":818,"message":"Registered 0 static groups, 0 dynamic groups and 0 virtual static groups. The static group cache is using 0 bytes of memory"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"PROTOCOL.LDAP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on Administration Connector 0.0.0.0:4444"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"PROTOCOL.LDAP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on LDAP 0.0.0.0:1389"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"PROTOCOL.HTTP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on HTTP 0.0.0.0:8080"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"PROTOCOL.HTTP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on HTTPS 0.0.0.0:8443"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"PROTOCOL.LDAP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on LDAPS 0.0.0.0:1636"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"CORE","severity":"NOTICE","msgId":135,"message":"The Directory Server has started successfully"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:30.355Z","category":"CORE","severity":"NOTICE","msgId":139,"message":"The Directory Server has sent an alert notification generated by class org.opends.server.core.DirectoryServer (alert type org.opends.server.DirectoryServerStarted, alert ID org.opends.messages.core-135): The Directory Server has started successfully"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:52.980Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":206,"message":"Replication server RS(ds-cts-1) has accepted a connection from replication server RS(ds-cts-2) for domain \"uid=monitor\" at /10.106.42.140:40440"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:52.980Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":206,"message":"Replication server RS(ds-cts-1) has accepted a connection from replication server RS(ds-cts-2) for domain \"ou=tokens\" at /10.106.42.140:40448"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.12","port":54174},"server":{"ip":"10.106.43.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":4,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"b73af599-4735-4d65-acc5-31211d8cac4e-627","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:46.693Z","_id":"b73af599-4735-4d65-acc5-31211d8cac4e-629","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.12","port":54174},"server":{"ip":"10.106.43.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":5,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"b73af599-4735-4d65-acc5-31211d8cac4e-630","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:46.701Z","_id":"b73af599-4735-4d65-acc5-31211d8cac4e-632","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.12","port":54174},"server":{"ip":"10.106.43.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":6,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["ds-cfg-time-limit","ds-cfg-default-password-policy","ds-cfg-etime-resolution","ds-cfg-allowed-task","ds-cfg-invalid-attribute-syntax-behavior","ds-cfg-max-psearches","ds-cfg-group-id","ds-cfg-check-schema","ds-cfg-add-missing-rdn-attributes","ds-cfg-max-candidate-set-size","ds-cfg-max-internal-buffer-size","ds-cfg-restricted-client","ds-cfg-single-structural-objectclass-behavior","ds-cfg-size-limit","ds-cfg-trust-transaction-ids","ds-cfg-proxy-protocol-enabled","ds-cfg-subordinate-base-dn","ds-cfg-denied-client","ds-cfg-bind-with-dn-requires-password","ds-cfg-advertised-listen-address","ds-cfg-allowed-client","ds-cfg-server-id","ds-cfg-max-allowed-client-connections","ds-cfg-listen-address","ds-cfg-writability-mode","ds-cfg-save-config-on-successful-startup","ds-cfg-proxy-protocol-allowed-client","ds-cfg-disabled-privilege","ds-cfg-return-bind-error-messages","ds-cfg-je-backend-shared-cache-enabled","ds-cfg-unauthenticated-requests-policy","ds-cfg-idle-time-limit","ds-cfg-proxied-authorization-identity-mapper","ds-cfg-restricted-client-connection-limit","ds-cfg-group-id-failover-order","ds-cfg-notify-abandoned-operations","ds-cfg-allow-attribute-name-exceptions"]},"transactionId":"b73af599-4735-4d65-acc5-31211d8cac4e-633","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:46.706Z","_id":"b73af599-4735-4d65-acc5-31211d8cac4e-635","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.12","port":54174},"server":{"ip":"10.106.43.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":8,"dn":"cn=Default Password Policy,cn=Password Policies,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"b73af599-4735-4d65-acc5-31211d8cac4e-637","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:46.727Z","_id":"b73af599-4735-4d65-acc5-31211d8cac4e-639","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.12","port":54174},"server":{"ip":"10.106.43.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":9,"dn":"cn=Default Password Policy,cn=Password Policies,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"b73af599-4735-4d65-acc5-31211d8cac4e-640","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:46.729Z","_id":"b73af599-4735-4d65-acc5-31211d8cac4e-642","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.12","port":54174},"server":{"ip":"10.106.43.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":10,"dn":"cn=Default Password Policy,cn=Password Policies,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["ds-cfg-java-class","ds-cfg-min-password-age","ds-cfg-require-change-by-time","ds-cfg-password-validator","ds-cfg-password-generator","ds-cfg-password-history-count","ds-cfg-default-password-storage-scheme","ds-cfg-allow-expired-password-changes","ds-cfg-lockout-duration","ds-cfg-allow-pre-encoded-passwords","ds-cfg-password-change-requires-current-password","ds-cfg-allow-multiple-password-values","ds-cfg-max-password-reset-age","ds-cfg-skip-validation-for-administrators","ds-cfg-last-login-time-attribute","ds-cfg-require-secure-password-changes","ds-cfg-require-secure-authentication","ds-cfg-state-update-failure-policy","ds-cfg-grace-login-count","ds-cfg-lockout-failure-expiration-interval","ds-cfg-password-expiration-warning-interval","ds-cfg-allow-user-password-changes","ds-cfg-force-change-on-reset","ds-cfg-lockout-failure-count","ds-cfg-password-history-duration","ds-cfg-expire-passwords-without-warning","ds-cfg-max-password-age","ds-cfg-last-login-time-format","ds-cfg-previous-last-login-time-format","ds-cfg-deprecated-password-storage-scheme","ds-cfg-account-status-notification-handler","ds-cfg-idle-lockout-interval","ds-cfg-password-attribute","ds-cfg-force-change-on-add"]},"transactionId":"b73af599-4735-4d65-acc5-31211d8cac4e-643","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:46.732Z","_id":"b73af599-4735-4d65-acc5-31211d8cac4e-645","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.12","port":54174},"server":{"ip":"10.106.43.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":12,"dn":"cn=Exact Match,cn=Identity Mappers,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"b73af599-4735-4d65-acc5-31211d8cac4e-647","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:46.739Z","_id":"b73af599-4735-4d65-acc5-31211d8cac4e-649","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.12","port":54174},"server":{"ip":"10.106.43.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":13,"dn":"cn=Exact Match,cn=Identity Mappers,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"b73af599-4735-4d65-acc5-31211d8cac4e-650","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:46.741Z","_id":"b73af599-4735-4d65-acc5-31211d8cac4e-652","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.12","port":54174},"server":{"ip":"10.106.43.12","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":14,"dn":"cn=Exact Match,cn=Identity Mappers,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["ds-cfg-java-class","ds-cfg-match-base-dn","ds-cfg-match-attribute","ds-cfg-enabled"]},"transactionId":"b73af599-4735-4d65-acc5-31211d8cac4e-653","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:46.744Z","_id":"b73af599-4735-4d65-acc5-31211d8cac4e-655","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.12","port":54174},"server":{"ip":"10.106.43.12","port":4444},"request":{"protocol":"LDAPS","operation":"MODIFY","connId":7,"msgId":15,"dn":"cn=config"},"transactionId":"b73af599-4735-4d65-acc5-31211d8cac4e-656","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":33,"elapsedTimeUnits":"MILLISECONDS"},"userId":"uid=admin","timestamp":"2023-08-12T14:29:46.782Z","_id":"b73af599-4735-4d65-acc5-31211d8cac4e-658","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.12","port":39304},"server":{"ip":"10.106.43.12","port":1389},"request":{"protocol":"LDAP","operation":"SEARCH","connId":8,"msgId":3,"dn":"cn=Filtering Criteria,cn=Console LDAP Access Logger,cn=Loggers,cn=config","scope":"sub","filter":"(objectClass=*)","attrs":["ALL"]},"transactionId":"b73af599-4735-4d65-acc5-31211d8cac4e-670","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":7},"userId":"uid=admin","timestamp":"2023-08-12T14:29:52.142Z","_id":"b73af599-4735-4d65-acc5-31211d8cac4e-672","source":"audit","topic":"ldap-access","level":"INFO"} --- stderr --- Defaulted container "ds" out of: ds, initialize (init) - Looking for string "heart" - Looking for string "publish" ---------------- Pod ds-cts-2 ---------------- [loop_until]: kubectl --namespace=xlou logs ds-cts-2 [loop_until]: (max_time=180, interval=5, expected_rc=[0] [loop_until]: OK (rc = 0) --- stdout --- Initializing "data/changelogDb" from Docker image Initializing "data/import-tmp" from Docker image Upgrading configuration and data... * OpenDJ data has already been upgraded to version 7.4.0.e46808a022da759ebe0ee43bf6f422fe91a4e54b Rebuilding degraded indexes for base DN "ou=tokens"... Server configured with: Group ID : default Server ID : ds-cts-2 Advertised listen address : ds-cts-2.ds-cts.xlou.svc.cluster.local Bootstrap replication server(s) : ds-cts-0.ds-cts.xlou.svc.cluster.local:8989,ds-cts-1.ds-cts.xlou.svc.cluster.local:8989 {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:51.706Z","category":"JVM","severity":"NOTICE","msgId":134,"message":"ForgeRock Directory Services 7.4.0-20230804090409-e46808a022da759ebe0ee43bf6f422fe91a4e54b (build 20230804100405, revision number e46808a022da759ebe0ee43bf6f422fe91a4e54b) starting up"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:51.706Z","category":"JVM","severity":"NOTICE","msgId":21,"message":"Installation Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:51.706Z","category":"JVM","severity":"NOTICE","msgId":23,"message":"Instance Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:51.706Z","category":"JVM","severity":"NOTICE","msgId":17,"message":"JVM Information: 17.0.8+7-LTS by Azul Systems, Inc., 64-bit architecture, 11274289152 bytes heap size"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:51.706Z","category":"JVM","severity":"NOTICE","msgId":20,"message":"JVM Host: ds-cts-2.ds-cts.xlou.svc.cluster.local default/ds-cts-2, running Linux 5.10.162+ amd64, unknown physical memory size, number of processors available 16"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:51.706Z","category":"JVM","severity":"NOTICE","msgId":19,"message":"JVM Arguments: \"-XX:+UseG1GC\", \"-XX:MaxRAMPercentage=75\", \"-XX:MaxTenuringThreshold=1\", \"-Djava.security.egd=file:/dev/urandom\", \"-Dorg.opends.server.scriptName=start-ds\""} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:51.906Z","category":"CORE","severity":"WARNING","msgId":779,"message":"'External Access Log Publisher' is DEPRECATED for removal since 7.2.0. Its usage is highly discouraged."} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:52.307Z","category":"BACKEND","severity":"NOTICE","msgId":513,"message":"The database backend amCts containing 5 entries has started"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:52.707Z","category":"SYNC.PURGE","severity":"INFORMATION","msgId":394,"message":"The purge delay has been set to: 12 h"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:52.707Z","category":"SYNC.LIFECYCLE","severity":"NOTICE","msgId":204,"message":"Replication server RS(ds-cts-2) started listening for new connections on address 0.0.0.0 port 8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:52.908Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":205,"message":"Replication server RS(ds-cts-2) has connected to replication server RS(ds-cts-1) for domain \"uid=monitor\" at ds-cts-1.ds-cts.xlou.svc.cluster.local/10.106.43.12:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:52.908Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":205,"message":"Replication server RS(ds-cts-2) has connected to replication server RS(ds-cts-0) for domain \"uid=monitor\" at ds-cts-0.ds-cts.xlou.svc.cluster.local/10.106.42.12:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:52.908Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":206,"message":"Replication server RS(ds-cts-2) has accepted a connection from replication server RS(ds-cts-0) for domain \"ou=tokens\" at /10.106.42.12:53856"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":205,"message":"Replication server RS(ds-cts-2) has connected to replication server RS(ds-cts-1) for domain \"ou=tokens\" at ds-cts-1.ds-cts.xlou.svc.cluster.local/10.106.43.12:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":207,"message":"Replication server RS(ds-cts-2) has accepted a connection from directory server DS(ds-cts-2) for domain \"uid=monitor\" at /10.106.42.140:58760"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"SYNC.CONNECTIONS","severity":"NOTICE","msgId":62,"message":"Directory server DS(ds-cts-2) has connected to replication server RS(ds-cts-2) for domain \"uid=monitor\" at 10.106.42.140:8989 with generation ID 48"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"SYNC.STATE","severity":"NOTICE","msgId":388,"message":"Directory server DS(ds-cts-2) did not find a generation ID for domain 'ou=tokens'. A new generation ID will be computed by exporting the first 5 entries in the domain."} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"BACKEND","severity":"NOTICE","msgId":515,"message":"Exported 5 entries and skipped 0 in 0 seconds (average rate 416.7/sec)"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"SYNC.CONNECTIONS","severity":"INFORMATION","msgId":207,"message":"Replication server RS(ds-cts-2) has accepted a connection from directory server DS(ds-cts-2) for domain \"ou=tokens\" at /10.106.42.140:58776"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"SYNC.CONNECTIONS","severity":"NOTICE","msgId":62,"message":"Directory server DS(ds-cts-2) has connected to replication server RS(ds-cts-2) for domain \"ou=tokens\" at 10.106.42.140:8989 with generation ID 69125"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"CORE","severity":"NOTICE","msgId":818,"message":"Registered 0 static groups, 0 dynamic groups and 0 virtual static groups. The static group cache is using 0 bytes of memory"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"PROTOCOL.LDAP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on Administration Connector 0.0.0.0:4444"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"PROTOCOL.LDAP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on LDAP 0.0.0.0:1389"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"PROTOCOL.HTTP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on HTTP 0.0.0.0:8080"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"PROTOCOL.HTTP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on HTTPS 0.0.0.0:8443"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"PROTOCOL.LDAP","severity":"NOTICE","msgId":276,"message":"Started listening for new connections on LDAPS 0.0.0.0:1636"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"CORE","severity":"NOTICE","msgId":135,"message":"The Directory Server has started successfully"} {"eventName":"DJ-SERVER","timestamp":"2023-08-12T13:47:53.108Z","category":"CORE","severity":"NOTICE","msgId":139,"message":"The Directory Server has sent an alert notification generated by class org.opends.server.core.DirectoryServer (alert type org.opends.server.DirectoryServerStarted, alert ID org.opends.messages.core-135): The Directory Server has started successfully"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.140","port":45410},"server":{"ip":"10.106.42.140","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":4,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-393","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:48.697Z","_id":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-395","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.140","port":45410},"server":{"ip":"10.106.42.140","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":5,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-396","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:48.704Z","_id":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-398","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.140","port":45410},"server":{"ip":"10.106.42.140","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":6,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["ds-cfg-time-limit","ds-cfg-default-password-policy","ds-cfg-etime-resolution","ds-cfg-allowed-task","ds-cfg-invalid-attribute-syntax-behavior","ds-cfg-max-psearches","ds-cfg-group-id","ds-cfg-check-schema","ds-cfg-add-missing-rdn-attributes","ds-cfg-max-candidate-set-size","ds-cfg-max-internal-buffer-size","ds-cfg-restricted-client","ds-cfg-single-structural-objectclass-behavior","ds-cfg-size-limit","ds-cfg-trust-transaction-ids","ds-cfg-proxy-protocol-enabled","ds-cfg-subordinate-base-dn","ds-cfg-denied-client","ds-cfg-bind-with-dn-requires-password","ds-cfg-advertised-listen-address","ds-cfg-allowed-client","ds-cfg-server-id","ds-cfg-max-allowed-client-connections","ds-cfg-listen-address","ds-cfg-writability-mode","ds-cfg-save-config-on-successful-startup","ds-cfg-proxy-protocol-allowed-client","ds-cfg-disabled-privilege","ds-cfg-return-bind-error-messages","ds-cfg-je-backend-shared-cache-enabled","ds-cfg-unauthenticated-requests-policy","ds-cfg-idle-time-limit","ds-cfg-proxied-authorization-identity-mapper","ds-cfg-restricted-client-connection-limit","ds-cfg-group-id-failover-order","ds-cfg-notify-abandoned-operations","ds-cfg-allow-attribute-name-exceptions"]},"transactionId":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-399","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:48.709Z","_id":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-401","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.140","port":45410},"server":{"ip":"10.106.42.140","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":8,"dn":"cn=Default Password Policy,cn=Password Policies,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-403","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:48.729Z","_id":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-405","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.140","port":45410},"server":{"ip":"10.106.42.140","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":9,"dn":"cn=Default Password Policy,cn=Password Policies,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-406","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:48.731Z","_id":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-408","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.140","port":45410},"server":{"ip":"10.106.42.140","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":10,"dn":"cn=Default Password Policy,cn=Password Policies,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["ds-cfg-java-class","ds-cfg-min-password-age","ds-cfg-require-change-by-time","ds-cfg-password-validator","ds-cfg-password-generator","ds-cfg-password-history-count","ds-cfg-default-password-storage-scheme","ds-cfg-allow-expired-password-changes","ds-cfg-lockout-duration","ds-cfg-allow-pre-encoded-passwords","ds-cfg-password-change-requires-current-password","ds-cfg-allow-multiple-password-values","ds-cfg-max-password-reset-age","ds-cfg-skip-validation-for-administrators","ds-cfg-last-login-time-attribute","ds-cfg-require-secure-password-changes","ds-cfg-require-secure-authentication","ds-cfg-state-update-failure-policy","ds-cfg-grace-login-count","ds-cfg-lockout-failure-expiration-interval","ds-cfg-password-expiration-warning-interval","ds-cfg-allow-user-password-changes","ds-cfg-force-change-on-reset","ds-cfg-lockout-failure-count","ds-cfg-password-history-duration","ds-cfg-expire-passwords-without-warning","ds-cfg-max-password-age","ds-cfg-last-login-time-format","ds-cfg-previous-last-login-time-format","ds-cfg-deprecated-password-storage-scheme","ds-cfg-account-status-notification-handler","ds-cfg-idle-lockout-interval","ds-cfg-password-attribute","ds-cfg-force-change-on-add"]},"transactionId":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-409","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:48.733Z","_id":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-411","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.140","port":45410},"server":{"ip":"10.106.42.140","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":12,"dn":"cn=Exact Match,cn=Identity Mappers,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-413","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:48.740Z","_id":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-415","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.140","port":45410},"server":{"ip":"10.106.42.140","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":13,"dn":"cn=Exact Match,cn=Identity Mappers,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-416","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:48.741Z","_id":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-418","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.140","port":45410},"server":{"ip":"10.106.42.140","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":7,"msgId":14,"dn":"cn=Exact Match,cn=Identity Mappers,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["ds-cfg-java-class","ds-cfg-match-base-dn","ds-cfg-match-attribute","ds-cfg-enabled"]},"transactionId":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-419","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-12T14:29:48.743Z","_id":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-421","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.140","port":45410},"server":{"ip":"10.106.42.140","port":4444},"request":{"protocol":"LDAPS","operation":"MODIFY","connId":7,"msgId":15,"dn":"cn=config"},"transactionId":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-422","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":34,"elapsedTimeUnits":"MILLISECONDS"},"userId":"uid=admin","timestamp":"2023-08-12T14:29:48.782Z","_id":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-424","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.140","port":59908},"server":{"ip":"10.106.42.140","port":1389},"request":{"protocol":"LDAP","operation":"SEARCH","connId":8,"msgId":3,"dn":"cn=Filtering Criteria,cn=Console LDAP Access Logger,cn=Loggers,cn=config","scope":"sub","filter":"(objectClass=*)","attrs":["ALL"]},"transactionId":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-430","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":7},"userId":"uid=admin","timestamp":"2023-08-12T14:29:53.767Z","_id":"0fe474d6-1cc3-46e5-bb26-d15bbeaec4aa-432","source":"audit","topic":"ldap-access","level":"INFO"} --- stderr --- Defaulted container "ds" out of: ds, initialize (init) - Looking for string "heart" - Looking for string "publish" ________________________________________________________________________________ [12/Aug/2023 14:34:49] CheckReplication_ds-cts step5 : Compare ds-sync-state for suffixes across all replicas ________________________________________________________________________________ [run_command]: kubectl --namespace=xlou exec ds-cts-0 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "QPvBZVHWObekI0iJPLbNDrTOLDzxA6ZL" --baseDn " " --searchScope base "objectclass=*" namingContexts [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- dn: namingContexts: uid=admin namingContexts: ou=tokens namingContexts: uid=monitor namingContexts: uid=proxy --- stderr --- => Using namingContexts: {'ou=tokens', 'uid=proxy'} [run_command]: kubectl --namespace=xlou exec ds-cts-0 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "QPvBZVHWObekI0iJPLbNDrTOLDzxA6ZL" --baseDn "ou=tokens" --searchScope base "objectclass=*" ds-sync-state [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- dn: ou=tokens ds-sync-state: 01080189ea2b767200001632ds-cts-0 ds-sync-state: 01080189ea2b74c300001603ds-cts-1 --- stderr --- [run_command]: kubectl --namespace=xlou exec ds-cts-1 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "QPvBZVHWObekI0iJPLbNDrTOLDzxA6ZL" --baseDn "ou=tokens" --searchScope base "objectclass=*" ds-sync-state [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- dn: ou=tokens ds-sync-state: 01080189ea2b74c300001603ds-cts-1 ds-sync-state: 01080189ea2b767200001632ds-cts-0 --- stderr --- [run_command]: kubectl --namespace=xlou exec ds-cts-2 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "QPvBZVHWObekI0iJPLbNDrTOLDzxA6ZL" --baseDn "ou=tokens" --searchScope base "objectclass=*" ds-sync-state [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- dn: ou=tokens ds-sync-state: 01080189ea2b74c300001603ds-cts-1 ds-sync-state: 01080189ea2b767200001632ds-cts-0 --- stderr --- [run_command]: kubectl --namespace=xlou exec ds-cts-0 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "QPvBZVHWObekI0iJPLbNDrTOLDzxA6ZL" --baseDn "uid=proxy" --searchScope base "objectclass=*" ds-sync-state [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- dn: uid=proxy --- stderr --- => Skipping suffix "uid=proxy" as "ds-sync-state" not found in stdout => loop 1 out of 30 : repl_state = {'ou=tokens': {'ds-cts-0': ['01080189ea2b767200001632ds-cts-0', '01080189ea2b74c300001603ds-cts-1'], 'ds-cts-1': ['01080189ea2b74c300001603ds-cts-1', '01080189ea2b767200001632ds-cts-0'], 'ds-cts-2': ['01080189ea2b74c300001603ds-cts-1', '01080189ea2b767200001632ds-cts-0']}} => ds-sync-state match for "ou=tokens" => {'ou=tokens', 'uid=proxy'} expunged. set() remain SUCCESS: replication seems to be synchronised ________________________________________________________________________________ [12/Aug/2023 14:34:57] CheckReplication_ds-cts step6 : Check replication is in sync by adding once and searching all ________________________________________________________________________________ [loop_until]: kubectl --namespace=xlou cp /tmp/tmp_0zatndg --container ds ds-cts-0:/tmp/entries.ldif [loop_until]: (max_time=180, interval=5, expected_rc=[0] [loop_until]: OK (rc = 0) --- stdout --- --- stderr --- [loop_until]: kubectl --namespace=xlou exec ds-cts-0 --container ds -- ldapmodify --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "QPvBZVHWObekI0iJPLbNDrTOLDzxA6ZL" /tmp/entries.ldif [loop_until]: (max_time=180, interval=5, expected_rc=[0] [loop_until]: OK (rc = 0) --- stdout --- # ADD operation successful for DN uid=pyrock_bbgot,ou=tokens --- stderr --- => Added test entry with dn "uid=pyrock_bbgot,ou=tokens" => loop 1 out of 5 to check "3" pods for presence of test entry "uid=pyrock_bbgot,ou=tokens" [run_command]: kubectl --namespace=xlou exec ds-cts-0 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "QPvBZVHWObekI0iJPLbNDrTOLDzxA6ZL" --baseDn "uid=pyrock_bbgot,ou=tokens" --searchScope base objectclass=* 1.1 [run_command]: OK (rc = 0 - expected to be in [0, 32]) --- stdout --- dn: uid=pyrock_bbgot,ou=tokens --- stderr --- => Found test entry "uid=pyrock_bbgot,ou=tokens" on "ds-cts-0" [run_command]: kubectl --namespace=xlou exec ds-cts-1 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "QPvBZVHWObekI0iJPLbNDrTOLDzxA6ZL" --baseDn "uid=pyrock_bbgot,ou=tokens" --searchScope base objectclass=* 1.1 [run_command]: OK (rc = 0 - expected to be in [0, 32]) --- stdout --- dn: uid=pyrock_bbgot,ou=tokens --- stderr --- => Found test entry "uid=pyrock_bbgot,ou=tokens" on "ds-cts-1" [run_command]: kubectl --namespace=xlou exec ds-cts-2 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "QPvBZVHWObekI0iJPLbNDrTOLDzxA6ZL" --baseDn "uid=pyrock_bbgot,ou=tokens" --searchScope base objectclass=* 1.1 [run_command]: OK (rc = 0 - expected to be in [0, 32]) --- stdout --- dn: uid=pyrock_bbgot,ou=tokens --- stderr --- => Found test entry "uid=pyrock_bbgot,ou=tokens" on "ds-cts-2" [loop_until]: kubectl --namespace=xlou exec ds-cts-0 --container ds -- ldapdelete --port 4444 --useSsl --trustAll --bindDn "uid=admin" --bindPassword "QPvBZVHWObekI0iJPLbNDrTOLDzxA6ZL" uid=pyrock_bbgot,ou=tokens [loop_until]: (max_time=180, interval=5, expected_rc=[0] [loop_until]: OK (rc = 0) --- stdout --- # DELETE operation successful for DN uid=pyrock_bbgot,ou=tokens --- stderr --- => Deleted test entry with dn "uid=pyrock_bbgot,ou=tokens" SUCCESS: replication seems to be synchronised ________________________________________________________________________________ [12/Aug/2023 14:35:17] CheckReplication_ds-cts post : N/A ________________________________________________________________________________ SUCCESS : replication seems to be synchronised Setting result to PASS Task has been successfully stopped