{"level":"warn","ts":"2026-04-02T06:05:00.534074Z","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-02T06:05:00.534237Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.232: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://199.19.213.232:2380","--initial-cluster=instance=https://199.19.213.232:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.232:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.232: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-02T06:05:00.534355Z","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-02T06:05:00.534375Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.232:2380"]} {"level":"info","ts":"2026-04-02T06:05:00.534402Z","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-02T06:05:00.535166Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.232:2379"]} {"level":"info","ts":"2026-04-02T06:05:00.535289Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.232:2380"],"listen-peer-urls":["https://199.19.213.232:2380"],"advertise-client-urls":["https://199.19.213.232:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.232:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.232: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-02T06:05:00.722493Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"186.888339ms"} {"level":"info","ts":"2026-04-02T06:05:00.915472Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"20a2700e013b1fa5","cluster-id":"b7b35e617ebc7ac7"} {"level":"info","ts":"2026-04-02T06:05:00.915585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T06:05:00.915606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became follower at term 0"} {"level":"info","ts":"2026-04-02T06:05:00.915618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 20a2700e013b1fa5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T06:05:00.915629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became follower at term 1"} {"level":"info","ts":"2026-04-02T06:05:00.915687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 switched to configuration voters=(2351565160893325221)"} {"level":"warn","ts":"2026-04-02T06:05:01.015088Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T06:05:01.051509Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T06:05:01.158027Z","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-02T06:05:01.251735Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"20a2700e013b1fa5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T06:05:01.252145Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"20a2700e013b1fa5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T06:05:01.252359Z","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-02T06:05:01.252496Z","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-02T06:05:01.252513Z","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-02T06:05:01.259519Z","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-02T06:05:01.259698Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.232:2380"} {"level":"info","ts":"2026-04-02T06:05:01.259775Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.232:2380"} {"level":"info","ts":"2026-04-02T06:05:01.259985Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"20a2700e013b1fa5","initial-advertise-peer-urls":["https://199.19.213.232:2380"],"listen-peer-urls":["https://199.19.213.232:2380"],"advertise-client-urls":["https://199.19.213.232:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.232:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T06:05:01.260066Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T06:05:01.285752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 switched to configuration voters=(2351565160893325221)"} {"level":"info","ts":"2026-04-02T06:05:01.286074Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b7b35e617ebc7ac7","local-member-id":"20a2700e013b1fa5","added-peer-id":"20a2700e013b1fa5","added-peer-peer-urls":["https://199.19.213.232:2380"]} {"level":"info","ts":"2026-04-02T06:05:01.755717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T06:05:01.755789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T06:05:01.755825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 received MsgPreVoteResp from 20a2700e013b1fa5 at term 1"} {"level":"info","ts":"2026-04-02T06:05:01.755847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became candidate at term 2"} {"level":"info","ts":"2026-04-02T06:05:01.755859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 received MsgVoteResp from 20a2700e013b1fa5 at term 2"} {"level":"info","ts":"2026-04-02T06:05:01.755875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became leader at term 2"} {"level":"info","ts":"2026-04-02T06:05:01.755892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 20a2700e013b1fa5 elected leader 20a2700e013b1fa5 at term 2"} {"level":"info","ts":"2026-04-02T06:05:01.762693Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"20a2700e013b1fa5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.232:2379]}","request-path":"/0/members/20a2700e013b1fa5/attributes","cluster-id":"b7b35e617ebc7ac7","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T06:05:01.762708Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T06:05:01.762781Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T06:05:01.763061Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T06:05:01.763149Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T06:05:01.763435Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T06:05:01.766682Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-02T06:05:01.766889Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.232:2379"} {"level":"info","ts":"2026-04-02T06:05:01.88336Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b7b35e617ebc7ac7","local-member-id":"20a2700e013b1fa5","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T06:05:01.883594Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T06:05:01.883677Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-02T06:05:02.101065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.869761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:05:02.101127Z","caller":"traceutil/trace.go:171","msg":"trace[1737207171] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"183.964333ms","start":"2026-04-02T06:05:01.917149Z","end":"2026-04-02T06:05:02.101113Z","steps":["trace[1737207171] 'range keys from in-memory index tree' (duration: 183.81872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:02.101264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.961563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-02T06:05:02.101303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.498339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:05:02.101332Z","caller":"traceutil/trace.go:171","msg":"trace[1727413978] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"184.062285ms","start":"2026-04-02T06:05:01.917261Z","end":"2026-04-02T06:05:02.101323Z","steps":["trace[1727413978] 'count revisions from in-memory index tree' (duration: 183.895681ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:02.101384Z","caller":"traceutil/trace.go:171","msg":"trace[2031847271] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"141.631933ms","start":"2026-04-02T06:05:01.959738Z","end":"2026-04-02T06:05:02.10137Z","steps":["trace[2031847271] 'range keys from in-memory index tree' (duration: 141.400517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:02.101417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.229935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:05:02.101488Z","caller":"traceutil/trace.go:171","msg":"trace[1009563440] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"153.300017ms","start":"2026-04-02T06:05:01.948177Z","end":"2026-04-02T06:05:02.101477Z","steps":["trace[1009563440] 'count revisions from in-memory index tree' (duration: 153.163054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:02.101578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.762805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:05:02.101612Z","caller":"traceutil/trace.go:171","msg":"trace[5561046] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"141.841917ms","start":"2026-04-02T06:05:01.959758Z","end":"2026-04-02T06:05:02.1016Z","steps":["trace[5561046] 'count revisions from in-memory index tree' (duration: 141.635442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:02.101671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.201723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-02T06:05:02.101773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.255338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:05:02.101831Z","caller":"traceutil/trace.go:171","msg":"trace[1101507807] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"128.368652ms","start":"2026-04-02T06:05:01.973454Z","end":"2026-04-02T06:05:02.101822Z","steps":["trace[1101507807] 'count revisions from in-memory index tree' (duration: 128.155446ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:02.10171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.55665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-02T06:05:02.100963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.772866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:05:02.101923Z","caller":"traceutil/trace.go:171","msg":"trace[2852903] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"153.782047ms","start":"2026-04-02T06:05:01.948115Z","end":"2026-04-02T06:05:02.101897Z","steps":["trace[2852903] 'range keys from in-memory index tree' (duration: 152.638642ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:02.101801Z","caller":"traceutil/trace.go:171","msg":"trace[2071600160] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"167.51128ms","start":"2026-04-02T06:05:01.934268Z","end":"2026-04-02T06:05:02.101779Z","steps":["trace[2071600160] 'range keys from in-memory index tree' (duration: 167.079759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:02.102002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.377922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:05:02.102032Z","caller":"traceutil/trace.go:171","msg":"trace[1989347837] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"128.442223ms","start":"2026-04-02T06:05:01.973583Z","end":"2026-04-02T06:05:02.102025Z","steps":["trace[1989347837] 'range keys from in-memory index tree' (duration: 128.300749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:02.101015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.556235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:05:02.102174Z","caller":"traceutil/trace.go:171","msg":"trace[502862337] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"196.726751ms","start":"2026-04-02T06:05:01.905439Z","end":"2026-04-02T06:05:02.102166Z","steps":["trace[502862337] 'count revisions from in-memory index tree' (duration: 195.523824ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:02.102209Z","caller":"traceutil/trace.go:171","msg":"trace[1980986033] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"167.836396ms","start":"2026-04-02T06:05:01.934052Z","end":"2026-04-02T06:05:02.101889Z","steps":["trace[1980986033] 'count revisions from in-memory index tree' (duration: 167.372226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:02.10233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.538578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-02T06:05:02.102258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.395384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:05:02.10242Z","caller":"traceutil/trace.go:171","msg":"trace[1525726929] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"114.640359ms","start":"2026-04-02T06:05:01.987755Z","end":"2026-04-02T06:05:02.102395Z","steps":["trace[1525726929] 'count revisions from in-memory index tree' (duration: 114.397045ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:02.102464Z","caller":"traceutil/trace.go:171","msg":"trace[726829730] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"114.60714ms","start":"2026-04-02T06:05:01.987839Z","end":"2026-04-02T06:05:02.102447Z","steps":["trace[726829730] 'range keys from in-memory index tree' (duration: 114.347753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:02.101031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.406452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:05:02.102524Z","caller":"traceutil/trace.go:171","msg":"trace[691410073] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"196.900235ms","start":"2026-04-02T06:05:01.905615Z","end":"2026-04-02T06:05:02.102516Z","steps":["trace[691410073] 'range keys from in-memory index tree' (duration: 195.351021ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.306484Z","caller":"traceutil/trace.go:171","msg":"trace[2101287306] linearizableReadLoop","detail":"{readStateIndex:19; appliedIndex:17; }","duration":"101.710316ms","start":"2026-04-02T06:05:03.20474Z","end":"2026-04-02T06:05:03.30645Z","steps":["trace[2101287306] 'read index received' (duration: 39.748871ms)","trace[2101287306] 'applied index is now lower than readState.Index' (duration: 61.960105ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:03.306662Z","caller":"traceutil/trace.go:171","msg":"trace[724221849] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"110.429555ms","start":"2026-04-02T06:05:03.196207Z","end":"2026-04-02T06:05:03.306636Z","steps":["trace[724221849] 'process raft request' (duration: 48.316506ms)","trace[724221849] 'compare' (duration: 61.588247ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:03.306715Z","caller":"traceutil/trace.go:171","msg":"trace[1543287625] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"110.328152ms","start":"2026-04-02T06:05:03.196364Z","end":"2026-04-02T06:05:03.306692Z","steps":["trace[1543287625] 'process raft request' (duration: 110.006015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:03.3068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.040924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:05:03.307273Z","caller":"traceutil/trace.go:171","msg":"trace[1931408262] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:15; }","duration":"102.553585ms","start":"2026-04-02T06:05:03.204703Z","end":"2026-04-02T06:05:03.307257Z","steps":["trace[1931408262] 'agreement among raft nodes before linearized reading' (duration: 102.001913ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.32376Z","caller":"traceutil/trace.go:171","msg":"trace[1295603377] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"118.960218ms","start":"2026-04-02T06:05:03.204764Z","end":"2026-04-02T06:05:03.323724Z","steps":["trace[1295603377] 'process raft request' (duration: 118.793284ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.3239Z","caller":"traceutil/trace.go:171","msg":"trace[625939696] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"119.003699ms","start":"2026-04-02T06:05:03.204801Z","end":"2026-04-02T06:05:03.323804Z","steps":["trace[625939696] 'process raft request' (duration: 118.836675ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.324135Z","caller":"traceutil/trace.go:171","msg":"trace[1306086795] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"119.181533ms","start":"2026-04-02T06:05:03.204943Z","end":"2026-04-02T06:05:03.324124Z","steps":["trace[1306086795] 'process raft request' (duration: 118.751623ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.324277Z","caller":"traceutil/trace.go:171","msg":"trace[702925306] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"115.479609ms","start":"2026-04-02T06:05:03.208734Z","end":"2026-04-02T06:05:03.324213Z","steps":["trace[702925306] 'process raft request' (duration: 115.155372ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.324361Z","caller":"traceutil/trace.go:171","msg":"trace[1269154426] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"119.217144ms","start":"2026-04-02T06:05:03.205132Z","end":"2026-04-02T06:05:03.324349Z","steps":["trace[1269154426] 'process raft request' (duration: 118.708843ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.324354Z","caller":"traceutil/trace.go:171","msg":"trace[1494476719] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"119.238614ms","start":"2026-04-02T06:05:03.205069Z","end":"2026-04-02T06:05:03.324308Z","steps":["trace[1494476719] 'process raft request' (duration: 118.722332ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:03.32446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.679335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-8vwn2\" ","response":"range_response_count:1 size:861"} {"level":"warn","ts":"2026-04-02T06:05:03.32416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.378767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-04-02T06:05:03.324632Z","caller":"traceutil/trace.go:171","msg":"trace[244905766] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:22; }","duration":"119.90365ms","start":"2026-04-02T06:05:03.204714Z","end":"2026-04-02T06:05:03.324617Z","steps":["trace[244905766] 'agreement among raft nodes before linearized reading' (duration: 119.301065ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.324249Z","caller":"traceutil/trace.go:171","msg":"trace[258946859] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"101.595014ms","start":"2026-04-02T06:05:03.222601Z","end":"2026-04-02T06:05:03.324196Z","steps":["trace[258946859] 'process raft request' (duration: 101.361059ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.32454Z","caller":"traceutil/trace.go:171","msg":"trace[548775868] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-8vwn2; range_end:; response_count:1; response_revision:22; }","duration":"119.755236ms","start":"2026-04-02T06:05:03.204754Z","end":"2026-04-02T06:05:03.324509Z","steps":["trace[548775868] 'agreement among raft nodes before linearized reading' (duration: 119.640053ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.530679Z","caller":"traceutil/trace.go:171","msg":"trace[672882215] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"168.600473ms","start":"2026-04-02T06:05:03.362054Z","end":"2026-04-02T06:05:03.530654Z","steps":["trace[672882215] 'process raft request' (duration: 168.501581ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.53066Z","caller":"traceutil/trace.go:171","msg":"trace[561791134] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"169.592736ms","start":"2026-04-02T06:05:03.361006Z","end":"2026-04-02T06:05:03.530599Z","steps":["trace[561791134] 'process raft request' (duration: 114.145488ms)","trace[561791134] 'compare' (duration: 55.07225ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:03.53073Z","caller":"traceutil/trace.go:171","msg":"trace[75442896] linearizableReadLoop","detail":"{readStateIndex:43; appliedIndex:37; }","duration":"162.421414ms","start":"2026-04-02T06:05:03.368285Z","end":"2026-04-02T06:05:03.530706Z","steps":["trace[75442896] 'read index received' (duration: 106.801112ms)","trace[75442896] 'applied index is now lower than readState.Index' (duration: 55.619282ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:03.530827Z","caller":"traceutil/trace.go:171","msg":"trace[21594810] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"169.510754ms","start":"2026-04-02T06:05:03.36131Z","end":"2026-04-02T06:05:03.530821Z","steps":["trace[21594810] 'process raft request' (duration: 169.134246ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.530863Z","caller":"traceutil/trace.go:171","msg":"trace[666178147] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"162.978146ms","start":"2026-04-02T06:05:03.367873Z","end":"2026-04-02T06:05:03.530851Z","steps":["trace[666178147] 'process raft request' (duration: 162.773321ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.53085Z","caller":"traceutil/trace.go:171","msg":"trace[2142211561] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"169.812961ms","start":"2026-04-02T06:05:03.361006Z","end":"2026-04-02T06:05:03.530819Z","steps":["trace[2142211561] 'process raft request' (duration: 169.394322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:03.531049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.003272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:05:03.53108Z","caller":"traceutil/trace.go:171","msg":"trace[574892461] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:40; }","duration":"150.077694ms","start":"2026-04-02T06:05:03.380993Z","end":"2026-04-02T06:05:03.531071Z","steps":["trace[574892461] 'agreement among raft nodes before linearized reading' (duration: 149.984362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:03.531058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.7324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/default/\" range_end:\"/registry/resourcequotas/default0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:05:03.531126Z","caller":"traceutil/trace.go:171","msg":"trace[2117581881] range","detail":"{range_begin:/registry/resourcequotas/default/; range_end:/registry/resourcequotas/default0; response_count:0; response_revision:40; }","duration":"162.850213ms","start":"2026-04-02T06:05:03.368255Z","end":"2026-04-02T06:05:03.531105Z","steps":["trace[2117581881] 'agreement among raft nodes before linearized reading' (duration: 162.648859ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.531184Z","caller":"traceutil/trace.go:171","msg":"trace[1473271550] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"163.340424ms","start":"2026-04-02T06:05:03.367807Z","end":"2026-04-02T06:05:03.531148Z","steps":["trace[1473271550] 'process raft request' (duration: 162.795002ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:03.531236Z","caller":"traceutil/trace.go:171","msg":"trace[946142729] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"162.876114ms","start":"2026-04-02T06:05:03.368344Z","end":"2026-04-02T06:05:03.53122Z","steps":["trace[946142729] 'process raft request' (duration: 162.332622ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:04.962061Z","caller":"traceutil/trace.go:171","msg":"trace[1002351663] transaction","detail":"{read_only:false; response_revision:214; number_of_response:1; }","duration":"104.224064ms","start":"2026-04-02T06:05:04.8578Z","end":"2026-04-02T06:05:04.962024Z","steps":["trace[1002351663] 'process raft request' (duration: 30.267557ms)","trace[1002351663] 'compare' (duration: 73.700281ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:05:05.322552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.364628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:bootstrap-signer\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:05:05.322653Z","caller":"traceutil/trace.go:171","msg":"trace[1378503952] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:bootstrap-signer; range_end:; response_count:0; response_revision:224; }","duration":"112.583984ms","start":"2026-04-02T06:05:05.210042Z","end":"2026-04-02T06:05:05.322626Z","steps":["trace[1378503952] 'agreement among raft nodes before linearized reading' (duration: 112.41346ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:05.322717Z","caller":"traceutil/trace.go:171","msg":"trace[1602736219] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"110.517727ms","start":"2026-04-02T06:05:05.212158Z","end":"2026-04-02T06:05:05.322675Z","steps":["trace[1602736219] 'process raft request' (duration: 110.146428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:05.786615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.575258ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:05:05.78673Z","caller":"traceutil/trace.go:171","msg":"trace[1055139505] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"415.875572ms","start":"2026-04-02T06:05:05.370836Z","end":"2026-04-02T06:05:05.786712Z","steps":["trace[1055139505] 'process raft request' (duration: 84.65687ms)","trace[1055139505] 'compare' (duration: 330.418884ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:05:05.786784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:05.370806Z","time spent":"415.956634ms","remote":"127.0.0.1:52956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":610,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T06:05:06.000254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.621794ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:05:06.000457Z","caller":"traceutil/trace.go:171","msg":"trace[1630320627] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"205.068131ms","start":"2026-04-02T06:05:05.795355Z","end":"2026-04-02T06:05:06.000423Z","steps":["trace[1630320627] 'process raft request' (duration: 96.175121ms)","trace[1630320627] 'compare' (duration: 108.401429ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:05:06.000849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.135992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-02T06:05:06.000962Z","caller":"traceutil/trace.go:171","msg":"trace[1021091745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:227; }","duration":"100.305795ms","start":"2026-04-02T06:05:05.900628Z","end":"2026-04-02T06:05:06.000933Z","steps":["trace[1021091745] 'agreement among raft nodes before linearized reading' (duration: 99.909536ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:06.132988Z","caller":"traceutil/trace.go:171","msg":"trace[127164072] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"126.391197ms","start":"2026-04-02T06:05:06.006559Z","end":"2026-04-02T06:05:06.132951Z","steps":["trace[127164072] 'process raft request' (duration: 112.721847ms)","trace[127164072] 'compare' (duration: 13.304852ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:06.133063Z","caller":"traceutil/trace.go:171","msg":"trace[1311222026] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"124.430402ms","start":"2026-04-02T06:05:06.008578Z","end":"2026-04-02T06:05:06.133009Z","steps":["trace[1311222026] 'process raft request' (duration: 124.183747ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:07.48301Z","caller":"traceutil/trace.go:171","msg":"trace[1143776656] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"119.690515ms","start":"2026-04-02T06:05:07.363297Z","end":"2026-04-02T06:05:07.482988Z","steps":["trace[1143776656] 'process raft request' (duration: 93.805499ms)","trace[1143776656] 'compare' (duration: 25.665801ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:05:12.535988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.51369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:05:12.536135Z","caller":"traceutil/trace.go:171","msg":"trace[1571851476] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"176.441442ms","start":"2026-04-02T06:05:12.35967Z","end":"2026-04-02T06:05:12.536111Z","steps":["trace[1571851476] 'process raft request' (duration: 75.463142ms)","trace[1571851476] 'compare' (duration: 100.397837ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:12.54105Z","caller":"traceutil/trace.go:171","msg":"trace[1850376111] linearizableReadLoop","detail":"{readStateIndex:382; appliedIndex:378; }","duration":"139.567176ms","start":"2026-04-02T06:05:12.401454Z","end":"2026-04-02T06:05:12.541021Z","steps":["trace[1850376111] 'read index received' (duration: 33.699414ms)","trace[1850376111] 'applied index is now lower than readState.Index' (duration: 105.866902ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:12.541145Z","caller":"traceutil/trace.go:171","msg":"trace[727443152] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"169.840763ms","start":"2026-04-02T06:05:12.371293Z","end":"2026-04-02T06:05:12.541133Z","steps":["trace[727443152] 'process raft request' (duration: 169.68377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:12.541248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.773661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-02T06:05:12.541289Z","caller":"traceutil/trace.go:171","msg":"trace[1730804044] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:367; }","duration":"139.891773ms","start":"2026-04-02T06:05:12.401388Z","end":"2026-04-02T06:05:12.541279Z","steps":["trace[1730804044] 'agreement among raft nodes before linearized reading' (duration: 139.794611ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:12.541062Z","caller":"traceutil/trace.go:171","msg":"trace[477263742] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"174.089749ms","start":"2026-04-02T06:05:12.366942Z","end":"2026-04-02T06:05:12.541032Z","steps":["trace[477263742] 'process raft request' (duration: 173.868183ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:12.542499Z","caller":"traceutil/trace.go:171","msg":"trace[836798808] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"172.490873ms","start":"2026-04-02T06:05:12.369982Z","end":"2026-04-02T06:05:12.542473Z","steps":["trace[836798808] 'process raft request' (duration: 170.964628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:12.796349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.187462ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:05:12.796542Z","caller":"traceutil/trace.go:171","msg":"trace[122907968] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:375; }","duration":"141.394927ms","start":"2026-04-02T06:05:12.655123Z","end":"2026-04-02T06:05:12.796518Z","steps":["trace[122907968] 'range keys from in-memory index tree' (duration: 141.161202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:12.796692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.71798ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:05:12.796822Z","caller":"traceutil/trace.go:171","msg":"trace[997083216] linearizableReadLoop","detail":"{readStateIndex:391; appliedIndex:390; }","duration":"163.58237ms","start":"2026-04-02T06:05:12.633221Z","end":"2026-04-02T06:05:12.796804Z","steps":["trace[997083216] 'read index received' (duration: 30.762888ms)","trace[997083216] 'applied index is now lower than readState.Index' (duration: 132.818372ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:12.796893Z","caller":"traceutil/trace.go:171","msg":"trace[1108041322] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"191.288778ms","start":"2026-04-02T06:05:12.605586Z","end":"2026-04-02T06:05:12.796875Z","steps":["trace[1108041322] 'process raft request' (duration: 58.281291ms)","trace[1108041322] 'compare' (duration: 132.496735ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:05:12.796937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.701553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-02T06:05:12.796964Z","caller":"traceutil/trace.go:171","msg":"trace[1484089479] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:376; }","duration":"163.780185ms","start":"2026-04-02T06:05:12.633174Z","end":"2026-04-02T06:05:12.796954Z","steps":["trace[1484089479] 'agreement among raft nodes before linearized reading' (duration: 163.675002ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:12.874988Z","caller":"traceutil/trace.go:171","msg":"trace[1172497468] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"237.869945ms","start":"2026-04-02T06:05:12.637074Z","end":"2026-04-02T06:05:12.874943Z","steps":["trace[1172497468] 'process raft request' (duration: 237.708311ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:12.87516Z","caller":"traceutil/trace.go:171","msg":"trace[1384734845] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"241.289383ms","start":"2026-04-02T06:05:12.633559Z","end":"2026-04-02T06:05:12.874848Z","steps":["trace[1384734845] 'process raft request' (duration: 240.942745ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:12.875066Z","caller":"traceutil/trace.go:171","msg":"trace[1502393137] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"240.907203ms","start":"2026-04-02T06:05:12.634103Z","end":"2026-04-02T06:05:12.87501Z","steps":["trace[1502393137] 'process raft request' (duration: 240.617607ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:13.079309Z","caller":"traceutil/trace.go:171","msg":"trace[1700368228] linearizableReadLoop","detail":"{readStateIndex:396; appliedIndex:394; }","duration":"195.716029ms","start":"2026-04-02T06:05:12.883563Z","end":"2026-04-02T06:05:13.079279Z","steps":["trace[1700368228] 'read index received' (duration: 3.797156ms)","trace[1700368228] 'applied index is now lower than readState.Index' (duration: 191.917853ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:13.079381Z","caller":"traceutil/trace.go:171","msg":"trace[1147934852] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"194.028471ms","start":"2026-04-02T06:05:12.88531Z","end":"2026-04-02T06:05:13.079338Z","steps":["trace[1147934852] 'process raft request' (duration: 193.923829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:13.079519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.924343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-04-02T06:05:13.079557Z","caller":"traceutil/trace.go:171","msg":"trace[597894448] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:382; }","duration":"196.016756ms","start":"2026-04-02T06:05:12.88353Z","end":"2026-04-02T06:05:13.079547Z","steps":["trace[597894448] 'agreement among raft nodes before linearized reading' (duration: 195.879473ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:13.079381Z","caller":"traceutil/trace.go:171","msg":"trace[683522298] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"199.462255ms","start":"2026-04-02T06:05:12.879884Z","end":"2026-04-02T06:05:13.079347Z","steps":["trace[683522298] 'process raft request' (duration: 136.128558ms)","trace[683522298] 'compare' (duration: 63.0215ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:13.084342Z","caller":"traceutil/trace.go:171","msg":"trace[1888032582] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"193.54202ms","start":"2026-04-02T06:05:12.890771Z","end":"2026-04-02T06:05:13.084313Z","steps":["trace[1888032582] 'process raft request' (duration: 193.421907ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:19.821793Z","caller":"traceutil/trace.go:171","msg":"trace[831162278] linearizableReadLoop","detail":"{readStateIndex:436; appliedIndex:435; }","duration":"248.403914ms","start":"2026-04-02T06:05:19.573361Z","end":"2026-04-02T06:05:19.821765Z","steps":["trace[831162278] 'read index received' (duration: 248.145567ms)","trace[831162278] 'applied index is now lower than readState.Index' (duration: 256.967µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:19.821894Z","caller":"traceutil/trace.go:171","msg":"trace[640937326] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"437.544114ms","start":"2026-04-02T06:05:19.384316Z","end":"2026-04-02T06:05:19.82186Z","steps":["trace[640937326] 'process raft request' (duration: 437.234696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:19.822106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:19.384298Z","time spent":"437.700188ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:05:19.822512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.097369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:05:19.822615Z","caller":"traceutil/trace.go:171","msg":"trace[660259191] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:419; }","duration":"249.287453ms","start":"2026-04-02T06:05:19.573306Z","end":"2026-04-02T06:05:19.822594Z","steps":["trace[660259191] 'agreement among raft nodes before linearized reading' (duration: 248.596348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:36.672859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.995367ms","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-02T06:05:36.672991Z","caller":"traceutil/trace.go:171","msg":"trace[1293244221] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:519; }","duration":"667.1779ms","start":"2026-04-02T06:05:36.005786Z","end":"2026-04-02T06:05:36.672963Z","steps":["trace[1293244221] 'range keys from in-memory index tree' (duration: 666.871983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:36.673049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.00577Z","time spent":"667.267823ms","remote":"127.0.0.1:52894","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-04-02T06:05:36.687065Z","caller":"traceutil/trace.go:171","msg":"trace[998892179] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"656.627394ms","start":"2026-04-02T06:05:36.030408Z","end":"2026-04-02T06:05:36.687035Z","steps":["trace[998892179] 'process raft request' (duration: 656.407289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:36.687272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.030387Z","time spent":"656.772997ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T06:05:36.69794Z","caller":"traceutil/trace.go:171","msg":"trace[998817492] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"659.976852ms","start":"2026-04-02T06:05:36.037937Z","end":"2026-04-02T06:05:36.697914Z","steps":["trace[998817492] 'process raft request' (duration: 659.735577ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:36.697973Z","caller":"traceutil/trace.go:171","msg":"trace[884550190] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"659.933821ms","start":"2026-04-02T06:05:36.038019Z","end":"2026-04-02T06:05:36.697952Z","steps":["trace[884550190] 'process raft request' (duration: 659.782648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:36.698042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.037915Z","time spent":"660.077985ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T06:05:36.698084Z","caller":"traceutil/trace.go:171","msg":"trace[329863659] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"651.580154ms","start":"2026-04-02T06:05:36.046434Z","end":"2026-04-02T06:05:36.698015Z","steps":["trace[329863659] 'process raft request' (duration: 651.418411ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:36.698182Z","caller":"traceutil/trace.go:171","msg":"trace[646009352] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"639.695675ms","start":"2026-04-02T06:05:36.058466Z","end":"2026-04-02T06:05:36.698162Z","steps":["trace[646009352] 'process raft request' (duration: 639.519981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:36.698227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.058448Z","time spent":"639.762566ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T06:05:36.698167Z","caller":"traceutil/trace.go:171","msg":"trace[938063268] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"646.350261ms","start":"2026-04-02T06:05:36.051752Z","end":"2026-04-02T06:05:36.698102Z","steps":["trace[938063268] 'process raft request' (duration: 646.193908ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:36.69828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.038013Z","time spent":"659.994092ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T06:05:36.698341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.046421Z","time spent":"651.800959ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T06:05:36.69837Z","caller":"traceutil/trace.go:171","msg":"trace[524213208] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"623.582286ms","start":"2026-04-02T06:05:36.074738Z","end":"2026-04-02T06:05:36.69832Z","steps":["trace[524213208] 'process raft request' (duration: 623.306789ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:36.698258Z","caller":"traceutil/trace.go:171","msg":"trace[1224634360] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"648.632485ms","start":"2026-04-02T06:05:36.04945Z","end":"2026-04-02T06:05:36.698083Z","steps":["trace[1224634360] 'process raft request' (duration: 648.451121ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:36.698526Z","caller":"traceutil/trace.go:171","msg":"trace[1525197116] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"623.689497ms","start":"2026-04-02T06:05:36.074826Z","end":"2026-04-02T06:05:36.698516Z","steps":["trace[1525197116] 'process raft request' (duration: 623.266347ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:36.698542Z","caller":"traceutil/trace.go:171","msg":"trace[1681875351] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"620.130443ms","start":"2026-04-02T06:05:36.078391Z","end":"2026-04-02T06:05:36.698521Z","steps":["trace[1681875351] 'process raft request' (duration: 619.874777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:36.698567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.074822Z","time spent":"623.726769ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T06:05:36.698597Z","caller":"traceutil/trace.go:171","msg":"trace[1043211465] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"593.351453ms","start":"2026-04-02T06:05:36.105213Z","end":"2026-04-02T06:05:36.698564Z","steps":["trace[1043211465] 'process raft request' (duration: 593.125568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:36.698586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.074716Z","time spent":"623.77606ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T06:05:36.698739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.105185Z","time spent":"593.456235ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T06:05:36.698839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.493116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-02T06:05:36.698882Z","caller":"traceutil/trace.go:171","msg":"trace[9366648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:532; }","duration":"393.582538ms","start":"2026-04-02T06:05:36.305286Z","end":"2026-04-02T06:05:36.698868Z","steps":["trace[9366648] 'agreement among raft nodes before linearized reading' (duration: 393.500316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:36.698906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.305261Z","time spent":"393.638219ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T06:05:36.698763Z","caller":"traceutil/trace.go:171","msg":"trace[598474051] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:541; }","duration":"393.417274ms","start":"2026-04-02T06:05:36.305332Z","end":"2026-04-02T06:05:36.69875Z","steps":["trace[598474051] 'read index received' (duration: 381.447033ms)","trace[598474051] 'applied index is now lower than readState.Index' (duration: 11.969111ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:36.698839Z","caller":"traceutil/trace.go:171","msg":"trace[705082363] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"475.251742ms","start":"2026-04-02T06:05:36.223578Z","end":"2026-04-02T06:05:36.69883Z","steps":["trace[705082363] 'process raft request' (duration: 474.905874ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:36.698955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.049441Z","time spent":"649.30369ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T06:05:36.69903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.223424Z","time spent":"475.585939ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T06:05:36.698454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.051709Z","time spent":"646.628028ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T06:05:36.698637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.078383Z","time spent":"620.226575ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T06:05:36.703799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.029332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.232\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-02T06:05:36.704092Z","caller":"traceutil/trace.go:171","msg":"trace[1471914970] range","detail":"{range_begin:/registry/masterleases/199.19.213.232; range_end:; response_count:1; response_revision:534; }","duration":"395.33953ms","start":"2026-04-02T06:05:36.308738Z","end":"2026-04-02T06:05:36.704078Z","steps":["trace[1471914970] 'agreement among raft nodes before linearized reading' (duration: 394.990422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:36.704273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.308728Z","time spent":"395.532644ms","remote":"127.0.0.1:52656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.232\" "} {"level":"warn","ts":"2026-04-02T06:05:36.703954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.420017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-02T06:05:36.70444Z","caller":"traceutil/trace.go:171","msg":"trace[387883059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:534; }","duration":"388.921659ms","start":"2026-04-02T06:05:36.315505Z","end":"2026-04-02T06:05:36.704427Z","steps":["trace[387883059] 'agreement among raft nodes before linearized reading' (duration: 388.406517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:36.704515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:36.315495Z","time spent":"388.996171ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T06:05:37.981814Z","caller":"traceutil/trace.go:171","msg":"trace[1709170159] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"583.822018ms","start":"2026-04-02T06:05:37.397957Z","end":"2026-04-02T06:05:37.981779Z","steps":["trace[1709170159] 'process raft request' (duration: 563.09383ms)","trace[1709170159] 'compare' (duration: 20.425691ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:05:37.981973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:37.397929Z","time spent":"583.95859ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:05:37.983821Z","caller":"traceutil/trace.go:171","msg":"trace[1649621591] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:612; }","duration":"411.4639ms","start":"2026-04-02T06:05:37.572337Z","end":"2026-04-02T06:05:37.983801Z","steps":["trace[1649621591] 'read index received' (duration: 388.792436ms)","trace[1649621591] 'applied index is now lower than readState.Index' (duration: 22.670224ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:37.983916Z","caller":"traceutil/trace.go:171","msg":"trace[851255466] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"490.591723ms","start":"2026-04-02T06:05:37.493299Z","end":"2026-04-02T06:05:37.983891Z","steps":["trace[851255466] 'process raft request' (duration: 490.05401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:37.984062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:37.493215Z","time spent":"490.750817ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T06:05:37.984085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.739326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:05:37.984131Z","caller":"traceutil/trace.go:171","msg":"trace[807220538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"411.788417ms","start":"2026-04-02T06:05:37.57233Z","end":"2026-04-02T06:05:37.984118Z","steps":["trace[807220538] 'agreement among raft nodes before linearized reading' (duration: 411.618333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:37.984174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:37.572269Z","time spent":"411.898999ms","remote":"127.0.0.1:52600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T06:05:43.521025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.117326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:05:43.521219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.898702ms","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:5"} {"level":"info","ts":"2026-04-02T06:05:43.521292Z","caller":"traceutil/trace.go:171","msg":"trace[826073748] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"482.999224ms","start":"2026-04-02T06:05:43.038262Z","end":"2026-04-02T06:05:43.521261Z","steps":["trace[826073748] 'count revisions from in-memory index tree' (duration: 482.806939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:43.521105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.437496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:05:43.521476Z","caller":"traceutil/trace.go:171","msg":"trace[1060479294] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:625; }","duration":"450.851727ms","start":"2026-04-02T06:05:43.0706Z","end":"2026-04-02T06:05:43.521452Z","steps":["trace[1060479294] 'range keys from in-memory index tree' (duration: 450.394735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:43.521547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.088309ms","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:5"} {"level":"info","ts":"2026-04-02T06:05:43.521602Z","caller":"traceutil/trace.go:171","msg":"trace[2142847290] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"467.158831ms","start":"2026-04-02T06:05:43.05443Z","end":"2026-04-02T06:05:43.521588Z","steps":["trace[2142847290] 'count revisions from in-memory index tree' (duration: 466.971627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:43.521642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:43.054427Z","time spent":"467.204432ms","remote":"127.0.0.1:40206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:05:43.521668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.178381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:05:43.521811Z","caller":"traceutil/trace.go:171","msg":"trace[547827352] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"467.392336ms","start":"2026-04-02T06:05:43.054388Z","end":"2026-04-02T06:05:43.521781Z","steps":["trace[547827352] 'range keys from in-memory index tree' (duration: 467.069819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:43.52187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.578021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:05:43.521985Z","caller":"traceutil/trace.go:171","msg":"trace[40812995] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:625; }","duration":"450.697713ms","start":"2026-04-02T06:05:43.071224Z","end":"2026-04-02T06:05:43.521921Z","steps":["trace[40812995] 'range keys from in-memory index tree' (duration: 450.466218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:43.522062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:43.071219Z","time spent":"450.826996ms","remote":"127.0.0.1:40220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"info","ts":"2026-04-02T06:05:43.52127Z","caller":"traceutil/trace.go:171","msg":"trace[1963993123] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"466.457213ms","start":"2026-04-02T06:05:43.054778Z","end":"2026-04-02T06:05:43.521235Z","steps":["trace[1963993123] 'range keys from in-memory index tree' (duration: 466.033314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:43.522311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:43.054773Z","time spent":"467.496288ms","remote":"127.0.0.1:40204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-02T06:05:43.521715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:43.070595Z","time spent":"450.98126ms","remote":"127.0.0.1:40220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T06:05:43.521124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.137477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:05:43.522538Z","caller":"traceutil/trace.go:171","msg":"trace[1731759218] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"484.613362ms","start":"2026-04-02T06:05:43.037874Z","end":"2026-04-02T06:05:43.522487Z","steps":["trace[1731759218] 'range keys from in-memory index tree' (duration: 483.041064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:43.521363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:43.03824Z","time spent":"483.109106ms","remote":"127.0.0.1:40204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:05:43.521628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.842577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:05:43.52275Z","caller":"traceutil/trace.go:171","msg":"trace[1541891032] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:625; }","duration":"451.978203ms","start":"2026-04-02T06:05:43.070748Z","end":"2026-04-02T06:05:43.522726Z","steps":["trace[1541891032] 'count revisions from in-memory index tree' (duration: 450.802226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:43.522803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:43.03785Z","time spent":"484.938889ms","remote":"127.0.0.1:40204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T06:05:43.522954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:43.05438Z","time spent":"468.561794ms","remote":"127.0.0.1:40206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T06:05:43.52295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:43.070745Z","time spent":"452.178058ms","remote":"127.0.0.1:40220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-04-02T06:05:43.527878Z","caller":"traceutil/trace.go:171","msg":"trace[1990122689] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"128.23028ms","start":"2026-04-02T06:05:43.39963Z","end":"2026-04-02T06:05:43.52786Z","steps":["trace[1990122689] 'process raft request' (duration: 127.533734ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:44.187978Z","caller":"traceutil/trace.go:171","msg":"trace[338646264] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"279.572082ms","start":"2026-04-02T06:05:43.908372Z","end":"2026-04-02T06:05:44.187944Z","steps":["trace[338646264] 'process raft request' (duration: 279.301166ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:44.731377Z","caller":"traceutil/trace.go:171","msg":"trace[1819092891] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:658; }","duration":"708.789921ms","start":"2026-04-02T06:05:44.022554Z","end":"2026-04-02T06:05:44.731344Z","steps":["trace[1819092891] 'read index received' (duration: 165.269912ms)","trace[1819092891] 'applied index is now lower than readState.Index' (duration: 543.518709ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:44.731471Z","caller":"traceutil/trace.go:171","msg":"trace[2136239050] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"714.770861ms","start":"2026-04-02T06:05:44.016632Z","end":"2026-04-02T06:05:44.731403Z","steps":["trace[2136239050] 'process raft request' (duration: 713.811519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:44.731777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.295411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gjh5x\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-02T06:05:44.731833Z","caller":"traceutil/trace.go:171","msg":"trace[852672215] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gjh5x; range_end:; response_count:1; response_revision:632; }","duration":"218.408434ms","start":"2026-04-02T06:05:44.513411Z","end":"2026-04-02T06:05:44.731819Z","steps":["trace[852672215] 'agreement among raft nodes before linearized reading' (duration: 218.142718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:44.731815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:44.016594Z","time spent":"714.973257ms","remote":"127.0.0.1:52742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:05:44.73294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.379958ms","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-02T06:05:44.733018Z","caller":"traceutil/trace.go:171","msg":"trace[875089222] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"710.479861ms","start":"2026-04-02T06:05:44.022518Z","end":"2026-04-02T06:05:44.732998Z","steps":["trace[875089222] 'agreement among raft nodes before linearized reading' (duration: 710.285457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:44.73306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:44.022506Z","time spent":"710.542762ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-02T06:05:44.922705Z","caller":"traceutil/trace.go:171","msg":"trace[89994210] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"173.519896ms","start":"2026-04-02T06:05:44.749158Z","end":"2026-04-02T06:05:44.922678Z","steps":["trace[89994210] 'process raft request' (duration: 173.314791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:46.031254Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.108667807s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T06:05:46.032673Z","caller":"traceutil/trace.go:171","msg":"trace[707020269] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"1.245290186s","start":"2026-04-02T06:05:44.787363Z","end":"2026-04-02T06:05:46.032653Z","steps":["trace[707020269] 'process raft request' (duration: 1.245147533s)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:46.032744Z","caller":"traceutil/trace.go:171","msg":"trace[1143607346] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"1.26077405s","start":"2026-04-02T06:05:44.771924Z","end":"2026-04-02T06:05:46.032698Z","steps":["trace[1143607346] 'process raft request' (duration: 1.259661724s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:46.032802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:44.787328Z","time spent":"1.245392699s","remote":"127.0.0.1:52870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T06:05:46.032895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.257243377s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-02T06:05:46.03293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:44.771902Z","time spent":"1.260922854s","remote":"127.0.0.1:52894","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-02T06:05:46.032957Z","caller":"traceutil/trace.go:171","msg":"trace[1151651130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"1.25734085s","start":"2026-04-02T06:05:44.775597Z","end":"2026-04-02T06:05:46.032938Z","steps":["trace[1151651130] 'agreement among raft nodes before linearized reading' (duration: 1.257111914s)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:46.032669Z","caller":"traceutil/trace.go:171","msg":"trace[500939153] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:661; }","duration":"1.256961911s","start":"2026-04-02T06:05:44.77563Z","end":"2026-04-02T06:05:46.032592Z","steps":["trace[500939153] 'read index received' (duration: 146.874139ms)","trace[500939153] 'applied index is now lower than readState.Index' (duration: 1.110085742s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:05:46.033012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:44.775585Z","time spent":"1.257414711s","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T06:05:46.033152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.251193635s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-02T06:05:46.033182Z","caller":"traceutil/trace.go:171","msg":"trace[73916490] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"1.251275167s","start":"2026-04-02T06:05:44.781898Z","end":"2026-04-02T06:05:46.033173Z","steps":["trace[73916490] 'agreement among raft nodes before linearized reading' (duration: 1.251177875s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:46.033212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:44.781865Z","time spent":"1.251340699s","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T06:05:46.033346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.642882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:05:46.033395Z","caller":"traceutil/trace.go:171","msg":"trace[686195653] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"461.753034ms","start":"2026-04-02T06:05:45.571624Z","end":"2026-04-02T06:05:46.033377Z","steps":["trace[686195653] 'agreement among raft nodes before linearized reading' (duration: 461.667302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:46.033426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:45.571596Z","time spent":"461.823136ms","remote":"127.0.0.1:52600","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-04-02T06:05:47.838056Z","caller":"traceutil/trace.go:171","msg":"trace[1799740063] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"159.463465ms","start":"2026-04-02T06:05:47.678553Z","end":"2026-04-02T06:05:47.838016Z","steps":["trace[1799740063] 'process raft request' (duration: 159.337873ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:50.843943Z","caller":"traceutil/trace.go:171","msg":"trace[1701060176] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"139.587026ms","start":"2026-04-02T06:05:50.704316Z","end":"2026-04-02T06:05:50.843903Z","steps":["trace[1701060176] 'process raft request' (duration: 139.254508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:02.698437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.779337ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-02T06:06:02.698563Z","caller":"traceutil/trace.go:171","msg":"trace[1152412767] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:830; }","duration":"1.058855204s","start":"2026-04-02T06:06:01.639688Z","end":"2026-04-02T06:06:02.698543Z","steps":["trace[1152412767] 'read index received' (duration: 103.066837ms)","trace[1152412767] 'applied index is now lower than readState.Index' (duration: 955.786427ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:06:02.698794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.05909011s","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-04-02T06:06:02.698884Z","caller":"traceutil/trace.go:171","msg":"trace[113418856] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"1.059188963s","start":"2026-04-02T06:06:01.639676Z","end":"2026-04-02T06:06:02.698865Z","steps":["trace[113418856] 'agreement among raft nodes before linearized reading' (duration: 1.058973428s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:02.698927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:01.639629Z","time spent":"1.059288665s","remote":"127.0.0.1:52894","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":"warn","ts":"2026-04-02T06:06:02.703567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.32933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:06:02.703589Z","caller":"traceutil/trace.go:171","msg":"trace[1969695182] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"1.057726679s","start":"2026-04-02T06:06:01.645839Z","end":"2026-04-02T06:06:02.703566Z","steps":["trace[1969695182] 'process raft request' (duration: 1.057474463s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:02.703599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.956157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-02T06:06:02.703647Z","caller":"traceutil/trace.go:171","msg":"trace[1727174527] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:799; }","duration":"130.457642ms","start":"2026-04-02T06:06:02.573168Z","end":"2026-04-02T06:06:02.703626Z","steps":["trace[1727174527] 'agreement among raft nodes before linearized reading' (duration: 130.301019ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:02.703663Z","caller":"traceutil/trace.go:171","msg":"trace[1839270014] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:799; }","duration":"560.035069ms","start":"2026-04-02T06:06:02.143612Z","end":"2026-04-02T06:06:02.703647Z","steps":["trace[1839270014] 'agreement among raft nodes before linearized reading' (duration: 559.845934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:02.703688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.955545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-02T06:06:02.703709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:02.143541Z","time spent":"560.157981ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T06:06:02.703711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:01.645819Z","time spent":"1.057822911s","remote":"127.0.0.1:52870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:06:02.703751Z","caller":"traceutil/trace.go:171","msg":"trace[1552846564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:799; }","duration":"554.052428ms","start":"2026-04-02T06:06:02.149682Z","end":"2026-04-02T06:06:02.703734Z","steps":["trace[1552846564] 'agreement among raft nodes before linearized reading' (duration: 553.837453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:02.703788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:02.149671Z","time spent":"554.111629ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T06:06:02.7038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.940999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-02T06:06:02.703836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.034299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T06:06:02.703882Z","caller":"traceutil/trace.go:171","msg":"trace[449016596] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:799; }","duration":"363.134032ms","start":"2026-04-02T06:06:02.340733Z","end":"2026-04-02T06:06:02.703867Z","steps":["trace[449016596] 'agreement among raft nodes before linearized reading' (duration: 362.986978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:02.703912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:02.340708Z","time spent":"363.193944ms","remote":"127.0.0.1:52968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":67,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"info","ts":"2026-04-02T06:06:02.704523Z","caller":"traceutil/trace.go:171","msg":"trace[722570620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:799; }","duration":"558.042912ms","start":"2026-04-02T06:06:02.145819Z","end":"2026-04-02T06:06:02.703862Z","steps":["trace[722570620] 'agreement among raft nodes before linearized reading' (duration: 557.861527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:02.704639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:02.145809Z","time spent":"558.805469ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T06:06:38.647026Z","caller":"traceutil/trace.go:171","msg":"trace[1266364353] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"757.371686ms","start":"2026-04-02T06:06:37.889638Z","end":"2026-04-02T06:06:38.647009Z","steps":["trace[1266364353] 'process raft request' (duration: 757.097779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:38.647157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:37.889615Z","time spent":"757.475929ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:06:43.237375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.860428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-02T06:06:43.237426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.255584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-02T06:06:43.237485Z","caller":"traceutil/trace.go:171","msg":"trace[704818771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1030; }","duration":"332.017162ms","start":"2026-04-02T06:06:42.905445Z","end":"2026-04-02T06:06:43.237462Z","steps":["trace[704818771] 'range keys from in-memory index tree' (duration: 331.612882ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:43.23751Z","caller":"traceutil/trace.go:171","msg":"trace[1074352982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1030; }","duration":"328.366406ms","start":"2026-04-02T06:06:42.909122Z","end":"2026-04-02T06:06:43.237489Z","steps":["trace[1074352982] 'range keys from in-memory index tree' (duration: 328.06986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:43.237533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:42.905428Z","time spent":"332.095063ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T06:06:43.237553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:42.909112Z","time spent":"328.432078ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T06:06:43.237808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.256016ms","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-04-02T06:06:43.237839Z","caller":"traceutil/trace.go:171","msg":"trace[1018978482] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1030; }","duration":"318.337378ms","start":"2026-04-02T06:06:42.919492Z","end":"2026-04-02T06:06:43.237829Z","steps":["trace[1018978482] 'range keys from in-memory index tree' (duration: 318.126833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:43.237867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:42.919468Z","time spent":"318.391749ms","remote":"127.0.0.1:52894","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":"warn","ts":"2026-04-02T06:06:43.237849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.612148ms","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-02T06:06:43.237915Z","caller":"traceutil/trace.go:171","msg":"trace[1589268252] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1030; }","duration":"137.721001ms","start":"2026-04-02T06:06:43.100177Z","end":"2026-04-02T06:06:43.237898Z","steps":["trace[1589268252] 'range keys from in-memory index tree' (duration: 137.459965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:43.238009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.550182ms","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-02T06:06:43.238053Z","caller":"traceutil/trace.go:171","msg":"trace[1217551899] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1030; }","duration":"331.636424ms","start":"2026-04-02T06:06:42.906403Z","end":"2026-04-02T06:06:43.238039Z","steps":["trace[1217551899] 'range keys from in-memory index tree' (duration: 331.385977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:43.238081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:42.906381Z","time spent":"331.692734ms","remote":"127.0.0.1:52894","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-04-02T06:06:43.358959Z","caller":"traceutil/trace.go:171","msg":"trace[223759196] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"117.339418ms","start":"2026-04-02T06:06:43.241595Z","end":"2026-04-02T06:06:43.358934Z","steps":["trace[223759196] 'process raft request' (duration: 117.126582ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:43.373139Z","caller":"traceutil/trace.go:171","msg":"trace[1003688272] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"130.618453ms","start":"2026-04-02T06:06:43.242502Z","end":"2026-04-02T06:06:43.37312Z","steps":["trace[1003688272] 'process raft request' (duration: 130.592773ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:43.373438Z","caller":"traceutil/trace.go:171","msg":"trace[138965912] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"130.996572ms","start":"2026-04-02T06:06:43.242422Z","end":"2026-04-02T06:06:43.373419Z","steps":["trace[138965912] 'process raft request' (duration: 130.622974ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:43.373466Z","caller":"traceutil/trace.go:171","msg":"trace[1074471193] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"131.033633ms","start":"2026-04-02T06:06:43.242422Z","end":"2026-04-02T06:06:43.373456Z","steps":["trace[1074471193] 'process raft request' (duration: 130.652754ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:43.373533Z","caller":"traceutil/trace.go:171","msg":"trace[48279121] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"131.197037ms","start":"2026-04-02T06:06:43.242326Z","end":"2026-04-02T06:06:43.373523Z","steps":["trace[48279121] 'process raft request' (duration: 130.644334ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:59.593059Z","caller":"traceutil/trace.go:171","msg":"trace[584361024] linearizableReadLoop","detail":"{readStateIndex:1130; appliedIndex:1129; }","duration":"164.838793ms","start":"2026-04-02T06:06:59.428204Z","end":"2026-04-02T06:06:59.593043Z","steps":["trace[584361024] 'read index received' (duration: 164.70823ms)","trace[584361024] 'applied index is now lower than readState.Index' (duration: 129.883µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:06:59.593117Z","caller":"traceutil/trace.go:171","msg":"trace[344481163] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"165.374717ms","start":"2026-04-02T06:06:59.427722Z","end":"2026-04-02T06:06:59.593096Z","steps":["trace[344481163] 'process raft request' (duration: 165.229203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:59.59321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.993137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-02T06:06:59.593237Z","caller":"traceutil/trace.go:171","msg":"trace[388054758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1084; }","duration":"165.061969ms","start":"2026-04-02T06:06:59.428169Z","end":"2026-04-02T06:06:59.59323Z","steps":["trace[388054758] 'agreement among raft nodes before linearized reading' (duration: 164.961586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:59.593325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.732962ms","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-02T06:06:59.593377Z","caller":"traceutil/trace.go:171","msg":"trace[74780962] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1084; }","duration":"148.809204ms","start":"2026-04-02T06:06:59.444554Z","end":"2026-04-02T06:06:59.593364Z","steps":["trace[74780962] 'agreement among raft nodes before linearized reading' (duration: 148.687791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:59.593499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.283362ms","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-04-02T06:06:59.593532Z","caller":"traceutil/trace.go:171","msg":"trace[1298904291] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1084; }","duration":"148.345124ms","start":"2026-04-02T06:06:59.445179Z","end":"2026-04-02T06:06:59.593524Z","steps":["trace[1298904291] 'agreement among raft nodes before linearized reading' (duration: 148.266402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:59.593561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.925876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-02T06:06:59.593581Z","caller":"traceutil/trace.go:171","msg":"trace[1684473059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1084; }","duration":"148.989368ms","start":"2026-04-02T06:06:59.444586Z","end":"2026-04-02T06:06:59.593575Z","steps":["trace[1684473059] 'agreement among raft nodes before linearized reading' (duration: 148.936387ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:00.27584Z","caller":"traceutil/trace.go:171","msg":"trace[1545277819] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"676.994492ms","start":"2026-04-02T06:06:59.598826Z","end":"2026-04-02T06:07:00.27582Z","steps":["trace[1545277819] 'process raft request' (duration: 676.962931ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:00.275916Z","caller":"traceutil/trace.go:171","msg":"trace[219513352] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"677.056272ms","start":"2026-04-02T06:06:59.598829Z","end":"2026-04-02T06:07:00.275885Z","steps":["trace[219513352] 'process raft request' (duration: 676.849178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:00.275967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:59.598792Z","time spent":"677.107004ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:07:00.276076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:59.598804Z","time spent":"677.182756ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:00.286489Z","caller":"traceutil/trace.go:171","msg":"trace[1982757751] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"304.775467ms","start":"2026-04-02T06:06:59.981701Z","end":"2026-04-02T06:07:00.286477Z","steps":["trace[1982757751] 'process raft request' (duration: 304.718396ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:00.286471Z","caller":"traceutil/trace.go:171","msg":"trace[1287644297] linearizableReadLoop","detail":"{readStateIndex:1135; appliedIndex:1130; }","duration":"248.906895ms","start":"2026-04-02T06:07:00.037546Z","end":"2026-04-02T06:07:00.286453Z","steps":["trace[1287644297] 'read index received' (duration: 238.16875ms)","trace[1287644297] 'applied index is now lower than readState.Index' (duration: 10.737235ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:07:00.286502Z","caller":"traceutil/trace.go:171","msg":"trace[954515049] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"687.268135ms","start":"2026-04-02T06:06:59.59922Z","end":"2026-04-02T06:07:00.286489Z","steps":["trace[954515049] 'process raft request' (duration: 687.06502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:00.286557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:59.981672Z","time spent":"304.849889ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:07:00.286595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.044038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:07:00.286617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:59.599201Z","time spent":"687.342277ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:00.286628Z","caller":"traceutil/trace.go:171","msg":"trace[1625807469] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1089; }","duration":"249.12009ms","start":"2026-04-02T06:07:00.037499Z","end":"2026-04-02T06:07:00.286619Z","steps":["trace[1625807469] 'agreement among raft nodes before linearized reading' (duration: 249.034818ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:00.286945Z","caller":"traceutil/trace.go:171","msg":"trace[709019226] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"687.563752ms","start":"2026-04-02T06:06:59.59937Z","end":"2026-04-02T06:07:00.286933Z","steps":["trace[709019226] 'process raft request' (duration: 687.011299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:00.287011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:59.599318Z","time spent":"687.668244ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:07:04.134731Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280401739490960210,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T06:07:04.37727Z","caller":"traceutil/trace.go:171","msg":"trace[1144289714] linearizableReadLoop","detail":"{readStateIndex:1144; appliedIndex:1143; }","duration":"743.623439ms","start":"2026-04-02T06:07:03.633628Z","end":"2026-04-02T06:07:04.377251Z","steps":["trace[1144289714] 'read index received' (duration: 743.406174ms)","trace[1144289714] 'applied index is now lower than readState.Index' (duration: 216.435µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:07:04.377343Z","caller":"traceutil/trace.go:171","msg":"trace[1620404737] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"752.428438ms","start":"2026-04-02T06:07:03.624885Z","end":"2026-04-02T06:07:04.377313Z","steps":["trace[1620404737] 'process raft request' (duration: 752.248784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:04.377446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.796923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T06:07:04.377465Z","caller":"traceutil/trace.go:171","msg":"trace[645589795] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1097; }","duration":"743.878116ms","start":"2026-04-02T06:07:03.633582Z","end":"2026-04-02T06:07:04.37746Z","steps":["trace[645589795] 'agreement among raft nodes before linearized reading' (duration: 743.769273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:04.377488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:03.633561Z","time spent":"743.921797ms","remote":"127.0.0.1:52720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":113,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:07:04.377504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:03.624865Z","time spent":"752.54228ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:07:04.377662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.441798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T06:07:04.377681Z","caller":"traceutil/trace.go:171","msg":"trace[701074714] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1097; }","duration":"287.490858ms","start":"2026-04-02T06:07:04.090186Z","end":"2026-04-02T06:07:04.377677Z","steps":["trace[701074714] 'agreement among raft nodes before linearized reading' (duration: 287.460438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:04.378072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.81771ms","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-04-02T06:07:04.378096Z","caller":"traceutil/trace.go:171","msg":"trace[1504367602] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1097; }","duration":"106.880981ms","start":"2026-04-02T06:07:04.27121Z","end":"2026-04-02T06:07:04.378091Z","steps":["trace[1504367602] 'agreement among raft nodes before linearized reading' (duration: 106.8463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:04.889685Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280401739490960213,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:07:05.390287Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280401739490960213,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:07:05.891318Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280401739490960213,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:07:06.391498Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280401739490960213,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:07:06.573969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000165087s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-02T06:07:06.574057Z","caller":"traceutil/trace.go:171","msg":"trace[1828584968] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000301299s","start":"2026-04-02T06:07:04.573736Z","end":"2026-04-02T06:07:06.574038Z","steps":["trace[1828584968] 'agreement among raft nodes before linearized reading' (duration: 2.000188017s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:06.574174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:04.573716Z","time spent":"2.000381242s","remote":"127.0.0.1:52600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T06:07:06.891678Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280401739490960213,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:07:07.392476Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280401739490960213,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:07:07.412314Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.02985878s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T06:07:07.412991Z","caller":"traceutil/trace.go:171","msg":"trace[1043004307] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"3.03073686s","start":"2026-04-02T06:07:04.382214Z","end":"2026-04-02T06:07:07.412951Z","steps":["trace[1043004307] 'process raft request' (duration: 3.030577967s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:07.41317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:04.382172Z","time spent":"3.030901034s","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:07.717193Z","caller":"traceutil/trace.go:171","msg":"trace[647645375] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"3.334796462s","start":"2026-04-02T06:07:04.382359Z","end":"2026-04-02T06:07:07.717156Z","steps":["trace[647645375] 'process raft request' (duration: 3.334438073s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:07.7174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:04.382329Z","time spent":"3.334968825s","remote":"127.0.0.1:52894","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-02T06:07:07.717444Z","caller":"traceutil/trace.go:171","msg":"trace[937405379] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"3.334917584s","start":"2026-04-02T06:07:04.382502Z","end":"2026-04-02T06:07:07.71742Z","steps":["trace[937405379] 'process raft request' (duration: 3.334490344s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:07.717629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:04.382486Z","time spent":"3.335044187s","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:07.717669Z","caller":"traceutil/trace.go:171","msg":"trace[1511108090] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"3.332603699s","start":"2026-04-02T06:07:04.385037Z","end":"2026-04-02T06:07:07.71764Z","steps":["trace[1511108090] 'process raft request' (duration: 3.332309432s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:07.717818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:04.385022Z","time spent":"3.332721851s","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:07.718354Z","caller":"traceutil/trace.go:171","msg":"trace[1309881223] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"2.959111793s","start":"2026-04-02T06:07:04.759226Z","end":"2026-04-02T06:07:07.718337Z","steps":["trace[1309881223] 'process raft request' (duration: 2.958153161s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:07.71845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:04.759203Z","time spent":"2.959198046s","remote":"127.0.0.1:52894","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-04-02T06:07:07.718815Z","caller":"traceutil/trace.go:171","msg":"trace[1964166006] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"1.70393193s","start":"2026-04-02T06:07:06.014874Z","end":"2026-04-02T06:07:07.718806Z","steps":["trace[1964166006] 'process raft request' (duration: 1.703110081s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:07.718882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:06.014849Z","time spent":"1.704003092s","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:07:07.719058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.330453078s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:07:07.719138Z","caller":"traceutil/trace.go:171","msg":"trace[901685605] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1103; }","duration":"3.330624821s","start":"2026-04-02T06:07:04.388495Z","end":"2026-04-02T06:07:07.719119Z","steps":["trace[901685605] 'agreement among raft nodes before linearized reading' (duration: 3.330481468s)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:07.718712Z","caller":"traceutil/trace.go:171","msg":"trace[1941552380] linearizableReadLoop","detail":"{readStateIndex:1150; appliedIndex:1144; }","duration":"3.33011533s","start":"2026-04-02T06:07:04.388586Z","end":"2026-04-02T06:07:07.718701Z","steps":["trace[1941552380] 'read index received' (duration: 3.024126264s)","trace[1941552380] 'applied index is now lower than readState.Index' (duration: 305.988166ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:07:07.719193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:04.388448Z","time spent":"3.330727954s","remote":"127.0.0.1:36736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:07:07.719304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.544098253s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:07:07.719345Z","caller":"traceutil/trace.go:171","msg":"trace[1781619133] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1103; }","duration":"1.544179625s","start":"2026-04-02T06:07:06.175155Z","end":"2026-04-02T06:07:07.719335Z","steps":["trace[1781619133] 'agreement among raft nodes before linearized reading' (duration: 1.544113294s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:07.719376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:06.175134Z","time spent":"1.544233966s","remote":"127.0.0.1:52736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:07:07.719591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.037277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T06:07:07.719636Z","caller":"traceutil/trace.go:171","msg":"trace[726356009] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1103; }","duration":"741.086408ms","start":"2026-04-02T06:07:06.97854Z","end":"2026-04-02T06:07:07.719626Z","steps":["trace[726356009] 'agreement among raft nodes before linearized reading' (duration: 741.015477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:07.719667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:06.978436Z","time spent":"741.222872ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:07:07.719789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144941882s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:07:07.719821Z","caller":"traceutil/trace.go:171","msg":"trace[1435313239] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1103; }","duration":"1.145001174s","start":"2026-04-02T06:07:06.574812Z","end":"2026-04-02T06:07:07.719813Z","steps":["trace[1435313239] 'agreement among raft nodes before linearized reading' (duration: 1.144956172s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:07.719845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:06.574795Z","time spent":"1.145044524s","remote":"127.0.0.1:52614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T06:07:07.720139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.337538233s","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-04-02T06:07:07.720195Z","caller":"traceutil/trace.go:171","msg":"trace[987185005] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1103; }","duration":"1.337622465s","start":"2026-04-02T06:07:06.382552Z","end":"2026-04-02T06:07:07.720175Z","steps":["trace[987185005] 'agreement among raft nodes before linearized reading' (duration: 1.337438761s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:07.720454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.405111013s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.232\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-02T06:07:07.720499Z","caller":"traceutil/trace.go:171","msg":"trace[996327112] range","detail":"{range_begin:/registry/masterleases/199.19.213.232; range_end:; response_count:1; response_revision:1103; }","duration":"1.405199595s","start":"2026-04-02T06:07:06.315289Z","end":"2026-04-02T06:07:07.720489Z","steps":["trace[996327112] 'agreement among raft nodes before linearized reading' (duration: 1.405053262s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:07.720544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:06.315266Z","time spent":"1.405271516s","remote":"127.0.0.1:52656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.232\" "} {"level":"warn","ts":"2026-04-02T06:07:07.721194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:06.38253Z","time spent":"1.337691757s","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-02T06:07:16.493276Z","caller":"traceutil/trace.go:171","msg":"trace[42314054] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"129.394665ms","start":"2026-04-02T06:07:16.363836Z","end":"2026-04-02T06:07:16.49323Z","steps":["trace[42314054] 'process raft request' (duration: 65.969443ms)","trace[42314054] 'compare' (duration: 63.175526ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:07:20.074564Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280401739490960412,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:07:20.575451Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280401739490960412,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:07:21.058789Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.586849219s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T06:07:21.059293Z","caller":"traceutil/trace.go:171","msg":"trace[1028535262] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"1.587387712s","start":"2026-04-02T06:07:19.471861Z","end":"2026-04-02T06:07:21.059249Z","steps":["trace[1028535262] 'process raft request' (duration: 1.587170456s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:21.059491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:19.471847Z","time spent":"1.587532565s","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:21.063117Z","caller":"traceutil/trace.go:171","msg":"trace[745263409] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"1.307583866s","start":"2026-04-02T06:07:19.75551Z","end":"2026-04-02T06:07:21.063093Z","steps":["trace[745263409] 'process raft request' (duration: 1.307433563s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:21.063246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:19.755487Z","time spent":"1.307667868s","remote":"127.0.0.1:52894","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-04-02T06:07:21.063288Z","caller":"traceutil/trace.go:171","msg":"trace[154892153] linearizableReadLoop","detail":"{readStateIndex:1245; appliedIndex:1242; }","duration":"1.489694358s","start":"2026-04-02T06:07:19.573569Z","end":"2026-04-02T06:07:21.063264Z","steps":["trace[154892153] 'read index received' (duration: 1.485355275s)","trace[154892153] 'applied index is now lower than readState.Index' (duration: 4.337573ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:07:21.063426Z","caller":"traceutil/trace.go:171","msg":"trace[1351836221] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"664.24691ms","start":"2026-04-02T06:07:20.399145Z","end":"2026-04-02T06:07:21.063392Z","steps":["trace[1351836221] 'process raft request' (duration: 663.897562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:21.063589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:20.399129Z","time spent":"664.373154ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:07:21.063561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.489993856s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:07:21.063665Z","caller":"traceutil/trace.go:171","msg":"trace[1062610768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1193; }","duration":"1.490111568s","start":"2026-04-02T06:07:19.573532Z","end":"2026-04-02T06:07:21.063644Z","steps":["trace[1062610768] 'agreement among raft nodes before linearized reading' (duration: 1.489919873s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:21.063698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:19.573517Z","time spent":"1.49017432s","remote":"127.0.0.1:52600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T06:07:21.063831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.272121026s","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-04-02T06:07:21.063894Z","caller":"traceutil/trace.go:171","msg":"trace[1745642662] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1193; }","duration":"1.272226298s","start":"2026-04-02T06:07:19.79165Z","end":"2026-04-02T06:07:21.063876Z","steps":["trace[1745642662] 'agreement among raft nodes before linearized reading' (duration: 1.272042674s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:21.063919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.293030931s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-02T06:07:21.063936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:19.791624Z","time spent":"1.27229894s","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-02T06:07:21.063976Z","caller":"traceutil/trace.go:171","msg":"trace[99158982] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1193; }","duration":"1.293320298s","start":"2026-04-02T06:07:19.770643Z","end":"2026-04-02T06:07:21.063963Z","steps":["trace[99158982] 'agreement among raft nodes before linearized reading' (duration: 1.29295961s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:21.064113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:19.770611Z","time spent":"1.293432481s","remote":"127.0.0.1:52894","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":"warn","ts":"2026-04-02T06:07:21.064157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.224019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:07:21.064198Z","caller":"traceutil/trace.go:171","msg":"trace[1900711776] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1193; }","duration":"680.304731ms","start":"2026-04-02T06:07:20.38388Z","end":"2026-04-02T06:07:21.064185Z","steps":["trace[1900711776] 'agreement among raft nodes before linearized reading' (duration: 680.237289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:21.064209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.277570665s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-02T06:07:21.064229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:20.383857Z","time spent":"680.363772ms","remote":"127.0.0.1:40220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-04-02T06:07:21.064255Z","caller":"traceutil/trace.go:171","msg":"trace[1875777272] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1193; }","duration":"1.277661937s","start":"2026-04-02T06:07:19.786581Z","end":"2026-04-02T06:07:21.064243Z","steps":["trace[1875777272] 'agreement among raft nodes before linearized reading' (duration: 1.277515653s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:21.064287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:19.786559Z","time spent":"1.277721169s","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T06:07:21.06466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.292894667s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-02T06:07:21.064787Z","caller":"traceutil/trace.go:171","msg":"trace[92420761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1193; }","duration":"1.2930217s","start":"2026-04-02T06:07:19.771695Z","end":"2026-04-02T06:07:21.064716Z","steps":["trace[92420761] 'agreement among raft nodes before linearized reading' (duration: 1.292810685s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:21.064991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:19.771677Z","time spent":"1.293295867s","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T06:07:35.704669Z","caller":"traceutil/trace.go:171","msg":"trace[79926401] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"133.131822ms","start":"2026-04-02T06:07:35.571515Z","end":"2026-04-02T06:07:35.704647Z","steps":["trace[79926401] 'process raft request' (duration: 132.990239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:35.985578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.136708ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:07:35.985835Z","caller":"traceutil/trace.go:171","msg":"trace[1843835000] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"272.628858ms","start":"2026-04-02T06:07:35.713106Z","end":"2026-04-02T06:07:35.985734Z","steps":["trace[1843835000] 'process raft request' (duration: 13.236474ms)","trace[1843835000] 'compare' (duration: 258.875801ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:07:36.782196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.435743ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:07:36.782305Z","caller":"traceutil/trace.go:171","msg":"trace[1337060350] linearizableReadLoop","detail":"{readStateIndex:1314; appliedIndex:1313; }","duration":"465.588776ms","start":"2026-04-02T06:07:36.31669Z","end":"2026-04-02T06:07:36.782279Z","steps":["trace[1337060350] 'read index received' (duration: 68.061µs)","trace[1337060350] 'applied index is now lower than readState.Index' (duration: 465.519635ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:07:36.782385Z","caller":"traceutil/trace.go:171","msg":"trace[118416751] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"785.929743ms","start":"2026-04-02T06:07:35.996444Z","end":"2026-04-02T06:07:36.782374Z","steps":["trace[118416751] 'process raft request' (duration: 135.212723ms)","trace[118416751] 'compare' (duration: 649.913061ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:07:36.782561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.981413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:07:36.782443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:35.996424Z","time spent":"785.989864ms","remote":"127.0.0.1:52830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11375,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:36.782616Z","caller":"traceutil/trace.go:171","msg":"trace[487494984] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1259; }","duration":"210.057854ms","start":"2026-04-02T06:07:36.572532Z","end":"2026-04-02T06:07:36.78259Z","steps":["trace[487494984] 'agreement among raft nodes before linearized reading' (duration: 209.982792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:36.782821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.141879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.232\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-02T06:07:36.782845Z","caller":"traceutil/trace.go:171","msg":"trace[29771871] range","detail":"{range_begin:/registry/masterleases/199.19.213.232; range_end:; response_count:1; response_revision:1259; }","duration":"466.20871ms","start":"2026-04-02T06:07:36.316631Z","end":"2026-04-02T06:07:36.782839Z","steps":["trace[29771871] 'agreement among raft nodes before linearized reading' (duration: 466.116018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:36.782864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:36.316601Z","time spent":"466.257971ms","remote":"127.0.0.1:52656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.232\" "} {"level":"warn","ts":"2026-04-02T06:07:37.355883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.228007ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-04-02T06:07:37.355993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:36.785549Z","time spent":"570.440629ms","remote":"127.0.0.1:52656","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-02T06:07:37.683206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.083488ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:07:37.683387Z","caller":"traceutil/trace.go:171","msg":"trace[838564129] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"892.035505ms","start":"2026-04-02T06:07:36.791338Z","end":"2026-04-02T06:07:37.683373Z","steps":["trace[838564129] 'process raft request' (duration: 892.000755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:37.683436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:36.791328Z","time spent":"892.086086ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9375,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:37.683531Z","caller":"traceutil/trace.go:171","msg":"trace[908784876] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"895.309343ms","start":"2026-04-02T06:07:36.788199Z","end":"2026-04-02T06:07:37.683508Z","steps":["trace[908784876] 'process raft request' (duration: 895.094418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:37.68366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:36.78818Z","time spent":"895.416326ms","remote":"127.0.0.1:52902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:37.683719Z","caller":"traceutil/trace.go:171","msg":"trace[1987056759] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"895.648651ms","start":"2026-04-02T06:07:36.788051Z","end":"2026-04-02T06:07:37.683699Z","steps":["trace[1987056759] 'process raft request' (duration: 689.99404ms)","trace[1987056759] 'compare' (duration: 204.970485ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:07:37.683839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:36.788026Z","time spent":"895.756033ms","remote":"127.0.0.1:52812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":915,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:37.757115Z","caller":"traceutil/trace.go:171","msg":"trace[959302191] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"644.41323ms","start":"2026-04-02T06:07:37.112689Z","end":"2026-04-02T06:07:37.757103Z","steps":["trace[959302191] 'process raft request' (duration: 644.300268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:37.757206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:37.112663Z","time spent":"644.491492ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:07:37.757234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.324128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-02T06:07:37.757258Z","caller":"traceutil/trace.go:171","msg":"trace[1100531278] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1264; }","duration":"625.38586ms","start":"2026-04-02T06:07:37.131867Z","end":"2026-04-02T06:07:37.757253Z","steps":["trace[1100531278] 'agreement among raft nodes before linearized reading' (duration: 625.266877ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:37.757223Z","caller":"traceutil/trace.go:171","msg":"trace[1512899892] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"400.340471ms","start":"2026-04-02T06:07:37.35684Z","end":"2026-04-02T06:07:37.757181Z","steps":["trace[1512899892] 'process raft request' (duration: 400.224738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:37.757278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:37.131853Z","time spent":"625.422441ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-02T06:07:37.757105Z","caller":"traceutil/trace.go:171","msg":"trace[476957681] linearizableReadLoop","detail":"{readStateIndex:1319; appliedIndex:1315; }","duration":"625.172645ms","start":"2026-04-02T06:07:37.131917Z","end":"2026-04-02T06:07:37.757089Z","steps":["trace[476957681] 'read index received' (duration: 346.139876ms)","trace[476957681] 'applied index is now lower than readState.Index' (duration: 279.031869ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:07:37.757405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.03082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-02T06:07:37.757399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:37.35682Z","time spent":"400.489664ms","remote":"127.0.0.1:52656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:37.757422Z","caller":"traceutil/trace.go:171","msg":"trace[279526210] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1264; }","duration":"622.066372ms","start":"2026-04-02T06:07:37.135352Z","end":"2026-04-02T06:07:37.757419Z","steps":["trace[279526210] 'agreement among raft nodes before linearized reading' (duration: 622.025331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:37.757436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:37.135343Z","time spent":"622.090222ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T06:07:37.757502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.853623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-02T06:07:37.757524Z","caller":"traceutil/trace.go:171","msg":"trace[1137755886] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1264; }","duration":"517.923376ms","start":"2026-04-02T06:07:37.239596Z","end":"2026-04-02T06:07:37.757519Z","steps":["trace[1137755886] 'agreement among raft nodes before linearized reading' (duration: 517.869685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:37.75753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.504407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-02T06:07:37.757537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:37.239568Z","time spent":"517.966076ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-02T06:07:37.757543Z","caller":"traceutil/trace.go:171","msg":"trace[443292361] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1264; }","duration":"607.575018ms","start":"2026-04-02T06:07:37.149965Z","end":"2026-04-02T06:07:37.75754Z","steps":["trace[443292361] 'agreement among raft nodes before linearized reading' (duration: 607.533518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:37.757555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:37.149936Z","time spent":"607.61726ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T06:07:37.75761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.387461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-02T06:07:37.757616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.876105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:07:37.757624Z","caller":"traceutil/trace.go:171","msg":"trace[192863434] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1264; }","duration":"620.543975ms","start":"2026-04-02T06:07:37.137077Z","end":"2026-04-02T06:07:37.757621Z","steps":["trace[192863434] 'agreement among raft nodes before linearized reading' (duration: 620.510875ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:37.757629Z","caller":"traceutil/trace.go:171","msg":"trace[1476819763] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1264; }","duration":"183.929656ms","start":"2026-04-02T06:07:37.573694Z","end":"2026-04-02T06:07:37.757624Z","steps":["trace[1476819763] 'agreement among raft nodes before linearized reading' (duration: 183.911176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:37.757637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:37.137043Z","time spent":"620.589986ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T06:07:37.91662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.014031ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:07:37.916786Z","caller":"traceutil/trace.go:171","msg":"trace[2079710274] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1320; }","duration":"152.623975ms","start":"2026-04-02T06:07:37.764138Z","end":"2026-04-02T06:07:37.916762Z","steps":["trace[2079710274] 'read index received' (duration: 27.43499ms)","trace[2079710274] 'applied index is now lower than readState.Index' (duration: 125.188475ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:07:37.916793Z","caller":"traceutil/trace.go:171","msg":"trace[824642407] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"153.494966ms","start":"2026-04-02T06:07:37.763287Z","end":"2026-04-02T06:07:37.916782Z","steps":["trace[824642407] 'process raft request' (duration: 153.440604ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:37.916843Z","caller":"traceutil/trace.go:171","msg":"trace[1411115501] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"152.185904ms","start":"2026-04-02T06:07:37.764645Z","end":"2026-04-02T06:07:37.916831Z","steps":["trace[1411115501] 'process raft request' (duration: 152.098792ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:37.916816Z","caller":"traceutil/trace.go:171","msg":"trace[2145613875] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"154.175391ms","start":"2026-04-02T06:07:37.762613Z","end":"2026-04-02T06:07:37.916788Z","steps":["trace[2145613875] 'process raft request' (duration: 154.068988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:37.916913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.770488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-02T06:07:37.916936Z","caller":"traceutil/trace.go:171","msg":"trace[1502332880] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1269; }","duration":"152.806659ms","start":"2026-04-02T06:07:37.764123Z","end":"2026-04-02T06:07:37.91693Z","steps":["trace[1502332880] 'agreement among raft nodes before linearized reading' (duration: 152.761378ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:37.916941Z","caller":"traceutil/trace.go:171","msg":"trace[1264037237] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"154.292654ms","start":"2026-04-02T06:07:37.762633Z","end":"2026-04-02T06:07:37.916926Z","steps":["trace[1264037237] 'process raft request' (duration: 154.076799ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:37.916964Z","caller":"traceutil/trace.go:171","msg":"trace[1632971421] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"154.363566ms","start":"2026-04-02T06:07:37.762592Z","end":"2026-04-02T06:07:37.916955Z","steps":["trace[1632971421] 'process raft request' (duration: 28.969226ms)","trace[1632971421] 'compare' (duration: 124.812676ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:07:37.917054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.165445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:07:37.91708Z","caller":"traceutil/trace.go:171","msg":"trace[1527494049] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1269; }","duration":"125.221575ms","start":"2026-04-02T06:07:37.791852Z","end":"2026-04-02T06:07:37.917073Z","steps":["trace[1527494049] 'agreement among raft nodes before linearized reading' (duration: 125.184134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:39.249899Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280401739490960591,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T06:07:39.475453Z","caller":"traceutil/trace.go:171","msg":"trace[456914724] linearizableReadLoop","detail":"{readStateIndex:1326; appliedIndex:1325; }","duration":"725.583723ms","start":"2026-04-02T06:07:38.749852Z","end":"2026-04-02T06:07:39.475436Z","steps":["trace[456914724] 'read index received' (duration: 725.383548ms)","trace[456914724] 'applied index is now lower than readState.Index' (duration: 199.655µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:07:39.475542Z","caller":"traceutil/trace.go:171","msg":"trace[1906049052] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"880.942511ms","start":"2026-04-02T06:07:38.594541Z","end":"2026-04-02T06:07:39.475484Z","steps":["trace[1906049052] 'process raft request' (duration: 880.771977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:39.4756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.717236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T06:07:39.475632Z","caller":"traceutil/trace.go:171","msg":"trace[277715528] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1270; }","duration":"725.809958ms","start":"2026-04-02T06:07:38.749812Z","end":"2026-04-02T06:07:39.475622Z","steps":["trace[277715528] 'agreement among raft nodes before linearized reading' (duration: 725.727517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:39.475658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:38.749793Z","time spent":"725.858019ms","remote":"127.0.0.1:53118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":3,"response size":30,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:07:39.475674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.949289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:07:39.475694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:38.594524Z","time spent":"881.090235ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:39.475729Z","caller":"traceutil/trace.go:171","msg":"trace[34434479] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1270; }","duration":"405.042752ms","start":"2026-04-02T06:07:39.070666Z","end":"2026-04-02T06:07:39.475709Z","steps":["trace[34434479] 'agreement among raft nodes before linearized reading' (duration: 404.941329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:39.475778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:39.070646Z","time spent":"405.122093ms","remote":"127.0.0.1:36032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"info","ts":"2026-04-02T06:07:40.339169Z","caller":"traceutil/trace.go:171","msg":"trace[1841535704] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"374.497069ms","start":"2026-04-02T06:07:39.964637Z","end":"2026-04-02T06:07:40.339134Z","steps":["trace[1841535704] 'process raft request' (duration: 374.224742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:40.339491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:39.964624Z","time spent":"374.705484ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:40.339217Z","caller":"traceutil/trace.go:171","msg":"trace[356658288] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"374.410127ms","start":"2026-04-02T06:07:39.964782Z","end":"2026-04-02T06:07:40.339192Z","steps":["trace[356658288] 'process raft request' (duration: 374.345105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:40.339723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:39.964756Z","time spent":"374.875558ms","remote":"127.0.0.1:52894","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-04-02T06:07:40.339237Z","caller":"traceutil/trace.go:171","msg":"trace[2025678579] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"374.500099ms","start":"2026-04-02T06:07:39.964702Z","end":"2026-04-02T06:07:40.339202Z","steps":["trace[2025678579] 'process raft request' (duration: 374.385737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:40.339881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:39.964694Z","time spent":"375.162255ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:40.340026Z","caller":"traceutil/trace.go:171","msg":"trace[1531387104] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"375.310978ms","start":"2026-04-02T06:07:39.964698Z","end":"2026-04-02T06:07:40.340009Z","steps":["trace[1531387104] 'process raft request' (duration: 374.309285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:40.340091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:39.964689Z","time spent":"375.371949ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:07:41.502805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.948892ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-02T06:07:41.503581Z","caller":"traceutil/trace.go:171","msg":"trace[63392353] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"125.150528ms","start":"2026-04-02T06:07:41.378412Z","end":"2026-04-02T06:07:41.503562Z","steps":["trace[63392353] 'process raft request' (duration: 124.491533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:51.930976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.112687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-04-02T06:07:51.931072Z","caller":"traceutil/trace.go:171","msg":"trace[1951183904] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1357; }","duration":"314.24669ms","start":"2026-04-02T06:07:51.616802Z","end":"2026-04-02T06:07:51.931048Z","steps":["trace[1951183904] 'range keys from in-memory index tree' (duration: 313.920983ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:51.931086Z","caller":"traceutil/trace.go:171","msg":"trace[790169476] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"120.00726ms","start":"2026-04-02T06:07:51.811059Z","end":"2026-04-02T06:07:51.931066Z","steps":["trace[790169476] 'process raft request' (duration: 118.032334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:51.931126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:51.616786Z","time spent":"314.327292ms","remote":"127.0.0.1:52894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-02T06:07:51.93114Z","caller":"traceutil/trace.go:171","msg":"trace[1036959351] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"108.928173ms","start":"2026-04-02T06:07:51.82218Z","end":"2026-04-02T06:07:51.931108Z","steps":["trace[1036959351] 'process raft request' (duration: 108.81002ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:09:02.961365Z","caller":"traceutil/trace.go:171","msg":"trace[1377526506] transaction","detail":"{read_only:false; response_revision:1687; number_of_response:1; }","duration":"145.817886ms","start":"2026-04-02T06:09:02.815499Z","end":"2026-04-02T06:09:02.961317Z","steps":["trace[1377526506] 'process raft request' (duration: 124.102024ms)","trace[1377526506] 'compare' (duration: 21.535688ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:09:03.134383Z","caller":"traceutil/trace.go:171","msg":"trace[460993973] transaction","detail":"{read_only:false; response_revision:1689; number_of_response:1; }","duration":"113.754267ms","start":"2026-04-02T06:09:03.020598Z","end":"2026-04-02T06:09:03.134352Z","steps":["trace[460993973] 'process raft request' (duration: 69.354361ms)","trace[460993973] 'compare' (duration: 44.252912ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:09:04.405093Z","caller":"traceutil/trace.go:171","msg":"trace[131079598] transaction","detail":"{read_only:false; response_revision:1692; number_of_response:1; }","duration":"134.70346ms","start":"2026-04-02T06:09:04.270346Z","end":"2026-04-02T06:09:04.40505Z","steps":["trace[131079598] 'process raft request' (duration: 88.089785ms)","trace[131079598] 'compare' (duration: 46.102284ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:09:09.114185Z","caller":"traceutil/trace.go:171","msg":"trace[1146921412] linearizableReadLoop","detail":"{readStateIndex:1787; appliedIndex:1786; }","duration":"161.173081ms","start":"2026-04-02T06:09:08.952986Z","end":"2026-04-02T06:09:09.114159Z","steps":["trace[1146921412] 'read index received' (duration: 160.942846ms)","trace[1146921412] 'applied index is now lower than readState.Index' (duration: 229.235µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:09:09.114309Z","caller":"traceutil/trace.go:171","msg":"trace[1816866480] transaction","detail":"{read_only:false; response_revision:1713; number_of_response:1; }","duration":"239.658593ms","start":"2026-04-02T06:09:08.87464Z","end":"2026-04-02T06:09:09.114298Z","steps":["trace[1816866480] 'process raft request' (duration: 239.330775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:09:09.114557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.357684ms","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-04-02T06:09:09.11461Z","caller":"traceutil/trace.go:171","msg":"trace[1702739825] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1713; }","duration":"115.467797ms","start":"2026-04-02T06:09:08.99913Z","end":"2026-04-02T06:09:09.114598Z","steps":["trace[1702739825] 'agreement among raft nodes before linearized reading' (duration: 115.299213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:09:09.114625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.641252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-02T06:09:09.114683Z","caller":"traceutil/trace.go:171","msg":"trace[99152215] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1713; }","duration":"161.749654ms","start":"2026-04-02T06:09:08.952919Z","end":"2026-04-02T06:09:09.114669Z","steps":["trace[99152215] 'agreement among raft nodes before linearized reading' (duration: 161.607861ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:09:09.297709Z","caller":"traceutil/trace.go:171","msg":"trace[1892902256] transaction","detail":"{read_only:false; response_revision:1715; number_of_response:1; }","duration":"178.041891ms","start":"2026-04-02T06:09:09.119627Z","end":"2026-04-02T06:09:09.297669Z","steps":["trace[1892902256] 'process raft request' (duration: 177.796845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:09:09.512767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.05277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-04-02T06:09:09.512931Z","caller":"traceutil/trace.go:171","msg":"trace[735751990] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1715; }","duration":"103.249484ms","start":"2026-04-02T06:09:09.409648Z","end":"2026-04-02T06:09:09.512897Z","steps":["trace[735751990] 'range keys from in-memory index tree' (duration: 102.835035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:09:09.513348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.587948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:09:09.513558Z","caller":"traceutil/trace.go:171","msg":"trace[1087805506] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1715; }","duration":"132.295074ms","start":"2026-04-02T06:09:09.381241Z","end":"2026-04-02T06:09:09.513536Z","steps":["trace[1087805506] 'count revisions from in-memory index tree' (duration: 131.464515ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:58.74938Z","caller":"traceutil/trace.go:171","msg":"trace[1131889314] transaction","detail":"{read_only:false; response_revision:2240; number_of_response:1; }","duration":"170.940218ms","start":"2026-04-02T06:10:58.578415Z","end":"2026-04-02T06:10:58.749355Z","steps":["trace[1131889314] 'process raft request' (duration: 170.791494ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:58.941619Z","caller":"traceutil/trace.go:171","msg":"trace[1741344374] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"261.21498ms","start":"2026-04-02T06:10:58.680378Z","end":"2026-04-02T06:10:58.941593Z","steps":["trace[1741344374] 'process raft request' (duration: 259.184985ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:11:08.703054Z","caller":"traceutil/trace.go:171","msg":"trace[199480799] linearizableReadLoop","detail":"{readStateIndex:2390; appliedIndex:2389; }","duration":"129.113156ms","start":"2026-04-02T06:11:08.573919Z","end":"2026-04-02T06:11:08.703033Z","steps":["trace[199480799] 'read index received' (duration: 128.940172ms)","trace[199480799] 'applied index is now lower than readState.Index' (duration: 172.084µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:11:08.703254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.324431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:11:08.703346Z","caller":"traceutil/trace.go:171","msg":"trace[1832985965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2291; }","duration":"129.464854ms","start":"2026-04-02T06:11:08.573857Z","end":"2026-04-02T06:11:08.703322Z","steps":["trace[1832985965] 'agreement among raft nodes before linearized reading' (duration: 129.348042ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:11:08.703379Z","caller":"traceutil/trace.go:171","msg":"trace[1091125020] transaction","detail":"{read_only:false; response_revision:2291; number_of_response:1; }","duration":"206.040716ms","start":"2026-04-02T06:11:08.497307Z","end":"2026-04-02T06:11:08.703348Z","steps":["trace[1091125020] 'process raft request' (duration: 205.599426ms)"],"step_count":1}