--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 ________________________________________________________________________________ [13/Aug/2023 01:02:46] CheckReplication_ds-cts pre : N/A ________________________________________________________________________________ max_time: 1h 59m sleep_interval: 10 [13/Aug/2023 01:02:46] - INFO: Timeout for this Task has changed to 4h (14400 seconds) [13/Aug/2023 01:02:46] - INFO: timeout was set to Task default (2x global_duration or 300 seconds (whatever is higher)), because it was unset ________________________________________________________________________________ [13/Aug/2023 01:02:46] 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 ________________________________________________________________________________ [13/Aug/2023 01:03:06] 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 ________________________________________________________________________________ [13/Aug/2023 01:03:11] 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 "iDO4jfjwcD1B0lpvgy2LanUPQjw3Y27W" --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.15:8989 ds-mon-connected-to-server-id: ds-cts-0 ds-mon-current-receive-window: 2147483638 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":50.663,"mean_rate":0.004,"m1_rate":0.099,"m5_rate":0.029,"m15_rate":0.011,"mean":4.222,"min":1.860,"max":7.078,"stddev":1.530,"p50":3.768,"p75":4.653,"p95":7.078,"p98":7.078,"p99":7.078,"p999":7.078,"p9999":7.078,"p99999":7.078} 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: 01080189ec6accc7000016a9ds-cts-1 ds-mon-server-state: 01080189ec6ad33d00001677ds-cts-2 ds-mon-server-state: 01080189ec6aca64000016d8ds-cts-0 ds-mon-ssl-encryption: true ds-mon-status: Normal ds-mon-status-last-changed: 20230813001407.873Z 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, 1, 0, 0, 0, 1, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 3, 0, 0, 0, 1, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 2, 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":6,"total":26.827,"mean_rate":0.007,"m1_rate":0.057,"m5_rate":0.027,"m15_rate":0.082,"mean":4.470,"min":1.860,"max":7.078,"stddev":2.086,"p50":3.768,"p75":6.586,"p95":7.078,"p98":7.078,"p99":7.078,"p999":7.078,"p9999":7.078,"p99999":7.078} 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":6,"total":23.836,"mean_rate":0.013,"m1_rate":0.048,"m5_rate":0.100,"m15_rate":0.246,"mean":3.973,"min":3.375,"max":4.653,"stddev":0.452,"p50":3.719,"p75":4.489,"p95":4.653,"p98":4.653,"p99":4.653,"p999":4.653,"p9999":4.653,"p99999":4.653} 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.15: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: 20230813001407.805Z 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, 1, 0, 0, 0, 1, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 3, 0, 0, 0, 1, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 2, 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 "iDO4jfjwcD1B0lpvgy2LanUPQjw3Y27W" --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.15:8989 ds-mon-connected-to-server-id: ds-cts-1 ds-mon-current-receive-window: 2147483641 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":14,"total":80.566,"mean_rate":0.005,"m1_rate":0.069,"m5_rate":0.021,"m15_rate":0.010,"mean":5.751,"min":2.245,"max":20.185,"stddev":4.734,"p50":4.489,"p75":4.882,"p95":20.185,"p98":20.185,"p99":20.185,"p999":20.185,"p9999":20.185,"p99999":20.185} ds-mon-replayed-updates-conflicts-resolved: 0 ds-mon-replayed-updates-conflicts-unresolved: 0 ds-mon-sent-updates: 6 ds-mon-server-id: ds-cts-1 ds-mon-server-state: 01080189ec6ad33d00001677ds-cts-2 ds-mon-server-state: 01080189ec6aca64000016d8ds-cts-0 ds-mon-server-state: 01080189ec6accc7000016a9ds-cts-1 ds-mon-ssl-encryption: true ds-mon-status: Normal ds-mon-status-last-changed: 20230813001431.507Z 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, 1, 0, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 3, 0, 0, 0, 1, 0, 0, 0, 1, 0, 0, 1, 0, 2, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 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":57.614,"mean_rate":0.004,"m1_rate":0.023,"m5_rate":0.008,"m15_rate":0.059,"mean":7.194,"min":2.490,"max":20.185,"stddev":5.818,"p50":4.653,"p75":5.014,"p95":20.185,"p98":20.185,"p99":20.185,"p999":20.185,"p9999":20.185,"p99999":20.185} 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":6,"total":22.952,"mean_rate":0.013,"m1_rate":0.044,"m5_rate":0.099,"m15_rate":0.244,"mean":3.827,"min":2.245,"max":4.588,"stddev":0.821,"p50":3.670,"p75":4.522,"p95":4.588,"p98":4.588,"p99":4.588,"p999":4.588,"p9999":4.588,"p99999":4.588} 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.42.15: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: 20230813001431.408Z 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, 1, 0, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 3, 0, 0, 0, 1, 0, 0, 0, 1, 0, 0, 1, 0, 2, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 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 "iDO4jfjwcD1B0lpvgy2LanUPQjw3Y27W" --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.143:8989 ds-mon-connected-to-server-id: ds-cts-2 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":14,"total":81.219,"mean_rate":0.005,"m1_rate":0.078,"m5_rate":0.023,"m15_rate":0.010,"mean":5.798,"min":1.532,"max":15.991,"stddev":3.971,"p50":5.112,"p75":6.685,"p95":15.991,"p98":15.991,"p99":15.991,"p999":15.991,"p9999":15.991,"p99999":15.991} ds-mon-replayed-updates-conflicts-resolved: 0 ds-mon-replayed-updates-conflicts-unresolved: 0 ds-mon-sent-updates: 6 ds-mon-server-id: ds-cts-2 ds-mon-server-state: 01080189ec6ad33d00001677ds-cts-2 ds-mon-server-state: 01080189ec6accc7000016a9ds-cts-1 ds-mon-server-state: 01080189ec6aca64000016d8ds-cts-0 ds-mon-ssl-encryption: true ds-mon-status: Normal ds-mon-status-last-changed: 20230813001457.980Z 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, 3, 0, 0, 0, 1, 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, 0, 0, 0, 0, 0, 1, 0, 2, 0, 2, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 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":58.553,"mean_rate":0.004,"m1_rate":0.021,"m5_rate":0.008,"m15_rate":0.058,"mean":7.315,"min":3.080,"max":15.991,"stddev":4.430,"p50":5.210,"p75":6.685,"p95":15.991,"p98":15.991,"p99":15.991,"p999":15.991,"p9999":15.991,"p99999":15.991} 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":6,"total":22.666,"mean_rate":0.007,"m1_rate":0.057,"m5_rate":0.027,"m15_rate":0.082,"mean":3.774,"min":1.532,"max":6.849,"stddev":1.859,"p50":3.408,"p75":5.308,"p95":6.849,"p98":6.849,"p99":6.849,"p999":6.849,"p9999":6.849,"p99999":6.849} 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.143: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: 20230813001457.890Z 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, 3, 0, 0, 0, 1, 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, 0, 0, 0, 0, 0, 1, 0, 2, 0, 2, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, 0] --- stderr --- ________________________________________________________________________________ [13/Aug/2023 01:03:16] 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-13T00:14:06.381Z","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-13T00:14:06.381Z","category":"JVM","severity":"NOTICE","msgId":21,"message":"Installation Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:06.381Z","category":"JVM","severity":"NOTICE","msgId":23,"message":"Instance Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:06.381Z","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-13T00:14:06.381Z","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-13T00:14:06.381Z","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-13T00:14:06.581Z","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-13T00:14:07.185Z","category":"BACKEND","severity":"NOTICE","msgId":513,"message":"The database backend amCts containing 5 entries has started"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:07.586Z","category":"SYNC.PURGE","severity":"INFORMATION","msgId":394,"message":"The purge delay has been set to: 12 h"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:07.586Z","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-13T00:14:07.586Z","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-13T00:14:07.786Z","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.15:51386"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:07.786Z","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.15:8989 with generation ID 48"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:07.786Z","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-13T00:14:07.786Z","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-13T00:14:07.786Z","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.15:51402"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:07.786Z","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.15:8989 with generation ID 69125"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:07.786Z","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-13T00:14:07.786Z","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-13T00:14:07.786Z","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-13T00:14:07.786Z","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-13T00:14:07.786Z","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-13T00:14:07.786Z","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-13T00:14:07.786Z","category":"CORE","severity":"NOTICE","msgId":135,"message":"The Directory Server has started successfully"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:07.786Z","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-13T00:14:31.211Z","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.42.15:40746"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:31.412Z","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.42.15:40764"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:57.634Z","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.143:53950"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:57.834Z","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.143:8989"} {"_id":"f81b1932-b455-485e-9237-38b9630f372a-3","timestamp":"2023-08-13T00:33:09.422Z","eventName":"DJ-HTTP","transactionId":"f81b1932-b455-485e-9237-38b9630f372a-2","client":{"ip":"10.106.43.143","port":50288},"server":{"ip":"10.106.43.15","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":"f81b1932-b455-485e-9237-38b9630f372a-13","timestamp":"2023-08-13T00:48:05.633Z","eventName":"DJ-HTTP","transactionId":"f81b1932-b455-485e-9237-38b9630f372a-12","client":{"ip":"10.106.44.14","port":41784},"server":{"ip":"10.106.43.15","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":"f81b1932-b455-485e-9237-38b9630f372a-17","timestamp":"2023-08-13T00:48:05.645Z","eventName":"DJ-HTTP","transactionId":"f81b1932-b455-485e-9237-38b9630f372a-16","client":{"ip":"10.106.43.144","port":59920},"server":{"ip":"10.106.43.15","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":"f81b1932-b455-485e-9237-38b9630f372a-21","timestamp":"2023-08-13T00:48:06.037Z","eventName":"DJ-HTTP","transactionId":"f81b1932-b455-485e-9237-38b9630f372a-20","client":{"ip":"10.106.46.152","port":51172},"server":{"ip":"10.106.43.15","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.43.15","port":33566},"server":{"ip":"10.106.43.15","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":10,"msgId":4,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"f81b1932-b455-485e-9237-38b9630f372a-517","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:12.589Z","_id":"f81b1932-b455-485e-9237-38b9630f372a-519","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.15","port":33566},"server":{"ip":"10.106.43.15","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":10,"msgId":5,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"f81b1932-b455-485e-9237-38b9630f372a-520","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:12.591Z","_id":"f81b1932-b455-485e-9237-38b9630f372a-522","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.15","port":33566},"server":{"ip":"10.106.43.15","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":"f81b1932-b455-485e-9237-38b9630f372a-523","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:12.595Z","_id":"f81b1932-b455-485e-9237-38b9630f372a-525","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.15","port":33566},"server":{"ip":"10.106.43.15","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":"f81b1932-b455-485e-9237-38b9630f372a-527","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:12.617Z","_id":"f81b1932-b455-485e-9237-38b9630f372a-529","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.15","port":33566},"server":{"ip":"10.106.43.15","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":"f81b1932-b455-485e-9237-38b9630f372a-530","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:12.619Z","_id":"f81b1932-b455-485e-9237-38b9630f372a-532","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.15","port":33566},"server":{"ip":"10.106.43.15","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":"f81b1932-b455-485e-9237-38b9630f372a-533","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:12.621Z","_id":"f81b1932-b455-485e-9237-38b9630f372a-535","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.15","port":33566},"server":{"ip":"10.106.43.15","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":"f81b1932-b455-485e-9237-38b9630f372a-537","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:12.629Z","_id":"f81b1932-b455-485e-9237-38b9630f372a-539","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.15","port":33566},"server":{"ip":"10.106.43.15","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":"f81b1932-b455-485e-9237-38b9630f372a-540","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:12.631Z","_id":"f81b1932-b455-485e-9237-38b9630f372a-542","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.15","port":33566},"server":{"ip":"10.106.43.15","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":"f81b1932-b455-485e-9237-38b9630f372a-543","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:12.633Z","_id":"f81b1932-b455-485e-9237-38b9630f372a-545","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.15","port":33566},"server":{"ip":"10.106.43.15","port":4444},"request":{"protocol":"LDAPS","operation":"MODIFY","connId":10,"msgId":15,"dn":"cn=config"},"transactionId":"f81b1932-b455-485e-9237-38b9630f372a-546","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":33,"elapsedTimeUnits":"MILLISECONDS"},"userId":"uid=admin","timestamp":"2023-08-13T00:58:12.670Z","_id":"f81b1932-b455-485e-9237-38b9630f372a-548","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.43.15","port":60970},"server":{"ip":"10.106.43.15","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":"f81b1932-b455-485e-9237-38b9630f372a-552","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":7},"userId":"uid=admin","timestamp":"2023-08-13T00:58:18.353Z","_id":"f81b1932-b455-485e-9237-38b9630f372a-554","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-13T00:14:30.097Z","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-13T00:14:30.097Z","category":"JVM","severity":"NOTICE","msgId":21,"message":"Installation Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:30.097Z","category":"JVM","severity":"NOTICE","msgId":23,"message":"Instance Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:30.097Z","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-13T00:14:30.097Z","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-13T00:14:30.097Z","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-13T00:14:30.298Z","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-13T00:14:30.698Z","category":"BACKEND","severity":"NOTICE","msgId":513,"message":"The database backend amCts containing 5 entries has started"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:31.099Z","category":"SYNC.PURGE","severity":"INFORMATION","msgId":394,"message":"The purge delay has been set to: 12 h"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:31.099Z","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-13T00:14:31.299Z","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.15:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:31.299Z","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.42.15:58442"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:31.299Z","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.42.15:8989 with generation ID 48"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:31.299Z","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-13T00:14:31.299Z","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-13T00:14:31.299Z","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.15:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:31.500Z","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.42.15:58448"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:31.500Z","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.42.15:8989 with generation ID 69125"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:31.500Z","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-13T00:14:31.500Z","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-13T00:14:31.500Z","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-13T00:14:31.500Z","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-13T00:14:31.500Z","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-13T00:14:31.500Z","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-13T00:14:31.500Z","category":"CORE","severity":"NOTICE","msgId":135,"message":"The Directory Server has started successfully"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:31.500Z","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-13T00:14:57.726Z","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.143:43546"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:57.726Z","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.143:43560"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.15","port":44160},"server":{"ip":"10.106.42.15","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":4,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"48653065-a753-4837-a62b-708488c49963-651","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:14.624Z","_id":"48653065-a753-4837-a62b-708488c49963-653","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.15","port":44160},"server":{"ip":"10.106.42.15","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":5,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"48653065-a753-4837-a62b-708488c49963-654","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:14.630Z","_id":"48653065-a753-4837-a62b-708488c49963-656","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.15","port":44160},"server":{"ip":"10.106.42.15","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":"48653065-a753-4837-a62b-708488c49963-657","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:14.635Z","_id":"48653065-a753-4837-a62b-708488c49963-659","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.15","port":44160},"server":{"ip":"10.106.42.15","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":"48653065-a753-4837-a62b-708488c49963-661","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:14.654Z","_id":"48653065-a753-4837-a62b-708488c49963-663","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.15","port":44160},"server":{"ip":"10.106.42.15","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":"48653065-a753-4837-a62b-708488c49963-664","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:14.656Z","_id":"48653065-a753-4837-a62b-708488c49963-666","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.15","port":44160},"server":{"ip":"10.106.42.15","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":"48653065-a753-4837-a62b-708488c49963-667","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:14.658Z","_id":"48653065-a753-4837-a62b-708488c49963-669","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.15","port":44160},"server":{"ip":"10.106.42.15","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":"48653065-a753-4837-a62b-708488c49963-671","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:14.664Z","_id":"48653065-a753-4837-a62b-708488c49963-673","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.15","port":44160},"server":{"ip":"10.106.42.15","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":"48653065-a753-4837-a62b-708488c49963-674","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:14.666Z","_id":"48653065-a753-4837-a62b-708488c49963-676","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.15","port":44160},"server":{"ip":"10.106.42.15","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":"48653065-a753-4837-a62b-708488c49963-677","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:14.668Z","_id":"48653065-a753-4837-a62b-708488c49963-679","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.15","port":44160},"server":{"ip":"10.106.42.15","port":4444},"request":{"protocol":"LDAPS","operation":"MODIFY","connId":8,"msgId":15,"dn":"cn=config"},"transactionId":"48653065-a753-4837-a62b-708488c49963-680","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":32,"elapsedTimeUnits":"MILLISECONDS"},"userId":"uid=admin","timestamp":"2023-08-13T00:58:14.704Z","_id":"48653065-a753-4837-a62b-708488c49963-682","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.15","port":38912},"server":{"ip":"10.106.42.15","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":"48653065-a753-4837-a62b-708488c49963-686","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":7},"userId":"uid=admin","timestamp":"2023-08-13T00:58:20.053Z","_id":"48653065-a753-4837-a62b-708488c49963-688","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-13T00:14:56.454Z","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-13T00:14:56.454Z","category":"JVM","severity":"NOTICE","msgId":21,"message":"Installation Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:56.454Z","category":"JVM","severity":"NOTICE","msgId":23,"message":"Instance Directory: /opt/opendj"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:56.454Z","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-13T00:14:56.454Z","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-13T00:14:56.454Z","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-13T00:14:56.654Z","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-13T00:14:57.255Z","category":"BACKEND","severity":"NOTICE","msgId":513,"message":"The database backend amCts containing 5 entries has started"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:57.455Z","category":"SYNC.PURGE","severity":"INFORMATION","msgId":394,"message":"The purge delay has been set to: 12 h"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:57.455Z","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-13T00:14:57.656Z","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.42.15:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:57.656Z","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.15:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:57.656Z","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.15:36152"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:57.856Z","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.42.15:8989"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:57.856Z","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.143:34856"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:57.856Z","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.143:8989 with generation ID 48"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:57.856Z","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-13T00:14:57.856Z","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-13T00:14:57.856Z","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.143:34866"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:57.856Z","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.143:8989 with generation ID 69125"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:57.856Z","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-13T00:14:57.856Z","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-13T00:14:57.856Z","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-13T00:14:57.856Z","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-13T00:14:57.856Z","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-13T00:14:57.856Z","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-13T00:14:57.856Z","category":"CORE","severity":"NOTICE","msgId":135,"message":"The Directory Server has started successfully"} {"eventName":"DJ-SERVER","timestamp":"2023-08-13T00:14:57.856Z","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.143","port":34958},"server":{"ip":"10.106.42.143","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":4,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["1.1"]},"transactionId":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-456","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:16.636Z","_id":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-458","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.143","port":34958},"server":{"ip":"10.106.42.143","port":4444},"request":{"protocol":"LDAPS","operation":"SEARCH","connId":8,"msgId":5,"dn":"cn=config","scope":"base","filter":"(objectClass=*)","attrs":["objectclass"]},"transactionId":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-459","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":0,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:16.643Z","_id":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-461","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.143","port":34958},"server":{"ip":"10.106.42.143","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":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-462","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:16.648Z","_id":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-464","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.143","port":34958},"server":{"ip":"10.106.42.143","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":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-466","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:16.670Z","_id":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-468","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.143","port":34958},"server":{"ip":"10.106.42.143","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":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-469","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:16.672Z","_id":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-471","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.143","port":34958},"server":{"ip":"10.106.42.143","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":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-472","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:16.675Z","_id":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-474","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.143","port":34958},"server":{"ip":"10.106.42.143","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":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-476","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:16.681Z","_id":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-478","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.143","port":34958},"server":{"ip":"10.106.42.143","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":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-479","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:16.683Z","_id":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-481","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.143","port":34958},"server":{"ip":"10.106.42.143","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":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-482","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":1,"elapsedTimeUnits":"MILLISECONDS","nentries":1},"userId":"uid=admin","timestamp":"2023-08-13T00:58:16.685Z","_id":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-484","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.143","port":34958},"server":{"ip":"10.106.42.143","port":4444},"request":{"protocol":"LDAPS","operation":"MODIFY","connId":8,"msgId":15,"dn":"cn=config"},"transactionId":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-485","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":34,"elapsedTimeUnits":"MILLISECONDS"},"userId":"uid=admin","timestamp":"2023-08-13T00:58:16.724Z","_id":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-487","source":"audit","topic":"ldap-access","level":"INFO"} {"eventName":"DJ-LDAP","client":{"ip":"10.106.42.143","port":58108},"server":{"ip":"10.106.42.143","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":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-495","response":{"status":"SUCCESSFUL","statusCode":"0","elapsedTime":2,"elapsedTimeUnits":"MILLISECONDS","nentries":7},"userId":"uid=admin","timestamp":"2023-08-13T00:58:21.680Z","_id":"c5d8f183-60d7-499e-8a63-5c9fdf7c3d2b-497","source":"audit","topic":"ldap-access","level":"INFO"} --- stderr --- Defaulted container "ds" out of: ds, initialize (init) - Looking for string "heart" - Looking for string "publish" ________________________________________________________________________________ [13/Aug/2023 01:03:17] 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 "iDO4jfjwcD1B0lpvgy2LanUPQjw3Y27W" --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 "iDO4jfjwcD1B0lpvgy2LanUPQjw3Y27W" --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: 01080189ec6accc7000016a9ds-cts-1 ds-sync-state: 01080189ec6ad33d00001677ds-cts-2 ds-sync-state: 01080189ec6aca64000016d8ds-cts-0 --- stderr --- [run_command]: kubectl --namespace=xlou exec ds-cts-1 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "iDO4jfjwcD1B0lpvgy2LanUPQjw3Y27W" --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: 01080189ec6ad33d00001677ds-cts-2 ds-sync-state: 01080189ec6aca64000016d8ds-cts-0 ds-sync-state: 01080189ec6accc7000016a9ds-cts-1 --- stderr --- [run_command]: kubectl --namespace=xlou exec ds-cts-2 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "iDO4jfjwcD1B0lpvgy2LanUPQjw3Y27W" --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: 01080189ec6ad33d00001677ds-cts-2 ds-sync-state: 01080189ec6accc7000016a9ds-cts-1 ds-sync-state: 01080189ec6aca64000016d8ds-cts-0 --- stderr --- [run_command]: kubectl --namespace=xlou exec ds-cts-0 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "iDO4jfjwcD1B0lpvgy2LanUPQjw3Y27W" --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': ['01080189ec6accc7000016a9ds-cts-1', '01080189ec6ad33d00001677ds-cts-2', '01080189ec6aca64000016d8ds-cts-0'], 'ds-cts-1': ['01080189ec6ad33d00001677ds-cts-2', '01080189ec6aca64000016d8ds-cts-0', '01080189ec6accc7000016a9ds-cts-1'], 'ds-cts-2': ['01080189ec6ad33d00001677ds-cts-2', '01080189ec6accc7000016a9ds-cts-1', '01080189ec6aca64000016d8ds-cts-0']}} => ds-sync-state match for "ou=tokens" => {'ou=tokens', 'uid=proxy'} expunged. set() remain SUCCESS: replication seems to be synchronised ________________________________________________________________________________ [13/Aug/2023 01:03:25] CheckReplication_ds-cts step6 : Check replication is in sync by adding once and searching all ________________________________________________________________________________ [loop_until]: kubectl --namespace=xlou cp /tmp/tmphejhrqkn --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 "iDO4jfjwcD1B0lpvgy2LanUPQjw3Y27W" /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_paoqf,ou=tokens --- stderr --- => Added test entry with dn "uid=pyrock_paoqf,ou=tokens" => loop 1 out of 5 to check "3" pods for presence of test entry "uid=pyrock_paoqf,ou=tokens" [run_command]: kubectl --namespace=xlou exec ds-cts-0 --container ds -- ldapsearch --noPropertiesFile --port 1389 --useStartTls --trustAll --bindDn "uid=admin" --bindPassword "iDO4jfjwcD1B0lpvgy2LanUPQjw3Y27W" --baseDn "uid=pyrock_paoqf,ou=tokens" --searchScope base objectclass=* 1.1 [run_command]: OK (rc = 0 - expected to be in [0, 32]) --- stdout --- dn: uid=pyrock_paoqf,ou=tokens --- stderr --- => Found test entry "uid=pyrock_paoqf,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 "iDO4jfjwcD1B0lpvgy2LanUPQjw3Y27W" --baseDn "uid=pyrock_paoqf,ou=tokens" --searchScope base objectclass=* 1.1 [run_command]: OK (rc = 0 - expected to be in [0, 32]) --- stdout --- dn: uid=pyrock_paoqf,ou=tokens --- stderr --- => Found test entry "uid=pyrock_paoqf,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 "iDO4jfjwcD1B0lpvgy2LanUPQjw3Y27W" --baseDn "uid=pyrock_paoqf,ou=tokens" --searchScope base objectclass=* 1.1 [run_command]: OK (rc = 0 - expected to be in [0, 32]) --- stdout --- dn: uid=pyrock_paoqf,ou=tokens --- stderr --- => Found test entry "uid=pyrock_paoqf,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 "iDO4jfjwcD1B0lpvgy2LanUPQjw3Y27W" uid=pyrock_paoqf,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_paoqf,ou=tokens --- stderr --- => Deleted test entry with dn "uid=pyrock_paoqf,ou=tokens" SUCCESS: replication seems to be synchronised ________________________________________________________________________________ [13/Aug/2023 01:03:44] CheckReplication_ds-cts post : N/A ________________________________________________________________________________ SUCCESS : replication seems to be synchronised Setting result to PASS Task has been successfully stopped