{"level":"warn","ts":"2026-03-13T23:06:13.864349Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-13T23:06:13.864491Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.49: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.49:2380","--initial-cluster=instance=https://162.253.55.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.49: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-03-13T23:06:13.864576Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-13T23:06:13.864593Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.49:2380"]} {"level":"info","ts":"2026-03-13T23:06:13.864616Z","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-03-13T23:06:13.865313Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.49:2379"]} {"level":"info","ts":"2026-03-13T23:06:13.865403Z","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":16,"max-cpu-available":16,"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.49:2380"],"listen-peer-urls":["https://162.253.55.49:2380"],"advertise-client-urls":["https://162.253.55.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.49: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-03-13T23:06:13.869702Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.078883ms"} {"level":"info","ts":"2026-03-13T23:06:13.876025Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6a9ba61e55fef5be","cluster-id":"9612db6e19ac6ce7"} {"level":"info","ts":"2026-03-13T23:06:13.876119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be switched to configuration voters=()"} {"level":"info","ts":"2026-03-13T23:06:13.876147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became follower at term 0"} {"level":"info","ts":"2026-03-13T23:06:13.876162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6a9ba61e55fef5be [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-13T23:06:13.87618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became follower at term 1"} {"level":"info","ts":"2026-03-13T23:06:13.876226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be switched to configuration voters=(7681916238632515006)"} {"level":"warn","ts":"2026-03-13T23:06:13.891804Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-13T23:06:13.894377Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-13T23:06:13.895801Z","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-03-13T23:06:13.89897Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6a9ba61e55fef5be","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-13T23:06:13.899183Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6a9ba61e55fef5be","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-13T23:06:13.899232Z","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-03-13T23:06:13.899411Z","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-03-13T23:06:13.899503Z","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-03-13T23:06:13.900233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be switched to configuration voters=(7681916238632515006)"} {"level":"info","ts":"2026-03-13T23:06:13.902168Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9612db6e19ac6ce7","local-member-id":"6a9ba61e55fef5be","added-peer-id":"6a9ba61e55fef5be","added-peer-peer-urls":["https://162.253.55.49:2380"]} {"level":"info","ts":"2026-03-13T23:06:13.905206Z","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-03-13T23:06:13.905364Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.49:2380"} {"level":"info","ts":"2026-03-13T23:06:13.905544Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.49:2380"} {"level":"info","ts":"2026-03-13T23:06:13.905576Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6a9ba61e55fef5be","initial-advertise-peer-urls":["https://162.253.55.49:2380"],"listen-peer-urls":["https://162.253.55.49:2380"],"advertise-client-urls":["https://162.253.55.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-13T23:06:13.905659Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-13T23:06:14.476878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be is starting a new election at term 1"} {"level":"info","ts":"2026-03-13T23:06:14.476937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became pre-candidate at term 1"} {"level":"info","ts":"2026-03-13T23:06:14.476978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be received MsgPreVoteResp from 6a9ba61e55fef5be at term 1"} {"level":"info","ts":"2026-03-13T23:06:14.476998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became candidate at term 2"} {"level":"info","ts":"2026-03-13T23:06:14.477009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be received MsgVoteResp from 6a9ba61e55fef5be at term 2"} {"level":"info","ts":"2026-03-13T23:06:14.477025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became leader at term 2"} {"level":"info","ts":"2026-03-13T23:06:14.477048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6a9ba61e55fef5be elected leader 6a9ba61e55fef5be at term 2"} {"level":"info","ts":"2026-03-13T23:06:14.478223Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6a9ba61e55fef5be","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.49:2379]}","request-path":"/0/members/6a9ba61e55fef5be/attributes","cluster-id":"9612db6e19ac6ce7","publish-timeout":"7s"} {"level":"info","ts":"2026-03-13T23:06:14.478233Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-13T23:06:14.478259Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-13T23:06:14.478274Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-13T23:06:14.478611Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-13T23:06:14.478637Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-13T23:06:14.47927Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9612db6e19ac6ce7","local-member-id":"6a9ba61e55fef5be","cluster-version":"3.5"} {"level":"info","ts":"2026-03-13T23:06:14.479434Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-13T23:06:14.479471Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-13T23:06:14.481392Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.49:2379"} {"level":"info","ts":"2026-03-13T23:06:14.48292Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-13T23:06:31.013483Z","caller":"traceutil/trace.go:171","msg":"trace[840590613] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"152.645718ms","start":"2026-03-13T23:06:30.860813Z","end":"2026-03-13T23:06:31.013459Z","steps":["trace[840590613] 'process raft request' (duration: 152.467565ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:06:50.54599Z","caller":"traceutil/trace.go:171","msg":"trace[174841731] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"110.964959ms","start":"2026-03-13T23:06:50.434991Z","end":"2026-03-13T23:06:50.545956Z","steps":["trace[174841731] 'process raft request' (duration: 110.765405ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:06:50.576368Z","caller":"traceutil/trace.go:171","msg":"trace[230043090] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"129.333243ms","start":"2026-03-13T23:06:50.446992Z","end":"2026-03-13T23:06:50.576325Z","steps":["trace[230043090] 'process raft request' (duration: 129.102908ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:06:50.875447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.476479ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-13T23:06:50.875564Z","caller":"traceutil/trace.go:171","msg":"trace[1840333891] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"294.041322ms","start":"2026-03-13T23:06:50.581507Z","end":"2026-03-13T23:06:50.875548Z","steps":["trace[1840333891] 'process raft request' (duration: 47.911749ms)","trace[1840333891] 'compare' (duration: 245.280813ms)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:07:10.94388Z","caller":"traceutil/trace.go:171","msg":"trace[179468161] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"253.001947ms","start":"2026-03-13T23:07:10.690852Z","end":"2026-03-13T23:07:10.943853Z","steps":["trace[179468161] 'process raft request' (duration: 252.829484ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:07:37.988944Z","caller":"traceutil/trace.go:171","msg":"trace[1253968780] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"116.731099ms","start":"2026-03-13T23:07:37.872185Z","end":"2026-03-13T23:07:37.988916Z","steps":["trace[1253968780] 'process raft request' (duration: 116.550915ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:08:00.813867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.337939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-03-13T23:08:00.813969Z","caller":"traceutil/trace.go:171","msg":"trace[607859740] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1537; }","duration":"219.496584ms","start":"2026-03-13T23:08:00.594449Z","end":"2026-03-13T23:08:00.813946Z","steps":["trace[607859740] 'range keys from in-memory index tree' (duration: 219.107784ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:08:00.813949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.041265ms","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-03-13T23:08:00.814069Z","caller":"traceutil/trace.go:171","msg":"trace[1000924538] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1537; }","duration":"125.178119ms","start":"2026-03-13T23:08:00.688872Z","end":"2026-03-13T23:08:00.81405Z","steps":["trace[1000924538] 'range keys from in-memory index tree' (duration: 124.883932ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:08:00.814558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.347875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-03-13T23:08:00.814628Z","caller":"traceutil/trace.go:171","msg":"trace[1054472318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1537; }","duration":"189.455577ms","start":"2026-03-13T23:08:00.625154Z","end":"2026-03-13T23:08:00.814609Z","steps":["trace[1054472318] 'range keys from in-memory index tree' (duration: 188.966426ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:08:51.849158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.490446ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-13T23:08:51.849373Z","caller":"traceutil/trace.go:171","msg":"trace[545875287] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"167.489511ms","start":"2026-03-13T23:08:51.681788Z","end":"2026-03-13T23:08:51.849277Z","steps":["trace[545875287] 'process raft request' (duration: 57.710449ms)","trace[545875287] 'compare' (duration: 109.358733ms)"],"step_count":2} {"level":"warn","ts":"2026-03-13T23:08:57.344397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.115452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-13T23:08:57.344533Z","caller":"traceutil/trace.go:171","msg":"trace[1500028235] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1871; }","duration":"115.295667ms","start":"2026-03-13T23:08:57.229207Z","end":"2026-03-13T23:08:57.344503Z","steps":["trace[1500028235] 'range keys from in-memory index tree' (duration: 114.98015ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:10:21.367254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.404519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-03-13T23:10:21.367364Z","caller":"traceutil/trace.go:171","msg":"trace[37167357] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2478; }","duration":"250.571674ms","start":"2026-03-13T23:10:21.11677Z","end":"2026-03-13T23:10:21.367341Z","steps":["trace[37167357] 'range keys from in-memory index tree' (duration: 250.212705ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:06.130216Z","caller":"traceutil/trace.go:171","msg":"trace[1984226791] transaction","detail":"{read_only:false; response_revision:4375; number_of_response:1; }","duration":"107.002268ms","start":"2026-03-13T23:14:06.023181Z","end":"2026-03-13T23:14:06.130184Z","steps":["trace[1984226791] 'process raft request' (duration: 106.744581ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:14:08.765056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.509942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-03-13T23:14:08.765159Z","caller":"traceutil/trace.go:171","msg":"trace[1768627968] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4499; }","duration":"210.619715ms","start":"2026-03-13T23:14:08.554516Z","end":"2026-03-13T23:14:08.765135Z","steps":["trace[1768627968] 'range keys from in-memory index tree' (duration: 210.329098ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:19.373658Z","caller":"traceutil/trace.go:171","msg":"trace[1035261748] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"107.777304ms","start":"2026-03-13T23:14:19.265826Z","end":"2026-03-13T23:14:19.373603Z","steps":["trace[1035261748] 'process raft request' (duration: 95.6367ms)","trace[1035261748] 'compare' (duration: 11.95432ms)"],"step_count":2} {"level":"warn","ts":"2026-03-13T23:14:29.060602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.544367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ed942a20-8c81-491a-b783-92add5bb8aee\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-03-13T23:14:29.060691Z","caller":"traceutil/trace.go:171","msg":"trace[2070020985] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ed942a20-8c81-491a-b783-92add5bb8aee; range_end:; response_count:1; response_revision:4897; }","duration":"138.702752ms","start":"2026-03-13T23:14:28.92197Z","end":"2026-03-13T23:14:29.060673Z","steps":["trace[2070020985] 'range keys from in-memory index tree' (duration: 138.341663ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:29.320012Z","caller":"traceutil/trace.go:171","msg":"trace[1853127552] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"178.555838ms","start":"2026-03-13T23:14:29.140636Z","end":"2026-03-13T23:14:29.319192Z","steps":["trace[1853127552] 'process raft request' (duration: 178.291052ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:29.454119Z","caller":"traceutil/trace.go:171","msg":"trace[2085998296] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"128.47876ms","start":"2026-03-13T23:14:29.325615Z","end":"2026-03-13T23:14:29.454094Z","steps":["trace[2085998296] 'process raft request' (duration: 127.499048ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:29.454413Z","caller":"traceutil/trace.go:171","msg":"trace[1214267944] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"128.647376ms","start":"2026-03-13T23:14:29.325755Z","end":"2026-03-13T23:14:29.454402Z","steps":["trace[1214267944] 'process raft request' (duration: 128.266226ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:29.454515Z","caller":"traceutil/trace.go:171","msg":"trace[438424605] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"128.742718ms","start":"2026-03-13T23:14:29.325749Z","end":"2026-03-13T23:14:29.454491Z","steps":["trace[438424605] 'process raft request' (duration: 128.569554ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:29.454565Z","caller":"traceutil/trace.go:171","msg":"trace[1342264387] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"128.435191ms","start":"2026-03-13T23:14:29.326111Z","end":"2026-03-13T23:14:29.454546Z","steps":["trace[1342264387] 'process raft request' (duration: 128.316508ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:29.454949Z","caller":"traceutil/trace.go:171","msg":"trace[828791422] transaction","detail":"{read_only:false; response_revision:4908; number_of_response:1; }","duration":"128.100123ms","start":"2026-03-13T23:14:29.326836Z","end":"2026-03-13T23:14:29.454936Z","steps":["trace[828791422] 'process raft request' (duration: 127.658993ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:29.455116Z","caller":"traceutil/trace.go:171","msg":"trace[1984115325] linearizableReadLoop","detail":"{readStateIndex:5098; appliedIndex:5094; }","duration":"129.233819ms","start":"2026-03-13T23:14:29.325849Z","end":"2026-03-13T23:14:29.455083Z","steps":["trace[1984115325] 'read index received' (duration: 33.277063ms)","trace[1984115325] 'applied index is now lower than readState.Index' (duration: 95.955256ms)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:14:29.455298Z","caller":"traceutil/trace.go:171","msg":"trace[770715472] transaction","detail":"{read_only:false; response_revision:4910; number_of_response:1; }","duration":"128.160634ms","start":"2026-03-13T23:14:29.327123Z","end":"2026-03-13T23:14:29.455284Z","steps":["trace[770715472] 'process raft request' (duration: 127.866957ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:14:29.455368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.494615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18183"} {"level":"info","ts":"2026-03-13T23:14:29.455406Z","caller":"traceutil/trace.go:171","msg":"trace[1116749481] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4911; }","duration":"129.554207ms","start":"2026-03-13T23:14:29.325841Z","end":"2026-03-13T23:14:29.455395Z","steps":["trace[1116749481] 'agreement among raft nodes before linearized reading' (duration: 129.363542ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:29.455409Z","caller":"traceutil/trace.go:171","msg":"trace[472422199] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"128.169805ms","start":"2026-03-13T23:14:29.327225Z","end":"2026-03-13T23:14:29.455395Z","steps":["trace[472422199] 'process raft request' (duration: 127.811456ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:29.455469Z","caller":"traceutil/trace.go:171","msg":"trace[1438346547] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"128.362729ms","start":"2026-03-13T23:14:29.327097Z","end":"2026-03-13T23:14:29.45546Z","steps":["trace[1438346547] 'process raft request' (duration: 127.754935ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:16:14.505687Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2743} {"level":"info","ts":"2026-03-13T23:16:14.564592Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2743,"took":"57.215703ms","hash":2873076842,"current-db-size-bytes":40984576,"current-db-size":"41 MB","current-db-size-in-use-bytes":30801920,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-03-13T23:16:14.564668Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2873076842,"revision":2743,"compact-revision":-1} {"level":"info","ts":"2026-03-13T23:20:24.435678Z","caller":"traceutil/trace.go:171","msg":"trace[1699661787] transaction","detail":"{read_only:false; response_revision:7495; number_of_response:1; }","duration":"111.158256ms","start":"2026-03-13T23:20:24.324494Z","end":"2026-03-13T23:20:24.435652Z","steps":["trace[1699661787] 'process raft request' (duration: 110.990262ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:20:36.119224Z","caller":"traceutil/trace.go:171","msg":"trace[1365332763] transaction","detail":"{read_only:false; response_revision:7552; number_of_response:1; }","duration":"100.065546ms","start":"2026-03-13T23:20:36.019123Z","end":"2026-03-13T23:20:36.119189Z","steps":["trace[1365332763] 'process raft request' (duration: 60.963675ms)","trace[1365332763] 'compare' (duration: 38.936787ms)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:20:37.017686Z","caller":"traceutil/trace.go:171","msg":"trace[1333446355] transaction","detail":"{read_only:false; response_revision:7555; number_of_response:1; }","duration":"163.254264ms","start":"2026-03-13T23:20:36.854408Z","end":"2026-03-13T23:20:37.017662Z","steps":["trace[1333446355] 'process raft request' (duration: 163.117501ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:20:37.041297Z","caller":"traceutil/trace.go:171","msg":"trace[729219634] transaction","detail":"{read_only:false; response_revision:7556; number_of_response:1; }","duration":"186.044619ms","start":"2026-03-13T23:20:36.855234Z","end":"2026-03-13T23:20:37.041279Z","steps":["trace[729219634] 'process raft request' (duration: 185.948987ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:21:05.604624Z","caller":"traceutil/trace.go:171","msg":"trace[1772447199] linearizableReadLoop","detail":"{readStateIndex:8038; appliedIndex:8037; }","duration":"201.668357ms","start":"2026-03-13T23:21:05.402927Z","end":"2026-03-13T23:21:05.604595Z","steps":["trace[1772447199] 'read index received' (duration: 201.435361ms)","trace[1772447199] 'applied index is now lower than readState.Index' (duration: 231.906µs)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:21:05.604708Z","caller":"traceutil/trace.go:171","msg":"trace[1161562809] transaction","detail":"{read_only:false; response_revision:7748; number_of_response:1; }","duration":"276.190501ms","start":"2026-03-13T23:21:05.328476Z","end":"2026-03-13T23:21:05.604666Z","steps":["trace[1161562809] 'process raft request' (duration: 275.954785ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:21:05.605103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.571077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-03-13T23:21:05.60518Z","caller":"traceutil/trace.go:171","msg":"trace[2067560065] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7748; }","duration":"131.718061ms","start":"2026-03-13T23:21:05.473437Z","end":"2026-03-13T23:21:05.605155Z","steps":["trace[2067560065] 'agreement among raft nodes before linearized reading' (duration: 131.408283ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:21:05.605157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.614306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-03-13T23:21:05.605275Z","caller":"traceutil/trace.go:171","msg":"trace[705323321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7748; }","duration":"198.769389ms","start":"2026-03-13T23:21:05.406475Z","end":"2026-03-13T23:21:05.605244Z","steps":["trace[705323321] 'agreement among raft nodes before linearized reading' (duration: 198.362728ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:21:05.60536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.433516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-13T23:21:05.605408Z","caller":"traceutil/trace.go:171","msg":"trace[2132814988] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7748; }","duration":"202.524478ms","start":"2026-03-13T23:21:05.402869Z","end":"2026-03-13T23:21:05.605393Z","steps":["trace[2132814988] 'agreement among raft nodes before linearized reading' (duration: 201.838221ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:21:05.731978Z","caller":"traceutil/trace.go:171","msg":"trace[1493501399] transaction","detail":"{read_only:false; response_revision:7749; number_of_response:1; }","duration":"121.342268ms","start":"2026-03-13T23:21:05.61061Z","end":"2026-03-13T23:21:05.731953Z","steps":["trace[1493501399] 'process raft request' (duration: 121.197434ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:21:05.733241Z","caller":"traceutil/trace.go:171","msg":"trace[1978658744] transaction","detail":"{read_only:false; response_revision:7750; number_of_response:1; }","duration":"121.92973ms","start":"2026-03-13T23:21:05.611279Z","end":"2026-03-13T23:21:05.733209Z","steps":["trace[1978658744] 'process raft request' (duration: 121.209213ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:21:05.733605Z","caller":"traceutil/trace.go:171","msg":"trace[1312810591] transaction","detail":"{read_only:false; response_revision:7751; number_of_response:1; }","duration":"122.089974ms","start":"2026-03-13T23:21:05.61146Z","end":"2026-03-13T23:21:05.73355Z","steps":["trace[1312810591] 'process raft request' (duration: 121.208063ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:21:07.952908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.832327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-03-13T23:21:07.95293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.184586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-03-13T23:21:07.952991Z","caller":"traceutil/trace.go:171","msg":"trace[1832311918] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7760; }","duration":"214.95178ms","start":"2026-03-13T23:21:07.73802Z","end":"2026-03-13T23:21:07.952972Z","steps":["trace[1832311918] 'range keys from in-memory index tree' (duration: 214.625422ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:21:07.953018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.466026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-03-13T23:21:07.953051Z","caller":"traceutil/trace.go:171","msg":"trace[1738217394] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7760; }","duration":"215.37145ms","start":"2026-03-13T23:21:07.737645Z","end":"2026-03-13T23:21:07.953017Z","steps":["trace[1738217394] 'range keys from in-memory index tree' (duration: 214.94862ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:21:07.953094Z","caller":"traceutil/trace.go:171","msg":"trace[1939486458] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7760; }","duration":"216.607849ms","start":"2026-03-13T23:21:07.736465Z","end":"2026-03-13T23:21:07.953072Z","steps":["trace[1939486458] 'range keys from in-memory index tree' (duration: 216.241451ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:21:14.51161Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5768} {"level":"info","ts":"2026-03-13T23:21:14.59992Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5768,"took":"86.345131ms","hash":1066931289,"current-db-size-bytes":42672128,"current-db-size":"43 MB","current-db-size-in-use-bytes":23035904,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-13T23:21:14.600005Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1066931289,"revision":5768,"compact-revision":2743} {"level":"info","ts":"2026-03-13T23:21:18.216827Z","caller":"traceutil/trace.go:171","msg":"trace[380056965] transaction","detail":"{read_only:false; response_revision:7851; number_of_response:1; }","duration":"138.832138ms","start":"2026-03-13T23:21:18.077969Z","end":"2026-03-13T23:21:18.216801Z","steps":["trace[380056965] 'process raft request' (duration: 138.619953ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:21:18.217083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.568863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-jjnk5\" ","response":"range_response_count:1 size:2802"} {"level":"info","ts":"2026-03-13T23:21:18.21716Z","caller":"traceutil/trace.go:171","msg":"trace[1049961822] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-jjnk5; range_end:; response_count:1; response_revision:7851; }","duration":"138.681465ms","start":"2026-03-13T23:21:18.078457Z","end":"2026-03-13T23:21:18.217138Z","steps":["trace[1049961822] 'agreement among raft nodes before linearized reading' (duration: 138.433059ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:21:18.216771Z","caller":"traceutil/trace.go:171","msg":"trace[330964919] linearizableReadLoop","detail":"{readStateIndex:8147; appliedIndex:8146; }","duration":"138.259455ms","start":"2026-03-13T23:21:18.078483Z","end":"2026-03-13T23:21:18.216743Z","steps":["trace[330964919] 'read index received' (duration: 138.05297ms)","trace[330964919] 'applied index is now lower than readState.Index' (duration: 205.455µs)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:25:05.22511Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6a9ba61e55fef5be","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-13T23:25:05.231972Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-13T23:25:05.232319Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-13T23:26:14.519483Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7822} {"level":"info","ts":"2026-03-13T23:26:14.586521Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7822,"took":"64.59714ms","hash":3480196433,"current-db-size-bytes":42672128,"current-db-size":"43 MB","current-db-size-in-use-bytes":25763840,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-13T23:26:14.586586Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3480196433,"revision":7822,"compact-revision":5768} {"level":"info","ts":"2026-03-13T23:31:14.525532Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9987} {"level":"info","ts":"2026-03-13T23:31:14.597682Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9987,"took":"70.490843ms","hash":3227904280,"current-db-size-bytes":42672128,"current-db-size":"43 MB","current-db-size-in-use-bytes":16699392,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-03-13T23:31:14.597732Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3227904280,"revision":9987,"compact-revision":7822}