{"level":"warn","ts":"2026-10-04T01:16:03.417345Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-04T01:16:03.41744Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.5:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.5:2380","--initial-cluster=instance=https://162.253.55.5:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.5:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.5:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-10-04T01:16:03.417524Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-04T01:16:03.417537Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.5:2380"]}
{"level":"info","ts":"2026-10-04T01:16:03.417557Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-10-04T01:16:03.418324Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"]}
{"level":"info","ts":"2026-10-04T01:16:03.418429Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.5:2380"],"listen-peer-urls":["https://162.253.55.5:2380"],"advertise-client-urls":["https://162.253.55.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.5:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-10-04T01:16:03.423081Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.34727ms"}
{"level":"info","ts":"2026-10-04T01:16:03.428548Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b512f7d8ac93be25","cluster-id":"e1953d9a3e7368e5"}
{"level":"info","ts":"2026-10-04T01:16:03.42862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=()"}
{"level":"info","ts":"2026-10-04T01:16:03.42864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became follower at term 0"}
{"level":"info","ts":"2026-10-04T01:16:03.428698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b512f7d8ac93be25 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-04T01:16:03.42871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became follower at term 1"}
{"level":"info","ts":"2026-10-04T01:16:03.428759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=(13047763580426108453)"}
{"level":"warn","ts":"2026-10-04T01:16:03.434939Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-04T01:16:03.438677Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-04T01:16:03.439644Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-10-04T01:16:03.442508Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b512f7d8ac93be25","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-04T01:16:03.44272Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b512f7d8ac93be25","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-04T01:16:03.445217Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-04T01:16:03.445292Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-04T01:16:03.445326Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-04T01:16:03.445325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=(13047763580426108453)"}
{"level":"info","ts":"2026-10-04T01:16:03.445603Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e1953d9a3e7368e5","local-member-id":"b512f7d8ac93be25","added-peer-id":"b512f7d8ac93be25","added-peer-peer-urls":["https://162.253.55.5:2380"]}
{"level":"info","ts":"2026-10-04T01:16:03.448054Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-10-04T01:16:03.448417Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b512f7d8ac93be25","initial-advertise-peer-urls":["https://162.253.55.5:2380"],"listen-peer-urls":["https://162.253.55.5:2380"],"advertise-client-urls":["https://162.253.55.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-04T01:16:03.448475Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-04T01:16:03.448197Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.5:2380"}
{"level":"info","ts":"2026-10-04T01:16:03.448558Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.5:2380"}
{"level":"info","ts":"2026-10-04T01:16:03.729883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 is starting a new election at term 1"}
{"level":"info","ts":"2026-10-04T01:16:03.73002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-04T01:16:03.730073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 received MsgPreVoteResp from b512f7d8ac93be25 at term 1"}
{"level":"info","ts":"2026-10-04T01:16:03.730123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became candidate at term 2"}
{"level":"info","ts":"2026-10-04T01:16:03.730183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 received MsgVoteResp from b512f7d8ac93be25 at term 2"}
{"level":"info","ts":"2026-10-04T01:16:03.730226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became leader at term 2"}
{"level":"info","ts":"2026-10-04T01:16:03.730265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b512f7d8ac93be25 elected leader b512f7d8ac93be25 at term 2"}
{"level":"info","ts":"2026-10-04T01:16:03.731018Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T01:16:03.731756Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b512f7d8ac93be25","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.5:2379]}","request-path":"/0/members/b512f7d8ac93be25/attributes","cluster-id":"e1953d9a3e7368e5","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-04T01:16:03.731869Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-04T01:16:03.732301Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e1953d9a3e7368e5","local-member-id":"b512f7d8ac93be25","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T01:16:03.732397Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T01:16:03.732396Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-04T01:16:03.732483Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-04T01:16:03.732425Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T01:16:03.731916Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-04T01:16:03.734003Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.5:2379"}
{"level":"info","ts":"2026-10-04T01:16:03.735339Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-04T01:16:37.531437Z","caller":"traceutil/trace.go:171","msg":"trace[1083401371] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"123.536913ms","start":"2026-10-04T01:16:37.407871Z","end":"2026-10-04T01:16:37.531408Z","steps":["trace[1083401371] 'process raft request'  (duration: 123.376399ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T01:16:45.887763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.476628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-10-04T01:16:45.887848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.443767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-04T01:16:45.887887Z","caller":"traceutil/trace.go:171","msg":"trace[290199394] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:628; }","duration":"284.662133ms","start":"2026-10-04T01:16:45.603206Z","end":"2026-10-04T01:16:45.887868Z","steps":["trace[290199394] 'range keys from in-memory index tree'  (duration: 284.192212ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:16:45.887951Z","caller":"traceutil/trace.go:171","msg":"trace[1063998030] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:628; }","duration":"284.54769ms","start":"2026-10-04T01:16:45.603362Z","end":"2026-10-04T01:16:45.88791Z","steps":["trace[1063998030] 'range keys from in-memory index tree'  (duration: 284.261153ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:16:45.889456Z","caller":"traceutil/trace.go:171","msg":"trace[794352592] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"281.522297ms","start":"2026-10-04T01:16:45.607885Z","end":"2026-10-04T01:16:45.889408Z","steps":["trace[794352592] 'read index received'  (duration: 281.442685ms)","trace[794352592] 'applied index is now lower than readState.Index'  (duration: 78.692µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T01:16:45.889811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.894166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-10-04T01:16:45.889855Z","caller":"traceutil/trace.go:171","msg":"trace[381445780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:629; }","duration":"282.000118ms","start":"2026-10-04T01:16:45.607842Z","end":"2026-10-04T01:16:45.889842Z","steps":["trace[381445780] 'agreement among raft nodes before linearized reading'  (duration: 281.697041ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:16:45.890086Z","caller":"traceutil/trace.go:171","msg":"trace[1958943513] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"286.312744ms","start":"2026-10-04T01:16:45.603751Z","end":"2026-10-04T01:16:45.890064Z","steps":["trace[1958943513] 'process raft request'  (duration: 285.459093ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:16:45.902868Z","caller":"traceutil/trace.go:171","msg":"trace[2076274292] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"268.363814ms","start":"2026-10-04T01:16:45.634464Z","end":"2026-10-04T01:16:45.902828Z","steps":["trace[2076274292] 'process raft request'  (duration: 268.250231ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:18:18.629712Z","caller":"traceutil/trace.go:171","msg":"trace[933509026] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"103.617481ms","start":"2026-10-04T01:18:18.526073Z","end":"2026-10-04T01:18:18.629691Z","steps":["trace[933509026] 'process raft request'  (duration: 103.58044ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:18:18.629767Z","caller":"traceutil/trace.go:171","msg":"trace[2140649554] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"104.86848ms","start":"2026-10-04T01:18:18.524872Z","end":"2026-10-04T01:18:18.629741Z","steps":["trace[2140649554] 'process raft request'  (duration: 30.948641ms)","trace[2140649554] 'compare'  (duration: 73.568421ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T01:18:18.629962Z","caller":"traceutil/trace.go:171","msg":"trace[343543911] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"104.099272ms","start":"2026-10-04T01:18:18.525852Z","end":"2026-10-04T01:18:18.629951Z","steps":["trace[343543911] 'process raft request'  (duration: 103.756574ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:18:18.88387Z","caller":"traceutil/trace.go:171","msg":"trace[1299010593] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"275.303093ms","start":"2026-10-04T01:18:18.608544Z","end":"2026-10-04T01:18:18.883847Z","steps":["trace[1299010593] 'process raft request'  (duration: 275.075137ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T01:18:32.10244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.670779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-10-04T01:18:32.1025Z","caller":"traceutil/trace.go:171","msg":"trace[523467675] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1971; }","duration":"103.759641ms","start":"2026-10-04T01:18:31.998725Z","end":"2026-10-04T01:18:32.102485Z","steps":["trace[523467675] 'range keys from in-memory index tree'  (duration: 103.556856ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T01:18:32.102653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.590856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-10-04T01:18:32.10268Z","caller":"traceutil/trace.go:171","msg":"trace[1378202019] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1971; }","duration":"100.663418ms","start":"2026-10-04T01:18:32.002011Z","end":"2026-10-04T01:18:32.102674Z","steps":["trace[1378202019] 'range keys from in-memory index tree'  (duration: 100.264007ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T01:18:52.885128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.740925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-04T01:18:52.885243Z","caller":"traceutil/trace.go:171","msg":"trace[598699012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2101; }","duration":"100.870628ms","start":"2026-10-04T01:18:52.784354Z","end":"2026-10-04T01:18:52.885225Z","steps":["trace[598699012] 'range keys from in-memory index tree'  (duration: 100.538111ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:18:53.152598Z","caller":"traceutil/trace.go:171","msg":"trace[1180320906] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"263.436969ms","start":"2026-10-04T01:18:52.889118Z","end":"2026-10-04T01:18:53.152555Z","steps":["trace[1180320906] 'process raft request'  (duration: 263.214674ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:18:53.165315Z","caller":"traceutil/trace.go:171","msg":"trace[1392164009] linearizableReadLoop","detail":"{readStateIndex:2188; appliedIndex:2185; }","duration":"172.797444ms","start":"2026-10-04T01:18:52.992493Z","end":"2026-10-04T01:18:53.165291Z","steps":["trace[1392164009] 'read index received'  (duration: 159.837675ms)","trace[1392164009] 'applied index is now lower than readState.Index'  (duration: 12.958359ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T01:18:53.165432Z","caller":"traceutil/trace.go:171","msg":"trace[1834847306] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"275.372083ms","start":"2026-10-04T01:18:52.890048Z","end":"2026-10-04T01:18:53.16542Z","steps":["trace[1834847306] 'process raft request'  (duration: 275.038536ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T01:18:53.165615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.095501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-04T01:18:53.165736Z","caller":"traceutil/trace.go:171","msg":"trace[1614960505] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2104; }","duration":"173.281445ms","start":"2026-10-04T01:18:52.992434Z","end":"2026-10-04T01:18:53.165715Z","steps":["trace[1614960505] 'agreement among raft nodes before linearized reading'  (duration: 173.104911ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T01:18:53.165767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.700499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12380"}
{"level":"info","ts":"2026-10-04T01:18:53.165811Z","caller":"traceutil/trace.go:171","msg":"trace[1943506871] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2104; }","duration":"166.789901ms","start":"2026-10-04T01:18:52.99901Z","end":"2026-10-04T01:18:53.1658Z","steps":["trace[1943506871] 'agreement among raft nodes before linearized reading'  (duration: 166.642148ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:18:53.165976Z","caller":"traceutil/trace.go:171","msg":"trace[2064316763] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"275.896107ms","start":"2026-10-04T01:18:52.890049Z","end":"2026-10-04T01:18:53.165945Z","steps":["trace[2064316763] 'process raft request'  (duration: 275.184999ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T01:18:53.402307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.953751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-10-04T01:18:53.402484Z","caller":"traceutil/trace.go:171","msg":"trace[31750157] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2104; }","duration":"207.160815ms","start":"2026-10-04T01:18:53.195298Z","end":"2026-10-04T01:18:53.402459Z","steps":["trace[31750157] 'range keys from in-memory index tree'  (duration: 206.763435ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T01:18:53.402296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.604105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18db2ecb76c1795f\" ","response":"range_response_count:1 size:846"}
{"level":"info","ts":"2026-10-04T01:18:53.402718Z","caller":"traceutil/trace.go:171","msg":"trace[1672206387] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18db2ecb76c1795f; range_end:; response_count:1; response_revision:2104; }","duration":"187.101197ms","start":"2026-10-04T01:18:53.2156Z","end":"2026-10-04T01:18:53.402701Z","steps":["trace[1672206387] 'range keys from in-memory index tree'  (duration: 186.310588ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:20:02.378788Z","caller":"traceutil/trace.go:171","msg":"trace[664613605] transaction","detail":"{read_only:false; response_revision:2577; number_of_response:1; }","duration":"162.387238ms","start":"2026-10-04T01:20:02.216378Z","end":"2026-10-04T01:20:02.378765Z","steps":["trace[664613605] 'process raft request'  (duration: 162.255775ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:25:08.767266Z","caller":"traceutil/trace.go:171","msg":"trace[1431481011] transaction","detail":"{read_only:false; response_revision:4966; number_of_response:1; }","duration":"121.19192ms","start":"2026-10-04T01:25:08.646027Z","end":"2026-10-04T01:25:08.767219Z","steps":["trace[1431481011] 'process raft request'  (duration: 120.978425ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:25:09.012781Z","caller":"traceutil/trace.go:171","msg":"trace[842934585] transaction","detail":"{read_only:false; response_revision:4968; number_of_response:1; }","duration":"105.632361ms","start":"2026-10-04T01:25:08.907123Z","end":"2026-10-04T01:25:09.012755Z","steps":["trace[842934585] 'process raft request'  (duration: 105.450027ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:25:21.449113Z","caller":"traceutil/trace.go:171","msg":"trace[1028934325] linearizableReadLoop","detail":"{readStateIndex:5330; appliedIndex:5329; }","duration":"117.985373ms","start":"2026-10-04T01:25:21.331107Z","end":"2026-10-04T01:25:21.449092Z","steps":["trace[1028934325] 'read index received'  (duration: 117.810969ms)","trace[1028934325] 'applied index is now lower than readState.Index'  (duration: 173.294µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T01:25:21.449235Z","caller":"traceutil/trace.go:171","msg":"trace[2097052154] transaction","detail":"{read_only:false; response_revision:5132; number_of_response:1; }","duration":"186.933463ms","start":"2026-10-04T01:25:21.262292Z","end":"2026-10-04T01:25:21.449225Z","steps":["trace[2097052154] 'process raft request'  (duration: 186.661586ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T01:25:21.449458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.255831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T01:25:21.449574Z","caller":"traceutil/trace.go:171","msg":"trace[98330976] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5132; }","duration":"113.432085ms","start":"2026-10-04T01:25:21.336123Z","end":"2026-10-04T01:25:21.449555Z","steps":["trace[98330976] 'agreement among raft nodes before linearized reading'  (duration: 113.239801ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T01:25:21.450453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.328045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-10-04T01:25:21.450504Z","caller":"traceutil/trace.go:171","msg":"trace[1306424651] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5132; }","duration":"119.387246ms","start":"2026-10-04T01:25:21.331102Z","end":"2026-10-04T01:25:21.450489Z","steps":["trace[1306424651] 'agreement among raft nodes before linearized reading'  (duration: 118.633809ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:25:21.723393Z","caller":"traceutil/trace.go:171","msg":"trace[783850124] transaction","detail":"{read_only:false; response_revision:5140; number_of_response:1; }","duration":"141.512014ms","start":"2026-10-04T01:25:21.581847Z","end":"2026-10-04T01:25:21.723359Z","steps":["trace[783850124] 'process raft request'  (duration: 105.874617ms)","trace[783850124] 'compare'  (duration: 35.507864ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T01:25:21.752019Z","caller":"traceutil/trace.go:171","msg":"trace[1577718085] transaction","detail":"{read_only:false; response_revision:5141; number_of_response:1; }","duration":"168.72595ms","start":"2026-10-04T01:25:21.583261Z","end":"2026-10-04T01:25:21.751987Z","steps":["trace[1577718085] 'process raft request'  (duration: 168.466894ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:25:21.752422Z","caller":"traceutil/trace.go:171","msg":"trace[1162004720] transaction","detail":"{read_only:false; response_revision:5142; number_of_response:1; }","duration":"164.696734ms","start":"2026-10-04T01:25:21.587678Z","end":"2026-10-04T01:25:21.752375Z","steps":["trace[1162004720] 'process raft request'  (duration: 164.234593ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:25:21.753206Z","caller":"traceutil/trace.go:171","msg":"trace[1210442612] transaction","detail":"{read_only:false; response_revision:5143; number_of_response:1; }","duration":"158.113228ms","start":"2026-10-04T01:25:21.595079Z","end":"2026-10-04T01:25:21.753192Z","steps":["trace[1210442612] 'process raft request'  (duration: 157.181356ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:25:21.897419Z","caller":"traceutil/trace.go:171","msg":"trace[1119878805] transaction","detail":"{read_only:false; response_revision:5147; number_of_response:1; }","duration":"134.301332ms","start":"2026-10-04T01:25:21.763079Z","end":"2026-10-04T01:25:21.897381Z","steps":["trace[1119878805] 'process raft request'  (duration: 76.754564ms)","trace[1119878805] 'compare'  (duration: 57.266561ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T01:25:21.897842Z","caller":"traceutil/trace.go:171","msg":"trace[848391731] transaction","detail":"{read_only:false; response_revision:5149; number_of_response:1; }","duration":"134.073187ms","start":"2026-10-04T01:25:21.763725Z","end":"2026-10-04T01:25:21.897798Z","steps":["trace[848391731] 'process raft request'  (duration: 133.983675ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:25:21.897873Z","caller":"traceutil/trace.go:171","msg":"trace[1637619873] transaction","detail":"{read_only:false; response_revision:5148; number_of_response:1; }","duration":"134.490407ms","start":"2026-10-04T01:25:21.763348Z","end":"2026-10-04T01:25:21.897838Z","steps":["trace[1637619873] 'process raft request'  (duration: 133.973415ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T01:26:03.767782Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2908}
{"level":"info","ts":"2026-10-04T01:26:03.846014Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2908,"took":"76.892897ms","hash":1046324032,"current-db-size-bytes":51486720,"current-db-size":"52 MB","current-db-size-in-use-bytes":28188672,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-04T01:26:03.846085Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1046324032,"revision":2908,"compact-revision":-1}
{"level":"info","ts":"2026-10-04T01:31:03.776709Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5515}
{"level":"info","ts":"2026-10-04T01:31:03.86105Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5515,"took":"82.698814ms","hash":1464949516,"current-db-size-bytes":51486720,"current-db-size":"52 MB","current-db-size-in-use-bytes":18575360,"current-db-size-in-use":"19 MB"}
{"level":"info","ts":"2026-10-04T01:31:03.861135Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1464949516,"revision":5515,"compact-revision":2908}