{"level":"warn","ts":"2026-04-10T04:14:44.446399Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T04:14:44.446525Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.110: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.110:2380","--initial-cluster=instance=https://162.253.55.110:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.110:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.110: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-04-10T04:14:44.446585Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T04:14:44.446595Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.110:2380"]} {"level":"info","ts":"2026-04-10T04:14:44.446611Z","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-04-10T04:14:44.447417Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"]} {"level":"info","ts":"2026-04-10T04:14:44.447499Z","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.110:2380"],"listen-peer-urls":["https://162.253.55.110:2380"],"advertise-client-urls":["https://162.253.55.110:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.110: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-04-10T04:14:44.451052Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.358131ms"} {"level":"info","ts":"2026-04-10T04:14:44.461575Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f52f30d5714009d5","cluster-id":"650981a7a383c714"} {"level":"info","ts":"2026-04-10T04:14:44.461724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=()"} {"level":"info","ts":"2026-04-10T04:14:44.461761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became follower at term 0"} {"level":"info","ts":"2026-04-10T04:14:44.461804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f52f30d5714009d5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-10T04:14:44.461848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became follower at term 1"} {"level":"info","ts":"2026-04-10T04:14:44.4622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=(17667393556483934677)"} {"level":"warn","ts":"2026-04-10T04:14:44.469502Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-10T04:14:44.472498Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-10T04:14:44.474394Z","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-04-10T04:14:44.476813Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f52f30d5714009d5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-10T04:14:44.476956Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f52f30d5714009d5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-10T04:14:44.477075Z","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-04-10T04:14:44.477111Z","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-04-10T04:14:44.477121Z","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-04-10T04:14:44.479994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=(17667393556483934677)"} {"level":"info","ts":"2026-04-10T04:14:44.480132Z","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-04-10T04:14:44.480194Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"650981a7a383c714","local-member-id":"f52f30d5714009d5","added-peer-id":"f52f30d5714009d5","added-peer-peer-urls":["https://162.253.55.110:2380"]} {"level":"info","ts":"2026-04-10T04:14:44.480282Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.110:2380"} {"level":"info","ts":"2026-04-10T04:14:44.480331Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.110:2380"} {"level":"info","ts":"2026-04-10T04:14:44.480431Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f52f30d5714009d5","initial-advertise-peer-urls":["https://162.253.55.110:2380"],"listen-peer-urls":["https://162.253.55.110:2380"],"advertise-client-urls":["https://162.253.55.110:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-10T04:14:44.480488Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-10T04:14:45.163256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 is starting a new election at term 1"} {"level":"info","ts":"2026-04-10T04:14:45.163404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-10T04:14:45.163442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 received MsgPreVoteResp from f52f30d5714009d5 at term 1"} {"level":"info","ts":"2026-04-10T04:14:45.163467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became candidate at term 2"} {"level":"info","ts":"2026-04-10T04:14:45.163479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 received MsgVoteResp from f52f30d5714009d5 at term 2"} {"level":"info","ts":"2026-04-10T04:14:45.163498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became leader at term 2"} {"level":"info","ts":"2026-04-10T04:14:45.163516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f52f30d5714009d5 elected leader f52f30d5714009d5 at term 2"} {"level":"info","ts":"2026-04-10T04:14:45.164894Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T04:14:45.165934Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T04:14:45.165936Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f52f30d5714009d5","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.110:2379]}","request-path":"/0/members/f52f30d5714009d5/attributes","cluster-id":"650981a7a383c714","publish-timeout":"7s"} {"level":"info","ts":"2026-04-10T04:14:45.165972Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T04:14:45.166402Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-10T04:14:45.166443Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-10T04:14:45.166735Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"650981a7a383c714","local-member-id":"f52f30d5714009d5","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T04:14:45.166906Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T04:14:45.166971Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T04:14:45.168584Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.110:2379"} {"level":"info","ts":"2026-04-10T04:14:45.17021Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-10T04:15:21.11318Z","caller":"traceutil/trace.go:171","msg":"trace[1837583708] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"286.391007ms","start":"2026-04-10T04:15:20.826763Z","end":"2026-04-10T04:15:21.113154Z","steps":["trace[1837583708] 'process raft request' (duration: 286.296585ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:15:21.11322Z","caller":"traceutil/trace.go:171","msg":"trace[1139903365] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:596; }","duration":"305.47431ms","start":"2026-04-10T04:15:20.807719Z","end":"2026-04-10T04:15:21.113193Z","steps":["trace[1139903365] 'read index received' (duration: 297.296807ms)","trace[1139903365] 'applied index is now lower than readState.Index' (duration: 8.176033ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:15:21.11339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.661483ms","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-04-10T04:15:21.113877Z","caller":"traceutil/trace.go:171","msg":"trace[1078322960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:576; }","duration":"306.210505ms","start":"2026-04-10T04:15:20.807642Z","end":"2026-04-10T04:15:21.113853Z","steps":["trace[1078322960] 'agreement among raft nodes before linearized reading' (duration: 305.583372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:15:21.113958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.268471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pg2x4\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-04-10T04:15:21.113932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:15:20.807607Z","time spent":"306.307267ms","remote":"127.0.0.1:46646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-10T04:15:21.113994Z","caller":"traceutil/trace.go:171","msg":"trace[748795505] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pg2x4; range_end:; response_count:1; response_revision:576; }","duration":"158.371883ms","start":"2026-04-10T04:15:20.955609Z","end":"2026-04-10T04:15:21.113981Z","steps":["trace[748795505] 'agreement among raft nodes before linearized reading' (duration: 158.21498ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:15:21.113449Z","caller":"traceutil/trace.go:171","msg":"trace[746829615] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"407.885072ms","start":"2026-04-10T04:15:20.705551Z","end":"2026-04-10T04:15:21.113436Z","steps":["trace[746829615] 'process raft request' (duration: 399.434353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:15:21.114042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.868048ms","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-04-10T04:15:21.114088Z","caller":"traceutil/trace.go:171","msg":"trace[647018879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:576; }","duration":"134.96645ms","start":"2026-04-10T04:15:20.979107Z","end":"2026-04-10T04:15:21.114074Z","steps":["trace[647018879] 'agreement among raft nodes before linearized reading' (duration: 134.816687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:15:21.11473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:15:20.705499Z","time spent":"408.590036ms","remote":"127.0.0.1:46870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T04:16:55.612158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.937135ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T04:16:55.612317Z","caller":"traceutil/trace.go:171","msg":"trace[1888155397] linearizableReadLoop","detail":"{readStateIndex:1884; appliedIndex:1883; }","duration":"127.549149ms","start":"2026-04-10T04:16:55.484748Z","end":"2026-04-10T04:16:55.612297Z","steps":["trace[1888155397] 'read index received' (duration: 28.951µs)","trace[1888155397] 'applied index is now lower than readState.Index' (duration: 127.518688ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:16:55.612334Z","caller":"traceutil/trace.go:171","msg":"trace[1075856513] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"331.308352ms","start":"2026-04-10T04:16:55.280989Z","end":"2026-04-10T04:16:55.612297Z","steps":["trace[1075856513] 'process raft request' (duration: 40.647923ms)","trace[1075856513] 'compare' (duration: 289.752872ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:16:55.612499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.755103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f6a53918-3229-49a8-86ba-4960152e3e73\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-10T04:16:55.612511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:16:55.280961Z","time spent":"331.451606ms","remote":"127.0.0.1:46646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:16:55.612539Z","caller":"traceutil/trace.go:171","msg":"trace[1089355444] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f6a53918-3229-49a8-86ba-4960152e3e73; range_end:; response_count:1; response_revision:1812; }","duration":"127.835525ms","start":"2026-04-10T04:16:55.484691Z","end":"2026-04-10T04:16:55.612526Z","steps":["trace[1089355444] 'agreement among raft nodes before linearized reading' (duration: 127.662181ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:16:55.812828Z","caller":"traceutil/trace.go:171","msg":"trace[1053370761] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"104.168102ms","start":"2026-04-10T04:16:55.708618Z","end":"2026-04-10T04:16:55.812786Z","steps":["trace[1053370761] 'process raft request' (duration: 33.387337ms)","trace[1053370761] 'compare' (duration: 70.491189ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:16:55.812948Z","caller":"traceutil/trace.go:171","msg":"trace[1786559979] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"104.246973ms","start":"2026-04-10T04:16:55.70867Z","end":"2026-04-10T04:16:55.812917Z","steps":["trace[1786559979] 'process raft request' (duration: 103.998138ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:16:56.00861Z","caller":"traceutil/trace.go:171","msg":"trace[263860468] linearizableReadLoop","detail":"{readStateIndex:1888; appliedIndex:1887; }","duration":"171.819206ms","start":"2026-04-10T04:16:55.836756Z","end":"2026-04-10T04:16:56.008575Z","steps":["trace[263860468] 'read index received' (duration: 119.895107ms)","trace[263860468] 'applied index is now lower than readState.Index' (duration: 51.922889ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:16:56.008823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.02716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:16:56.008794Z","caller":"traceutil/trace.go:171","msg":"trace[1993458023] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"190.858635ms","start":"2026-04-10T04:16:55.817857Z","end":"2026-04-10T04:16:56.008715Z","steps":["trace[1993458023] 'process raft request' (duration: 138.914027ms)","trace[1993458023] 'compare' (duration: 51.601892ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:16:56.008866Z","caller":"traceutil/trace.go:171","msg":"trace[1747640005] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1816; }","duration":"172.126181ms","start":"2026-04-10T04:16:55.836726Z","end":"2026-04-10T04:16:56.008852Z","steps":["trace[1747640005] 'agreement among raft nodes before linearized reading' (duration: 171.978158ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:17:09.445407Z","caller":"traceutil/trace.go:171","msg":"trace[1410307730] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"230.436336ms","start":"2026-04-10T04:17:09.214936Z","end":"2026-04-10T04:17:09.445372Z","steps":["trace[1410307730] 'process raft request' (duration: 230.224382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:17:40.366401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.560785ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T04:17:40.366739Z","caller":"traceutil/trace.go:171","msg":"trace[1837816935] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"124.426252ms","start":"2026-04-10T04:17:40.242258Z","end":"2026-04-10T04:17:40.366684Z","steps":["trace[1837816935] 'compare' (duration: 114.066985ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:17:40.564527Z","caller":"traceutil/trace.go:171","msg":"trace[1002540363] linearizableReadLoop","detail":"{readStateIndex:2197; appliedIndex:2196; }","duration":"106.384201ms","start":"2026-04-10T04:17:40.458111Z","end":"2026-04-10T04:17:40.564495Z","steps":["trace[1002540363] 'read index received' (duration: 91.334469ms)","trace[1002540363] 'applied index is now lower than readState.Index' (duration: 15.048032ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:17:40.564687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.557754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:17:40.564787Z","caller":"traceutil/trace.go:171","msg":"trace[1459278099] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2116; }","duration":"106.729498ms","start":"2026-04-10T04:17:40.458044Z","end":"2026-04-10T04:17:40.564773Z","steps":["trace[1459278099] 'agreement among raft nodes before linearized reading' (duration: 106.565524ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:17:40.565431Z","caller":"traceutil/trace.go:171","msg":"trace[648651807] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"122.888081ms","start":"2026-04-10T04:17:40.441669Z","end":"2026-04-10T04:17:40.564557Z","steps":["trace[648651807] 'process raft request' (duration: 107.824489ms)","trace[648651807] 'compare' (duration: 14.851648ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:17:46.582259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.13227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-10T04:17:46.5829Z","caller":"traceutil/trace.go:171","msg":"trace[1763656620] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2146; }","duration":"192.817222ms","start":"2026-04-10T04:17:46.39006Z","end":"2026-04-10T04:17:46.582877Z","steps":["trace[1763656620] 'range keys from in-memory index tree' (duration: 191.812253ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:17:46.729666Z","caller":"traceutil/trace.go:171","msg":"trace[1509581455] linearizableReadLoop","detail":"{readStateIndex:2229; appliedIndex:2228; }","duration":"144.646308ms","start":"2026-04-10T04:17:46.584993Z","end":"2026-04-10T04:17:46.729639Z","steps":["trace[1509581455] 'read index received' (duration: 144.514895ms)","trace[1509581455] 'applied index is now lower than readState.Index' (duration: 129.783µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:17:46.729732Z","caller":"traceutil/trace.go:171","msg":"trace[316671220] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"144.842482ms","start":"2026-04-10T04:17:46.584852Z","end":"2026-04-10T04:17:46.729694Z","steps":["trace[316671220] 'process raft request' (duration: 144.587247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:17:46.730051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.037355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:15 size:25781"} {"level":"info","ts":"2026-04-10T04:17:46.730103Z","caller":"traceutil/trace.go:171","msg":"trace[795037848] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:15; response_revision:2147; }","duration":"145.142177ms","start":"2026-04-10T04:17:46.584948Z","end":"2026-04-10T04:17:46.730091Z","steps":["trace[795037848] 'agreement among raft nodes before linearized reading' (duration: 144.827671ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:17:46.832533Z","caller":"traceutil/trace.go:171","msg":"trace[1093418792] linearizableReadLoop","detail":"{readStateIndex:2231; appliedIndex:2229; }","duration":"102.746227ms","start":"2026-04-10T04:17:46.729748Z","end":"2026-04-10T04:17:46.832495Z","steps":["trace[1093418792] 'read index received' (duration: 66.283317ms)","trace[1093418792] 'applied index is now lower than readState.Index' (duration: 36.46159ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:17:46.832573Z","caller":"traceutil/trace.go:171","msg":"trace[481214470] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"116.942701ms","start":"2026-04-10T04:17:46.715605Z","end":"2026-04-10T04:17:46.832547Z","steps":["trace[481214470] 'process raft request' (duration: 116.830529ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:17:46.832554Z","caller":"traceutil/trace.go:171","msg":"trace[1904695232] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"245.395605ms","start":"2026-04-10T04:17:46.587127Z","end":"2026-04-10T04:17:46.832523Z","steps":["trace[1904695232] 'process raft request' (duration: 209.070247ms)","trace[1904695232] 'compare' (duration: 36.068553ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:17:46.833277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.504608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:15 size:25781"} {"level":"info","ts":"2026-04-10T04:17:46.833339Z","caller":"traceutil/trace.go:171","msg":"trace[1575886327] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:15; response_revision:2149; }","duration":"247.611601ms","start":"2026-04-10T04:17:46.585715Z","end":"2026-04-10T04:17:46.833326Z","steps":["trace[1575886327] 'agreement among raft nodes before linearized reading' (duration: 246.986587ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:17:51.967799Z","caller":"traceutil/trace.go:171","msg":"trace[195905117] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"125.624105ms","start":"2026-04-10T04:17:51.84214Z","end":"2026-04-10T04:17:51.967764Z","steps":["trace[195905117] 'process raft request' (duration: 125.431211ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:19:15.859011Z","caller":"traceutil/trace.go:171","msg":"trace[871964801] transaction","detail":"{read_only:false; response_revision:2820; number_of_response:1; }","duration":"153.160114ms","start":"2026-04-10T04:19:15.705816Z","end":"2026-04-10T04:19:15.858976Z","steps":["trace[871964801] 'process raft request' (duration: 152.96296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:21:51.951331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.36125ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T04:21:51.951552Z","caller":"traceutil/trace.go:171","msg":"trace[1335589320] transaction","detail":"{read_only:false; response_revision:3843; number_of_response:1; }","duration":"165.731035ms","start":"2026-04-10T04:21:51.785795Z","end":"2026-04-10T04:21:51.951526Z","steps":["trace[1335589320] 'process raft request' (duration: 37.054778ms)","trace[1335589320] 'compare' (duration: 128.217118ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:23:13.74172Z","caller":"traceutil/trace.go:171","msg":"trace[784024737] linearizableReadLoop","detail":"{readStateIndex:4998; appliedIndex:4997; }","duration":"107.768815ms","start":"2026-04-10T04:23:13.633932Z","end":"2026-04-10T04:23:13.741701Z","steps":["trace[784024737] 'read index received' (duration: 103.904817ms)","trace[784024737] 'applied index is now lower than readState.Index' (duration: 3.863368ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:23:13.741846Z","caller":"traceutil/trace.go:171","msg":"trace[722240515] transaction","detail":"{read_only:false; response_revision:4815; number_of_response:1; }","duration":"107.927648ms","start":"2026-04-10T04:23:13.633882Z","end":"2026-04-10T04:23:13.74181Z","steps":["trace[722240515] 'process raft request' (duration: 104.02363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:23:13.74194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.984579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7465"} {"level":"info","ts":"2026-04-10T04:23:13.741972Z","caller":"traceutil/trace.go:171","msg":"trace[1089799824] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4815; }","duration":"108.058261ms","start":"2026-04-10T04:23:13.633905Z","end":"2026-04-10T04:23:13.741963Z","steps":["trace[1089799824] 'agreement among raft nodes before linearized reading' (duration: 107.899968ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:23:20.311221Z","caller":"traceutil/trace.go:171","msg":"trace[1472749116] linearizableReadLoop","detail":"{readStateIndex:5237; appliedIndex:5236; }","duration":"127.374455ms","start":"2026-04-10T04:23:20.183822Z","end":"2026-04-10T04:23:20.311196Z","steps":["trace[1472749116] 'read index received' (duration: 127.283753ms)","trace[1472749116] 'applied index is now lower than readState.Index' (duration: 89.512µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:23:20.311351Z","caller":"traceutil/trace.go:171","msg":"trace[1679139215] transaction","detail":"{read_only:false; response_revision:5046; number_of_response:1; }","duration":"142.148179ms","start":"2026-04-10T04:23:20.169191Z","end":"2026-04-10T04:23:20.311339Z","steps":["trace[1679139215] 'process raft request' (duration: 141.837523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:23:20.311758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.883505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9cce4afe-dae6-4c2c-acf1-d9fd8d7267e5\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-10T04:23:20.311918Z","caller":"traceutil/trace.go:171","msg":"trace[426362427] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9cce4afe-dae6-4c2c-acf1-d9fd8d7267e5; range_end:; response_count:1; response_revision:5046; }","duration":"128.10621ms","start":"2026-04-10T04:23:20.183773Z","end":"2026-04-10T04:23:20.311879Z","steps":["trace[426362427] 'agreement among raft nodes before linearized reading' (duration: 127.62645ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:23:20.415961Z","caller":"traceutil/trace.go:171","msg":"trace[176494492] transaction","detail":"{read_only:false; response_revision:5047; number_of_response:1; }","duration":"115.08351ms","start":"2026-04-10T04:23:20.300852Z","end":"2026-04-10T04:23:20.415935Z","steps":["trace[176494492] 'process raft request' (duration: 76.610664ms)","trace[176494492] 'compare' (duration: 38.239551ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:23:20.41597Z","caller":"traceutil/trace.go:171","msg":"trace[1138838257] linearizableReadLoop","detail":"{readStateIndex:5238; appliedIndex:5237; }","duration":"104.624132ms","start":"2026-04-10T04:23:20.311309Z","end":"2026-04-10T04:23:20.415933Z","steps":["trace[1138838257] 'read index received' (duration: 66.234818ms)","trace[1138838257] 'applied index is now lower than readState.Index' (duration: 38.386724ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:23:20.416105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.960892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:23:20.41621Z","caller":"traceutil/trace.go:171","msg":"trace[1431094638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5047; }","duration":"164.105745ms","start":"2026-04-10T04:23:20.252081Z","end":"2026-04-10T04:23:20.416187Z","steps":["trace[1431094638] 'agreement among raft nodes before linearized reading' (duration: 163.919421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:23:20.416227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.170554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ltj28\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-10T04:23:20.416217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.419372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-04-10T04:23:20.416267Z","caller":"traceutil/trace.go:171","msg":"trace[1170214618] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ltj28; range_end:; response_count:1; response_revision:5047; }","duration":"186.233495ms","start":"2026-04-10T04:23:20.230021Z","end":"2026-04-10T04:23:20.416255Z","steps":["trace[1170214618] 'agreement among raft nodes before linearized reading' (duration: 186.026841ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:23:20.416328Z","caller":"traceutil/trace.go:171","msg":"trace[1536845965] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5047; }","duration":"154.575715ms","start":"2026-04-10T04:23:20.261726Z","end":"2026-04-10T04:23:20.416301Z","steps":["trace[1536845965] 'agreement among raft nodes before linearized reading' (duration: 154.258489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:23:20.417413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.569235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777677"} {"level":"info","ts":"2026-04-10T04:23:20.417508Z","caller":"traceutil/trace.go:171","msg":"trace[2139619956] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5047; }","duration":"159.700307ms","start":"2026-04-10T04:23:20.257788Z","end":"2026-04-10T04:23:20.417489Z","steps":["trace[2139619956] 'agreement among raft nodes before linearized reading' (duration: 158.157586ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:23:20.811773Z","caller":"traceutil/trace.go:171","msg":"trace[474055166] linearizableReadLoop","detail":"{readStateIndex:5241; appliedIndex:5240; }","duration":"168.292899ms","start":"2026-04-10T04:23:20.643452Z","end":"2026-04-10T04:23:20.811744Z","steps":["trace[474055166] 'read index received' (duration: 167.962002ms)","trace[474055166] 'applied index is now lower than readState.Index' (duration: 328.447µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:23:20.811911Z","caller":"traceutil/trace.go:171","msg":"trace[1505544198] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"209.687223ms","start":"2026-04-10T04:23:20.602173Z","end":"2026-04-10T04:23:20.81186Z","steps":["trace[1505544198] 'process raft request' (duration: 209.347146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:23:20.812158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.679147ms","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-04-10T04:23:20.812245Z","caller":"traceutil/trace.go:171","msg":"trace[724466278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5049; }","duration":"168.80742ms","start":"2026-04-10T04:23:20.643419Z","end":"2026-04-10T04:23:20.812226Z","steps":["trace[724466278] 'agreement among raft nodes before linearized reading' (duration: 168.463574ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:23:31.584947Z","caller":"traceutil/trace.go:171","msg":"trace[501857849] transaction","detail":"{read_only:false; response_revision:5257; number_of_response:1; }","duration":"138.928973ms","start":"2026-04-10T04:23:31.445969Z","end":"2026-04-10T04:23:31.584898Z","steps":["trace[501857849] 'process raft request' (duration: 138.603287ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:23:31.69147Z","caller":"traceutil/trace.go:171","msg":"trace[1252015319] transaction","detail":"{read_only:false; response_revision:5258; number_of_response:1; }","duration":"104.529239ms","start":"2026-04-10T04:23:31.586909Z","end":"2026-04-10T04:23:31.691438Z","steps":["trace[1252015319] 'process raft request' (duration: 94.856688ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:23:42.036841Z","caller":"traceutil/trace.go:171","msg":"trace[1166726539] transaction","detail":"{read_only:false; response_revision:5454; number_of_response:1; }","duration":"107.330895ms","start":"2026-04-10T04:23:41.929446Z","end":"2026-04-10T04:23:42.036777Z","steps":["trace[1166726539] 'process raft request' (duration: 100.49648ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:23:42.273504Z","caller":"traceutil/trace.go:171","msg":"trace[2096133096] linearizableReadLoop","detail":"{readStateIndex:5656; appliedIndex:5654; }","duration":"157.994044ms","start":"2026-04-10T04:23:42.115466Z","end":"2026-04-10T04:23:42.27346Z","steps":["trace[2096133096] 'read index received' (duration: 5.253854ms)","trace[2096133096] 'applied index is now lower than readState.Index' (duration: 152.73822ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:23:42.27358Z","caller":"traceutil/trace.go:171","msg":"trace[1624699470] transaction","detail":"{read_only:false; response_revision:5456; number_of_response:1; }","duration":"177.173616ms","start":"2026-04-10T04:23:42.096366Z","end":"2026-04-10T04:23:42.273539Z","steps":["trace[1624699470] 'process raft request' (duration: 156.348691ms)","trace[1624699470] 'compare' (duration: 19.718862ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:23:42.273885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.396293ms","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-04-10T04:23:42.273938Z","caller":"traceutil/trace.go:171","msg":"trace[490724541] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5456; }","duration":"158.523805ms","start":"2026-04-10T04:23:42.115404Z","end":"2026-04-10T04:23:42.273928Z","steps":["trace[490724541] 'agreement among raft nodes before linearized reading' (duration: 158.26833ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:23:42.275044Z","caller":"traceutil/trace.go:171","msg":"trace[618896636] transaction","detail":"{read_only:false; response_revision:5457; number_of_response:1; }","duration":"139.264331ms","start":"2026-04-10T04:23:42.135761Z","end":"2026-04-10T04:23:42.275025Z","steps":["trace[618896636] 'process raft request' (duration: 139.100697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:23:42.275271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.160547ms","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-04-10T04:23:42.275398Z","caller":"traceutil/trace.go:171","msg":"trace[790307951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5457; }","duration":"158.315219ms","start":"2026-04-10T04:23:42.11706Z","end":"2026-04-10T04:23:42.275375Z","steps":["trace[790307951] 'agreement among raft nodes before linearized reading' (duration: 157.960293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:23:42.275888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.491799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:23:42.276007Z","caller":"traceutil/trace.go:171","msg":"trace[1565215592] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5457; }","duration":"108.664332ms","start":"2026-04-10T04:23:42.167316Z","end":"2026-04-10T04:23:42.27598Z","steps":["trace[1565215592] 'agreement among raft nodes before linearized reading' (duration: 108.459197ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:24:45.19155Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2981} {"level":"info","ts":"2026-04-10T04:24:45.274812Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2981,"took":"81.381011ms","hash":462049153,"current-db-size-bytes":58068992,"current-db-size":"58 MB","current-db-size-in-use-bytes":33579008,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-10T04:24:45.274913Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":462049153,"revision":2981,"compact-revision":-1} {"level":"info","ts":"2026-04-10T04:29:45.226457Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6040} {"level":"info","ts":"2026-04-10T04:29:45.45633Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6040,"took":"227.426566ms","hash":3949843743,"current-db-size-bytes":58068992,"current-db-size":"58 MB","current-db-size-in-use-bytes":21704704,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-10T04:29:45.456427Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3949843743,"revision":6040,"compact-revision":2981} {"level":"info","ts":"2026-04-10T04:29:52.639217Z","caller":"traceutil/trace.go:171","msg":"trace[1811519896] transaction","detail":"{read_only:false; response_revision:8297; number_of_response:1; }","duration":"316.807666ms","start":"2026-04-10T04:29:52.322381Z","end":"2026-04-10T04:29:52.639188Z","steps":["trace[1811519896] 'process raft request' (duration: 316.625463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:29:52.639391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:29:52.322368Z","time spent":"316.93763ms","remote":"127.0.0.1:46646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:29:52.661378Z","caller":"traceutil/trace.go:171","msg":"trace[926432819] transaction","detail":"{read_only:false; response_revision:8298; number_of_response:1; }","duration":"337.662933ms","start":"2026-04-10T04:29:52.323682Z","end":"2026-04-10T04:29:52.661345Z","steps":["trace[926432819] 'process raft request' (duration: 337.456329ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:29:52.661478Z","caller":"traceutil/trace.go:171","msg":"trace[635878399] linearizableReadLoop","detail":"{readStateIndex:8590; appliedIndex:8588; }","duration":"198.954287ms","start":"2026-04-10T04:29:52.462492Z","end":"2026-04-10T04:29:52.661446Z","steps":["trace[635878399] 'read index received' (duration: 176.552431ms)","trace[635878399] 'applied index is now lower than readState.Index' (duration: 22.399556ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:29:52.661541Z","caller":"traceutil/trace.go:171","msg":"trace[1743576570] transaction","detail":"{read_only:false; response_revision:8299; number_of_response:1; }","duration":"155.264237ms","start":"2026-04-10T04:29:52.506249Z","end":"2026-04-10T04:29:52.661513Z","steps":["trace[1743576570] 'process raft request' (duration: 155.037942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:29:52.661594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:29:52.323649Z","time spent":"337.829826ms","remote":"127.0.0.1:46646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:29:52.661628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.10167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:29:52.661659Z","caller":"traceutil/trace.go:171","msg":"trace[90048169] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8299; }","duration":"199.205292ms","start":"2026-04-10T04:29:52.462446Z","end":"2026-04-10T04:29:52.661651Z","steps":["trace[90048169] 'agreement among raft nodes before linearized reading' (duration: 199.101ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:30:06.031697Z","caller":"traceutil/trace.go:171","msg":"trace[11633020] transaction","detail":"{read_only:false; response_revision:8369; number_of_response:1; }","duration":"195.894936ms","start":"2026-04-10T04:30:05.835493Z","end":"2026-04-10T04:30:06.031388Z","steps":["trace[11633020] 'process raft request' (duration: 195.645592ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:30:06.222146Z","caller":"traceutil/trace.go:171","msg":"trace[1866046427] transaction","detail":"{read_only:false; response_revision:8370; number_of_response:1; }","duration":"164.297695ms","start":"2026-04-10T04:30:06.057714Z","end":"2026-04-10T04:30:06.222011Z","steps":["trace[1866046427] 'process raft request' (duration: 145.184874ms)","trace[1866046427] 'compare' (duration: 18.55739ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:30:33.736839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.717546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:30:33.736938Z","caller":"traceutil/trace.go:171","msg":"trace[488439287] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:8570; }","duration":"130.045773ms","start":"2026-04-10T04:30:33.606881Z","end":"2026-04-10T04:30:33.736927Z","steps":["trace[488439287] 'agreement among raft nodes before linearized reading' (duration: 129.701036ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:30:33.737352Z","caller":"traceutil/trace.go:171","msg":"trace[1354425127] linearizableReadLoop","detail":"{readStateIndex:8874; appliedIndex:8873; }","duration":"129.632534ms","start":"2026-04-10T04:30:33.606913Z","end":"2026-04-10T04:30:33.736545Z","steps":["trace[1354425127] 'read index received' (duration: 127.380289ms)","trace[1354425127] 'applied index is now lower than readState.Index' (duration: 2.214925ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:30:33.737706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.948712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T04:30:33.737732Z","caller":"traceutil/trace.go:171","msg":"trace[320775085] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:8570; }","duration":"121.986493ms","start":"2026-04-10T04:30:33.615739Z","end":"2026-04-10T04:30:33.737726Z","steps":["trace[320775085] 'agreement among raft nodes before linearized reading' (duration: 121.744677ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:30:47.087018Z","caller":"traceutil/trace.go:171","msg":"trace[392556017] linearizableReadLoop","detail":"{readStateIndex:8990; appliedIndex:8989; }","duration":"104.050944ms","start":"2026-04-10T04:30:46.982943Z","end":"2026-04-10T04:30:47.086994Z","steps":["trace[392556017] 'read index received' (duration: 59.158349ms)","trace[392556017] 'applied index is now lower than readState.Index' (duration: 44.891415ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:30:47.087133Z","caller":"traceutil/trace.go:171","msg":"trace[1664140756] transaction","detail":"{read_only:false; response_revision:8682; number_of_response:1; }","duration":"130.149915ms","start":"2026-04-10T04:30:46.956945Z","end":"2026-04-10T04:30:47.087094Z","steps":["trace[1664140756] 'process raft request' (duration: 85.192949ms)","trace[1664140756] 'compare' (duration: 44.735182ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:30:47.08723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.272128ms","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-04-10T04:30:47.087263Z","caller":"traceutil/trace.go:171","msg":"trace[1351618008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8682; }","duration":"104.3647ms","start":"2026-04-10T04:30:46.982888Z","end":"2026-04-10T04:30:47.087253Z","steps":["trace[1351618008] 'agreement among raft nodes before linearized reading' (duration: 104.226578ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:30:47.222491Z","caller":"traceutil/trace.go:171","msg":"trace[820029763] transaction","detail":"{read_only:false; response_revision:8683; number_of_response:1; }","duration":"130.719406ms","start":"2026-04-10T04:30:47.09173Z","end":"2026-04-10T04:30:47.222449Z","steps":["trace[820029763] 'process raft request' (duration: 96.844571ms)","trace[820029763] 'compare' (duration: 33.556999ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:30:48.115833Z","caller":"traceutil/trace.go:171","msg":"trace[925912261] linearizableReadLoop","detail":"{readStateIndex:8998; appliedIndex:8997; }","duration":"115.565994ms","start":"2026-04-10T04:30:48.00024Z","end":"2026-04-10T04:30:48.115806Z","steps":["trace[925912261] 'read index received' (duration: 115.312199ms)","trace[925912261] 'applied index is now lower than readState.Index' (duration: 252.765µs)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:30:48.116071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.812299ms","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-04-10T04:30:48.116118Z","caller":"traceutil/trace.go:171","msg":"trace[1767982796] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8690; }","duration":"115.937191ms","start":"2026-04-10T04:30:48.000168Z","end":"2026-04-10T04:30:48.116105Z","steps":["trace[1767982796] 'agreement among raft nodes before linearized reading' (duration: 115.740137ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:30:48.116166Z","caller":"traceutil/trace.go:171","msg":"trace[850324719] transaction","detail":"{read_only:false; response_revision:8690; number_of_response:1; }","duration":"235.493016ms","start":"2026-04-10T04:30:47.880643Z","end":"2026-04-10T04:30:48.116136Z","steps":["trace[850324719] 'process raft request' (duration: 234.976596ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:31:12.210171Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000243f.wal"} {"level":"warn","ts":"2026-04-10T04:31:52.43823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.310497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"} {"level":"info","ts":"2026-04-10T04:31:52.438473Z","caller":"traceutil/trace.go:171","msg":"trace[622743518] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:9363; }","duration":"104.605793ms","start":"2026-04-10T04:31:52.333845Z","end":"2026-04-10T04:31:52.438451Z","steps":["trace[622743518] 'range keys from in-memory index tree' (duration: 104.130213ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:32:37.397049Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f52f30d5714009d5","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-10T04:32:37.404041Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-10T04:32:37.404147Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-10T04:34:45.235006Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8132} {"level":"info","ts":"2026-04-10T04:34:45.299634Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8132,"took":"61.113703ms","hash":2009245017,"current-db-size-bytes":58068992,"current-db-size":"58 MB","current-db-size-in-use-bytes":29077504,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-10T04:34:45.299705Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2009245017,"revision":8132,"compact-revision":6040} {"level":"info","ts":"2026-04-10T04:39:45.244299Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10644} {"level":"info","ts":"2026-04-10T04:39:45.329424Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10644,"took":"82.380235ms","hash":3733473563,"current-db-size-bytes":58068992,"current-db-size":"58 MB","current-db-size-in-use-bytes":21368832,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-10T04:39:45.329504Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3733473563,"revision":10644,"compact-revision":8132}