--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 ________________________________________________________________________________ [16/Aug/2023 01:30:38] CheckReplication_ds-cts pre : N/A ________________________________________________________________________________ max_time: 3h 59m sleep_interval: 10 [16/Aug/2023 01:30:38] - INFO: Timeout for this Task has changed to 8h (28800 seconds) [16/Aug/2023 01:30:38] - INFO: timeout was set to Task default (2x global_duration or 300 seconds (whatever is higher)), because it was unset ________________________________________________________________________________ [16/Aug/2023 01:30:38] CheckReplication_ds-cts step1 : Check number of entries ________________________________________________________________________________ loop 1 : ERROR : Pod "ds-cts-0" has 10 entries but pod "ds-cts-1" has 13 entries (should have same number of entries) loop 1 : ERROR : Pod "ds-cts-0" has 10 entries but pod "ds-cts-2" has 15 entries (should have same number of entries) loop 1 : ERROR : Pod "ds-cts-1" has 13 entries but pod "ds-cts-2" has 15 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 15 entries) loop 2 : SUCCESS: Pods "ds-cts-0" and "ds-cts-2" are in sync (both have 15 entries) loop 2 : SUCCESS: Pods "ds-cts-1" and "ds-cts-2" are in sync (both have 15 entries) [check_number_of_entries] SUCCESS : replication is synchronised after 15s ________________________________________________________________________________ [16/Aug/2023 01:30:59] 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 ________________________________________________________________________________ [16/Aug/2023 01:31:03] 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 "pAiyKr3TwOXE52P460SQlo0aihI6fN2H" --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.2:8989 ds-mon-connected-to-server-id: ds-cts-0 ds-mon-current-receive-window: 2147483640 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":62.410,"mean_rate":0.004,"m1_rate":0.082,"m5_rate":0.024,"m15_rate":0.010,"mean":5.199,"min":1.851,"max":15.401,"stddev":3.358,"p50":4.047,"p75":4.784,"p95":15.401,"p98":15.401,"p99":15.401,"p999":15.401,"p9999":15.401,"p99999":15.401} ds-mon-replayed-updates-conflicts-resolved: 0 ds-mon-replayed-updates-conflicts-unresolved: 0 ds-mon-sent-updates: 7 ds-mon-server-id: ds-cts-0 ds-mon-server-state: 01080189fbf76a180000173bds-cts-1 ds-mon-server-state: 01080189fbf763250000176cds-cts-0 ds-mon-server-state: 01080189fbf75b6c000016f9ds-cts-2 ds-mon-ssl-encryption: true ds-mon-status: Normal ds-mon-status-last-changed: 20230816004046.286Z 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, 1, 0, 0, 4, 1, 0, 0, 0, 0, 0, 0, 2, 0, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 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-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":8,"total":47.573,"mean_rate":0.008,"m1_rate":0.055,"m5_rate":0.033,"m15_rate":0.147,"mean":5.944,"min":1.851,"max":15.401,"stddev":3.879,"p50":4.489,"p75":6.685,"p95":15.401,"p98":15.401,"p99":15.401,"p999":15.401,"p9999":15.401,"p99999":15.401} ds-mon-server-id: ds-cts-1 dn: ds-mon-server-id=ds-cts-2,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":4,"total":14.837,"mean_rate":0.008,"m1_rate":0.023,"m5_rate":0.083,"m15_rate":0.233,"mean":3.709,"min":2.867,"max":4.555,"stddev":0.632,"p50":3.391,"p75":4.047,"p95":4.555,"p98":4.555,"p99":4.555,"p999":4.555,"p9999":4.555,"p99999":4.555} ds-mon-server-id: ds-cts-2 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.2: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: 20230816004046.212Z 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, 1, 0, 0, 4, 1, 0, 0, 0, 0, 0, 0, 2, 0, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] --- 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 "pAiyKr3TwOXE52P460SQlo0aihI6fN2H" --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.41.130:8989 ds-mon-connected-to-server-id: ds-cts-1 ds-mon-current-receive-window: 2147483640 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":11,"total":52.912,"mean_rate":0.004,"m1_rate":0.080,"m5_rate":0.023,"m15_rate":0.009,"mean":4.815,"min":2.048,"max":14.221,"stddev":3.097,"p50":3.801,"p75":4.719,"p95":14.221,"p98":14.221,"p99":14.221,"p999":14.221,"p9999":14.221,"p99999":14.221} 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-1 ds-mon-server-state: 01080189fbf76a180000173bds-cts-1 ds-mon-server-state: 01080189fbf763250000176cds-cts-0 ds-mon-server-state: 01080189fbf75b6c000016f9ds-cts-2 ds-mon-ssl-encryption: true ds-mon-status: Normal ds-mon-status-last-changed: 20230816004112.446Z 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, 2, 0, 0, 0, 0, 0, 0, 4, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 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, 0, 2] 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":7,"total":36.241,"mean_rate":0.004,"m1_rate":0.057,"m5_rate":0.016,"m15_rate":0.056,"mean":5.184,"min":2.048,"max":14.221,"stddev":3.757,"p50":3.801,"p75":4.719,"p95":14.221,"p98":14.221,"p99":14.221,"p999":14.221,"p9999":14.221,"p99999":14.221} ds-mon-server-id: ds-cts-0 dn: ds-mon-server-id=ds-cts-2,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":4,"total":16.671,"mean_rate":0.008,"m1_rate":0.023,"m5_rate":0.083,"m15_rate":0.233,"mean":4.170,"min":3.064,"max":5.603,"stddev":1.006,"p50":3.391,"p75":4.653,"p95":5.603,"p98":5.603,"p99":5.603,"p999":5.603,"p9999":5.603,"p99999":5.603} ds-mon-server-id: ds-cts-2 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.41.130: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: 20230816004112.342Z 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, 2, 0, 0, 0, 0, 0, 0, 4, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 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, 0, 2] --- 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 "pAiyKr3TwOXE52P460SQlo0aihI6fN2H" --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.41.2:8989 ds-mon-connected-to-server-id: ds-cts-2 ds-mon-current-receive-window: 2147483637 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":15,"total":87.673,"mean_rate":0.005,"m1_rate":0.112,"m5_rate":0.031,"m15_rate":0.012,"mean":5.842,"min":1.892,"max":16.384,"stddev":4.053,"p50":4.653,"p75":6.259,"p95":16.384,"p98":16.384,"p99":16.384,"p999":16.384,"p9999":16.384,"p99999":16.384} ds-mon-replayed-updates-conflicts-resolved: 0 ds-mon-replayed-updates-conflicts-unresolved: 0 ds-mon-sent-updates: 4 ds-mon-server-id: ds-cts-2 ds-mon-server-state: 01080189fbf763250000176cds-cts-0 ds-mon-server-state: 01080189fbf75b6c000016f9ds-cts-2 ds-mon-server-state: 01080189fbf76a180000173bds-cts-1 ds-mon-ssl-encryption: true ds-mon-status: Normal ds-mon-status-last-changed: 20230816004140.844Z 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, 2, 0, 0, 0, 1, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 2, 0, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 2] 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":7,"total":33.406,"mean_rate":0.004,"m1_rate":0.057,"m5_rate":0.016,"m15_rate":0.056,"mean":4.772,"min":1.892,"max":14.025,"stddev":3.841,"p50":3.441,"p75":4.227,"p95":14.025,"p98":14.025,"p99":14.025,"p999":14.025,"p9999":14.025,"p99999":14.025} 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":8,"total":54.267,"mean_rate":0.008,"m1_rate":0.055,"m5_rate":0.033,"m15_rate":0.147,"mean":6.778,"min":2.195,"max":16.384,"stddev":4.002,"p50":5.571,"p75":6.259,"p95":16.384,"p98":16.384,"p99":16.384,"p999":16.384,"p9999":16.384,"p99999":16.384} 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.41.2: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: 20230816004140.740Z 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, 2, 0, 0, 0, 1, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 2, 0, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 2] --- stderr --- ________________________________________________________________________________ [16/Aug/2023 01:31:08] 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.f75b7e92e20bf5ea223a7345f7b07d2fa02f34a5 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-16T00:40:44.938Z","category":"JVM","severity":"NOTICE","msgId":134,"message":"ForgeRock Directory Services 7.4.0-20230811152215-f75b7e92e20bf5ea223a7345f7b07d2fa02f34a5 (build 20230811153801, revision number f75b7e92e20bf5ea223a7345f7b07d2fa02f34a5) starting up"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:40:44.938Z","category":"JVM","severity":"NOTICE","msgId":21,"message":"Installation Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:40:44.938Z","category":"JVM","severity":"NOTICE","msgId":23,"message":"Instance Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:40:44.938Z","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-16T00:40:44.938Z","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-16T00:40:44.938Z","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-16T00:40:45.138Z","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-16T00:40:45.539Z","category":"BACKEND","severity":"NOTICE","msgId":513,"message":"The database backend amCts containing 5 entries has started"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:40:45.940Z","category":"SYNC.PURGE","severity":"INFORMATION","msgId":394,"message":"The purge delay has been set to: 12 h"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:40:45.940Z","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-16T00:40:45.940Z","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-16T00:40:46.140Z","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.43.2:39562"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:40:46.140Z","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.43.2:8989 with generation ID 48"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:40:46.140Z","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-16T00:40:46.140Z","category":"BACKEND","severity":"NOTICE","msgId":515,"message":"Exported 5 entries and skipped 0 in 0 seconds (average rate 454.5/sec)"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:40:46.140Z","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.43.2:39576"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:40:46.140Z","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.43.2:8989 with generation ID 69125"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:40:46.140Z","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-16T00:40:46.140Z","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-16T00:40:46.140Z","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-16T00:40:46.340Z","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-16T00:40:46.340Z","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-16T00:40:46.340Z","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-16T00:40:46.340Z","category":"CORE","severity":"NOTICE","msgId":135,"message":"The Directory Server has started successfully"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:40:46.340Z","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-16T00:41:12.169Z","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.41.130:40106"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:12.370Z","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.41.130:40130"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:40.596Z","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.41.2:51498"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:40.596Z","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.41.2:8989"} {"_id":"4de37815-87db-4716-9e15-69b07f993be8-3","timestamp":"2023-08-16T00:59:48.883Z","eventName":"DJ-HTTP","transactionId":"4de37815-87db-4716-9e15-69b07f993be8-2","client":{"ip":"10.106.46.3","port":54698},"server":{"ip":"10.106.43.2","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":26,"elapsedTimeUnits":"MILLISECONDS"},"source":"audit","topic":"http-access","level":"INFO"} {"_id":"4de37815-87db-4716-9e15-69b07f993be8-13","timestamp":"2023-08-16T01:14:50.428Z","eventName":"DJ-HTTP","transactionId":"4de37815-87db-4716-9e15-69b07f993be8-12","client":{"ip":"10.106.44.130","port":59792},"server":{"ip":"10.106.43.2","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":"4de37815-87db-4716-9e15-69b07f993be8-17","timestamp":"2023-08-16T01:14:50.522Z","eventName":"DJ-HTTP","transactionId":"4de37815-87db-4716-9e15-69b07f993be8-16","client":{"ip":"10.106.43.131","port":37396},"server":{"ip":"10.106.43.2","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":"4de37815-87db-4716-9e15-69b07f993be8-21","timestamp":"2023-08-16T01:14:51.187Z","eventName":"DJ-HTTP","transactionId":"4de37815-87db-4716-9e15-69b07f993be8-20","client":{"ip":"10.106.46.4","port":60040},"server":{"ip":"10.106.43.2","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"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.2","port":53284},"server":{"ip":"10.106.43.2","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":10,"msgId":4,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"4de37815-87db-4716-9e15-69b07f993be8-551","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:04.590Z","_id":"4de37815-87db-4716-9e15-69b07f993be8-553","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.2","port":53284},"server":{"ip":"10.106.43.2","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":10,"msgId":5,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"4de37815-87db-4716-9e15-69b07f993be8-554","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:04.593Z","_id":"4de37815-87db-4716-9e15-69b07f993be8-556","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.2","port":53284},"server":{"ip":"10.106.43.2","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":"4de37815-87db-4716-9e15-69b07f993be8-557","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:04.598Z","_id":"4de37815-87db-4716-9e15-69b07f993be8-559","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.2","port":53284},"server":{"ip":"10.106.43.2","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":"4de37815-87db-4716-9e15-69b07f993be8-561","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:04.619Z","_id":"4de37815-87db-4716-9e15-69b07f993be8-563","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.2","port":53284},"server":{"ip":"10.106.43.2","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":"4de37815-87db-4716-9e15-69b07f993be8-564","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:04.621Z","_id":"4de37815-87db-4716-9e15-69b07f993be8-566","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.2","port":53284},"server":{"ip":"10.106.43.2","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":"4de37815-87db-4716-9e15-69b07f993be8-567","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:04.624Z","_id":"4de37815-87db-4716-9e15-69b07f993be8-569","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.2","port":53284},"server":{"ip":"10.106.43.2","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":"4de37815-87db-4716-9e15-69b07f993be8-571","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:04.631Z","_id":"4de37815-87db-4716-9e15-69b07f993be8-573","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.2","port":53284},"server":{"ip":"10.106.43.2","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":"4de37815-87db-4716-9e15-69b07f993be8-574","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:04.633Z","_id":"4de37815-87db-4716-9e15-69b07f993be8-576","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.2","port":53284},"server":{"ip":"10.106.43.2","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":"4de37815-87db-4716-9e15-69b07f993be8-577","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:04.635Z","_id":"4de37815-87db-4716-9e15-69b07f993be8-579","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.2","port":53284},"server":{"ip":"10.106.43.2","port":4444},"request":{"protocol":"LDAPS","operation":"MODIFY","connId":10,"msgId":15,"dn":"cn=config"},"transactionId":"4de37815-87db-4716-9e15-69b07f993be8-580","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":34,"elapsedTimeUnits":"MILLISECONDS"},"userId":"uid=admin","timestamp":"2023-08-16T01:26:04.673Z","_id":"4de37815-87db-4716-9e15-69b07f993be8-582","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.2","port":55844},"server":{"ip":"10.106.43.2","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":"4de37815-87db-4716-9e15-69b07f993be8-591","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":7},"userId":"uid=admin","timestamp":"2023-08-16T01:26:10.438Z","_id":"4de37815-87db-4716-9e15-69b07f993be8-593","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.f75b7e92e20bf5ea223a7345f7b07d2fa02f34a5 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-16T00:41:10.982Z","category":"JVM","severity":"NOTICE","msgId":134,"message":"ForgeRock Directory Services 7.4.0-20230811152215-f75b7e92e20bf5ea223a7345f7b07d2fa02f34a5 (build 20230811153801, revision number f75b7e92e20bf5ea223a7345f7b07d2fa02f34a5) starting up"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:10.982Z","category":"JVM","severity":"NOTICE","msgId":21,"message":"Installation Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:10.982Z","category":"JVM","severity":"NOTICE","msgId":23,"message":"Instance Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:10.982Z","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-16T00:41:10.982Z","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-16T00:41:10.982Z","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-16T00:41:11.182Z","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-16T00:41:11.583Z","category":"BACKEND","severity":"NOTICE","msgId":513,"message":"The database backend amCts containing 5 entries has started"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:11.983Z","category":"SYNC.PURGE","severity":"INFORMATION","msgId":394,"message":"The purge delay has been set to: 12 h"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:11.983Z","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-16T00:41:12.184Z","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.43.2:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:12.184Z","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.41.130:59682"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:12.184Z","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.41.130:8989 with generation ID 48"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:12.184Z","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-16T00:41:12.184Z","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-16T00:41:12.384Z","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.43.2:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:12.384Z","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.41.130:59688"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:12.384Z","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.41.130:8989 with generation ID 69125"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:12.384Z","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-16T00:41:12.384Z","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-16T00:41:12.384Z","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-16T00:41:12.384Z","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-16T00:41:12.384Z","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-16T00:41:12.384Z","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-16T00:41:12.384Z","category":"CORE","severity":"NOTICE","msgId":135,"message":"The Directory Server has started successfully"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:12.384Z","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-16T00:41:40.618Z","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.41.2:53396"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:40.618Z","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.41.2:53406"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.130","port":50334},"server":{"ip":"10.106.41.130","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":4,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"030c358f-f913-49d7-ae19-7781d476c2ef-699","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:06.706Z","_id":"030c358f-f913-49d7-ae19-7781d476c2ef-701","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.130","port":50334},"server":{"ip":"10.106.41.130","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":5,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"030c358f-f913-49d7-ae19-7781d476c2ef-702","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:06.715Z","_id":"030c358f-f913-49d7-ae19-7781d476c2ef-704","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.130","port":50334},"server":{"ip":"10.106.41.130","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"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":"030c358f-f913-49d7-ae19-7781d476c2ef-705","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:06.720Z","_id":"030c358f-f913-49d7-ae19-7781d476c2ef-707","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.130","port":50334},"server":{"ip":"10.106.41.130","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":8,"dn":"cn=Default Password Policy,cn=Password Policies,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"030c358f-f913-49d7-ae19-7781d476c2ef-709","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:06.743Z","_id":"030c358f-f913-49d7-ae19-7781d476c2ef-711","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.130","port":50334},"server":{"ip":"10.106.41.130","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":9,"dn":"cn=Default Password Policy,cn=Password Policies,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"030c358f-f913-49d7-ae19-7781d476c2ef-712","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:06.746Z","_id":"030c358f-f913-49d7-ae19-7781d476c2ef-714","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.130","port":50334},"server":{"ip":"10.106.41.130","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"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":"030c358f-f913-49d7-ae19-7781d476c2ef-715","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:06.750Z","_id":"030c358f-f913-49d7-ae19-7781d476c2ef-717","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.130","port":50334},"server":{"ip":"10.106.41.130","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":12,"dn":"cn=Exact Match,cn=Identity Mappers,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"030c358f-f913-49d7-ae19-7781d476c2ef-719","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:06.758Z","_id":"030c358f-f913-49d7-ae19-7781d476c2ef-721","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.130","port":50334},"server":{"ip":"10.106.41.130","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":13,"dn":"cn=Exact Match,cn=Identity Mappers,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"030c358f-f913-49d7-ae19-7781d476c2ef-722","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:06.761Z","_id":"030c358f-f913-49d7-ae19-7781d476c2ef-724","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.130","port":50334},"server":{"ip":"10.106.41.130","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"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":"030c358f-f913-49d7-ae19-7781d476c2ef-725","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:06.764Z","_id":"030c358f-f913-49d7-ae19-7781d476c2ef-727","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.130","port":50334},"server":{"ip":"10.106.41.130","port":4444},"request":{"protocol":"LDAPS","operation":"MODIFY","connId":8,"msgId":15,"dn":"cn=config"},"transactionId":"030c358f-f913-49d7-ae19-7781d476c2ef-728","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":44,"elapsedTimeUnits":"MILLISECONDS"},"userId":"uid=admin","timestamp":"2023-08-16T01:26:06.814Z","_id":"030c358f-f913-49d7-ae19-7781d476c2ef-730","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.130","port":45402},"server":{"ip":"10.106.41.130","port":1389},"request":{"protocol":"LDAP","operation":"SEARCH","connId":9,"msgId":3,"dn":"cn=Filtering Criteria,cn=Console LDAP Access Logger,cn=Loggers,cn=config","scope":"sub","filter":"(objectClass=*)","attrs":["ALL"]},"transactionId":"030c358f-f913-49d7-ae19-7781d476c2ef-734","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":2,"elapsedTimeUnits":"MILLISECONDS","nentries":7},"userId":"uid=admin","timestamp":"2023-08-16T01:26:12.109Z","_id":"030c358f-f913-49d7-ae19-7781d476c2ef-736","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.f75b7e92e20bf5ea223a7345f7b07d2fa02f34a5 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-16T00:41:39.302Z","category":"JVM","severity":"NOTICE","msgId":134,"message":"ForgeRock Directory Services 7.4.0-20230811152215-f75b7e92e20bf5ea223a7345f7b07d2fa02f34a5 (build 20230811153801, revision number f75b7e92e20bf5ea223a7345f7b07d2fa02f34a5) starting up"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:39.302Z","category":"JVM","severity":"NOTICE","msgId":21,"message":"Installation Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:39.302Z","category":"JVM","severity":"NOTICE","msgId":23,"message":"Instance Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:39.302Z","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-16T00:41:39.302Z","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-16T00:41:39.302Z","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-16T00:41:39.502Z","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-16T00:41:39.903Z","category":"BACKEND","severity":"NOTICE","msgId":513,"message":"The database backend amCts containing 5 entries has started"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:40.303Z","category":"SYNC.PURGE","severity":"INFORMATION","msgId":394,"message":"The purge delay has been set to: 12 h"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:40.303Z","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-16T00:41:40.504Z","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.41.130:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:40.504Z","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.43.2:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:40.504Z","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.43.2:58852"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:40.704Z","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.41.130:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:40.704Z","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.41.2:56136"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:40.704Z","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.41.2:8989 with generation ID 48"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:40.704Z","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-16T00:41:40.704Z","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-16T00:41:40.704Z","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.41.2:56148"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:40.704Z","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.41.2:8989 with generation ID 69125"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:40.704Z","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-16T00:41:40.704Z","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-16T00:41:40.704Z","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-16T00:41:40.904Z","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-16T00:41:40.904Z","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-16T00:41:40.904Z","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-16T00:41:40.904Z","category":"CORE","severity":"NOTICE","msgId":135,"message":"The Directory Server has started successfully"} {"eventName":"DJ-SERVER","timestamp":"2023-08-16T00:41:40.904Z","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.41.2","port":40736},"server":{"ip":"10.106.41.2","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":4,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"2166951d-3157-4e1e-8c95-82179297ce19-529","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:08.789Z","_id":"2166951d-3157-4e1e-8c95-82179297ce19-531","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.2","port":40736},"server":{"ip":"10.106.41.2","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":5,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"2166951d-3157-4e1e-8c95-82179297ce19-532","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:08.797Z","_id":"2166951d-3157-4e1e-8c95-82179297ce19-534","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.2","port":40736},"server":{"ip":"10.106.41.2","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"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":"2166951d-3157-4e1e-8c95-82179297ce19-535","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:08.803Z","_id":"2166951d-3157-4e1e-8c95-82179297ce19-537","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.2","port":40736},"server":{"ip":"10.106.41.2","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":8,"dn":"cn=Default Password Policy,cn=Password Policies,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"2166951d-3157-4e1e-8c95-82179297ce19-539","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:08.823Z","_id":"2166951d-3157-4e1e-8c95-82179297ce19-541","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.2","port":40736},"server":{"ip":"10.106.41.2","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":9,"dn":"cn=Default Password Policy,cn=Password Policies,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"2166951d-3157-4e1e-8c95-82179297ce19-542","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:08.825Z","_id":"2166951d-3157-4e1e-8c95-82179297ce19-544","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.2","port":40736},"server":{"ip":"10.106.41.2","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"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":"2166951d-3157-4e1e-8c95-82179297ce19-545","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:08.828Z","_id":"2166951d-3157-4e1e-8c95-82179297ce19-547","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.2","port":40736},"server":{"ip":"10.106.41.2","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":12,"dn":"cn=Exact Match,cn=Identity Mappers,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"2166951d-3157-4e1e-8c95-82179297ce19-549","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:08.834Z","_id":"2166951d-3157-4e1e-8c95-82179297ce19-551","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.2","port":40736},"server":{"ip":"10.106.41.2","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":13,"dn":"cn=Exact Match,cn=Identity Mappers,cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"2166951d-3157-4e1e-8c95-82179297ce19-552","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:08.835Z","_id":"2166951d-3157-4e1e-8c95-82179297ce19-554","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.2","port":40736},"server":{"ip":"10.106.41.2","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"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":"2166951d-3157-4e1e-8c95-82179297ce19-555","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-16T01:26:08.838Z","_id":"2166951d-3157-4e1e-8c95-82179297ce19-557","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.2","port":40736},"server":{"ip":"10.106.41.2","port":4444},"request":{"protocol":"LDAPS","operation":"MODIFY","connId":8,"msgId":15,"dn":"cn=config"},"transactionId":"2166951d-3157-4e1e-8c95-82179297ce19-558","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":34,"elapsedTimeUnits":"MILLISECONDS"},"userId":"uid=admin","timestamp":"2023-08-16T01:26:08.877Z","_id":"2166951d-3157-4e1e-8c95-82179297ce19-560","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.41.2","port":34576},"server":{"ip":"10.106.41.2","port":1389},"request":{"protocol":"LDAP","operation":"SEARCH","connId":9,"msgId":3,"dn":"cn=Filtering Criteria,cn=Console LDAP Access Logger,cn=Loggers,cn=config","scope":"sub","filter":"(objectClass=*)","attrs":["ALL"]},"transactionId":"2166951d-3157-4e1e-8c95-82179297ce19-564","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":2,"elapsedTimeUnits":"MILLISECONDS","nentries":7},"userId":"uid=admin","timestamp":"2023-08-16T01:26:13.699Z","_id":"2166951d-3157-4e1e-8c95-82179297ce19-566","source":"audit","topic":"ldap-access","level":"INFO"} --- stderr --- Defaulted container "ds" out of: ds, initialize (init) - Looking for string "heart" - Looking for string "publish" ________________________________________________________________________________ [16/Aug/2023 01:31:10] 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 "pAiyKr3TwOXE52P460SQlo0aihI6fN2H" --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 "pAiyKr3TwOXE52P460SQlo0aihI6fN2H" --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: 01080189fbf76a180000173bds-cts-1 ds-sync-state: 01080189fbf763250000176cds-cts-0 ds-sync-state: 01080189fbf75b6c000016f9ds-cts-2 --- stderr --- [run_command]: kubectl --namespace=xlou exec ds-cts-1 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "pAiyKr3TwOXE52P460SQlo0aihI6fN2H" --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: 01080189fbf76a180000173bds-cts-1 ds-sync-state: 01080189fbf763250000176cds-cts-0 ds-sync-state: 01080189fbf75b6c000016f9ds-cts-2 --- stderr --- [run_command]: kubectl --namespace=xlou exec ds-cts-2 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "pAiyKr3TwOXE52P460SQlo0aihI6fN2H" --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: 01080189fbf763250000176cds-cts-0 ds-sync-state: 01080189fbf75b6c000016f9ds-cts-2 ds-sync-state: 01080189fbf76a180000173bds-cts-1 --- stderr --- [run_command]: kubectl --namespace=xlou exec ds-cts-0 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "pAiyKr3TwOXE52P460SQlo0aihI6fN2H" --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': ['01080189fbf76a180000173bds-cts-1', '01080189fbf763250000176cds-cts-0', '01080189fbf75b6c000016f9ds-cts-2'], 'ds-cts-1': ['01080189fbf76a180000173bds-cts-1', '01080189fbf763250000176cds-cts-0', '01080189fbf75b6c000016f9ds-cts-2'], 'ds-cts-2': ['01080189fbf763250000176cds-cts-0', '01080189fbf75b6c000016f9ds-cts-2', '01080189fbf76a180000173bds-cts-1']}} => ds-sync-state match for "ou=tokens" => {'ou=tokens', 'uid=proxy'} expunged. set() remain SUCCESS: replication seems to be synchronised ________________________________________________________________________________ [16/Aug/2023 01:31:18] CheckReplication_ds-cts step6 : Check replication is in sync by adding once and searching all ________________________________________________________________________________ [loop_until]: kubectl --namespace=xlou cp /tmp/tmplpsg8ez9 --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 "pAiyKr3TwOXE52P460SQlo0aihI6fN2H" /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_smzrr,ou=tokens --- stderr --- => Added test entry with dn "uid=pyrock_smzrr,ou=tokens" => loop 1 out of 5 to check "3" pods for presence of test entry "uid=pyrock_smzrr,ou=tokens" [run_command]: kubectl --namespace=xlou exec ds-cts-0 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "pAiyKr3TwOXE52P460SQlo0aihI6fN2H" --baseDn "uid=pyrock_smzrr,ou=tokens" --searchScope base objectclass=* 1.1 [run_command]: OK (rc = 0 - expected to be in [0, 32]) --- stdout --- dn: uid=pyrock_smzrr,ou=tokens --- stderr --- => Found test entry "uid=pyrock_smzrr,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 "pAiyKr3TwOXE52P460SQlo0aihI6fN2H" --baseDn "uid=pyrock_smzrr,ou=tokens" --searchScope base objectclass=* 1.1 [run_command]: OK (rc = 0 - expected to be in [0, 32]) --- stdout --- dn: uid=pyrock_smzrr,ou=tokens --- stderr --- => Found test entry "uid=pyrock_smzrr,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 "pAiyKr3TwOXE52P460SQlo0aihI6fN2H" --baseDn "uid=pyrock_smzrr,ou=tokens" --searchScope base objectclass=* 1.1 [run_command]: OK (rc = 0 - expected to be in [0, 32]) --- stdout --- dn: uid=pyrock_smzrr,ou=tokens --- stderr --- => Found test entry "uid=pyrock_smzrr,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 "pAiyKr3TwOXE52P460SQlo0aihI6fN2H" uid=pyrock_smzrr,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_smzrr,ou=tokens --- stderr --- => Deleted test entry with dn "uid=pyrock_smzrr,ou=tokens" SUCCESS: replication seems to be synchronised ________________________________________________________________________________ [16/Aug/2023 01:31:37] CheckReplication_ds-cts post : N/A ________________________________________________________________________________ SUCCESS : replication seems to be synchronised Setting result to PASS Task has been successfully stopped