{"level":"warn","ts":"2026-09-03T05:19:22.651059Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-03T05:19:22.651183Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.193: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.193:2380","--initial-cluster=instance=https://162.253.55.193:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.193:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.193: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-09-03T05:19:22.651256Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-03T05:19:22.651277Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.193:2380"]} {"level":"info","ts":"2026-09-03T05:19:22.651304Z","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-09-03T05:19:22.651943Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"]} {"level":"info","ts":"2026-09-03T05:19:22.652045Z","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.193:2380"],"listen-peer-urls":["https://162.253.55.193:2380"],"advertise-client-urls":["https://162.253.55.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.193: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-09-03T05:19:22.655508Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.252383ms"} {"level":"info","ts":"2026-09-03T05:19:22.668765Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6814e3e3d6b4d713","cluster-id":"e5e99c9118b1492a"} {"level":"info","ts":"2026-09-03T05:19:22.668862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=()"} {"level":"info","ts":"2026-09-03T05:19:22.6689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became follower at term 0"} {"level":"info","ts":"2026-09-03T05:19:22.668923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6814e3e3d6b4d713 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-03T05:19:22.668956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became follower at term 1"} {"level":"info","ts":"2026-09-03T05:19:22.669011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=(7499869847177975571)"} {"level":"warn","ts":"2026-09-03T05:19:22.675318Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-03T05:19:22.677055Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-03T05:19:22.678704Z","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-09-03T05:19:22.682159Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6814e3e3d6b4d713","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-03T05:19:22.683374Z","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-09-03T05:19:22.683428Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6814e3e3d6b4d713","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-03T05:19:22.683557Z","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-09-03T05:19:22.684262Z","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-09-03T05:19:22.684842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=(7499869847177975571)"} {"level":"info","ts":"2026-09-03T05:19:22.685677Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e5e99c9118b1492a","local-member-id":"6814e3e3d6b4d713","added-peer-id":"6814e3e3d6b4d713","added-peer-peer-urls":["https://162.253.55.193:2380"]} {"level":"info","ts":"2026-09-03T05:19:22.688078Z","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-09-03T05:19:22.688292Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.193:2380"} {"level":"info","ts":"2026-09-03T05:19:22.688366Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.193:2380"} {"level":"info","ts":"2026-09-03T05:19:22.688699Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6814e3e3d6b4d713","initial-advertise-peer-urls":["https://162.253.55.193:2380"],"listen-peer-urls":["https://162.253.55.193:2380"],"advertise-client-urls":["https://162.253.55.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-03T05:19:22.688769Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-03T05:19:23.469959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 is starting a new election at term 1"} {"level":"info","ts":"2026-09-03T05:19:23.470043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-03T05:19:23.470075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 received MsgPreVoteResp from 6814e3e3d6b4d713 at term 1"} {"level":"info","ts":"2026-09-03T05:19:23.470094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became candidate at term 2"} {"level":"info","ts":"2026-09-03T05:19:23.470104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 received MsgVoteResp from 6814e3e3d6b4d713 at term 2"} {"level":"info","ts":"2026-09-03T05:19:23.470119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became leader at term 2"} {"level":"info","ts":"2026-09-03T05:19:23.470132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6814e3e3d6b4d713 elected leader 6814e3e3d6b4d713 at term 2"} {"level":"info","ts":"2026-09-03T05:19:23.471319Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6814e3e3d6b4d713","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.193:2379]}","request-path":"/0/members/6814e3e3d6b4d713/attributes","cluster-id":"e5e99c9118b1492a","publish-timeout":"7s"} {"level":"info","ts":"2026-09-03T05:19:23.471321Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-03T05:19:23.471383Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-03T05:19:23.471345Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T05:19:23.471727Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-03T05:19:23.471753Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-03T05:19:23.473141Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e5e99c9118b1492a","local-member-id":"6814e3e3d6b4d713","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T05:19:23.473253Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T05:19:23.47329Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T05:19:23.475178Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.193:2379"} {"level":"info","ts":"2026-09-03T05:19:23.475402Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-03T05:19:39.049478Z","caller":"traceutil/trace.go:171","msg":"trace[540038709] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"168.442754ms","start":"2026-09-03T05:19:38.881004Z","end":"2026-09-03T05:19:39.049447Z","steps":["trace[540038709] 'process raft request' (duration: 168.124937ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:19:49.8116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.189953ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-03T05:19:49.811775Z","caller":"traceutil/trace.go:171","msg":"trace[1089217569] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"288.975166ms","start":"2026-09-03T05:19:49.522781Z","end":"2026-09-03T05:19:49.811756Z","steps":["trace[1089217569] 'process raft request' (duration: 157.971765ms)","trace[1089217569] 'compare' (duration: 130.06137ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:20:10.381438Z","caller":"traceutil/trace.go:171","msg":"trace[475910705] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"124.621108ms","start":"2026-09-03T05:20:10.256791Z","end":"2026-09-03T05:20:10.381412Z","steps":["trace[475910705] 'read index received' (duration: 123.909882ms)","trace[475910705] 'applied index is now lower than readState.Index' (duration: 709.766µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:20:10.381483Z","caller":"traceutil/trace.go:171","msg":"trace[1059612531] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"216.427597ms","start":"2026-09-03T05:20:10.165036Z","end":"2026-09-03T05:20:10.381463Z","steps":["trace[1059612531] 'process raft request' (duration: 215.871505ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:20:10.381579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.767891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T05:20:10.381629Z","caller":"traceutil/trace.go:171","msg":"trace[1695361083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"124.868403ms","start":"2026-09-03T05:20:10.256746Z","end":"2026-09-03T05:20:10.381614Z","steps":["trace[1695361083] 'agreement among raft nodes before linearized reading' (duration: 124.775741ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:20:10.645391Z","caller":"traceutil/trace.go:171","msg":"trace[1675428419] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"178.804303ms","start":"2026-09-03T05:20:10.466552Z","end":"2026-09-03T05:20:10.645356Z","steps":["trace[1675428419] 'process raft request' (duration: 178.596889ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:20:11.259131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.677258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-klkcg\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-03T05:20:11.2594Z","caller":"traceutil/trace.go:171","msg":"trace[503549329] range","detail":"{range_begin:/registry/pods/kube-system/cilium-klkcg; range_end:; response_count:1; response_revision:639; }","duration":"300.984604ms","start":"2026-09-03T05:20:10.958356Z","end":"2026-09-03T05:20:11.25934Z","steps":["trace[503549329] 'range keys from in-memory index tree' (duration: 298.684664ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:20:11.259512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:20:10.958328Z","time spent":"301.121168ms","remote":"127.0.0.1:50334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-klkcg\" "} {"level":"info","ts":"2026-09-03T05:20:11.264207Z","caller":"traceutil/trace.go:171","msg":"trace[2018620762] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"197.355539ms","start":"2026-09-03T05:20:11.066816Z","end":"2026-09-03T05:20:11.264171Z","steps":["trace[2018620762] 'process raft request' (duration: 189.990133ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:20:13.29892Z","caller":"traceutil/trace.go:171","msg":"trace[162891629] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"150.809864ms","start":"2026-09-03T05:20:13.14807Z","end":"2026-09-03T05:20:13.29888Z","steps":["trace[162891629] 'process raft request' (duration: 133.333482ms)","trace[162891629] 'compare' (duration: 17.37777ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:20:13.303633Z","caller":"traceutil/trace.go:171","msg":"trace[1397312096] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"112.456214ms","start":"2026-09-03T05:20:13.191152Z","end":"2026-09-03T05:20:13.303608Z","steps":["trace[1397312096] 'process raft request' (duration: 112.315471ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:20:13.303876Z","caller":"traceutil/trace.go:171","msg":"trace[1356946021] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"103.414771ms","start":"2026-09-03T05:20:13.200418Z","end":"2026-09-03T05:20:13.303833Z","steps":["trace[1356946021] 'process raft request' (duration: 103.153555ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:20:27.791787Z","caller":"traceutil/trace.go:171","msg":"trace[1700883425] linearizableReadLoop","detail":"{readStateIndex:837; appliedIndex:836; }","duration":"115.659446ms","start":"2026-09-03T05:20:27.676091Z","end":"2026-09-03T05:20:27.79175Z","steps":["trace[1700883425] 'read index received' (duration: 115.500082ms)","trace[1700883425] 'applied index is now lower than readState.Index' (duration: 158.024µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:20:27.791868Z","caller":"traceutil/trace.go:171","msg":"trace[1731648110] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"117.737222ms","start":"2026-09-03T05:20:27.674089Z","end":"2026-09-03T05:20:27.791826Z","steps":["trace[1731648110] 'process raft request' (duration: 117.480267ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:20:27.79196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.85373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T05:20:27.792005Z","caller":"traceutil/trace.go:171","msg":"trace[1937716321] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:809; }","duration":"115.962802ms","start":"2026-09-03T05:20:27.676032Z","end":"2026-09-03T05:20:27.791995Z","steps":["trace[1937716321] 'agreement among raft nodes before linearized reading' (duration: 115.86849ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:20:28.016756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.151928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-03T05:20:28.016874Z","caller":"traceutil/trace.go:171","msg":"trace[219935081] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:810; }","duration":"100.339032ms","start":"2026-09-03T05:20:27.916513Z","end":"2026-09-03T05:20:28.016852Z","steps":["trace[219935081] 'count revisions from in-memory index tree' (duration: 99.969884ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:21:51.999255Z","caller":"traceutil/trace.go:171","msg":"trace[782332905] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"157.518102ms","start":"2026-09-03T05:21:51.841699Z","end":"2026-09-03T05:21:51.999217Z","steps":["trace[782332905] 'process raft request' (duration: 157.282816ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:21:52.052503Z","caller":"traceutil/trace.go:171","msg":"trace[251620755] linearizableReadLoop","detail":"{readStateIndex:1987; appliedIndex:1985; }","duration":"176.877836ms","start":"2026-09-03T05:21:51.875577Z","end":"2026-09-03T05:21:52.052455Z","steps":["trace[251620755] 'read index received' (duration: 123.504762ms)","trace[251620755] 'applied index is now lower than readState.Index' (duration: 53.371354ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T05:21:52.052643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.038909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-03T05:21:52.052763Z","caller":"traceutil/trace.go:171","msg":"trace[417800043] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1913; }","duration":"177.219723ms","start":"2026-09-03T05:21:51.875522Z","end":"2026-09-03T05:21:52.052741Z","steps":["trace[417800043] 'agreement among raft nodes before linearized reading' (duration: 177.033459ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:21:52.052857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.150339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-03T05:21:52.052907Z","caller":"traceutil/trace.go:171","msg":"trace[468491080] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1913; }","duration":"166.234742ms","start":"2026-09-03T05:21:51.88666Z","end":"2026-09-03T05:21:52.052895Z","steps":["trace[468491080] 'agreement among raft nodes before linearized reading' (duration: 165.971426ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:22:03.868485Z","caller":"traceutil/trace.go:171","msg":"trace[466431354] transaction","detail":"{read_only:false; response_revision:2012; number_of_response:1; }","duration":"154.067285ms","start":"2026-09-03T05:22:03.714371Z","end":"2026-09-03T05:22:03.868438Z","steps":["trace[466431354] 'process raft request' (duration: 153.772749ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:22:36.522119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.666633ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-03T05:22:36.522301Z","caller":"traceutil/trace.go:171","msg":"trace[2078117074] transaction","detail":"{read_only:false; response_revision:2204; number_of_response:1; }","duration":"151.415716ms","start":"2026-09-03T05:22:36.370854Z","end":"2026-09-03T05:22:36.522269Z","steps":["trace[2078117074] 'process raft request' (duration: 32.496326ms)","trace[2078117074] 'compare' (duration: 118.501649ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T05:22:42.294795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.193227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T05:22:42.294921Z","caller":"traceutil/trace.go:171","msg":"trace[368254252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2233; }","duration":"106.415712ms","start":"2026-09-03T05:22:42.188477Z","end":"2026-09-03T05:22:42.294893Z","steps":["trace[368254252] 'range keys from in-memory index tree' (duration: 106.071214ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:22:42.76934Z","caller":"traceutil/trace.go:171","msg":"trace[842792780] linearizableReadLoop","detail":"{readStateIndex:2320; appliedIndex:2319; }","duration":"190.717238ms","start":"2026-09-03T05:22:42.5786Z","end":"2026-09-03T05:22:42.769317Z","steps":["trace[842792780] 'read index received' (duration: 190.41734ms)","trace[842792780] 'applied index is now lower than readState.Index' (duration: 298.618µs)"],"step_count":2} {"level":"warn","ts":"2026-09-03T05:22:42.769612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.844317ms","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-09-03T05:22:42.769679Z","caller":"traceutil/trace.go:171","msg":"trace[1573471770] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2235; }","duration":"162.94468ms","start":"2026-09-03T05:22:42.60672Z","end":"2026-09-03T05:22:42.769665Z","steps":["trace[1573471770] 'agreement among raft nodes before linearized reading' (duration: 162.775086ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:22:42.769751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.115377ms","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-09-03T05:22:42.769441Z","caller":"traceutil/trace.go:171","msg":"trace[741644934] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"212.736142ms","start":"2026-09-03T05:22:42.556652Z","end":"2026-09-03T05:22:42.769388Z","steps":["trace[741644934] 'process raft request' (duration: 212.461855ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:22:42.7699Z","caller":"traceutil/trace.go:171","msg":"trace[838227366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2235; }","duration":"191.345962ms","start":"2026-09-03T05:22:42.578522Z","end":"2026-09-03T05:22:42.769868Z","steps":["trace[838227366] 'agreement among raft nodes before linearized reading' (duration: 190.922142ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:22:42.974289Z","caller":"traceutil/trace.go:171","msg":"trace[1693015716] transaction","detail":"{read_only:false; response_revision:2237; number_of_response:1; }","duration":"199.829386ms","start":"2026-09-03T05:22:42.774419Z","end":"2026-09-03T05:22:42.974248Z","steps":["trace[1693015716] 'process raft request' (duration: 197.296058ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:22:42.974314Z","caller":"traceutil/trace.go:171","msg":"trace[1720597104] linearizableReadLoop","detail":"{readStateIndex:2322; appliedIndex:2320; }","duration":"183.280277ms","start":"2026-09-03T05:22:42.790994Z","end":"2026-09-03T05:22:42.974274Z","steps":["trace[1720597104] 'read index received' (duration: 2.482567ms)","trace[1720597104] 'applied index is now lower than readState.Index' (duration: 180.79366ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T05:22:42.97454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.504132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-03T05:22:42.974603Z","caller":"traceutil/trace.go:171","msg":"trace[1343806108] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:2238; }","duration":"183.615445ms","start":"2026-09-03T05:22:42.790965Z","end":"2026-09-03T05:22:42.97458Z","steps":["trace[1343806108] 'agreement among raft nodes before linearized reading' (duration: 183.41129ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:22:42.974837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.000872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-03T05:22:42.97496Z","caller":"traceutil/trace.go:171","msg":"trace[289863651] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2238; }","duration":"143.183086ms","start":"2026-09-03T05:22:42.831742Z","end":"2026-09-03T05:22:42.974925Z","steps":["trace[289863651] 'agreement among raft nodes before linearized reading' (duration: 142.868679ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:22:43.283092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.510848ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-03T05:22:43.283356Z","caller":"traceutil/trace.go:171","msg":"trace[594438746] linearizableReadLoop","detail":"{readStateIndex:2324; appliedIndex:2323; }","duration":"278.85842ms","start":"2026-09-03T05:22:43.004462Z","end":"2026-09-03T05:22:43.28332Z","steps":["trace[594438746] 'read index received' (duration: 102.85843ms)","trace[594438746] 'applied index is now lower than readState.Index' (duration: 175.986039ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T05:22:43.283653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.170697ms","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-09-03T05:22:43.283707Z","caller":"traceutil/trace.go:171","msg":"trace[786681550] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2240; }","duration":"279.267349ms","start":"2026-09-03T05:22:43.00442Z","end":"2026-09-03T05:22:43.283688Z","steps":["trace[786681550] 'agreement among raft nodes before linearized reading' (duration: 279.026093ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:22:43.283829Z","caller":"traceutil/trace.go:171","msg":"trace[1028818161] transaction","detail":"{read_only:false; response_revision:2239; number_of_response:1; }","duration":"303.28541ms","start":"2026-09-03T05:22:42.979988Z","end":"2026-09-03T05:22:43.283273Z","steps":["trace[1028818161] 'process raft request' (duration: 127.453864ms)","trace[1028818161] 'compare' (duration: 175.280733ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T05:22:43.283994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:22:42.97996Z","time spent":"303.925484ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T05:23:34.724708Z","caller":"traceutil/trace.go:171","msg":"trace[145360678] transaction","detail":"{read_only:false; response_revision:2688; number_of_response:1; }","duration":"119.106704ms","start":"2026-09-03T05:23:34.60556Z","end":"2026-09-03T05:23:34.724667Z","steps":["trace[145360678] 'process raft request' (duration: 118.892269ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:24:08.082316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.623258ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-03T05:24:08.082417Z","caller":"traceutil/trace.go:171","msg":"trace[1301588537] transaction","detail":"{read_only:false; response_revision:2893; number_of_response:1; }","duration":"374.781099ms","start":"2026-09-03T05:24:07.707617Z","end":"2026-09-03T05:24:08.082398Z","steps":["trace[1301588537] 'process raft request' (duration: 172.996406ms)","trace[1301588537] 'compare' (duration: 201.442744ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T05:24:08.082473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:24:07.707597Z","time spent":"374.85066ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T05:24:13.394546Z","caller":"traceutil/trace.go:171","msg":"trace[1714430272] transaction","detail":"{read_only:false; response_revision:2919; number_of_response:1; }","duration":"119.97072ms","start":"2026-09-03T05:24:13.274533Z","end":"2026-09-03T05:24:13.394504Z","steps":["trace[1714430272] 'process raft request' (duration: 114.529897ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:27:16.268485Z","caller":"traceutil/trace.go:171","msg":"trace[2023745497] transaction","detail":"{read_only:false; response_revision:4082; number_of_response:1; }","duration":"214.241264ms","start":"2026-09-03T05:27:16.054204Z","end":"2026-09-03T05:27:16.268445Z","steps":["trace[2023745497] 'process raft request' (duration: 214.022389ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:29:08.435663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.081316ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-03T05:29:08.435802Z","caller":"traceutil/trace.go:171","msg":"trace[2142369170] transaction","detail":"{read_only:false; response_revision:5572; number_of_response:1; }","duration":"202.827391ms","start":"2026-09-03T05:29:08.232949Z","end":"2026-09-03T05:29:08.435776Z","steps":["trace[2142369170] 'process raft request' (duration: 40.52774ms)","trace[2142369170] 'compare' (duration: 161.944603ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:29:08.495158Z","caller":"traceutil/trace.go:171","msg":"trace[952117857] transaction","detail":"{read_only:false; response_revision:5573; number_of_response:1; }","duration":"256.722337ms","start":"2026-09-03T05:29:08.238394Z","end":"2026-09-03T05:29:08.495117Z","steps":["trace[952117857] 'process raft request' (duration: 256.557194ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:29:09.799574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.131607ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-03T05:29:09.799738Z","caller":"traceutil/trace.go:171","msg":"trace[1963625422] transaction","detail":"{read_only:false; response_revision:5596; number_of_response:1; }","duration":"339.428668ms","start":"2026-09-03T05:29:09.46027Z","end":"2026-09-03T05:29:09.799699Z","steps":["trace[1963625422] 'process raft request' (duration: 170.069357ms)","trace[1963625422] 'compare' (duration: 168.992513ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T05:29:09.80001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:29:09.460224Z","time spent":"339.703354ms","remote":"127.0.0.1:53998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10926,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T05:29:20.334424Z","caller":"traceutil/trace.go:171","msg":"trace[1756304852] transaction","detail":"{read_only:false; response_revision:5807; number_of_response:1; }","duration":"131.996472ms","start":"2026-09-03T05:29:20.202399Z","end":"2026-09-03T05:29:20.334395Z","steps":["trace[1756304852] 'process raft request' (duration: 38.747251ms)","trace[1756304852] 'compare' (duration: 93.047226ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:29:20.334999Z","caller":"traceutil/trace.go:171","msg":"trace[1396254438] transaction","detail":"{read_only:false; response_revision:5808; number_of_response:1; }","duration":"116.612602ms","start":"2026-09-03T05:29:20.218322Z","end":"2026-09-03T05:29:20.334934Z","steps":["trace[1396254438] 'process raft request' (duration: 116.010077ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:29:20.459502Z","caller":"traceutil/trace.go:171","msg":"trace[1153381340] transaction","detail":"{read_only:false; response_revision:5815; number_of_response:1; }","duration":"106.670345ms","start":"2026-09-03T05:29:20.352802Z","end":"2026-09-03T05:29:20.459473Z","steps":["trace[1153381340] 'process raft request' (duration: 106.605664ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:29:20.459557Z","caller":"traceutil/trace.go:171","msg":"trace[184562407] transaction","detail":"{read_only:false; response_revision:5814; number_of_response:1; }","duration":"113.754536ms","start":"2026-09-03T05:29:20.34576Z","end":"2026-09-03T05:29:20.459515Z","steps":["trace[184562407] 'process raft request' (duration: 98.450798ms)","trace[184562407] 'compare' (duration: 15.052712ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:29:20.584506Z","caller":"traceutil/trace.go:171","msg":"trace[1252337720] transaction","detail":"{read_only:false; response_revision:5816; number_of_response:1; }","duration":"109.177183ms","start":"2026-09-03T05:29:20.475296Z","end":"2026-09-03T05:29:20.584474Z","steps":["trace[1252337720] 'process raft request' (duration: 106.004751ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:29:20.594682Z","caller":"traceutil/trace.go:171","msg":"trace[1458950365] linearizableReadLoop","detail":"{readStateIndex:6032; appliedIndex:6030; }","duration":"105.779484ms","start":"2026-09-03T05:29:20.488856Z","end":"2026-09-03T05:29:20.594636Z","steps":["trace[1458950365] 'read index received' (duration: 92.453562ms)","trace[1458950365] 'applied index is now lower than readState.Index' (duration: 13.324332ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:29:20.594811Z","caller":"traceutil/trace.go:171","msg":"trace[508339117] transaction","detail":"{read_only:false; response_revision:5817; number_of_response:1; }","duration":"113.618553ms","start":"2026-09-03T05:29:20.48113Z","end":"2026-09-03T05:29:20.594749Z","steps":["trace[508339117] 'process raft request' (duration: 113.231364ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:29:20.594914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.03188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-03T05:29:20.594995Z","caller":"traceutil/trace.go:171","msg":"trace[269673590] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5817; }","duration":"106.161713ms","start":"2026-09-03T05:29:20.488815Z","end":"2026-09-03T05:29:20.594977Z","steps":["trace[269673590] 'agreement among raft nodes before linearized reading' (duration: 105.946808ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:29:23.505512Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2977} {"level":"info","ts":"2026-09-03T05:29:23.593473Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2977,"took":"85.678529ms","hash":562468156,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":32313344,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-03T05:29:23.593647Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":562468156,"revision":2977,"compact-revision":-1} {"level":"info","ts":"2026-09-03T05:34:23.5143Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5853} {"level":"info","ts":"2026-09-03T05:34:23.604569Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5853,"took":"86.079757ms","hash":2557140947,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":26202112,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-03T05:34:23.604647Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2557140947,"revision":5853,"compact-revision":2977} {"level":"info","ts":"2026-09-03T05:35:50.170917Z","caller":"traceutil/trace.go:171","msg":"trace[804785823] linearizableReadLoop","detail":"{readStateIndex:9029; appliedIndex:9028; }","duration":"237.024928ms","start":"2026-09-03T05:35:49.933868Z","end":"2026-09-03T05:35:50.170893Z","steps":["trace[804785823] 'read index received' (duration: 236.788821ms)","trace[804785823] 'applied index is now lower than readState.Index' (duration: 235.297µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:35:50.171006Z","caller":"traceutil/trace.go:171","msg":"trace[1020108157] transaction","detail":"{read_only:false; response_revision:8719; number_of_response:1; }","duration":"300.301406ms","start":"2026-09-03T05:35:49.870662Z","end":"2026-09-03T05:35:50.170963Z","steps":["trace[1020108157] 'process raft request' (duration: 300.04728ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:35:50.171124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.241413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-03T05:35:50.171168Z","caller":"traceutil/trace.go:171","msg":"trace[1655511203] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8719; }","duration":"237.369595ms","start":"2026-09-03T05:35:49.933788Z","end":"2026-09-03T05:35:50.171158Z","steps":["trace[1655511203] 'agreement among raft nodes before linearized reading' (duration: 237.209272ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:35:50.171194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:35:49.870639Z","time spent":"300.450729ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T05:35:50.363136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.915154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-03T05:35:50.363289Z","caller":"traceutil/trace.go:171","msg":"trace[385382831] transaction","detail":"{read_only:false; response_revision:8720; number_of_response:1; }","duration":"187.635585ms","start":"2026-09-03T05:35:50.175628Z","end":"2026-09-03T05:35:50.363264Z","steps":["trace[385382831] 'process raft request' (duration: 86.489396ms)","trace[385382831] 'compare' (duration: 100.658608ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:35:50.401001Z","caller":"traceutil/trace.go:171","msg":"trace[2012143147] linearizableReadLoop","detail":"{readStateIndex:9031; appliedIndex:9029; }","duration":"144.194568ms","start":"2026-09-03T05:35:50.256786Z","end":"2026-09-03T05:35:50.40098Z","steps":["trace[2012143147] 'read index received' (duration: 5.346972ms)","trace[2012143147] 'applied index is now lower than readState.Index' (duration: 138.844286ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:35:50.40109Z","caller":"traceutil/trace.go:171","msg":"trace[1776891221] transaction","detail":"{read_only:false; response_revision:8721; number_of_response:1; }","duration":"156.355574ms","start":"2026-09-03T05:35:50.244714Z","end":"2026-09-03T05:35:50.401069Z","steps":["trace[1776891221] 'process raft request' (duration: 156.150809ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:35:50.401168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.366341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T05:35:50.401259Z","caller":"traceutil/trace.go:171","msg":"trace[994792364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8721; }","duration":"144.464023ms","start":"2026-09-03T05:35:50.256773Z","end":"2026-09-03T05:35:50.401237Z","steps":["trace[994792364] 'agreement among raft nodes before linearized reading' (duration: 144.31387ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:35:50.409761Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000234a.wal"} {"level":"info","ts":"2026-09-03T05:36:01.031966Z","caller":"traceutil/trace.go:171","msg":"trace[1937327441] transaction","detail":"{read_only:false; response_revision:8778; number_of_response:1; }","duration":"103.161573ms","start":"2026-09-03T05:36:00.928772Z","end":"2026-09-03T05:36:01.031933Z","steps":["trace[1937327441] 'process raft request' (duration: 102.931588ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:36:02.609471Z","caller":"traceutil/trace.go:171","msg":"trace[979375312] transaction","detail":"{read_only:false; response_revision:8783; number_of_response:1; }","duration":"132.97496ms","start":"2026-09-03T05:36:02.476469Z","end":"2026-09-03T05:36:02.609444Z","steps":["trace[979375312] 'process raft request' (duration: 132.801576ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:36:02.625449Z","caller":"traceutil/trace.go:171","msg":"trace[314462738] transaction","detail":"{read_only:false; response_revision:8784; number_of_response:1; }","duration":"148.742147ms","start":"2026-09-03T05:36:02.476682Z","end":"2026-09-03T05:36:02.625424Z","steps":["trace[314462738] 'process raft request' (duration: 148.447761ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:36:02.62575Z","caller":"traceutil/trace.go:171","msg":"trace[1546099641] transaction","detail":"{read_only:false; response_revision:8785; number_of_response:1; }","duration":"148.737518ms","start":"2026-09-03T05:36:02.476989Z","end":"2026-09-03T05:36:02.625727Z","steps":["trace[1546099641] 'process raft request' (duration: 148.3962ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:36:02.625835Z","caller":"traceutil/trace.go:171","msg":"trace[993573357] transaction","detail":"{read_only:false; response_revision:8786; number_of_response:1; }","duration":"146.851185ms","start":"2026-09-03T05:36:02.478947Z","end":"2026-09-03T05:36:02.625798Z","steps":["trace[993573357] 'process raft request' (duration: 146.687431ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:36:32.677189Z","caller":"traceutil/trace.go:171","msg":"trace[1722212216] transaction","detail":"{read_only:false; response_revision:9000; number_of_response:1; }","duration":"221.53354ms","start":"2026-09-03T05:36:32.455632Z","end":"2026-09-03T05:36:32.677165Z","steps":["trace[1722212216] 'process raft request' (duration: 221.385077ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:36:45.876532Z","caller":"traceutil/trace.go:171","msg":"trace[2099211135] transaction","detail":"{read_only:false; response_revision:9083; number_of_response:1; }","duration":"125.853458ms","start":"2026-09-03T05:36:45.75065Z","end":"2026-09-03T05:36:45.876503Z","steps":["trace[2099211135] 'process raft request' (duration: 125.772326ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:36:45.876746Z","caller":"traceutil/trace.go:171","msg":"trace[1264829140] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9082; }","duration":"126.028352ms","start":"2026-09-03T05:36:45.750645Z","end":"2026-09-03T05:36:45.876673Z","steps":["trace[1264829140] 'process raft request' (duration: 115.485272ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:36:46.089414Z","caller":"traceutil/trace.go:171","msg":"trace[2058416122] linearizableReadLoop","detail":"{readStateIndex:9408; appliedIndex:9405; }","duration":"260.324571ms","start":"2026-09-03T05:36:45.829062Z","end":"2026-09-03T05:36:46.089387Z","steps":["trace[2058416122] 'read index received' (duration: 37.133693ms)","trace[2058416122] 'applied index is now lower than readState.Index' (duration: 223.189918ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:36:46.089938Z","caller":"traceutil/trace.go:171","msg":"trace[1239434902] transaction","detail":"{read_only:false; response_revision:9084; number_of_response:1; }","duration":"320.326983ms","start":"2026-09-03T05:36:45.769593Z","end":"2026-09-03T05:36:46.08992Z","steps":["trace[1239434902] 'process raft request' (duration: 266.06795ms)","trace[1239434902] 'compare' (duration: 53.296341ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T05:36:46.090058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:36:45.76956Z","time spent":"320.419675ms","remote":"127.0.0.1:39352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":415350,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T05:36:46.090468Z","caller":"traceutil/trace.go:171","msg":"trace[2044700495] transaction","detail":"{read_only:false; response_revision:9085; number_of_response:1; }","duration":"258.379516ms","start":"2026-09-03T05:36:45.832052Z","end":"2026-09-03T05:36:46.090431Z","steps":["trace[2044700495] 'process raft request' (duration: 257.273332ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:36:46.090471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.381215ms","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-09-03T05:36:46.090561Z","caller":"traceutil/trace.go:171","msg":"trace[587989429] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:9085; }","duration":"261.500328ms","start":"2026-09-03T05:36:45.829039Z","end":"2026-09-03T05:36:46.090539Z","steps":["trace[587989429] 'agreement among raft nodes before linearized reading' (duration: 261.311303ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:36:46.109404Z","caller":"traceutil/trace.go:171","msg":"trace[1882121589] transaction","detail":"{read_only:false; response_revision:9086; number_of_response:1; }","duration":"140.560382ms","start":"2026-09-03T05:36:45.968815Z","end":"2026-09-03T05:36:46.109376Z","steps":["trace[1882121589] 'process raft request' (duration: 140.403088ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:36:46.110126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.053233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-qfngf\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-09-03T05:36:46.110237Z","caller":"traceutil/trace.go:171","msg":"trace[2012690449] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-qfngf; range_end:; response_count:1; response_revision:9086; }","duration":"278.217557ms","start":"2026-09-03T05:36:45.832004Z","end":"2026-09-03T05:36:46.110222Z","steps":["trace[2012690449] 'agreement among raft nodes before linearized reading' (duration: 277.998632ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:36:46.110493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.922134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-qfngf\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-09-03T05:36:46.110529Z","caller":"traceutil/trace.go:171","msg":"trace[2029886943] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-qfngf; range_end:; response_count:1; response_revision:9086; }","duration":"220.034465ms","start":"2026-09-03T05:36:45.890485Z","end":"2026-09-03T05:36:46.11052Z","steps":["trace[2029886943] 'agreement among raft nodes before linearized reading' (duration: 219.946083ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:37:45.950529Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6814e3e3d6b4d713","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-03T05:37:45.970712Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-03T05:37:45.970834Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-09-03T05:38:13.266873Z","caller":"traceutil/trace.go:171","msg":"trace[1554041956] transaction","detail":"{read_only:false; response_revision:9922; number_of_response:1; }","duration":"122.923124ms","start":"2026-09-03T05:38:13.143922Z","end":"2026-09-03T05:38:13.266845Z","steps":["trace[1554041956] 'process raft request' (duration: 122.7187ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:38:13.289818Z","caller":"traceutil/trace.go:171","msg":"trace[255965331] transaction","detail":"{read_only:false; response_revision:9923; number_of_response:1; }","duration":"143.217597ms","start":"2026-09-03T05:38:13.146571Z","end":"2026-09-03T05:38:13.289788Z","steps":["trace[255965331] 'process raft request' (duration: 143.054284ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:39:23.523223Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8035} {"level":"info","ts":"2026-09-03T05:39:23.593894Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8035,"took":"68.77123ms","hash":2575481836,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":28246016,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-03T05:39:23.593979Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2575481836,"revision":8035,"compact-revision":5853} {"level":"info","ts":"2026-09-03T05:43:51.401014Z","caller":"traceutil/trace.go:171","msg":"trace[1787003805] linearizableReadLoop","detail":"{readStateIndex:12777; appliedIndex:12776; }","duration":"216.881537ms","start":"2026-09-03T05:43:51.184099Z","end":"2026-09-03T05:43:51.400981Z","steps":["trace[1787003805] 'read index received' (duration: 216.710823ms)","trace[1787003805] 'applied index is now lower than readState.Index' (duration: 169.564µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:43:51.401085Z","caller":"traceutil/trace.go:171","msg":"trace[1956826404] transaction","detail":"{read_only:false; response_revision:12351; number_of_response:1; }","duration":"261.071476ms","start":"2026-09-03T05:43:51.13995Z","end":"2026-09-03T05:43:51.401022Z","steps":["trace[1956826404] 'process raft request' (duration: 260.864601ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:43:51.401266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.131093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-03T05:43:51.4013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.605572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T05:43:51.401378Z","caller":"traceutil/trace.go:171","msg":"trace[369517323] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12351; }","duration":"217.285147ms","start":"2026-09-03T05:43:51.18407Z","end":"2026-09-03T05:43:51.401355Z","steps":["trace[369517323] 'agreement among raft nodes before linearized reading' (duration: 217.039541ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:43:51.401405Z","caller":"traceutil/trace.go:171","msg":"trace[442625592] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12351; }","duration":"216.741734ms","start":"2026-09-03T05:43:51.184638Z","end":"2026-09-03T05:43:51.401379Z","steps":["trace[442625592] 'agreement among raft nodes before linearized reading' (duration: 216.586601ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:43:51.40151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.639794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T05:43:51.401546Z","caller":"traceutil/trace.go:171","msg":"trace[1753623693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12351; }","duration":"213.692215ms","start":"2026-09-03T05:43:51.187843Z","end":"2026-09-03T05:43:51.401535Z","steps":["trace[1753623693] 'agreement among raft nodes before linearized reading' (duration: 213.640943ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:43:51.401519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.689593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-03T05:43:51.401544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.365543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"} {"level":"warn","ts":"2026-09-03T05:43:51.401576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.881328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T05:43:51.401603Z","caller":"traceutil/trace.go:171","msg":"trace[1844773909] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12351; }","duration":"216.835737ms","start":"2026-09-03T05:43:51.184746Z","end":"2026-09-03T05:43:51.401581Z","steps":["trace[1844773909] 'agreement among raft nodes before linearized reading' (duration: 216.674263ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:43:51.401651Z","caller":"traceutil/trace.go:171","msg":"trace[247728118] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12351; }","duration":"215.504406ms","start":"2026-09-03T05:43:51.186121Z","end":"2026-09-03T05:43:51.401626Z","steps":["trace[247728118] 'agreement among raft nodes before linearized reading' (duration: 215.23961ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:43:51.401668Z","caller":"traceutil/trace.go:171","msg":"trace[1779083755] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12351; }","duration":"216.99671ms","start":"2026-09-03T05:43:51.184648Z","end":"2026-09-03T05:43:51.401645Z","steps":["trace[1779083755] 'agreement among raft nodes before linearized reading' (duration: 216.879107ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:43:52.541373Z","caller":"traceutil/trace.go:171","msg":"trace[1129858226] transaction","detail":"{read_only:false; response_revision:12356; number_of_response:1; }","duration":"167.809328ms","start":"2026-09-03T05:43:52.37348Z","end":"2026-09-03T05:43:52.54129Z","steps":["trace[1129858226] 'process raft request' (duration: 167.567173ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:43:52.558015Z","caller":"traceutil/trace.go:171","msg":"trace[1470437303] transaction","detail":"{read_only:false; response_revision:12357; number_of_response:1; }","duration":"172.748491ms","start":"2026-09-03T05:43:52.385238Z","end":"2026-09-03T05:43:52.557987Z","steps":["trace[1470437303] 'process raft request' (duration: 172.555716ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:43:52.558249Z","caller":"traceutil/trace.go:171","msg":"trace[1285377892] transaction","detail":"{read_only:false; response_revision:12358; number_of_response:1; }","duration":"170.327986ms","start":"2026-09-03T05:43:52.387887Z","end":"2026-09-03T05:43:52.558215Z","steps":["trace[1285377892] 'process raft request' (duration: 170.05548ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:44:23.531427Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10404} {"level":"info","ts":"2026-09-03T05:44:23.618872Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10404,"took":"85.147782ms","hash":1955275727,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":25718784,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-03T05:44:23.618951Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1955275727,"revision":10404,"compact-revision":8035} {"level":"info","ts":"2026-09-03T05:49:23.537848Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12572} {"level":"info","ts":"2026-09-03T05:49:23.618408Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12572,"took":"77.954507ms","hash":2862731844,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":27521024,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-03T05:49:23.618545Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2862731844,"revision":12572,"compact-revision":10404} {"level":"info","ts":"2026-09-03T05:51:07.923792Z","caller":"traceutil/trace.go:171","msg":"trace[1773699755] transaction","detail":"{read_only:false; response_revision:15202; number_of_response:1; }","duration":"141.861336ms","start":"2026-09-03T05:51:07.781888Z","end":"2026-09-03T05:51:07.92375Z","steps":["trace[1773699755] 'process raft request' (duration: 141.642821ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:51:36.582842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.282032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-03T05:51:36.582917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.813ms","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-09-03T05:51:36.582959Z","caller":"traceutil/trace.go:171","msg":"trace[1864617179] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15537; }","duration":"393.439656ms","start":"2026-09-03T05:51:36.189488Z","end":"2026-09-03T05:51:36.582928Z","steps":["trace[1864617179] 'range keys from in-memory index tree' (duration: 393.192531ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:51:36.583017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:51:36.189473Z","time spent":"393.535418ms","remote":"127.0.0.1:50172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-03T05:51:36.583023Z","caller":"traceutil/trace.go:171","msg":"trace[522563788] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15537; }","duration":"369.962532ms","start":"2026-09-03T05:51:36.213032Z","end":"2026-09-03T05:51:36.582995Z","steps":["trace[522563788] 'range keys from in-memory index tree' (duration: 369.564954ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:51:36.583082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:51:36.213018Z","time spent":"370.047815ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-03T05:51:36.583359Z","caller":"traceutil/trace.go:171","msg":"trace[674407798] transaction","detail":"{read_only:false; response_revision:15538; number_of_response:1; }","duration":"263.923901ms","start":"2026-09-03T05:51:36.319407Z","end":"2026-09-03T05:51:36.583331Z","steps":["trace[674407798] 'process raft request' (duration: 214.851666ms)","trace[674407798] 'compare' (duration: 48.691976ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T05:51:36.583465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.923664ms","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-09-03T05:51:36.583572Z","caller":"traceutil/trace.go:171","msg":"trace[1271441609] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15537; }","duration":"378.061447ms","start":"2026-09-03T05:51:36.205483Z","end":"2026-09-03T05:51:36.583544Z","steps":["trace[1271441609] 'range keys from in-memory index tree' (duration: 377.680198ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:51:36.583627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:51:36.205471Z","time spent":"378.141958ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-03T05:51:36.626387Z","caller":"traceutil/trace.go:171","msg":"trace[1648661629] transaction","detail":"{read_only:false; response_revision:15539; number_of_response:1; }","duration":"303.835189ms","start":"2026-09-03T05:51:36.322503Z","end":"2026-09-03T05:51:36.626339Z","steps":["trace[1648661629] 'process raft request' (duration: 303.600104ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:51:36.626636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:51:36.322487Z","time spent":"304.009163ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T05:51:36.626841Z","caller":"traceutil/trace.go:171","msg":"trace[297158304] transaction","detail":"{read_only:false; response_revision:15540; number_of_response:1; }","duration":"300.730248ms","start":"2026-09-03T05:51:36.326065Z","end":"2026-09-03T05:51:36.626795Z","steps":["trace[297158304] 'process raft request' (duration: 300.214596ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:51:36.626941Z","caller":"traceutil/trace.go:171","msg":"trace[2089217495] linearizableReadLoop","detail":"{readStateIndex:16083; appliedIndex:16079; }","duration":"245.454801ms","start":"2026-09-03T05:51:36.381462Z","end":"2026-09-03T05:51:36.626916Z","steps":["trace[2089217495] 'read index received' (duration: 152.891347ms)","trace[2089217495] 'applied index is now lower than readState.Index' (duration: 92.562344ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:51:36.627045Z","caller":"traceutil/trace.go:171","msg":"trace[260948992] transaction","detail":"{read_only:false; response_revision:15542; number_of_response:1; }","duration":"215.456419ms","start":"2026-09-03T05:51:36.411578Z","end":"2026-09-03T05:51:36.627034Z","steps":["trace[260948992] 'process raft request' (duration: 215.264905ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:51:36.627058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:51:36.326052Z","time spent":"300.889673ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T05:51:36.627195Z","caller":"traceutil/trace.go:171","msg":"trace[45558264] transaction","detail":"{read_only:false; response_revision:15541; number_of_response:1; }","duration":"294.949876ms","start":"2026-09-03T05:51:36.33223Z","end":"2026-09-03T05:51:36.62718Z","steps":["trace[45558264] 'process raft request' (duration: 294.378073ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:51:36.627283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.81382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4c285362-98b2-4468-b4e0-56c89d8a1b63\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-09-03T05:51:36.627362Z","caller":"traceutil/trace.go:171","msg":"trace[1171549280] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4c285362-98b2-4468-b4e0-56c89d8a1b63; range_end:; response_count:1; response_revision:15542; }","duration":"245.935843ms","start":"2026-09-03T05:51:36.381402Z","end":"2026-09-03T05:51:36.627338Z","steps":["trace[1171549280] 'agreement among raft nodes before linearized reading' (duration: 245.724138ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:51:36.658475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.181156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-03T05:51:36.658548Z","caller":"traceutil/trace.go:171","msg":"trace[1497496488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15544; }","duration":"165.330999ms","start":"2026-09-03T05:51:36.4932Z","end":"2026-09-03T05:51:36.658531Z","steps":["trace[1497496488] 'agreement among raft nodes before linearized reading' (duration: 165.081953ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:51:36.658554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.603849ms","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-09-03T05:51:36.658648Z","caller":"traceutil/trace.go:171","msg":"trace[1028830911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15544; }","duration":"170.727852ms","start":"2026-09-03T05:51:36.487893Z","end":"2026-09-03T05:51:36.658621Z","steps":["trace[1028830911] 'agreement among raft nodes before linearized reading' (duration: 170.516477ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:51:36.658637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.266987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T05:51:36.658755Z","caller":"traceutil/trace.go:171","msg":"trace[907856469] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:15544; }","duration":"179.4451ms","start":"2026-09-03T05:51:36.47928Z","end":"2026-09-03T05:51:36.658725Z","steps":["trace[907856469] 'agreement among raft nodes before linearized reading' (duration: 179.214115ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:51:36.658912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.219721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-g4bmt\" ","response":"range_response_count:1 size:20644"} {"level":"info","ts":"2026-09-03T05:51:36.658944Z","caller":"traceutil/trace.go:171","msg":"trace[740257417] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-g4bmt; range_end:; response_count:1; response_revision:15544; }","duration":"185.292673ms","start":"2026-09-03T05:51:36.473642Z","end":"2026-09-03T05:51:36.658935Z","steps":["trace[740257417] 'agreement among raft nodes before linearized reading' (duration: 185.202591ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:54:23.54384Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14573} {"level":"info","ts":"2026-09-03T05:54:23.618406Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14573,"took":"72.493528ms","hash":4165434123,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":30670848,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-03T05:54:23.618475Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4165434123,"revision":14573,"compact-revision":12572} {"level":"warn","ts":"2026-09-03T05:59:21.358616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.356301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-03T05:59:21.358732Z","caller":"traceutil/trace.go:171","msg":"trace[2092957670] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19094; }","duration":"169.505604ms","start":"2026-09-03T05:59:21.189201Z","end":"2026-09-03T05:59:21.358706Z","steps":["trace[2092957670] 'range keys from in-memory index tree' (duration: 169.29778ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:59:21.358961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.627073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-09-03T05:59:21.359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.831547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-09-03T05:59:21.359064Z","caller":"traceutil/trace.go:171","msg":"trace[434344984] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19094; }","duration":"259.764587ms","start":"2026-09-03T05:59:21.09926Z","end":"2026-09-03T05:59:21.359025Z","steps":["trace[434344984] 'range keys from in-memory index tree' (duration: 259.46888ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:59:21.358964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.283326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-09-03T05:59:21.359083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.546908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-03T05:59:21.359109Z","caller":"traceutil/trace.go:171","msg":"trace[664191265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19094; }","duration":"182.979562ms","start":"2026-09-03T05:59:21.176091Z","end":"2026-09-03T05:59:21.35907Z","steps":["trace[664191265] 'range keys from in-memory index tree' (duration: 182.627293ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:59:21.359159Z","caller":"traceutil/trace.go:171","msg":"trace[332537230] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19094; }","duration":"339.536141ms","start":"2026-09-03T05:59:21.019605Z","end":"2026-09-03T05:59:21.359141Z","steps":["trace[332537230] 'range keys from in-memory index tree' (duration: 339.065121ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:59:21.359176Z","caller":"traceutil/trace.go:171","msg":"trace[1929990767] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19094; }","duration":"177.726331ms","start":"2026-09-03T05:59:21.181428Z","end":"2026-09-03T05:59:21.359154Z","steps":["trace[1929990767] 'range keys from in-memory index tree' (duration: 177.320592ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:59:21.359224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:59:21.019586Z","time spent":"339.619014ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-03T05:59:21.359265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.497452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-03T05:59:21.359321Z","caller":"traceutil/trace.go:171","msg":"trace[382372938] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:19094; }","duration":"380.600475ms","start":"2026-09-03T05:59:20.978704Z","end":"2026-09-03T05:59:21.359305Z","steps":["trace[382372938] 'count revisions from in-memory index tree' (duration: 380.38889ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:59:21.35936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:59:20.978682Z","time spent":"380.668527ms","remote":"127.0.0.1:34464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-09-03T05:59:23.549259Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16876} {"level":"info","ts":"2026-09-03T05:59:23.666708Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16876,"took":"114.406312ms","hash":646812054,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":31830016,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-03T05:59:23.666792Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":646812054,"revision":16876,"compact-revision":14573} {"level":"info","ts":"2026-09-03T05:59:25.629947Z","caller":"traceutil/trace.go:171","msg":"trace[1147241399] transaction","detail":"{read_only:false; response_revision:19174; number_of_response:1; }","duration":"114.097695ms","start":"2026-09-03T05:59:25.515821Z","end":"2026-09-03T05:59:25.629919Z","steps":["trace[1147241399] 'process raft request' (duration: 96.529506ms)","trace[1147241399] 'compare' (duration: 17.440646ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:59:25.631493Z","caller":"traceutil/trace.go:171","msg":"trace[395428189] linearizableReadLoop","detail":"{readStateIndex:19834; appliedIndex:19831; }","duration":"108.400754ms","start":"2026-09-03T05:59:25.523048Z","end":"2026-09-03T05:59:25.631449Z","steps":["trace[395428189] 'read index received' (duration: 89.26587ms)","trace[395428189] 'applied index is now lower than readState.Index' (duration: 19.133624ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T05:59:25.631612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.548148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-heat-server\" ","response":"range_response_count:1 size:9566"} {"level":"info","ts":"2026-09-03T05:59:25.631664Z","caller":"traceutil/trace.go:171","msg":"trace[1681695639] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-heat-server; range_end:; response_count:1; response_revision:19176; }","duration":"108.655411ms","start":"2026-09-03T05:59:25.522994Z","end":"2026-09-03T05:59:25.63165Z","steps":["trace[1681695639] 'agreement among raft nodes before linearized reading' (duration: 108.543458ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:59:25.631955Z","caller":"traceutil/trace.go:171","msg":"trace[446652050] transaction","detail":"{read_only:false; response_revision:19175; number_of_response:1; }","duration":"114.563565ms","start":"2026-09-03T05:59:25.51738Z","end":"2026-09-03T05:59:25.631944Z","steps":["trace[446652050] 'process raft request' (duration: 113.903949ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:59:25.632237Z","caller":"traceutil/trace.go:171","msg":"trace[1024321262] transaction","detail":"{read_only:false; response_revision:19176; number_of_response:1; }","duration":"110.678588ms","start":"2026-09-03T05:59:25.521547Z","end":"2026-09-03T05:59:25.632226Z","steps":["trace[1024321262] 'process raft request' (duration: 109.823407ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:59:29.187841Z","caller":"traceutil/trace.go:171","msg":"trace[550055351] linearizableReadLoop","detail":"{readStateIndex:19918; appliedIndex:19917; }","duration":"115.960707ms","start":"2026-09-03T05:59:29.071856Z","end":"2026-09-03T05:59:29.187817Z","steps":["trace[550055351] 'read index received' (duration: 99.37364ms)","trace[550055351] 'applied index is now lower than readState.Index' (duration: 16.585677ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T05:59:29.187912Z","caller":"traceutil/trace.go:171","msg":"trace[284069804] transaction","detail":"{read_only:false; response_revision:19255; number_of_response:1; }","duration":"133.23423ms","start":"2026-09-03T05:59:29.054645Z","end":"2026-09-03T05:59:29.18788Z","steps":["trace[284069804] 'process raft request' (duration: 116.607092ms)","trace[284069804] 'compare' (duration: 16.446234ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T05:59:29.18816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.820609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:709"} {"level":"info","ts":"2026-09-03T05:59:29.188237Z","caller":"traceutil/trace.go:171","msg":"trace[1293498158] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:19255; }","duration":"113.939582ms","start":"2026-09-03T05:59:29.074279Z","end":"2026-09-03T05:59:29.188219Z","steps":["trace[1293498158] 'agreement among raft nodes before linearized reading' (duration: 113.712267ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:59:29.188284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.64604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/libvirt-libvirt-default-g4bmt-api-6z7bl\" ","response":"range_response_count:1 size:2533"} {"level":"info","ts":"2026-09-03T05:59:29.188348Z","caller":"traceutil/trace.go:171","msg":"trace[1134652299] range","detail":"{range_begin:/registry/secrets/openstack/libvirt-libvirt-default-g4bmt-api-6z7bl; range_end:; response_count:1; response_revision:19255; }","duration":"133.741081ms","start":"2026-09-03T05:59:29.054593Z","end":"2026-09-03T05:59:29.188334Z","steps":["trace[1134652299] 'agreement among raft nodes before linearized reading' (duration: 133.440255ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T05:59:29.189199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.202204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225409"} {"level":"info","ts":"2026-09-03T05:59:29.189257Z","caller":"traceutil/trace.go:171","msg":"trace[505845412] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:19255; }","duration":"117.306147ms","start":"2026-09-03T05:59:29.071934Z","end":"2026-09-03T05:59:29.189241Z","steps":["trace[505845412] 'agreement among raft nodes before linearized reading' (duration: 116.025318ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T05:59:36.956453Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6814e3e3d6b4d713","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-03T05:59:36.962936Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-09-03T05:59:36.963062Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-09-03T06:04:23.561118Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19117} {"level":"info","ts":"2026-09-03T06:04:23.663017Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19117,"took":"99.175693ms","hash":1168626457,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":33755136,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-03T06:04:23.663079Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1168626457,"revision":19117,"compact-revision":16876} {"level":"info","ts":"2026-09-03T06:05:30.649521Z","caller":"traceutil/trace.go:171","msg":"trace[1007468873] transaction","detail":"{read_only:false; response_revision:22020; number_of_response:1; }","duration":"154.305057ms","start":"2026-09-03T06:05:30.495165Z","end":"2026-09-03T06:05:30.64947Z","steps":["trace[1007468873] 'process raft request' (duration: 154.126263ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T06:05:31.164665Z","caller":"traceutil/trace.go:171","msg":"trace[1711551919] linearizableReadLoop","detail":"{readStateIndex:22771; appliedIndex:22770; }","duration":"176.810649ms","start":"2026-09-03T06:05:30.987827Z","end":"2026-09-03T06:05:31.164638Z","steps":["trace[1711551919] 'read index received' (duration: 176.594824ms)","trace[1711551919] 'applied index is now lower than readState.Index' (duration: 214.875µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T06:05:31.164723Z","caller":"traceutil/trace.go:171","msg":"trace[751684791] transaction","detail":"{read_only:false; response_revision:22021; number_of_response:1; }","duration":"185.490865ms","start":"2026-09-03T06:05:30.979203Z","end":"2026-09-03T06:05:31.164694Z","steps":["trace[751684791] 'process raft request' (duration: 185.24829ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T06:05:31.165033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.172627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-03T06:05:31.165098Z","caller":"traceutil/trace.go:171","msg":"trace[2131028419] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:22021; }","duration":"177.29909ms","start":"2026-09-03T06:05:30.987783Z","end":"2026-09-03T06:05:31.165082Z","steps":["trace[2131028419] 'agreement among raft nodes before linearized reading' (duration: 176.952702ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T06:05:31.358346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.440156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-09-03T06:05:31.358427Z","caller":"traceutil/trace.go:171","msg":"trace[722779257] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:22021; }","duration":"178.57597ms","start":"2026-09-03T06:05:31.179832Z","end":"2026-09-03T06:05:31.358408Z","steps":["trace[722779257] 'range keys from in-memory index tree' (duration: 178.280883ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T06:05:31.746143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.601988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-09-03T06:05:31.746332Z","caller":"traceutil/trace.go:171","msg":"trace[385364555] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22023; }","duration":"170.837733ms","start":"2026-09-03T06:05:31.575473Z","end":"2026-09-03T06:05:31.74631Z","steps":["trace[385364555] 'range keys from in-memory index tree' (duration: 170.423564ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T06:05:31.746153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.59365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-09-03T06:05:31.74684Z","caller":"traceutil/trace.go:171","msg":"trace[6393580] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22023; }","duration":"179.339436ms","start":"2026-09-03T06:05:31.56747Z","end":"2026-09-03T06:05:31.746809Z","steps":["trace[6393580] 'range keys from in-memory index tree' (duration: 178.389716ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T06:05:31.746225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.209425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-03T06:05:31.74699Z","caller":"traceutil/trace.go:171","msg":"trace[1372350620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22023; }","duration":"177.073415ms","start":"2026-09-03T06:05:31.569889Z","end":"2026-09-03T06:05:31.746962Z","steps":["trace[1372350620] 'range keys from in-memory index tree' (duration: 175.937769ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T06:05:31.908656Z","caller":"traceutil/trace.go:171","msg":"trace[191660489] transaction","detail":"{read_only:false; response_revision:22024; number_of_response:1; }","duration":"157.167643ms","start":"2026-09-03T06:05:31.751466Z","end":"2026-09-03T06:05:31.908634Z","steps":["trace[191660489] 'process raft request' (duration: 156.978499ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T06:05:32.21543Z","caller":"traceutil/trace.go:171","msg":"trace[1622213542] transaction","detail":"{read_only:false; response_revision:22025; number_of_response:1; }","duration":"463.840192ms","start":"2026-09-03T06:05:31.751555Z","end":"2026-09-03T06:05:32.215395Z","steps":["trace[1622213542] 'process raft request' (duration: 374.105272ms)","trace[1622213542] 'compare' (duration: 89.486054ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T06:05:32.215463Z","caller":"traceutil/trace.go:171","msg":"trace[1631845468] transaction","detail":"{read_only:false; response_revision:22026; number_of_response:1; }","duration":"463.135307ms","start":"2026-09-03T06:05:31.752298Z","end":"2026-09-03T06:05:32.215433Z","steps":["trace[1631845468] 'process raft request' (duration: 463.023454ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T06:05:32.215516Z","caller":"traceutil/trace.go:171","msg":"trace[475563542] linearizableReadLoop","detail":"{readStateIndex:22778; appliedIndex:22773; }","duration":"359.88947ms","start":"2026-09-03T06:05:31.855583Z","end":"2026-09-03T06:05:32.215473Z","steps":["trace[475563542] 'read index received' (duration: 52.881392ms)","trace[475563542] 'applied index is now lower than readState.Index' (duration: 307.007258ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T06:05:32.215543Z","caller":"traceutil/trace.go:171","msg":"trace[554649404] transaction","detail":"{read_only:false; response_revision:22028; number_of_response:1; }","duration":"392.509712ms","start":"2026-09-03T06:05:31.823007Z","end":"2026-09-03T06:05:32.215517Z","steps":["trace[554649404] 'process raft request' (duration: 392.404039ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T06:05:32.2156Z","caller":"traceutil/trace.go:171","msg":"trace[1257922425] transaction","detail":"{read_only:false; response_revision:22027; number_of_response:1; }","duration":"409.231022ms","start":"2026-09-03T06:05:31.806351Z","end":"2026-09-03T06:05:32.215582Z","steps":["trace[1257922425] 'process raft request' (duration: 409.025628ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T06:05:32.215635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:05:31.752281Z","time spent":"463.261119ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T06:05:32.21563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:05:31.751533Z","time spent":"463.992956ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T06:05:32.215665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:05:31.822989Z","time spent":"392.605203ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T06:05:32.215675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:05:31.806326Z","time spent":"409.294803ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T06:05:32.215655Z","caller":"traceutil/trace.go:171","msg":"trace[171983146] transaction","detail":"{read_only:false; response_revision:22029; number_of_response:1; }","duration":"342.445803ms","start":"2026-09-03T06:05:31.873192Z","end":"2026-09-03T06:05:32.215637Z","steps":["trace[171983146] 'process raft request' (duration: 342.245819ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T06:05:32.215739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.156245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"} {"level":"info","ts":"2026-09-03T06:05:32.215773Z","caller":"traceutil/trace.go:171","msg":"trace[803986183] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:22029; }","duration":"360.241077ms","start":"2026-09-03T06:05:31.855522Z","end":"2026-09-03T06:05:32.215763Z","steps":["trace[803986183] 'agreement among raft nodes before linearized reading' (duration: 360.123595ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T06:05:32.215809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:05:31.855503Z","time spent":"360.292949ms","remote":"127.0.0.1:50312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" "} {"level":"warn","ts":"2026-09-03T06:05:32.215826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:05:31.873158Z","time spent":"342.591907ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T06:05:32.23045Z","caller":"traceutil/trace.go:171","msg":"trace[97659780] transaction","detail":"{read_only:false; response_revision:22030; number_of_response:1; }","duration":"256.141332ms","start":"2026-09-03T06:05:31.97428Z","end":"2026-09-03T06:05:32.230421Z","steps":["trace[97659780] 'process raft request' (duration: 255.945238ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T06:09:23.571196Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21572} {"level":"info","ts":"2026-09-03T06:09:23.697933Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21572,"took":"120.825707ms","hash":1323146807,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":31076352,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-03T06:09:23.698101Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1323146807,"revision":21572,"compact-revision":19117} {"level":"info","ts":"2026-09-03T06:09:50.045831Z","caller":"traceutil/trace.go:171","msg":"trace[1689565571] transaction","detail":"{read_only:false; response_revision:24568; number_of_response:1; }","duration":"270.59151ms","start":"2026-09-03T06:09:49.775198Z","end":"2026-09-03T06:09:50.045789Z","steps":["trace[1689565571] 'process raft request' (duration: 270.373665ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T06:09:50.083752Z","caller":"traceutil/trace.go:171","msg":"trace[1784209383] transaction","detail":"{read_only:false; response_revision:24569; number_of_response:1; }","duration":"307.425688ms","start":"2026-09-03T06:09:49.776302Z","end":"2026-09-03T06:09:50.083728Z","steps":["trace[1784209383] 'process raft request' (duration: 307.233094ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T06:09:50.083924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:09:49.776288Z","time spent":"307.54312ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T06:09:50.084087Z","caller":"traceutil/trace.go:171","msg":"trace[251326550] transaction","detail":"{read_only:false; response_revision:24570; number_of_response:1; }","duration":"307.111531ms","start":"2026-09-03T06:09:49.776843Z","end":"2026-09-03T06:09:50.083954Z","steps":["trace[251326550] 'process raft request' (duration: 306.833865ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T06:09:50.084184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:09:49.776827Z","time spent":"307.312975ms","remote":"127.0.0.1:53798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T06:09:50.084257Z","caller":"traceutil/trace.go:171","msg":"trace[1773353366] transaction","detail":"{read_only:false; response_revision:24571; number_of_response:1; }","duration":"277.15404ms","start":"2026-09-03T06:09:49.807014Z","end":"2026-09-03T06:09:50.084168Z","steps":["trace[1773353366] 'process raft request' (duration: 276.836393ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T06:11:24.426004Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006748.wal"} {"level":"info","ts":"2026-09-03T06:14:23.580845Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23815} {"level":"info","ts":"2026-09-03T06:14:23.706004Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23815,"took":"121.360416ms","hash":2000118950,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":41988096,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-09-03T06:14:23.706069Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2000118950,"revision":23815,"compact-revision":21572} {"level":"info","ts":"2026-09-03T06:19:10.557882Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6814e3e3d6b4d713","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-03T06:19:10.564287Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-09-03T06:19:10.564381Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-09-03T06:19:23.587879Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26919} {"level":"info","ts":"2026-09-03T06:19:23.738398Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26919,"took":"146.468876ms","hash":2020321452,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":30121984,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-03T06:19:23.738484Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2020321452,"revision":26919,"compact-revision":23815}