{"level":"warn","ts":"2026-02-20T18:20:38.590514Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-20T18:20:38.590615Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.52:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.52:2380","--initial-cluster=instance=https://162.253.55.52:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.52:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.52: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-02-20T18:20:38.590697Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-20T18:20:38.590713Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.52:2380"]} {"level":"info","ts":"2026-02-20T18:20:38.590734Z","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-02-20T18:20:38.591431Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"]} {"level":"info","ts":"2026-02-20T18:20:38.591504Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.52: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-02-20T18:20:38.983446Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"391.625467ms"} {"level":"info","ts":"2026-02-20T18:20:39.338854Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b11e7fc5714be64b","cluster-id":"9349e4f32a52a90a"} {"level":"info","ts":"2026-02-20T18:20:39.339103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=()"} {"level":"info","ts":"2026-02-20T18:20:39.339202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 0"} {"level":"info","ts":"2026-02-20T18:20:39.339287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b11e7fc5714be64b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-20T18:20:39.33937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 1"} {"level":"info","ts":"2026-02-20T18:20:39.33949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"} {"level":"warn","ts":"2026-02-20T18:20:39.417975Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-20T18:20:39.587566Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-20T18:20:39.632947Z","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-02-20T18:20:39.728602Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b11e7fc5714be64b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-20T18:20:39.729345Z","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-02-20T18:20:39.729476Z","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-02-20T18:20:39.729489Z","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-02-20T18:20:39.7295Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b11e7fc5714be64b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-20T18:20:39.734451Z","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-02-20T18:20:39.734573Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.52:2380"} {"level":"info","ts":"2026-02-20T18:20:39.734634Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.52:2380"} {"level":"info","ts":"2026-02-20T18:20:39.734685Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b11e7fc5714be64b","initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-20T18:20:39.73473Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-20T18:20:39.773552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"} {"level":"info","ts":"2026-02-20T18:20:39.773976Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","added-peer-id":"b11e7fc5714be64b","added-peer-peer-urls":["https://162.253.55.52:2380"]} {"level":"info","ts":"2026-02-20T18:20:40.240169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b is starting a new election at term 1"} {"level":"info","ts":"2026-02-20T18:20:40.240322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became pre-candidate at term 1"} {"level":"info","ts":"2026-02-20T18:20:40.240412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgPreVoteResp from b11e7fc5714be64b at term 1"} {"level":"info","ts":"2026-02-20T18:20:40.240473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became candidate at term 2"} {"level":"info","ts":"2026-02-20T18:20:40.240513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgVoteResp from b11e7fc5714be64b at term 2"} {"level":"info","ts":"2026-02-20T18:20:40.240565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became leader at term 2"} {"level":"info","ts":"2026-02-20T18:20:40.240606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b11e7fc5714be64b elected leader b11e7fc5714be64b at term 2"} {"level":"info","ts":"2026-02-20T18:20:40.491944Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b11e7fc5714be64b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.52:2379]}","request-path":"/0/members/b11e7fc5714be64b/attributes","cluster-id":"9349e4f32a52a90a","publish-timeout":"7s"} {"level":"info","ts":"2026-02-20T18:20:40.491944Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-20T18:20:40.491996Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-20T18:20:40.492061Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-20T18:20:40.492403Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-20T18:20:40.492692Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-20T18:20:40.496145Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-20T18:20:40.496623Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.52:2379"} {"level":"info","ts":"2026-02-20T18:20:40.519515Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","cluster-version":"3.5"} {"level":"info","ts":"2026-02-20T18:20:40.519724Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-20T18:20:40.519783Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-02-20T18:20:40.83777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.521298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-20T18:20:40.837778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.112136ms","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":"warn","ts":"2026-02-20T18:20:40.837664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.696212ms","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":"warn","ts":"2026-02-20T18:20:40.837865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.516348ms","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":"info","ts":"2026-02-20T18:20:40.837916Z","caller":"traceutil/trace.go:171","msg":"trace[1911028154] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"141.03787ms","start":"2026-02-20T18:20:40.696866Z","end":"2026-02-20T18:20:40.837903Z","steps":["trace[1911028154] 'range keys from in-memory index tree' (duration: 140.624321ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:40.837893Z","caller":"traceutil/trace.go:171","msg":"trace[394684249] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"202.272849ms","start":"2026-02-20T18:20:40.63559Z","end":"2026-02-20T18:20:40.837863Z","steps":["trace[394684249] 'count revisions from in-memory index tree' (duration: 202.009633ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:40.837946Z","caller":"traceutil/trace.go:171","msg":"trace[2136316029] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"127.632752ms","start":"2026-02-20T18:20:40.710295Z","end":"2026-02-20T18:20:40.837928Z","steps":["trace[2136316029] 'count revisions from in-memory index tree' (duration: 127.423716ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:40.837981Z","caller":"traceutil/trace.go:171","msg":"trace[1415337457] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"106.626451ms","start":"2026-02-20T18:20:40.731226Z","end":"2026-02-20T18:20:40.837852Z","steps":["trace[1415337457] 'range keys from in-memory index tree' (duration: 106.473687ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.838002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.53014ms","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":"warn","ts":"2026-02-20T18:20:40.838152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.177674ms","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-02-20T18:20:40.838131Z","caller":"traceutil/trace.go:171","msg":"trace[795011708] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"164.735876ms","start":"2026-02-20T18:20:40.673366Z","end":"2026-02-20T18:20:40.838101Z","steps":["trace[795011708] 'range keys from in-memory index tree' (duration: 164.418997ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:40.838194Z","caller":"traceutil/trace.go:171","msg":"trace[511628806] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"128.231776ms","start":"2026-02-20T18:20:40.709953Z","end":"2026-02-20T18:20:40.838184Z","steps":["trace[511628806] 'range keys from in-memory index tree' (duration: 128.152014ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.838214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.377381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:40.838256Z","caller":"traceutil/trace.go:171","msg":"trace[541279646] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"251.452262ms","start":"2026-02-20T18:20:40.586791Z","end":"2026-02-20T18:20:40.838243Z","steps":["trace[541279646] 'count revisions from in-memory index tree' (duration: 251.305449ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.838323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.326944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-20T18:20:40.83786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.477637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-20T18:20:40.83825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.962624ms","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-02-20T18:20:40.83838Z","caller":"traceutil/trace.go:171","msg":"trace[593257094] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"163.106647ms","start":"2026-02-20T18:20:40.675267Z","end":"2026-02-20T18:20:40.838373Z","steps":["trace[593257094] 'count revisions from in-memory index tree' (duration: 162.893253ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:40.838346Z","caller":"traceutil/trace.go:171","msg":"trace[1133885434] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"119.370345ms","start":"2026-02-20T18:20:40.718969Z","end":"2026-02-20T18:20:40.838339Z","steps":["trace[1133885434] 'range keys from in-memory index tree' (duration: 119.293003ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.838526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.637239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:40.838573Z","caller":"traceutil/trace.go:171","msg":"trace[15980869] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"236.70215ms","start":"2026-02-20T18:20:40.60186Z","end":"2026-02-20T18:20:40.838562Z","steps":["trace[15980869] 'count revisions from in-memory index tree' (duration: 236.548087ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.838785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.334222ms","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":"warn","ts":"2026-02-20T18:20:40.83884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.006202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:40.838853Z","caller":"traceutil/trace.go:171","msg":"trace[221663401] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"189.407014ms","start":"2026-02-20T18:20:40.649435Z","end":"2026-02-20T18:20:40.838842Z","steps":["trace[221663401] 'range keys from in-memory index tree' (duration: 189.300661ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:40.838871Z","caller":"traceutil/trace.go:171","msg":"trace[1108190043] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"225.052203ms","start":"2026-02-20T18:20:40.613809Z","end":"2026-02-20T18:20:40.838861Z","steps":["trace[1108190043] 'count revisions from in-memory index tree' (duration: 224.958111ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.838922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.131446ms","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":"warn","ts":"2026-02-20T18:20:40.839034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.383867ms","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":"info","ts":"2026-02-20T18:20:40.83904Z","caller":"traceutil/trace.go:171","msg":"trace[770300765] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"142.26917ms","start":"2026-02-20T18:20:40.696757Z","end":"2026-02-20T18:20:40.839027Z","steps":["trace[770300765] 'count revisions from in-memory index tree' (duration: 142.076175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.839004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.446865ms","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":"info","ts":"2026-02-20T18:20:40.83982Z","caller":"traceutil/trace.go:171","msg":"trace[1561393908] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"190.294325ms","start":"2026-02-20T18:20:40.649508Z","end":"2026-02-20T18:20:40.839803Z","steps":["trace[1561393908] 'count revisions from in-memory index tree' (duration: 189.390613ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.838804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.890814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:40.839899Z","caller":"traceutil/trace.go:171","msg":"trace[1419686578] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"238.005242ms","start":"2026-02-20T18:20:40.601878Z","end":"2026-02-20T18:20:40.839883Z","steps":["trace[1419686578] 'range keys from in-memory index tree' (duration: 236.812753ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:40.839082Z","caller":"traceutil/trace.go:171","msg":"trace[1785552761] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"177.421249ms","start":"2026-02-20T18:20:40.661632Z","end":"2026-02-20T18:20:40.839053Z","steps":["trace[1785552761] 'count revisions from in-memory index tree' (duration: 177.319885ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.839111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.47008ms","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":"info","ts":"2026-02-20T18:20:40.84033Z","caller":"traceutil/trace.go:171","msg":"trace[1689105343] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"178.708229ms","start":"2026-02-20T18:20:40.661607Z","end":"2026-02-20T18:20:40.840315Z","steps":["trace[1689105343] 'range keys from in-memory index tree' (duration: 177.378307ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.839183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.523878ms","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-02-20T18:20:40.840493Z","caller":"traceutil/trace.go:171","msg":"trace[1516130613] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"154.844099ms","start":"2026-02-20T18:20:40.685626Z","end":"2026-02-20T18:20:40.84047Z","steps":["trace[1516130613] 'count revisions from in-memory index tree' (duration: 153.476957ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.839238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.489407ms","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-02-20T18:20:40.84072Z","caller":"traceutil/trace.go:171","msg":"trace[995824927] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"155.021113ms","start":"2026-02-20T18:20:40.685691Z","end":"2026-02-20T18:20:40.840712Z","steps":["trace[995824927] 'range keys from in-memory index tree' (duration: 153.427735ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:40.838375Z","caller":"traceutil/trace.go:171","msg":"trace[250441378] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"107.023711ms","start":"2026-02-20T18:20:40.731338Z","end":"2026-02-20T18:20:40.838362Z","steps":["trace[250441378] 'count revisions from in-memory index tree' (duration: 106.451866ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.839297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.205484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:40.841Z","caller":"traceutil/trace.go:171","msg":"trace[127913790] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"121.911195ms","start":"2026-02-20T18:20:40.719081Z","end":"2026-02-20T18:20:40.840992Z","steps":["trace[127913790] 'count revisions from in-memory index tree' (duration: 120.120102ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.839308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.35742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:40.841169Z","caller":"traceutil/trace.go:171","msg":"trace[1227024265] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"227.250656ms","start":"2026-02-20T18:20:40.613911Z","end":"2026-02-20T18:20:40.841162Z","steps":["trace[1227024265] 'range keys from in-memory index tree' (duration: 225.317459ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.839356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.676909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:40.841353Z","caller":"traceutil/trace.go:171","msg":"trace[552403327] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"217.698749ms","start":"2026-02-20T18:20:40.623646Z","end":"2026-02-20T18:20:40.841344Z","steps":["trace[552403327] 'range keys from in-memory index tree' (duration: 215.642168ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.839413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.595698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:40.841495Z","caller":"traceutil/trace.go:171","msg":"trace[244666853] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"217.695078ms","start":"2026-02-20T18:20:40.623794Z","end":"2026-02-20T18:20:40.841489Z","steps":["trace[244666853] 'count revisions from in-memory index tree' (duration: 215.563337ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:40.839454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.860287ms","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-02-20T18:20:40.841659Z","caller":"traceutil/trace.go:171","msg":"trace[1269773503] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"206.074161ms","start":"2026-02-20T18:20:40.635578Z","end":"2026-02-20T18:20:40.841652Z","steps":["trace[1269773503] 'range keys from in-memory index tree' (duration: 203.821076ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:41.938002Z","caller":"traceutil/trace.go:171","msg":"trace[175574918] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:6; }","duration":"159.645941ms","start":"2026-02-20T18:20:41.778329Z","end":"2026-02-20T18:20:41.937975Z","steps":["trace[175574918] 'read index received' (duration: 105.822817ms)","trace[175574918] 'applied index is now lower than readState.Index' (duration: 53.821564ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:20:41.93804Z","caller":"traceutil/trace.go:171","msg":"trace[1213259814] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"160.141113ms","start":"2026-02-20T18:20:41.777864Z","end":"2026-02-20T18:20:41.938005Z","steps":["trace[1213259814] 'process raft request' (duration: 106.247987ms)","trace[1213259814] 'compare' (duration: 53.6452ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:20:41.938234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.878707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:41.938347Z","caller":"traceutil/trace.go:171","msg":"trace[1328207447] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4; }","duration":"160.0279ms","start":"2026-02-20T18:20:41.778299Z","end":"2026-02-20T18:20:41.938327Z","steps":["trace[1328207447] 'agreement among raft nodes before linearized reading' (duration: 159.832946ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:41.968167Z","caller":"traceutil/trace.go:171","msg":"trace[1722692838] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"189.461584ms","start":"2026-02-20T18:20:41.778681Z","end":"2026-02-20T18:20:41.968142Z","steps":["trace[1722692838] 'process raft request' (duration: 189.281088ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:41.968324Z","caller":"traceutil/trace.go:171","msg":"trace[358897414] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"184.370491ms","start":"2026-02-20T18:20:41.783925Z","end":"2026-02-20T18:20:41.968295Z","steps":["trace[358897414] 'process raft request' (duration: 184.265529ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:41.968333Z","caller":"traceutil/trace.go:171","msg":"trace[266543157] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"184.74972ms","start":"2026-02-20T18:20:41.783555Z","end":"2026-02-20T18:20:41.968304Z","steps":["trace[266543157] 'process raft request' (duration: 184.512695ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:41.968428Z","caller":"traceutil/trace.go:171","msg":"trace[210012506] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"184.450523ms","start":"2026-02-20T18:20:41.78397Z","end":"2026-02-20T18:20:41.96842Z","steps":["trace[210012506] 'process raft request' (duration: 184.244808ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:41.968483Z","caller":"traceutil/trace.go:171","msg":"trace[1875335040] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"184.826482ms","start":"2026-02-20T18:20:41.783646Z","end":"2026-02-20T18:20:41.968472Z","steps":["trace[1875335040] 'process raft request' (duration: 184.475994ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:41.968442Z","caller":"traceutil/trace.go:171","msg":"trace[1929992538] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"154.394816ms","start":"2026-02-20T18:20:41.813997Z","end":"2026-02-20T18:20:41.968392Z","steps":["trace[1929992538] 'process raft request' (duration: 154.272804ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:41.968565Z","caller":"traceutil/trace.go:171","msg":"trace[1109559725] transaction","detail":"{read_only:false; number_of_response:0; response_revision:6; }","duration":"184.664228ms","start":"2026-02-20T18:20:41.783631Z","end":"2026-02-20T18:20:41.968295Z","steps":["trace[1109559725] 'process raft request' (duration: 184.467334ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:41.968567Z","caller":"traceutil/trace.go:171","msg":"trace[1099994412] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"184.871303ms","start":"2026-02-20T18:20:41.783673Z","end":"2026-02-20T18:20:41.968545Z","steps":["trace[1099994412] 'process raft request' (duration: 184.491504ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:41.968388Z","caller":"traceutil/trace.go:171","msg":"trace[839060321] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"159.904107ms","start":"2026-02-20T18:20:41.808464Z","end":"2026-02-20T18:20:41.968368Z","steps":["trace[839060321] 'process raft request' (duration: 159.774184ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:41.968918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.821361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-02-20T18:20:41.968969Z","caller":"traceutil/trace.go:171","msg":"trace[1373369685] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:12; }","duration":"140.886773ms","start":"2026-02-20T18:20:41.82807Z","end":"2026-02-20T18:20:41.968956Z","steps":["trace[1373369685] 'agreement among raft nodes before linearized reading' (duration: 140.630807ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:41.969709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.232026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:41.970463Z","caller":"traceutil/trace.go:171","msg":"trace[662491769] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:12; }","duration":"186.993214ms","start":"2026-02-20T18:20:41.783433Z","end":"2026-02-20T18:20:41.970427Z","steps":["trace[662491769] 'agreement among raft nodes before linearized reading' (duration: 184.874184ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:42.626451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.799586ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-02-20T18:20:42.626682Z","caller":"traceutil/trace.go:171","msg":"trace[1958862554] transaction","detail":"{read_only:false; response_revision:69; number_of_response:1; }","duration":"231.659761ms","start":"2026-02-20T18:20:42.394997Z","end":"2026-02-20T18:20:42.626656Z","steps":["trace[1958862554] 'process raft request' (duration: 74.840801ms)","trace[1958862554] 'compare' (duration: 155.637212ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:20:42.824184Z","caller":"traceutil/trace.go:171","msg":"trace[1994437040] linearizableReadLoop","detail":"{readStateIndex:74; appliedIndex:73; }","duration":"144.502866ms","start":"2026-02-20T18:20:42.679656Z","end":"2026-02-20T18:20:42.824159Z","steps":["trace[1994437040] 'read index received' (duration: 53.892458ms)","trace[1994437040] 'applied index is now lower than readState.Index' (duration: 90.609408ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:20:42.824313Z","caller":"traceutil/trace.go:171","msg":"trace[1438192272] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"193.037607ms","start":"2026-02-20T18:20:42.631262Z","end":"2026-02-20T18:20:42.824299Z","steps":["trace[1438192272] 'process raft request' (duration: 102.370738ms)","trace[1438192272] 'compare' (duration: 90.409183ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:20:42.824447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.766782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:42.824515Z","caller":"traceutil/trace.go:171","msg":"trace[949262121] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:70; }","duration":"144.874044ms","start":"2026-02-20T18:20:42.679616Z","end":"2026-02-20T18:20:42.82449Z","steps":["trace[949262121] 'agreement among raft nodes before linearized reading' (duration: 144.778392ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:42.824563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.71894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:42.824674Z","caller":"traceutil/trace.go:171","msg":"trace[937024987] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:70; }","duration":"144.954546ms","start":"2026-02-20T18:20:42.679698Z","end":"2026-02-20T18:20:42.824652Z","steps":["trace[937024987] 'agreement among raft nodes before linearized reading' (duration: 144.70036ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:43.104907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.177419ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-20T18:20:43.10513Z","caller":"traceutil/trace.go:171","msg":"trace[1172465091] linearizableReadLoop","detail":"{readStateIndex:75; appliedIndex:74; }","duration":"276.102218ms","start":"2026-02-20T18:20:42.829004Z","end":"2026-02-20T18:20:43.105106Z","steps":["trace[1172465091] 'read index received' (duration: 129.667551ms)","trace[1172465091] 'applied index is now lower than readState.Index' (duration: 146.433447ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:20:43.105206Z","caller":"traceutil/trace.go:171","msg":"trace[1346422423] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"276.750973ms","start":"2026-02-20T18:20:42.828364Z","end":"2026-02-20T18:20:43.105115Z","steps":["trace[1346422423] 'process raft request' (duration: 130.296916ms)","trace[1346422423] 'compare' (duration: 145.970595ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:20:43.105284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.270041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:43.105467Z","caller":"traceutil/trace.go:171","msg":"trace[881484427] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:71; }","duration":"276.488167ms","start":"2026-02-20T18:20:42.828952Z","end":"2026-02-20T18:20:43.10544Z","steps":["trace[881484427] 'agreement among raft nodes before linearized reading' (duration: 276.239521ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:43.575847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.663204ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-20T18:20:43.575983Z","caller":"traceutil/trace.go:171","msg":"trace[1435071724] transaction","detail":"{read_only:false; response_revision:78; number_of_response:1; }","duration":"270.444558ms","start":"2026-02-20T18:20:43.30551Z","end":"2026-02-20T18:20:43.575955Z","steps":["trace[1435071724] 'process raft request' (duration: 138.58807ms)","trace[1435071724] 'compare' (duration: 131.515091ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:20:44.162818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.347895ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-20T18:20:44.163071Z","caller":"traceutil/trace.go:171","msg":"trace[418329544] transaction","detail":"{read_only:false; response_revision:84; number_of_response:1; }","duration":"390.484711ms","start":"2026-02-20T18:20:43.772514Z","end":"2026-02-20T18:20:44.162999Z","steps":["trace[418329544] 'process raft request' (duration: 232.88211ms)","trace[418329544] 'compare' (duration: 157.202562ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:20:44.16322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.499764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:44.163329Z","caller":"traceutil/trace.go:171","msg":"trace[1841200053] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:84; }","duration":"330.653777ms","start":"2026-02-20T18:20:43.832653Z","end":"2026-02-20T18:20:44.163307Z","steps":["trace[1841200053] 'agreement among raft nodes before linearized reading' (duration: 330.438282ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:44.163241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:20:43.772505Z","time spent":"390.673946ms","remote":"127.0.0.1:40594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-20T18:20:44.16338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:20:43.832632Z","time spent":"330.73943ms","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-20T18:20:44.163138Z","caller":"traceutil/trace.go:171","msg":"trace[1266142598] linearizableReadLoop","detail":"{readStateIndex:88; appliedIndex:87; }","duration":"330.217147ms","start":"2026-02-20T18:20:43.832696Z","end":"2026-02-20T18:20:44.162913Z","steps":["trace[1266142598] 'read index received' (duration: 172.645647ms)","trace[1266142598] 'applied index is now lower than readState.Index' (duration: 157.57051ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:20:44.163859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.707828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-20T18:20:44.163862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.777321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-20T18:20:44.163926Z","caller":"traceutil/trace.go:171","msg":"trace[1290304372] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:84; }","duration":"322.7978ms","start":"2026-02-20T18:20:43.841117Z","end":"2026-02-20T18:20:44.163915Z","steps":["trace[1290304372] 'agreement among raft nodes before linearized reading' (duration: 322.689598ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:44.163948Z","caller":"traceutil/trace.go:171","msg":"trace[794319775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:84; }","duration":"330.908064ms","start":"2026-02-20T18:20:43.833026Z","end":"2026-02-20T18:20:44.163934Z","steps":["trace[794319775] 'agreement among raft nodes before linearized reading' (duration: 330.73641ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:44.164178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:20:43.833004Z","time spent":"331.160169ms","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-20T18:20:44.164003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:20:43.841107Z","time spent":"322.889022ms","remote":"127.0.0.1:40566","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-02-20T18:20:44.361319Z","caller":"traceutil/trace.go:171","msg":"trace[1171935010] transaction","detail":"{read_only:false; response_revision:89; number_of_response:1; }","duration":"122.742275ms","start":"2026-02-20T18:20:44.238559Z","end":"2026-02-20T18:20:44.361301Z","steps":["trace[1171935010] 'process raft request' (duration: 106.906936ms)","trace[1171935010] 'compare' (duration: 15.43663ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:20:44.361304Z","caller":"traceutil/trace.go:171","msg":"trace[2030097084] transaction","detail":"{read_only:false; response_revision:90; number_of_response:1; }","duration":"122.473239ms","start":"2026-02-20T18:20:44.238803Z","end":"2026-02-20T18:20:44.361277Z","steps":["trace[2030097084] 'process raft request' (duration: 122.249994ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:20:44.572386Z","caller":"traceutil/trace.go:171","msg":"trace[641296562] transaction","detail":"{read_only:false; response_revision:99; number_of_response:1; }","duration":"127.733916ms","start":"2026-02-20T18:20:44.444614Z","end":"2026-02-20T18:20:44.572348Z","steps":["trace[641296562] 'process raft request' (duration: 87.053409ms)","trace[641296562] 'compare' (duration: 40.543863ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:20:56.548596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.15164ms","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-02-20T18:20:56.548704Z","caller":"traceutil/trace.go:171","msg":"trace[1406269620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:407; }","duration":"250.264323ms","start":"2026-02-20T18:20:56.29842Z","end":"2026-02-20T18:20:56.548684Z","steps":["trace[1406269620] 'range keys from in-memory index tree' (duration: 249.983705ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:20:56.549086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.314078ms","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-02-20T18:20:56.549136Z","caller":"traceutil/trace.go:171","msg":"trace[821475689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:407; }","duration":"137.399991ms","start":"2026-02-20T18:20:56.411722Z","end":"2026-02-20T18:20:56.549122Z","steps":["trace[821475689] 'range keys from in-memory index tree' (duration: 137.122723ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:03.196312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.195047ms","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-02-20T18:21:03.196357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.537756ms","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-02-20T18:21:03.196403Z","caller":"traceutil/trace.go:171","msg":"trace[1712380112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:454; }","duration":"596.33186ms","start":"2026-02-20T18:21:02.60005Z","end":"2026-02-20T18:21:03.196382Z","steps":["trace[1712380112] 'range keys from in-memory index tree' (duration: 596.082434ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:03.196447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:02.600025Z","time spent":"596.412712ms","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-20T18:21:03.196448Z","caller":"traceutil/trace.go:171","msg":"trace[1263842684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:454; }","duration":"616.668738ms","start":"2026-02-20T18:21:02.579755Z","end":"2026-02-20T18:21:03.196424Z","steps":["trace[1263842684] 'range keys from in-memory index tree' (duration: 616.439013ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:03.196501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:02.579741Z","time spent":"616.746121ms","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-20T18:21:05.518848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.982763ms","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-02-20T18:21:05.518942Z","caller":"traceutil/trace.go:171","msg":"trace[771632378] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:460; }","duration":"160.126087ms","start":"2026-02-20T18:21:05.358795Z","end":"2026-02-20T18:21:05.518921Z","steps":["trace[771632378] 'range keys from in-memory index tree' (duration: 159.889441ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:05.687218Z","caller":"traceutil/trace.go:171","msg":"trace[371495439] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"162.235449ms","start":"2026-02-20T18:21:05.524951Z","end":"2026-02-20T18:21:05.687186Z","steps":["trace[371495439] 'process raft request' (duration: 121.538659ms)","trace[371495439] 'compare' (duration: 40.454684ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:21:12.876606Z","caller":"traceutil/trace.go:171","msg":"trace[1330889718] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"104.031581ms","start":"2026-02-20T18:21:12.77255Z","end":"2026-02-20T18:21:12.876581Z","steps":["trace[1330889718] 'process raft request' (duration: 103.865777ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:13.507074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.175026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:21:13.507185Z","caller":"traceutil/trace.go:171","msg":"trace[2094521219] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:513; }","duration":"290.32348ms","start":"2026-02-20T18:21:13.216831Z","end":"2026-02-20T18:21:13.507155Z","steps":["trace[2094521219] 'range keys from in-memory index tree' (duration: 290.016702ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:13.50732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.388005ms","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-02-20T18:21:13.507448Z","caller":"traceutil/trace.go:171","msg":"trace[670180764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:513; }","duration":"183.521518ms","start":"2026-02-20T18:21:13.323862Z","end":"2026-02-20T18:21:13.507384Z","steps":["trace[670180764] 'range keys from in-memory index tree' (duration: 183.276563ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:13.507331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.224245ms","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-02-20T18:21:13.507651Z","caller":"traceutil/trace.go:171","msg":"trace[1169579843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"171.560003ms","start":"2026-02-20T18:21:13.336068Z","end":"2026-02-20T18:21:13.507628Z","steps":["trace[1169579843] 'range keys from in-memory index tree' (duration: 171.090931ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:15.77856Z","caller":"traceutil/trace.go:171","msg":"trace[1545980497] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"258.381837ms","start":"2026-02-20T18:21:15.520154Z","end":"2026-02-20T18:21:15.778536Z","steps":["trace[1545980497] 'process raft request' (duration: 258.250764ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:15.786709Z","caller":"traceutil/trace.go:171","msg":"trace[1635313239] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:555; }","duration":"145.044461ms","start":"2026-02-20T18:21:15.641644Z","end":"2026-02-20T18:21:15.786688Z","steps":["trace[1635313239] 'read index received' (duration: 136.742225ms)","trace[1635313239] 'applied index is now lower than readState.Index' (duration: 8.301476ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:21:15.786746Z","caller":"traceutil/trace.go:171","msg":"trace[697995713] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"264.798227ms","start":"2026-02-20T18:21:15.521925Z","end":"2026-02-20T18:21:15.786724Z","steps":["trace[697995713] 'process raft request' (duration: 264.664674ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:15.786823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.161134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.52\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-20T18:21:15.78685Z","caller":"traceutil/trace.go:171","msg":"trace[451100666] range","detail":"{range_begin:/registry/masterleases/162.253.55.52; range_end:; response_count:1; response_revision:541; }","duration":"145.245896ms","start":"2026-02-20T18:21:15.641597Z","end":"2026-02-20T18:21:15.786843Z","steps":["trace[451100666] 'agreement among raft nodes before linearized reading' (duration: 145.182444ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:15.7869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.901315ms","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-02-20T18:21:15.786951Z","caller":"traceutil/trace.go:171","msg":"trace[1491722845] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:541; }","duration":"118.978566ms","start":"2026-02-20T18:21:15.667961Z","end":"2026-02-20T18:21:15.78694Z","steps":["trace[1491722845] 'agreement among raft nodes before linearized reading' (duration: 118.878634ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:21.995894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.852906ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-20T18:21:21.996003Z","caller":"traceutil/trace.go:171","msg":"trace[321504487] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:573; }","duration":"779.612241ms","start":"2026-02-20T18:21:21.216375Z","end":"2026-02-20T18:21:21.995987Z","steps":["trace[321504487] 'read index received' (duration: 30.57µs)","trace[321504487] 'applied index is now lower than readState.Index' (duration: 779.57791ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:21:21.996137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.759632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:21:21.99617Z","caller":"traceutil/trace.go:171","msg":"trace[400486563] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"779.839913ms","start":"2026-02-20T18:21:21.216321Z","end":"2026-02-20T18:21:21.996161Z","steps":["trace[400486563] 'agreement among raft nodes before linearized reading' (duration: 779.774113ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:21.996206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:21.216305Z","time spent":"779.888694ms","remote":"127.0.0.1:40566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-20T18:21:21.996397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.356776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9sj47\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-20T18:21:21.996439Z","caller":"traceutil/trace.go:171","msg":"trace[1788052968] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9sj47; range_end:; response_count:1; response_revision:556; }","duration":"744.416477ms","start":"2026-02-20T18:21:21.25201Z","end":"2026-02-20T18:21:21.996427Z","steps":["trace[1788052968] 'agreement among raft nodes before linearized reading' (duration: 744.325526ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:21.996469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:21.252Z","time spent":"744.462077ms","remote":"127.0.0.1:40748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16676,"request content":"key:\"/registry/pods/kube-system/cilium-9sj47\" "} {"level":"warn","ts":"2026-02-20T18:21:21.996577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.015737ms","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-02-20T18:21:21.996608Z","caller":"traceutil/trace.go:171","msg":"trace[1405397037] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:556; }","duration":"181.060008ms","start":"2026-02-20T18:21:21.815539Z","end":"2026-02-20T18:21:21.996599Z","steps":["trace[1405397037] 'agreement among raft nodes before linearized reading' (duration: 180.929936ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:21.996735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.62925ms","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-02-20T18:21:21.996799Z","caller":"traceutil/trace.go:171","msg":"trace[96610940] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:556; }","duration":"189.72878ms","start":"2026-02-20T18:21:21.807053Z","end":"2026-02-20T18:21:21.996782Z","steps":["trace[96610940] 'agreement among raft nodes before linearized reading' (duration: 189.520217ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:21.996791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.119769ms","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-02-20T18:21:21.996823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.667346ms","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-02-20T18:21:21.99685Z","caller":"traceutil/trace.go:171","msg":"trace[1270911348] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:556; }","duration":"181.211891ms","start":"2026-02-20T18:21:21.81563Z","end":"2026-02-20T18:21:21.996842Z","steps":["trace[1270911348] 'agreement among raft nodes before linearized reading' (duration: 181.10281ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:21.996865Z","caller":"traceutil/trace.go:171","msg":"trace[1389233750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:556; }","duration":"182.726166ms","start":"2026-02-20T18:21:21.81413Z","end":"2026-02-20T18:21:21.996856Z","steps":["trace[1389233750] 'agreement among raft nodes before linearized reading' (duration: 182.623235ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:23.717774Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594529309579685806,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-20T18:21:23.752535Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.751144659s","expected-duration":"1s"} {"level":"info","ts":"2026-02-20T18:21:23.752919Z","caller":"traceutil/trace.go:171","msg":"trace[578584948] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"1.751594004s","start":"2026-02-20T18:21:22.001303Z","end":"2026-02-20T18:21:23.752897Z","steps":["trace[578584948] 'process raft request' (duration: 1.751442173s)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:23.753062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:22.001289Z","time spent":"1.751700595s","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-20T18:21:25.2176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000504271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-20T18:21:25.217703Z","caller":"traceutil/trace.go:171","msg":"trace[832730265] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000673854s","start":"2026-02-20T18:21:23.217011Z","end":"2026-02-20T18:21:25.217684Z","steps":["trace[832730265] 'agreement among raft nodes before linearized reading' (duration: 2.000540392s)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:25.217755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:23.216993Z","time spent":"2.000750334s","remote":"127.0.0.1:40566","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-02-20T18:21:27.000174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:22.001685Z","time spent":"4.998482538s","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-02-20T18:21:27.000185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:22.001669Z","time spent":"4.998507528s","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/02/20 18:21:27 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" 2026/02/20 18:21:27 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-20T18:21:27.218115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999964207s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-20T18:21:27.218221Z","caller":"traceutil/trace.go:171","msg":"trace[141361920] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000105939s","start":"2026-02-20T18:21:25.218097Z","end":"2026-02-20T18:21:27.218202Z","steps":["trace[141361920] 'agreement among raft nodes before linearized reading' (duration: 1.999980207s)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:27.218308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:25.218086Z","time spent":"2.000174539s","remote":"127.0.0.1:40560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/20 18:21:27 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-20T18:21:28.382513Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.629717682s","expected-duration":"1s"} {"level":"info","ts":"2026-02-20T18:21:28.382911Z","caller":"traceutil/trace.go:171","msg":"trace[1343067871] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"6.371122438s","start":"2026-02-20T18:21:22.011774Z","end":"2026-02-20T18:21:28.382896Z","steps":["trace[1343067871] 'process raft request' (duration: 6.371052987s)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:28.382999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:22.011758Z","time spent":"6.371189309s","remote":"127.0.0.1:40748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-20T18:21:28.383068Z","caller":"traceutil/trace.go:171","msg":"trace[1798533098] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"6.381309208s","start":"2026-02-20T18:21:22.001639Z","end":"2026-02-20T18:21:28.382948Z","steps":["trace[1798533098] 'process raft request' (duration: 6.381038675s)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:28.383139Z","caller":"traceutil/trace.go:171","msg":"trace[352126684] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:574; }","duration":"5.166028542s","start":"2026-02-20T18:21:23.217058Z","end":"2026-02-20T18:21:28.383086Z","steps":["trace[352126684] 'read index received' (duration: 535.773012ms)","trace[352126684] 'applied index is now lower than readState.Index' (duration: 4.63025387s)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:21:28.383219Z","caller":"traceutil/trace.go:171","msg":"trace[1452000252] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"5.416199526s","start":"2026-02-20T18:21:22.967001Z","end":"2026-02-20T18:21:28.383201Z","steps":["trace[1452000252] 'process raft request' (duration: 5.415870722s)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:28.383326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:22.966974Z","time spent":"5.416278617s","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-20T18:21:28.383691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:22.001632Z","time spent":"6.3815024s","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-20T18:21:28.423317Z","caller":"traceutil/trace.go:171","msg":"trace[351610123] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"1.20198495s","start":"2026-02-20T18:21:27.221304Z","end":"2026-02-20T18:21:28.423289Z","steps":["trace[351610123] 'process raft request' (duration: 1.201829048s)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:28.42343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:27.221283Z","time spent":"1.202087421s","remote":"127.0.0.1:40636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-20T18:21:28.423719Z","caller":"traceutil/trace.go:171","msg":"trace[1780286412] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"679.888577ms","start":"2026-02-20T18:21:27.743815Z","end":"2026-02-20T18:21:28.423703Z","steps":["trace[1780286412] 'process raft request' (duration: 679.397191ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:28.423775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:27.743794Z","time spent":"679.950198ms","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-20T18:21:28.423863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.199776094s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:21:28.42389Z","caller":"traceutil/trace.go:171","msg":"trace[1102618711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:564; }","duration":"1.199829604s","start":"2026-02-20T18:21:27.224051Z","end":"2026-02-20T18:21:28.423881Z","steps":["trace[1102618711] 'agreement among raft nodes before linearized reading' (duration: 1.199791734s)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:28.423912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:27.224034Z","time spent":"1.199872575s","remote":"127.0.0.1:40560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-20T18:21:28.424017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.520320447s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:21:28.424035Z","caller":"traceutil/trace.go:171","msg":"trace[1727531122] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:564; }","duration":"1.520375887s","start":"2026-02-20T18:21:26.903653Z","end":"2026-02-20T18:21:28.424029Z","steps":["trace[1727531122] 'agreement among raft nodes before linearized reading' (duration: 1.520345856s)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:28.424052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:26.903631Z","time spent":"1.520416568s","remote":"127.0.0.1:40566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-20T18:21:28.424212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.667390201s","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-02-20T18:21:28.424232Z","caller":"traceutil/trace.go:171","msg":"trace[2012090926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:564; }","duration":"2.667449031s","start":"2026-02-20T18:21:25.756776Z","end":"2026-02-20T18:21:28.424225Z","steps":["trace[2012090926] 'agreement among raft nodes before linearized reading' (duration: 2.66736418s)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:28.424249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:25.756748Z","time spent":"2.667496422s","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-20T18:21:28.424355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.781629901s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.52\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-20T18:21:28.424385Z","caller":"traceutil/trace.go:171","msg":"trace[1672580475] range","detail":"{range_begin:/registry/masterleases/162.253.55.52; range_end:; response_count:1; response_revision:564; }","duration":"2.781693402s","start":"2026-02-20T18:21:25.642686Z","end":"2026-02-20T18:21:28.424379Z","steps":["trace[1672580475] 'agreement among raft nodes before linearized reading' (duration: 2.781637641s)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:28.424403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:25.642668Z","time spent":"2.781730292s","remote":"127.0.0.1:40590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.52\" "} {"level":"info","ts":"2026-02-20T18:21:30.900925Z","caller":"traceutil/trace.go:171","msg":"trace[68446319] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"434.970715ms","start":"2026-02-20T18:21:30.465924Z","end":"2026-02-20T18:21:30.900895Z","steps":["trace[68446319] 'process raft request' (duration: 413.980227ms)","trace[68446319] 'compare' (duration: 20.868327ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:21:30.901107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:30.465905Z","time spent":"435.112216ms","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-20T18:21:30.916458Z","caller":"traceutil/trace.go:171","msg":"trace[1214494749] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"207.405443ms","start":"2026-02-20T18:21:30.709024Z","end":"2026-02-20T18:21:30.916429Z","steps":["trace[1214494749] 'process raft request' (duration: 207.359833ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:30.916507Z","caller":"traceutil/trace.go:171","msg":"trace[1227344603] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"407.723059ms","start":"2026-02-20T18:21:30.508769Z","end":"2026-02-20T18:21:30.916493Z","steps":["trace[1227344603] 'process raft request' (duration: 407.506636ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:30.916727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:30.508753Z","time spent":"407.905521ms","remote":"127.0.0.1:40618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-20T18:21:31.590695Z","caller":"traceutil/trace.go:171","msg":"trace[283617020] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"234.894523ms","start":"2026-02-20T18:21:31.355777Z","end":"2026-02-20T18:21:31.590672Z","steps":["trace[283617020] 'process raft request' (duration: 234.825042ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:31.591435Z","caller":"traceutil/trace.go:171","msg":"trace[1053563731] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"237.117192ms","start":"2026-02-20T18:21:31.353615Z","end":"2026-02-20T18:21:31.590732Z","steps":["trace[1053563731] 'process raft request' (duration: 236.861149ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:31.685729Z","caller":"traceutil/trace.go:171","msg":"trace[1236620189] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"174.139035ms","start":"2026-02-20T18:21:31.511561Z","end":"2026-02-20T18:21:31.6857Z","steps":["trace[1236620189] 'process raft request' (duration: 174.084864ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:31.685755Z","caller":"traceutil/trace.go:171","msg":"trace[736905241] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"263.916366ms","start":"2026-02-20T18:21:31.421809Z","end":"2026-02-20T18:21:31.685726Z","steps":["trace[736905241] 'process raft request' (duration: 263.684713ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:32.26284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.025766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:21:32.262927Z","caller":"traceutil/trace.go:171","msg":"trace[1767159651] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:624; }","duration":"156.154938ms","start":"2026-02-20T18:21:32.106751Z","end":"2026-02-20T18:21:32.262906Z","steps":["trace[1767159651] 'range keys from in-memory index tree' (duration: 155.877533ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:33.609936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.386277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-02-20T18:21:33.610017Z","caller":"traceutil/trace.go:171","msg":"trace[265692849] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:637; }","duration":"103.515078ms","start":"2026-02-20T18:21:33.506481Z","end":"2026-02-20T18:21:33.609996Z","steps":["trace[265692849] 'range keys from in-memory index tree' (duration: 103.211315ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:55.473422Z","caller":"traceutil/trace.go:171","msg":"trace[240155368] linearizableReadLoop","detail":"{readStateIndex:823; appliedIndex:822; }","duration":"336.155571ms","start":"2026-02-20T18:21:55.137245Z","end":"2026-02-20T18:21:55.473401Z","steps":["trace[240155368] 'read index received' (duration: 335.972298ms)","trace[240155368] 'applied index is now lower than readState.Index' (duration: 182.293µs)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:21:55.473676Z","caller":"traceutil/trace.go:171","msg":"trace[1161282243] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"354.114668ms","start":"2026-02-20T18:21:55.11955Z","end":"2026-02-20T18:21:55.473665Z","steps":["trace[1161282243] 'process raft request' (duration: 353.725511ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:55.47378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:55.119537Z","time spent":"354.180218ms","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-20T18:21:55.474691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.451981ms","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-02-20T18:21:55.474738Z","caller":"traceutil/trace.go:171","msg":"trace[933596755] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:796; }","duration":"337.541883ms","start":"2026-02-20T18:21:55.137184Z","end":"2026-02-20T18:21:55.474726Z","steps":["trace[933596755] 'agreement among raft nodes before linearized reading' (duration: 337.407701ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:55.474769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:55.137162Z","time spent":"337.600963ms","remote":"127.0.0.1:40838","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-02-20T18:21:55.474929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.685442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:21:55.474963Z","caller":"traceutil/trace.go:171","msg":"trace[1404846903] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:796; }","duration":"258.743842ms","start":"2026-02-20T18:21:55.216211Z","end":"2026-02-20T18:21:55.474955Z","steps":["trace[1404846903] 'agreement among raft nodes before linearized reading' (duration: 258.691012ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:13.773196Z","caller":"traceutil/trace.go:171","msg":"trace[431735253] linearizableReadLoop","detail":"{readStateIndex:879; appliedIndex:878; }","duration":"127.522547ms","start":"2026-02-20T18:22:13.645651Z","end":"2026-02-20T18:22:13.773173Z","steps":["trace[431735253] 'read index received' (duration: 95.154389ms)","trace[431735253] 'applied index is now lower than readState.Index' (duration: 32.366888ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:22:13.773253Z","caller":"traceutil/trace.go:171","msg":"trace[769278928] transaction","detail":"{read_only:false; response_revision:848; number_of_response:1; }","duration":"135.952507ms","start":"2026-02-20T18:22:13.637272Z","end":"2026-02-20T18:22:13.773225Z","steps":["trace[769278928] 'process raft request' (duration: 103.575199ms)","trace[769278928] 'compare' (duration: 32.214675ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:22:13.773393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.735321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-02-20T18:22:13.773639Z","caller":"traceutil/trace.go:171","msg":"trace[955422128] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:848; }","duration":"127.839553ms","start":"2026-02-20T18:22:13.645576Z","end":"2026-02-20T18:22:13.773416Z","steps":["trace[955422128] 'agreement among raft nodes before linearized reading' (duration: 127.69133ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:17.158599Z","caller":"traceutil/trace.go:171","msg":"trace[2027515468] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"251.159832ms","start":"2026-02-20T18:22:16.907408Z","end":"2026-02-20T18:22:17.158567Z","steps":["trace[2027515468] 'process raft request' (duration: 238.112685ms)","trace[2027515468] 'compare' (duration: 12.818763ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:22:19.372861Z","caller":"traceutil/trace.go:171","msg":"trace[1161510969] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"149.624798ms","start":"2026-02-20T18:22:19.223206Z","end":"2026-02-20T18:22:19.372831Z","steps":["trace[1161510969] 'process raft request' (duration: 116.397967ms)","trace[1161510969] 'compare' (duration: 33.057568ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:22:21.226051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.796219ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-20T18:22:23.154248Z","caller":"traceutil/trace.go:171","msg":"trace[651255008] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"202.735703ms","start":"2026-02-20T18:22:22.951464Z","end":"2026-02-20T18:22:23.154199Z","steps":["trace[651255008] 'process raft request' (duration: 202.281125ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:23.484867Z","caller":"traceutil/trace.go:171","msg":"trace[2142617589] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"246.965674ms","start":"2026-02-20T18:22:23.237487Z","end":"2026-02-20T18:22:23.484452Z","steps":["trace[2142617589] 'process raft request' (duration: 246.635678ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:23.734245Z","caller":"traceutil/trace.go:171","msg":"trace[2664713] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"246.17749ms","start":"2026-02-20T18:22:23.488045Z","end":"2026-02-20T18:22:23.734223Z","steps":["trace[2664713] 'process raft request' (duration: 239.676417ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:24.367885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.26645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329936"} {"level":"info","ts":"2026-02-20T18:22:24.367964Z","caller":"traceutil/trace.go:171","msg":"trace[51016218] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:876; }","duration":"150.356992ms","start":"2026-02-20T18:22:24.21759Z","end":"2026-02-20T18:22:24.367947Z","steps":["trace[51016218] 'range keys from in-memory index tree' (duration: 149.513576ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:28.024307Z","caller":"traceutil/trace.go:171","msg":"trace[741070131] linearizableReadLoop","detail":"{readStateIndex:919; appliedIndex:918; }","duration":"198.850066ms","start":"2026-02-20T18:22:27.825436Z","end":"2026-02-20T18:22:28.024286Z","steps":["trace[741070131] 'read index received' (duration: 198.735444ms)","trace[741070131] 'applied index is now lower than readState.Index' (duration: 113.542µs)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:22:28.024408Z","caller":"traceutil/trace.go:171","msg":"trace[2008088404] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"217.454559ms","start":"2026-02-20T18:22:27.806931Z","end":"2026-02-20T18:22:28.024385Z","steps":["trace[2008088404] 'process raft request' (duration: 217.238485ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:28.024644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.176472ms","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-02-20T18:22:28.024761Z","caller":"traceutil/trace.go:171","msg":"trace[1184060602] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:885; }","duration":"199.338584ms","start":"2026-02-20T18:22:27.825391Z","end":"2026-02-20T18:22:28.02473Z","steps":["trace[1184060602] 'agreement among raft nodes before linearized reading' (duration: 199.043789ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:28.13139Z","caller":"traceutil/trace.go:171","msg":"trace[1470512671] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"103.060772ms","start":"2026-02-20T18:22:28.028309Z","end":"2026-02-20T18:22:28.13137Z","steps":["trace[1470512671] 'process raft request' (duration: 102.95402ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:29.317261Z","caller":"traceutil/trace.go:171","msg":"trace[1489268568] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"125.543769ms","start":"2026-02-20T18:22:29.19169Z","end":"2026-02-20T18:22:29.317234Z","steps":["trace[1489268568] 'process raft request' (duration: 125.406717ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:29.789677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.072001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"} {"level":"info","ts":"2026-02-20T18:22:29.789798Z","caller":"traceutil/trace.go:171","msg":"trace[770091801] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:888; }","duration":"298.242244ms","start":"2026-02-20T18:22:29.49153Z","end":"2026-02-20T18:22:29.789772Z","steps":["trace[770091801] 'range keys from in-memory index tree' (duration: 297.569891ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:29.78988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.065038ms","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-02-20T18:22:29.790206Z","caller":"traceutil/trace.go:171","msg":"trace[1556630277] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:888; }","duration":"256.445945ms","start":"2026-02-20T18:22:29.53373Z","end":"2026-02-20T18:22:29.790176Z","steps":["trace[1556630277] 'range keys from in-memory index tree' (duration: 255.418445ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:29.866312Z","caller":"traceutil/trace.go:171","msg":"trace[944251603] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"170.54049ms","start":"2026-02-20T18:22:29.695718Z","end":"2026-02-20T18:22:29.866259Z","steps":["trace[944251603] 'process raft request' (duration: 170.376507ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:29.982204Z","caller":"traceutil/trace.go:171","msg":"trace[1845274579] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"186.071478ms","start":"2026-02-20T18:22:29.796104Z","end":"2026-02-20T18:22:29.982175Z","steps":["trace[1845274579] 'process raft request' (duration: 147.601413ms)","trace[1845274579] 'compare' (duration: 38.304632ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:22:30.497056Z","caller":"traceutil/trace.go:171","msg":"trace[475314185] linearizableReadLoop","detail":"{readStateIndex:925; appliedIndex:924; }","duration":"469.038593ms","start":"2026-02-20T18:22:30.027985Z","end":"2026-02-20T18:22:30.497024Z","steps":["trace[475314185] 'read index received' (duration: 433.173754ms)","trace[475314185] 'applied index is now lower than readState.Index' (duration: 35.863529ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:22:30.497183Z","caller":"traceutil/trace.go:171","msg":"trace[1656955987] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"535.995905ms","start":"2026-02-20T18:22:29.961158Z","end":"2026-02-20T18:22:30.497154Z","steps":["trace[1656955987] 'process raft request' (duration: 500.078415ms)","trace[1656955987] 'compare' (duration: 35.650165ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:22:30.497393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.395949ms","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-02-20T18:22:30.497443Z","caller":"traceutil/trace.go:171","msg":"trace[1800903350] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:891; }","duration":"469.493831ms","start":"2026-02-20T18:22:30.027936Z","end":"2026-02-20T18:22:30.49743Z","steps":["trace[1800903350] 'agreement among raft nodes before linearized reading' (duration: 469.308428ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:30.497479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:30.027918Z","time spent":"469.553402ms","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-20T18:22:30.49759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.64157ms","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-02-20T18:22:30.497617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:29.961126Z","time spent":"536.256509ms","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-20T18:22:30.497744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.736459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:22:30.497815Z","caller":"traceutil/trace.go:171","msg":"trace[1484636617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:891; }","duration":"279.85249ms","start":"2026-02-20T18:22:30.217949Z","end":"2026-02-20T18:22:30.497801Z","steps":["trace[1484636617] 'agreement among raft nodes before linearized reading' (duration: 279.762238ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:30.497873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.598479ms","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-02-20T18:22:30.497919Z","caller":"traceutil/trace.go:171","msg":"trace[1925624208] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:891; }","duration":"362.664851ms","start":"2026-02-20T18:22:30.135244Z","end":"2026-02-20T18:22:30.497908Z","steps":["trace[1925624208] 'agreement among raft nodes before linearized reading' (duration: 362.555229ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:30.49795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:30.135233Z","time spent":"362.710493ms","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-20T18:22:30.497665Z","caller":"traceutil/trace.go:171","msg":"trace[2118431345] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:891; }","duration":"375.744091ms","start":"2026-02-20T18:22:30.121902Z","end":"2026-02-20T18:22:30.497646Z","steps":["trace[2118431345] 'agreement among raft nodes before linearized reading' (duration: 375.550127ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:30.498058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:30.12189Z","time spent":"376.16132ms","remote":"127.0.0.1:40838","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":"warn","ts":"2026-02-20T18:22:31.443623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.111261ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-20T18:22:31.443699Z","caller":"traceutil/trace.go:171","msg":"trace[1721195124] linearizableReadLoop","detail":"{readStateIndex:929; appliedIndex:928; }","duration":"122.52597ms","start":"2026-02-20T18:22:31.321161Z","end":"2026-02-20T18:22:31.443687Z","steps":["trace[1721195124] 'read index received' (duration: 49.742µs)","trace[1721195124] 'applied index is now lower than readState.Index' (duration: 122.475078ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:22:31.443814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.658383ms","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-02-20T18:22:31.443833Z","caller":"traceutil/trace.go:171","msg":"trace[42027804] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:894; }","duration":"122.718584ms","start":"2026-02-20T18:22:31.321109Z","end":"2026-02-20T18:22:31.443828Z","steps":["trace[42027804] 'agreement among raft nodes before linearized reading' (duration: 122.609822ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:32.712361Z","caller":"traceutil/trace.go:171","msg":"trace[348396252] linearizableReadLoop","detail":"{readStateIndex:932; appliedIndex:931; }","duration":"147.104064ms","start":"2026-02-20T18:22:32.565235Z","end":"2026-02-20T18:22:32.712339Z","steps":["trace[348396252] 'read index received' (duration: 146.90174ms)","trace[348396252] 'applied index is now lower than readState.Index' (duration: 201.064µs)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:22:32.712409Z","caller":"traceutil/trace.go:171","msg":"trace[1192536416] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"194.686694ms","start":"2026-02-20T18:22:32.51769Z","end":"2026-02-20T18:22:32.712376Z","steps":["trace[1192536416] 'process raft request' (duration: 194.51508ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:32.712575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.281937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-20T18:22:32.71261Z","caller":"traceutil/trace.go:171","msg":"trace[565046881] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:897; }","duration":"147.364768ms","start":"2026-02-20T18:22:32.565237Z","end":"2026-02-20T18:22:32.712602Z","steps":["trace[565046881] 'agreement among raft nodes before linearized reading' (duration: 147.227915ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:32.71261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.362848ms","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-02-20T18:22:32.712687Z","caller":"traceutil/trace.go:171","msg":"trace[646896471] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:897; }","duration":"147.47609ms","start":"2026-02-20T18:22:32.565193Z","end":"2026-02-20T18:22:32.712669Z","steps":["trace[646896471] 'agreement among raft nodes before linearized reading' (duration: 147.227455ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:34.4513Z","caller":"traceutil/trace.go:171","msg":"trace[1363037958] linearizableReadLoop","detail":"{readStateIndex:938; appliedIndex:937; }","duration":"234.008633ms","start":"2026-02-20T18:22:34.217267Z","end":"2026-02-20T18:22:34.451276Z","steps":["trace[1363037958] 'read index received' (duration: 233.891351ms)","trace[1363037958] 'applied index is now lower than readState.Index' (duration: 116.382µs)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:22:34.451454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.167707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:22:34.451494Z","caller":"traceutil/trace.go:171","msg":"trace[1055432223] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:903; }","duration":"234.255198ms","start":"2026-02-20T18:22:34.217228Z","end":"2026-02-20T18:22:34.451483Z","steps":["trace[1055432223] 'agreement among raft nodes before linearized reading' (duration: 234.141516ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:34.451729Z","caller":"traceutil/trace.go:171","msg":"trace[22863993] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"420.447151ms","start":"2026-02-20T18:22:34.031269Z","end":"2026-02-20T18:22:34.451716Z","steps":["trace[22863993] 'process raft request' (duration: 419.888421ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:34.451819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:34.031253Z","time spent":"420.517223ms","remote":"127.0.0.1:40636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":702,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-20T18:22:34.855258Z","caller":"traceutil/trace.go:171","msg":"trace[980904338] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"135.319645ms","start":"2026-02-20T18:22:34.719853Z","end":"2026-02-20T18:22:34.855173Z","steps":["trace[980904338] 'process raft request' (duration: 130.885807ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:35.039607Z","caller":"traceutil/trace.go:171","msg":"trace[779231596] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"180.426683ms","start":"2026-02-20T18:22:34.859155Z","end":"2026-02-20T18:22:35.039581Z","steps":["trace[779231596] 'process raft request' (duration: 173.242443ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:35.055113Z","caller":"traceutil/trace.go:171","msg":"trace[1816352169] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"195.247602ms","start":"2026-02-20T18:22:34.859842Z","end":"2026-02-20T18:22:35.05509Z","steps":["trace[1816352169] 'process raft request' (duration: 195.066368ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:35.055261Z","caller":"traceutil/trace.go:171","msg":"trace[1582489396] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"195.272743ms","start":"2026-02-20T18:22:34.859958Z","end":"2026-02-20T18:22:35.055231Z","steps":["trace[1582489396] 'process raft request' (duration: 195.079359ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:35.285795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.556337ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-20T18:22:35.285936Z","caller":"traceutil/trace.go:171","msg":"trace[1453176810] linearizableReadLoop","detail":"{readStateIndex:945; appliedIndex:944; }","duration":"220.181668ms","start":"2026-02-20T18:22:35.065732Z","end":"2026-02-20T18:22:35.285913Z","steps":["trace[1453176810] 'read index received' (duration: 107.424708ms)","trace[1453176810] 'applied index is now lower than readState.Index' (duration: 112.755ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:22:35.286051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.305231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:22:35.286013Z","caller":"traceutil/trace.go:171","msg":"trace[620440224] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"227.067563ms","start":"2026-02-20T18:22:35.058887Z","end":"2026-02-20T18:22:35.285955Z","steps":["trace[620440224] 'process raft request' (duration: 114.245931ms)","trace[620440224] 'compare' (duration: 112.386984ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:22:35.286098Z","caller":"traceutil/trace.go:171","msg":"trace[709474338] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:910; }","duration":"220.383931ms","start":"2026-02-20T18:22:35.065699Z","end":"2026-02-20T18:22:35.286083Z","steps":["trace[709474338] 'agreement among raft nodes before linearized reading' (duration: 220.274279ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:35.321253Z","caller":"traceutil/trace.go:171","msg":"trace[236646003] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"255.171001ms","start":"2026-02-20T18:22:35.066054Z","end":"2026-02-20T18:22:35.321225Z","steps":["trace[236646003] 'process raft request' (duration: 255.028979ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:35.663194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.59156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-212e44b1-2909-4cfe-9b00-5469b8a25aaa\" ","response":"range_response_count:1 size:2491"} {"level":"info","ts":"2026-02-20T18:22:35.663298Z","caller":"traceutil/trace.go:171","msg":"trace[134364464] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-212e44b1-2909-4cfe-9b00-5469b8a25aaa; range_end:; response_count:1; response_revision:912; }","duration":"276.725263ms","start":"2026-02-20T18:22:35.386547Z","end":"2026-02-20T18:22:35.663272Z","steps":["trace[134364464] 'range keys from in-memory index tree' (duration: 276.527639ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:35.69331Z","caller":"traceutil/trace.go:171","msg":"trace[1370563775] linearizableReadLoop","detail":"{readStateIndex:948; appliedIndex:947; }","duration":"303.922884ms","start":"2026-02-20T18:22:35.38936Z","end":"2026-02-20T18:22:35.693283Z","steps":["trace[1370563775] 'read index received' (duration: 303.690589ms)","trace[1370563775] 'applied index is now lower than readState.Index' (duration: 231.235µs)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:22:35.693585Z","caller":"traceutil/trace.go:171","msg":"trace[1281887232] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"306.036034ms","start":"2026-02-20T18:22:35.387537Z","end":"2026-02-20T18:22:35.693573Z","steps":["trace[1281887232] 'process raft request' (duration: 305.608656ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:35.693702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:35.387523Z","time spent":"306.098975ms","remote":"127.0.0.1:40748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3519,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-20T18:22:35.694034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.82886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-20T18:22:35.694115Z","caller":"traceutil/trace.go:171","msg":"trace[1253132798] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:913; }","duration":"118.971442ms","start":"2026-02-20T18:22:35.575124Z","end":"2026-02-20T18:22:35.694095Z","steps":["trace[1253132798] 'agreement among raft nodes before linearized reading' (duration: 118.807609ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:35.694109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.73805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/test-pvc.189607813c0e4d29\" ","response":"range_response_count:1 size:915"} {"level":"warn","ts":"2026-02-20T18:22:35.694183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.312196ms","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-02-20T18:22:35.694327Z","caller":"traceutil/trace.go:171","msg":"trace[414697282] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:913; }","duration":"168.553241ms","start":"2026-02-20T18:22:35.525745Z","end":"2026-02-20T18:22:35.694299Z","steps":["trace[414697282] 'agreement among raft nodes before linearized reading' (duration: 168.04876ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:35.694341Z","caller":"traceutil/trace.go:171","msg":"trace[476205613] range","detail":"{range_begin:/registry/events/default/test-pvc.189607813c0e4d29; range_end:; response_count:1; response_revision:913; }","duration":"304.835071ms","start":"2026-02-20T18:22:35.389316Z","end":"2026-02-20T18:22:35.694151Z","steps":["trace[476205613] 'agreement among raft nodes before linearized reading' (duration: 304.436433ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:35.694428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:35.389297Z","time spent":"305.114277ms","remote":"127.0.0.1:40636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":939,"request content":"key:\"/registry/events/default/test-pvc.189607813c0e4d29\" "} {"level":"warn","ts":"2026-02-20T18:22:37.207548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.118766ms","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-02-20T18:22:37.207616Z","caller":"traceutil/trace.go:171","msg":"trace[425954369] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:921; }","duration":"164.219908ms","start":"2026-02-20T18:22:37.04338Z","end":"2026-02-20T18:22:37.2076Z","steps":["trace[425954369] 'range keys from in-memory index tree' (duration: 163.988413ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:37.208038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.720012ms","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-02-20T18:22:37.208161Z","caller":"traceutil/trace.go:171","msg":"trace[649264774] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:921; }","duration":"148.885185ms","start":"2026-02-20T18:22:37.059255Z","end":"2026-02-20T18:22:37.20814Z","steps":["trace[649264774] 'range keys from in-memory index tree' (duration: 148.451147ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:37.390384Z","caller":"traceutil/trace.go:171","msg":"trace[1367164626] linearizableReadLoop","detail":"{readStateIndex:959; appliedIndex:957; }","duration":"174.797685ms","start":"2026-02-20T18:22:37.21556Z","end":"2026-02-20T18:22:37.390358Z","steps":["trace[1367164626] 'read index received' (duration: 88.301395ms)","trace[1367164626] 'applied index is now lower than readState.Index' (duration: 86.49539ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:22:37.390492Z","caller":"traceutil/trace.go:171","msg":"trace[2132646441] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"177.903506ms","start":"2026-02-20T18:22:37.21256Z","end":"2026-02-20T18:22:37.390463Z","steps":["trace[2132646441] 'process raft request' (duration: 168.239836ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:37.390518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.938207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:22:37.390567Z","caller":"traceutil/trace.go:171","msg":"trace[472173040] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:923; }","duration":"175.03722ms","start":"2026-02-20T18:22:37.215519Z","end":"2026-02-20T18:22:37.390556Z","steps":["trace[472173040] 'agreement among raft nodes before linearized reading' (duration: 174.938028ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:51.56547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.400651ms","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-02-20T18:22:51.565549Z","caller":"traceutil/trace.go:171","msg":"trace[1907706905] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:987; }","duration":"195.511352ms","start":"2026-02-20T18:22:51.370022Z","end":"2026-02-20T18:22:51.565533Z","steps":["trace[1907706905] 'range keys from in-memory index tree' (duration: 195.264508ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:51.961059Z","caller":"traceutil/trace.go:171","msg":"trace[938872841] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"391.743263ms","start":"2026-02-20T18:22:51.569288Z","end":"2026-02-20T18:22:51.961032Z","steps":["trace[938872841] 'process raft request' (duration: 391.548909ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:51.961244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:51.569263Z","time spent":"391.880605ms","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-20T18:22:52.004306Z","caller":"traceutil/trace.go:171","msg":"trace[1555255529] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1028; }","duration":"307.274867ms","start":"2026-02-20T18:22:51.697001Z","end":"2026-02-20T18:22:52.004276Z","steps":["trace[1555255529] 'read index received' (duration: 263.85692ms)","trace[1555255529] 'applied index is now lower than readState.Index' (duration: 43.416867ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:22:52.004401Z","caller":"traceutil/trace.go:171","msg":"trace[1118419625] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"434.183169ms","start":"2026-02-20T18:22:51.570188Z","end":"2026-02-20T18:22:52.004372Z","steps":["trace[1118419625] 'process raft request' (duration: 398.52516ms)","trace[1118419625] 'compare' (duration: 35.439325ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:22:52.004559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:51.570174Z","time spent":"434.278571ms","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-20T18:22:52.004576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.503201ms","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-02-20T18:22:52.004633Z","caller":"traceutil/trace.go:171","msg":"trace[336836110] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:989; }","duration":"307.664755ms","start":"2026-02-20T18:22:51.696951Z","end":"2026-02-20T18:22:52.004616Z","steps":["trace[336836110] 'agreement among raft nodes before linearized reading' (duration: 307.476231ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:52.004682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:51.696928Z","time spent":"307.742606ms","remote":"127.0.0.1:40594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":67,"response size":31,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-02-20T18:22:52.004703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.860599ms","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-02-20T18:22:52.004772Z","caller":"traceutil/trace.go:171","msg":"trace[1705081690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:989; }","duration":"121.964141ms","start":"2026-02-20T18:22:51.882789Z","end":"2026-02-20T18:22:52.004753Z","steps":["trace[1705081690] 'agreement among raft nodes before linearized reading' (duration: 121.764767ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:56.190575Z","caller":"traceutil/trace.go:171","msg":"trace[75563862] linearizableReadLoop","detail":"{readStateIndex:1047; appliedIndex:1046; }","duration":"157.366912ms","start":"2026-02-20T18:22:56.033182Z","end":"2026-02-20T18:22:56.190549Z","steps":["trace[75563862] 'read index received' (duration: 154.518004ms)","trace[75563862] 'applied index is now lower than readState.Index' (duration: 2.847998ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:22:56.190693Z","caller":"traceutil/trace.go:171","msg":"trace[290762578] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"169.651705ms","start":"2026-02-20T18:22:56.021005Z","end":"2026-02-20T18:22:56.190656Z","steps":["trace[290762578] 'process raft request' (duration: 166.763296ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:56.190876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.684258ms","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-02-20T18:22:56.190977Z","caller":"traceutil/trace.go:171","msg":"trace[381842102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1004; }","duration":"157.818891ms","start":"2026-02-20T18:22:56.033135Z","end":"2026-02-20T18:22:56.190954Z","steps":["trace[381842102] 'agreement among raft nodes before linearized reading' (duration: 157.565606ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:23:06.576032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.733062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/default/\" range_end:\"/registry/limitranges/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:23:06.576126Z","caller":"traceutil/trace.go:171","msg":"trace[888869078] range","detail":"{range_begin:/registry/limitranges/default/; range_end:/registry/limitranges/default0; response_count:0; response_revision:1034; }","duration":"126.890305ms","start":"2026-02-20T18:23:06.449218Z","end":"2026-02-20T18:23:06.576109Z","steps":["trace[888869078] 'range keys from in-memory index tree' (duration: 126.67478ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:23:06.576153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.409128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-20T18:23:06.576249Z","caller":"traceutil/trace.go:171","msg":"trace[204534093] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1034; }","duration":"100.544651ms","start":"2026-02-20T18:23:06.475667Z","end":"2026-02-20T18:23:06.576211Z","steps":["trace[204534093] 'count revisions from in-memory index tree' (duration: 100.312755ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:23:20.888083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.231471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-20T18:23:20.888216Z","caller":"traceutil/trace.go:171","msg":"trace[697470137] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"356.658756ms","start":"2026-02-20T18:23:20.531521Z","end":"2026-02-20T18:23:20.88818Z","steps":["trace[697470137] 'read index received' (duration: 49.226662ms)","trace[697470137] 'applied index is now lower than readState.Index' (duration: 307.430994ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:23:20.888253Z","caller":"traceutil/trace.go:171","msg":"trace[1155351136] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"358.629818ms","start":"2026-02-20T18:23:20.52958Z","end":"2026-02-20T18:23:20.88821Z","steps":["trace[1155351136] 'process raft request' (duration: 51.147503ms)","trace[1155351136] 'compare' (duration: 307.115917ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:23:20.888417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.892431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9sj47\" ","response":"range_response_count:1 size:18058"} {"level":"info","ts":"2026-02-20T18:23:20.888456Z","caller":"traceutil/trace.go:171","msg":"trace[1813842518] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9sj47; range_end:; response_count:1; response_revision:1072; }","duration":"356.959103ms","start":"2026-02-20T18:23:20.531486Z","end":"2026-02-20T18:23:20.888445Z","steps":["trace[1813842518] 'agreement among raft nodes before linearized reading' (duration: 356.790839ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:23:20.888428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.788769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-20T18:23:20.888457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:23:20.52956Z","time spent":"358.796412ms","remote":"127.0.0.1:40838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-20T18:23:20.888493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:23:20.531468Z","time spent":"357.018134ms","remote":"127.0.0.1:40748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18082,"request content":"key:\"/registry/pods/kube-system/cilium-9sj47\" "} {"level":"info","ts":"2026-02-20T18:23:20.888513Z","caller":"traceutil/trace.go:171","msg":"trace[2025399791] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1072; }","duration":"242.953722ms","start":"2026-02-20T18:23:20.64554Z","end":"2026-02-20T18:23:20.888494Z","steps":["trace[2025399791] 'agreement among raft nodes before linearized reading' (duration: 242.787948ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:23:21.06598Z","caller":"traceutil/trace.go:171","msg":"trace[988510980] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"162.526119ms","start":"2026-02-20T18:23:20.903427Z","end":"2026-02-20T18:23:21.065953Z","steps":["trace[988510980] 'process raft request' (duration: 123.164298ms)","trace[988510980] 'compare' (duration: 39.218428ms)"],"step_count":2}