{"level":"warn","ts":"2026-02-25T19:29:51.860121Z","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-25T19:29:51.860213Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.54:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.54:2380","--initial-cluster=instance=https://199.19.213.54:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.54:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.54: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-25T19:29:51.860314Z","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-25T19:29:51.860331Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.54:2380"]} {"level":"info","ts":"2026-02-25T19:29:51.860352Z","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-25T19:29:51.861695Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.54:2379"]} {"level":"info","ts":"2026-02-25T19:29:51.86179Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.54:2380"],"listen-peer-urls":["https://199.19.213.54:2380"],"advertise-client-urls":["https://199.19.213.54:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.54:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.54: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-25T19:29:51.867139Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.973268ms"} {"level":"info","ts":"2026-02-25T19:29:51.87212Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"193b4dda7792855b","cluster-id":"dd6702a2f79ce697"} {"level":"info","ts":"2026-02-25T19:29:51.872187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T19:29:51.872214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became follower at term 0"} {"level":"info","ts":"2026-02-25T19:29:51.872231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 193b4dda7792855b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T19:29:51.87224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became follower at term 1"} {"level":"info","ts":"2026-02-25T19:29:51.872282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b switched to configuration voters=(1818132475278427483)"} {"level":"warn","ts":"2026-02-25T19:29:51.878108Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T19:29:51.87938Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T19:29:51.880391Z","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-25T19:29:51.88559Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"193b4dda7792855b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T19:29:51.885838Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"193b4dda7792855b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T19:29:51.889453Z","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-25T19:29:51.88954Z","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-25T19:29:51.889553Z","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-25T19:29:51.890128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b switched to configuration voters=(1818132475278427483)"} {"level":"info","ts":"2026-02-25T19:29:51.890901Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dd6702a2f79ce697","local-member-id":"193b4dda7792855b","added-peer-id":"193b4dda7792855b","added-peer-peer-urls":["https://199.19.213.54:2380"]} {"level":"info","ts":"2026-02-25T19:29:51.892972Z","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-25T19:29:51.893081Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.54:2380"} {"level":"info","ts":"2026-02-25T19:29:51.893134Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.54:2380"} {"level":"info","ts":"2026-02-25T19:29:51.893557Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"193b4dda7792855b","initial-advertise-peer-urls":["https://199.19.213.54:2380"],"listen-peer-urls":["https://199.19.213.54:2380"],"advertise-client-urls":["https://199.19.213.54:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.54:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T19:29:51.893634Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T19:29:52.472646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T19:29:52.472873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T19:29:52.47334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b received MsgPreVoteResp from 193b4dda7792855b at term 1"} {"level":"info","ts":"2026-02-25T19:29:52.473398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became candidate at term 2"} {"level":"info","ts":"2026-02-25T19:29:52.473422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b received MsgVoteResp from 193b4dda7792855b at term 2"} {"level":"info","ts":"2026-02-25T19:29:52.473552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became leader at term 2"} {"level":"info","ts":"2026-02-25T19:29:52.473583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 193b4dda7792855b elected leader 193b4dda7792855b at term 2"} {"level":"info","ts":"2026-02-25T19:29:52.862862Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T19:29:52.863004Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T19:29:52.863021Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T19:29:52.863069Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"193b4dda7792855b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.54:2379]}","request-path":"/0/members/193b4dda7792855b/attributes","cluster-id":"dd6702a2f79ce697","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T19:29:52.863651Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T19:29:52.863726Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T19:29:52.865946Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.54:2379"} {"level":"info","ts":"2026-02-25T19:29:52.866926Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-25T19:29:53.028556Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dd6702a2f79ce697","local-member-id":"193b4dda7792855b","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T19:29:53.028987Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T19:29:53.029143Z","caller":"traceutil/trace.go:171","msg":"trace[52640549] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"118.178138ms","start":"2026-02-25T19:29:52.910889Z","end":"2026-02-25T19:29:53.029067Z","steps":["trace[52640549] 'read index received' (duration: 115.87616ms)","trace[52640549] 'applied index is now lower than readState.Index' (duration: 2.299518ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:29:53.030737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.795681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.03094Z","caller":"traceutil/trace.go:171","msg":"trace[1113442484] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"119.944395ms","start":"2026-02-25T19:29:52.910883Z","end":"2026-02-25T19:29:53.030827Z","steps":["trace[1113442484] 'agreement among raft nodes before linearized reading' (duration: 118.476927ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:53.029984Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-02-25T19:29:53.031225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.1923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.031343Z","caller":"traceutil/trace.go:171","msg":"trace[1276505769] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"120.345823ms","start":"2026-02-25T19:29:52.910976Z","end":"2026-02-25T19:29:53.031322Z","steps":["trace[1276505769] 'agreement among raft nodes before linearized reading' (duration: 118.413974ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.613455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.064118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.613547Z","caller":"traceutil/trace.go:171","msg":"trace[1114507014] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1; }","duration":"312.20053ms","start":"2026-02-25T19:29:53.301322Z","end":"2026-02-25T19:29:53.613522Z","steps":["trace[1114507014] 'count revisions from in-memory index tree' (duration: 311.990025ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.613545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.321378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.613593Z","caller":"traceutil/trace.go:171","msg":"trace[368319545] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1; }","duration":"167.469002ms","start":"2026-02-25T19:29:53.446114Z","end":"2026-02-25T19:29:53.613583Z","steps":["trace[368319545] 'range keys from in-memory index tree' (duration: 167.274277ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.613614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.767833ms","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":"warn","ts":"2026-02-25T19:29:53.613604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.30131Z","time spent":"312.282423ms","remote":"127.0.0.1:40270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"info","ts":"2026-02-25T19:29:53.613656Z","caller":"traceutil/trace.go:171","msg":"trace[721489152] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"523.851145ms","start":"2026-02-25T19:29:53.089798Z","end":"2026-02-25T19:29:53.613649Z","steps":["trace[721489152] 'count revisions from in-memory index tree' (duration: 523.69477ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.613685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.089777Z","time spent":"523.901126ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:29:53.613478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.571464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.613778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.444078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.613795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.876835ms","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":"info","ts":"2026-02-25T19:29:53.613833Z","caller":"traceutil/trace.go:171","msg":"trace[833636942] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"523.918996ms","start":"2026-02-25T19:29:53.089908Z","end":"2026-02-25T19:29:53.613827Z","steps":["trace[833636942] 'range keys from in-memory index tree' (duration: 523.802984ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:53.613835Z","caller":"traceutil/trace.go:171","msg":"trace[459418998] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1; }","duration":"156.50216ms","start":"2026-02-25T19:29:53.457323Z","end":"2026-02-25T19:29:53.613825Z","steps":["trace[459418998] 'range keys from in-memory index tree' (duration: 156.406138ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.613854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.089885Z","time spent":"523.964387ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 "} {"level":"info","ts":"2026-02-25T19:29:53.613806Z","caller":"traceutil/trace.go:171","msg":"trace[107716832] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1; }","duration":"167.928133ms","start":"2026-02-25T19:29:53.445857Z","end":"2026-02-25T19:29:53.613785Z","steps":["trace[107716832] 'count revisions from in-memory index tree' (duration: 167.500612ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.613936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.286646ms","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-25T19:29:53.613952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.624915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.61396Z","caller":"traceutil/trace.go:171","msg":"trace[716996583] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"508.347518ms","start":"2026-02-25T19:29:53.105607Z","end":"2026-02-25T19:29:53.613955Z","steps":["trace[716996583] 'range keys from in-memory index tree' (duration: 508.178833ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.613975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.604864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.614012Z","caller":"traceutil/trace.go:171","msg":"trace[1129192861] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1; }","duration":"156.684745ms","start":"2026-02-25T19:29:53.457319Z","end":"2026-02-25T19:29:53.614004Z","steps":["trace[1129192861] 'count revisions from in-memory index tree' (duration: 156.551862ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.614025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.751929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.614052Z","caller":"traceutil/trace.go:171","msg":"trace[1378358310] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"437.80651ms","start":"2026-02-25T19:29:53.176237Z","end":"2026-02-25T19:29:53.614043Z","steps":["trace[1378358310] 'range keys from in-memory index tree' (duration: 437.627555ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.614092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.176217Z","time spent":"437.865732ms","remote":"127.0.0.1:40190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T19:29:53.614131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.626066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.614166Z","caller":"traceutil/trace.go:171","msg":"trace[1243263429] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1; }","duration":"119.685497ms","start":"2026-02-25T19:29:53.494472Z","end":"2026-02-25T19:29:53.614158Z","steps":["trace[1243263429] 'range keys from in-memory index tree' (duration: 119.584115ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.614192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.77654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.614223Z","caller":"traceutil/trace.go:171","msg":"trace[454613230] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"494.821741ms","start":"2026-02-25T19:29:53.119395Z","end":"2026-02-25T19:29:53.614216Z","steps":["trace[454613230] 'count revisions from in-memory index tree' (duration: 494.728219ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.614248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.119389Z","time spent":"494.851752ms","remote":"127.0.0.1:40164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:29:53.614254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.320996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.614278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.670757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.6143Z","caller":"traceutil/trace.go:171","msg":"trace[2003259437] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1; }","duration":"119.694027ms","start":"2026-02-25T19:29:53.4946Z","end":"2026-02-25T19:29:53.614294Z","steps":["trace[2003259437] 'count revisions from in-memory index tree' (duration: 119.604296ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:53.614302Z","caller":"traceutil/trace.go:171","msg":"trace[566981424] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"426.360327ms","start":"2026-02-25T19:29:53.187922Z","end":"2026-02-25T19:29:53.614282Z","steps":["trace[566981424] 'range keys from in-memory index tree' (duration: 426.222543ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.614336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.187825Z","time spent":"426.50166ms","remote":"127.0.0.1:40202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T19:29:53.61438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.0311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.614406Z","caller":"traceutil/trace.go:171","msg":"trace[1797052501] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1; }","duration":"110.068291ms","start":"2026-02-25T19:29:53.50433Z","end":"2026-02-25T19:29:53.614399Z","steps":["trace[1797052501] 'count revisions from in-memory index tree' (duration: 110.002419ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.614485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.606954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.614498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.469789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.614515Z","caller":"traceutil/trace.go:171","msg":"trace[897374305] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1; }","duration":"247.684576ms","start":"2026-02-25T19:29:53.366821Z","end":"2026-02-25T19:29:53.614505Z","steps":["trace[897374305] 'range keys from in-memory index tree' (duration: 247.493282ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.614532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.241715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.614538Z","caller":"traceutil/trace.go:171","msg":"trace[346285911] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"426.545381ms","start":"2026-02-25T19:29:53.187982Z","end":"2026-02-25T19:29:53.614527Z","steps":["trace[346285911] 'count revisions from in-memory index tree' (duration: 426.325866ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:53.614558Z","caller":"traceutil/trace.go:171","msg":"trace[1634710799] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1; }","duration":"110.284766ms","start":"2026-02-25T19:29:53.504268Z","end":"2026-02-25T19:29:53.614553Z","steps":["trace[1634710799] 'range keys from in-memory index tree' (duration: 110.117032ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.61457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.187959Z","time spent":"426.601354ms","remote":"127.0.0.1:40202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:29:53.614612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.100315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.616223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.421129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.616267Z","caller":"traceutil/trace.go:171","msg":"trace[646333580] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1; }","duration":"314.750696ms","start":"2026-02-25T19:29:53.301495Z","end":"2026-02-25T19:29:53.616246Z","steps":["trace[646333580] 'range keys from in-memory index tree' (duration: 313.071164ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.616308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.301487Z","time spent":"314.810468ms","remote":"127.0.0.1:40270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":27,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" limit:10000 "} {"level":"info","ts":"2026-02-25T19:29:53.616409Z","caller":"traceutil/trace.go:171","msg":"trace[1686228019] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1; }","duration":"396.509291ms","start":"2026-02-25T19:29:53.219771Z","end":"2026-02-25T19:29:53.61628Z","steps":["trace[1686228019] 'count revisions from in-memory index tree' (duration: 396.319276ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.616568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.219757Z","time spent":"396.703516ms","remote":"127.0.0.1:40220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:29:53.615362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.657351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.61682Z","caller":"traceutil/trace.go:171","msg":"trace[455352149] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1; }","duration":"223.140299ms","start":"2026-02-25T19:29:53.393668Z","end":"2026-02-25T19:29:53.616808Z","steps":["trace[455352149] 'range keys from in-memory index tree' (duration: 221.599009ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.617037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.575565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.617085Z","caller":"traceutil/trace.go:171","msg":"trace[519462091] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1; }","duration":"343.624966ms","start":"2026-02-25T19:29:53.273449Z","end":"2026-02-25T19:29:53.617074Z","steps":["trace[519462091] 'range keys from in-memory index tree' (duration: 343.518554ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.61713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.273398Z","time spent":"343.716578ms","remote":"127.0.0.1:40250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":27,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T19:29:53.615569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.814875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.617261Z","caller":"traceutil/trace.go:171","msg":"trace[426625793] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1; }","duration":"223.524879ms","start":"2026-02-25T19:29:53.39372Z","end":"2026-02-25T19:29:53.617245Z","steps":["trace[426625793] 'count revisions from in-memory index tree' (duration: 221.754264ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.617391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.823704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.617419Z","caller":"traceutil/trace.go:171","msg":"trace[1336601764] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1; }","duration":"386.872795ms","start":"2026-02-25T19:29:53.230537Z","end":"2026-02-25T19:29:53.61741Z","steps":["trace[1336601764] 'range keys from in-memory index tree' (duration: 386.736882ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.617455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.230522Z","time spent":"386.921946ms","remote":"127.0.0.1:40222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":27,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T19:29:53.615663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.371494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.617907Z","caller":"traceutil/trace.go:171","msg":"trace[1900112450] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1; }","duration":"209.642382ms","start":"2026-02-25T19:29:53.408249Z","end":"2026-02-25T19:29:53.617892Z","steps":["trace[1900112450] 'range keys from in-memory index tree' (duration: 207.267822ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.613452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.483271ms","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":"info","ts":"2026-02-25T19:29:53.618302Z","caller":"traceutil/trace.go:171","msg":"trace[1472028955] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"511.121539ms","start":"2026-02-25T19:29:53.106932Z","end":"2026-02-25T19:29:53.618054Z","steps":["trace[1472028955] 'count revisions from in-memory index tree' (duration: 506.405897ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.618363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.10689Z","time spent":"511.457457ms","remote":"127.0.0.1:40154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":27,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:29:53.615693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.345204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.618862Z","caller":"traceutil/trace.go:171","msg":"trace[1908705528] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1; }","duration":"210.510175ms","start":"2026-02-25T19:29:53.408334Z","end":"2026-02-25T19:29:53.618844Z","steps":["trace[1908705528] 'count revisions from in-memory index tree' (duration: 207.294553ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.618929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.95739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.618966Z","caller":"traceutil/trace.go:171","msg":"trace[48374370] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1; }","duration":"375.029711ms","start":"2026-02-25T19:29:53.243927Z","end":"2026-02-25T19:29:53.618957Z","steps":["trace[48374370] 'range keys from in-memory index tree' (duration: 374.890188ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.618991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.243905Z","time spent":"375.076133ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":27,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T19:29:53.617998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.564313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.619116Z","caller":"traceutil/trace.go:171","msg":"trace[1770408530] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1; }","duration":"102.695972ms","start":"2026-02-25T19:29:53.516382Z","end":"2026-02-25T19:29:53.619078Z","steps":["trace[1770408530] 'range keys from in-memory index tree' (duration: 101.43272ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.619277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.686018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.613982Z","caller":"traceutil/trace.go:171","msg":"trace[197896175] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"437.680957ms","start":"2026-02-25T19:29:53.176291Z","end":"2026-02-25T19:29:53.613972Z","steps":["trace[197896175] 'count revisions from in-memory index tree' (duration: 437.582914ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.61398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.105578Z","time spent":"508.397119ms","remote":"127.0.0.1:40154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T19:29:53.615833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.896079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.615877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.782205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.615877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.858378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.615994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.190729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.616015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.192254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.616028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.962532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.619468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.368731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.619509Z","caller":"traceutil/trace.go:171","msg":"trace[1182140436] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1; }","duration":"183.442471ms","start":"2026-02-25T19:29:53.436047Z","end":"2026-02-25T19:29:53.619489Z","steps":["trace[1182140436] 'range keys from in-memory index tree' (duration: 179.88682ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:53.619527Z","caller":"traceutil/trace.go:171","msg":"trace[1612285265] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"489.431824ms","start":"2026-02-25T19:29:53.130064Z","end":"2026-02-25T19:29:53.619496Z","steps":["trace[1612285265] 'range keys from in-memory index tree' (duration: 485.099822ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:53.619556Z","caller":"traceutil/trace.go:171","msg":"trace[112296972] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1; }","duration":"241.013807ms","start":"2026-02-25T19:29:53.378535Z","end":"2026-02-25T19:29:53.619548Z","steps":["trace[112296972] 'count revisions from in-memory index tree' (duration: 236.633564ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.619564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.130045Z","time spent":"489.507935ms","remote":"127.0.0.1:40172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 "} {"level":"info","ts":"2026-02-25T19:29:53.619603Z","caller":"traceutil/trace.go:171","msg":"trace[1526839803] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1; }","duration":"197.681206ms","start":"2026-02-25T19:29:53.421915Z","end":"2026-02-25T19:29:53.619596Z","steps":["trace[1526839803] 'range keys from in-memory index tree' (duration: 193.846438ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:53.619641Z","caller":"traceutil/trace.go:171","msg":"trace[1477150288] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1; }","duration":"197.586963ms","start":"2026-02-25T19:29:53.422048Z","end":"2026-02-25T19:29:53.619635Z","steps":["trace[1477150288] 'count revisions from in-memory index tree' (duration: 193.634152ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.619396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.457791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.619693Z","caller":"traceutil/trace.go:171","msg":"trace[9543921] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"414.804991ms","start":"2026-02-25T19:29:53.204877Z","end":"2026-02-25T19:29:53.619682Z","steps":["trace[9543921] 'range keys from in-memory index tree' (duration: 410.306345ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:53.619714Z","caller":"traceutil/trace.go:171","msg":"trace[1171941270] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"479.198401ms","start":"2026-02-25T19:29:53.140507Z","end":"2026-02-25T19:29:53.619705Z","steps":["trace[1171941270] 'range keys from in-memory index tree' (duration: 472.725884ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.61974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.140487Z","time spent":"479.241132ms","remote":"127.0.0.1:40174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":27,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T19:29:53.619746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.204858Z","time spent":"414.868623ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T19:29:53.619435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.858332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.619801Z","caller":"traceutil/trace.go:171","msg":"trace[1047781215] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1; }","duration":"184.034486ms","start":"2026-02-25T19:29:53.435758Z","end":"2026-02-25T19:29:53.619792Z","steps":["trace[1047781215] 'count revisions from in-memory index tree' (duration: 180.142708ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:53.619859Z","caller":"traceutil/trace.go:171","msg":"trace[746869083] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1; }","duration":"400.054212ms","start":"2026-02-25T19:29:53.219758Z","end":"2026-02-25T19:29:53.619812Z","steps":["trace[746869083] 'range keys from in-memory index tree' (duration: 396.089371ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:53.619873Z","caller":"traceutil/trace.go:171","msg":"trace[294262471] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1; }","duration":"241.326425ms","start":"2026-02-25T19:29:53.378534Z","end":"2026-02-25T19:29:53.61986Z","steps":["trace[294262471] 'range keys from in-memory index tree' (duration: 236.656985ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.619442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.41994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.619914Z","caller":"traceutil/trace.go:171","msg":"trace[774678813] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1; }","duration":"303.043096ms","start":"2026-02-25T19:29:53.316858Z","end":"2026-02-25T19:29:53.619901Z","steps":["trace[774678813] 'range keys from in-memory index tree' (duration: 302.312197ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.613916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.397563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.619947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.219736Z","time spent":"400.144514ms","remote":"127.0.0.1:40220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":27,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T19:29:53.619472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.275708ms","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-25T19:29:53.620088Z","caller":"traceutil/trace.go:171","msg":"trace[668965460] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"489.902604ms","start":"2026-02-25T19:29:53.130163Z","end":"2026-02-25T19:29:53.620066Z","steps":["trace[668965460] 'count revisions from in-memory index tree' (duration: 485.107632ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.614347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.226891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.615722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.646313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.619968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.316836Z","time spent":"303.111578ms","remote":"127.0.0.1:40286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":27,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T19:29:53.618895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.356743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.62017Z","caller":"traceutil/trace.go:171","msg":"trace[696271516] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"415.16419ms","start":"2026-02-25T19:29:53.204978Z","end":"2026-02-25T19:29:53.620143Z","steps":["trace[696271516] 'count revisions from in-memory index tree' (duration: 410.540401ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:53.620265Z","caller":"traceutil/trace.go:171","msg":"trace[38620115] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1; }","duration":"389.721088ms","start":"2026-02-25T19:29:53.230485Z","end":"2026-02-25T19:29:53.620206Z","steps":["trace[38620115] 'count revisions from in-memory index tree' (duration: 388.207559ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.620309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.23046Z","time spent":"389.83287ms","remote":"127.0.0.1:40222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:29:53.620142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.130154Z","time spent":"489.972576ms","remote":"127.0.0.1:40172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:29:53.620523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.204924Z","time spent":"415.539489ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:29:53.621231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.170125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.621266Z","caller":"traceutil/trace.go:171","msg":"trace[150274637] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1; }","duration":"304.257638ms","start":"2026-02-25T19:29:53.317Z","end":"2026-02-25T19:29:53.621257Z","steps":["trace[150274637] 'count revisions from in-memory index tree' (duration: 304.080983ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.621353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.316942Z","time spent":"304.401941ms","remote":"127.0.0.1:40286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:29:53.621461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.186281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.621511Z","caller":"traceutil/trace.go:171","msg":"trace[1608074173] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1; }","duration":"289.238862ms","start":"2026-02-25T19:29:53.332257Z","end":"2026-02-25T19:29:53.621496Z","steps":["trace[1608074173] 'range keys from in-memory index tree' (duration: 289.021167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.621524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.231442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.62155Z","caller":"traceutil/trace.go:171","msg":"trace[203438023] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1; }","duration":"289.261953ms","start":"2026-02-25T19:29:53.33228Z","end":"2026-02-25T19:29:53.621542Z","steps":["trace[203438023] 'count revisions from in-memory index tree' (duration: 289.077808ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.621614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.875047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.621631Z","caller":"traceutil/trace.go:171","msg":"trace[921408960] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1; }","duration":"278.909689ms","start":"2026-02-25T19:29:53.342717Z","end":"2026-02-25T19:29:53.621626Z","steps":["trace[921408960] 'range keys from in-memory index tree' (duration: 278.845717ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.621688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.61734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.621718Z","caller":"traceutil/trace.go:171","msg":"trace[2131466607] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1; }","duration":"278.683372ms","start":"2026-02-25T19:29:53.343028Z","end":"2026-02-25T19:29:53.621712Z","steps":["trace[2131466607] 'count revisions from in-memory index tree' (duration: 278.572329ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.621802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.471704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:53.621837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.611008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.621849Z","caller":"traceutil/trace.go:171","msg":"trace[104363550] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1; }","duration":"267.543987ms","start":"2026-02-25T19:29:53.354293Z","end":"2026-02-25T19:29:53.621837Z","steps":["trace[104363550] 'count revisions from in-memory index tree' (duration: 267.419853ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.621876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.55171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.621889Z","caller":"traceutil/trace.go:171","msg":"trace[2068486720] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1; }","duration":"255.622691ms","start":"2026-02-25T19:29:53.366262Z","end":"2026-02-25T19:29:53.621885Z","steps":["trace[2068486720] 'count revisions from in-memory index tree' (duration: 255.445296ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:53.62186Z","caller":"traceutil/trace.go:171","msg":"trace[1309659246] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1; }","duration":"267.674469ms","start":"2026-02-25T19:29:53.35418Z","end":"2026-02-25T19:29:53.621854Z","steps":["trace[1309659246] 'range keys from in-memory index tree' (duration: 267.457834ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.622179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.581184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.622212Z","caller":"traceutil/trace.go:171","msg":"trace[2092908319] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1; }","duration":"348.666426ms","start":"2026-02-25T19:29:53.273538Z","end":"2026-02-25T19:29:53.622205Z","steps":["trace[2092908319] 'count revisions from in-memory index tree' (duration: 348.436969ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.622236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.273487Z","time spent":"348.742387ms","remote":"127.0.0.1:40250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":27,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:29:53.6226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.243073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.622633Z","caller":"traceutil/trace.go:171","msg":"trace[1970965168] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1; }","duration":"378.291424ms","start":"2026-02-25T19:29:53.244334Z","end":"2026-02-25T19:29:53.622625Z","steps":["trace[1970965168] 'count revisions from in-memory index tree' (duration: 378.206412ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.622661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.244328Z","time spent":"378.322145ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":27,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:29:53.622686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.653158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.622709Z","caller":"traceutil/trace.go:171","msg":"trace[1666468643] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1; }","duration":"361.70658ms","start":"2026-02-25T19:29:53.260996Z","end":"2026-02-25T19:29:53.622703Z","steps":["trace[1666468643] 'range keys from in-memory index tree' (duration: 361.567456ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.622724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.260971Z","time spent":"361.748441ms","remote":"127.0.0.1:40240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":27,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T19:29:53.622803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.576916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.622821Z","caller":"traceutil/trace.go:171","msg":"trace[77610325] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1; }","duration":"361.657667ms","start":"2026-02-25T19:29:53.261159Z","end":"2026-02-25T19:29:53.622817Z","steps":["trace[77610325] 'count revisions from in-memory index tree' (duration: 361.469913ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.622835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.261129Z","time spent":"361.702519ms","remote":"127.0.0.1:40240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:29:53.6231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.176273Z","time spent":"446.809341ms","remote":"127.0.0.1:40190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-02-25T19:29:53.623777Z","caller":"traceutil/trace.go:171","msg":"trace[222569862] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"483.344497ms","start":"2026-02-25T19:29:53.140422Z","end":"2026-02-25T19:29:53.623767Z","steps":["trace[222569862] 'count revisions from in-memory index tree' (duration: 473.208407ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.623808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.140396Z","time spent":"483.403299ms","remote":"127.0.0.1:40174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:29:53.623882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.86869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.6239Z","caller":"traceutil/trace.go:171","msg":"trace[1011925029] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1; }","duration":"339.915652ms","start":"2026-02-25T19:29:53.28398Z","end":"2026-02-25T19:29:53.623896Z","steps":["trace[1011925029] 'range keys from in-memory index tree' (duration: 339.740336ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.623916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.283964Z","time spent":"339.946982ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T19:29:53.62404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.948932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:53.624059Z","caller":"traceutil/trace.go:171","msg":"trace[1409554119] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1; }","duration":"340.035954ms","start":"2026-02-25T19:29:53.284018Z","end":"2026-02-25T19:29:53.624054Z","steps":["trace[1409554119] 'count revisions from in-memory index tree' (duration: 339.87581ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.624072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.283998Z","time spent":"340.070436ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"info","ts":"2026-02-25T19:29:53.624224Z","caller":"traceutil/trace.go:171","msg":"trace[1404403391] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"505.137684ms","start":"2026-02-25T19:29:53.119079Z","end":"2026-02-25T19:29:53.624217Z","steps":["trace[1404403391] 'range keys from in-memory index tree' (duration: 495.087368ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:53.624248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:29:53.119053Z","time spent":"505.188556ms","remote":"127.0.0.1:40164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":27,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" limit:10000 "} {"level":"info","ts":"2026-02-25T19:29:54.425021Z","caller":"traceutil/trace.go:171","msg":"trace[612569352] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"225.671303ms","start":"2026-02-25T19:29:54.199325Z","end":"2026-02-25T19:29:54.424996Z","steps":["trace[612569352] 'read index received' (duration: 225.469238ms)","trace[612569352] 'applied index is now lower than readState.Index' (duration: 200.795µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:29:54.42505Z","caller":"traceutil/trace.go:171","msg":"trace[638164555] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"235.338781ms","start":"2026-02-25T19:29:54.18969Z","end":"2026-02-25T19:29:54.425028Z","steps":["trace[638164555] 'process raft request' (duration: 235.009783ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:54.425261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.916079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:54.425374Z","caller":"traceutil/trace.go:171","msg":"trace[576534693] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:2; }","duration":"226.28581ms","start":"2026-02-25T19:29:54.19903Z","end":"2026-02-25T19:29:54.425316Z","steps":["trace[576534693] 'agreement among raft nodes before linearized reading' (duration: 226.084314ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:54.44155Z","caller":"traceutil/trace.go:171","msg":"trace[786142014] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"196.178028ms","start":"2026-02-25T19:29:54.245298Z","end":"2026-02-25T19:29:54.441476Z","steps":["trace[786142014] 'process raft request' (duration: 195.925231ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:54.441667Z","caller":"traceutil/trace.go:171","msg":"trace[1310309337] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"194.276319ms","start":"2026-02-25T19:29:54.247377Z","end":"2026-02-25T19:29:54.441653Z","steps":["trace[1310309337] 'process raft request' (duration: 193.963441ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:54.441784Z","caller":"traceutil/trace.go:171","msg":"trace[1712773174] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"193.93088ms","start":"2026-02-25T19:29:54.247833Z","end":"2026-02-25T19:29:54.441764Z","steps":["trace[1712773174] 'process raft request' (duration: 193.835068ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:54.441913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.392277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T19:29:54.441943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.015675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:54.441915Z","caller":"traceutil/trace.go:171","msg":"trace[2126285956] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"194.34926ms","start":"2026-02-25T19:29:54.247502Z","end":"2026-02-25T19:29:54.441851Z","steps":["trace[2126285956] 'process raft request' (duration: 193.93964ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:54.44206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.22633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.54\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:54.442094Z","caller":"traceutil/trace.go:171","msg":"trace[66813492] range","detail":"{range_begin:/registry/masterleases/199.19.213.54; range_end:; response_count:0; response_revision:10; }","duration":"198.285943ms","start":"2026-02-25T19:29:54.243799Z","end":"2026-02-25T19:29:54.442085Z","steps":["trace[66813492] 'agreement among raft nodes before linearized reading' (duration: 198.243831ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:54.442041Z","caller":"traceutil/trace.go:171","msg":"trace[119007289] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"143.127257ms","start":"2026-02-25T19:29:54.298893Z","end":"2026-02-25T19:29:54.44202Z","steps":["trace[119007289] 'agreement among raft nodes before linearized reading' (duration: 142.893872ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:54.442206Z","caller":"traceutil/trace.go:171","msg":"trace[1865977764] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"194.683109ms","start":"2026-02-25T19:29:54.247504Z","end":"2026-02-25T19:29:54.442187Z","steps":["trace[1865977764] 'process raft request' (duration: 193.976981ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:54.441887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.717843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:54.44257Z","caller":"traceutil/trace.go:171","msg":"trace[1555770000] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"192.414271ms","start":"2026-02-25T19:29:54.250145Z","end":"2026-02-25T19:29:54.442559Z","steps":["trace[1555770000] 'agreement among raft nodes before linearized reading' (duration: 191.727074ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:54.441984Z","caller":"traceutil/trace.go:171","msg":"trace[1862933810] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"195.476319ms","start":"2026-02-25T19:29:54.24649Z","end":"2026-02-25T19:29:54.441967Z","steps":["trace[1862933810] 'agreement among raft nodes before linearized reading' (duration: 195.407627ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:54.441977Z","caller":"traceutil/trace.go:171","msg":"trace[1106692046] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"163.942121ms","start":"2026-02-25T19:29:54.278017Z","end":"2026-02-25T19:29:54.441959Z","steps":["trace[1106692046] 'process raft request' (duration: 163.691845ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:54.442024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.296785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:54.442868Z","caller":"traceutil/trace.go:171","msg":"trace[1683999016] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"198.095727ms","start":"2026-02-25T19:29:54.244697Z","end":"2026-02-25T19:29:54.442792Z","steps":["trace[1683999016] 'agreement among raft nodes before linearized reading' (duration: 197.304426ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:54.44185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.915099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:54.443049Z","caller":"traceutil/trace.go:171","msg":"trace[410594975] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"241.135211ms","start":"2026-02-25T19:29:54.201892Z","end":"2026-02-25T19:29:54.443027Z","steps":["trace[410594975] 'agreement among raft nodes before linearized reading' (duration: 239.871768ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:54.44234Z","caller":"traceutil/trace.go:171","msg":"trace[1855598611] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"194.368881ms","start":"2026-02-25T19:29:54.247941Z","end":"2026-02-25T19:29:54.44231Z","steps":["trace[1855598611] 'process raft request' (duration: 193.747605ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:54.442394Z","caller":"traceutil/trace.go:171","msg":"trace[28466739] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"163.714996ms","start":"2026-02-25T19:29:54.278665Z","end":"2026-02-25T19:29:54.44238Z","steps":["trace[28466739] 'process raft request' (duration: 163.067799ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:29:55.378569Z","caller":"traceutil/trace.go:171","msg":"trace[1694200443] linearizableReadLoop","detail":"{readStateIndex:75; appliedIndex:74; }","duration":"231.822481ms","start":"2026-02-25T19:29:55.146716Z","end":"2026-02-25T19:29:55.378538Z","steps":["trace[1694200443] 'read index received' (duration: 231.601486ms)","trace[1694200443] 'applied index is now lower than readState.Index' (duration: 218.925µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:29:55.378678Z","caller":"traceutil/trace.go:171","msg":"trace[1606391829] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"231.933133ms","start":"2026-02-25T19:29:55.146702Z","end":"2026-02-25T19:29:55.378635Z","steps":["trace[1606391829] 'process raft request' (duration: 231.666147ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:55.378789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.051956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:55.378861Z","caller":"traceutil/trace.go:171","msg":"trace[401324180] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:71; }","duration":"232.16234ms","start":"2026-02-25T19:29:55.146673Z","end":"2026-02-25T19:29:55.378835Z","steps":["trace[401324180] 'agreement among raft nodes before linearized reading' (duration: 232.028396ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:29:55.378791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.492628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T19:29:55.378964Z","caller":"traceutil/trace.go:171","msg":"trace[1477339888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:71; }","duration":"129.706145ms","start":"2026-02-25T19:29:55.249242Z","end":"2026-02-25T19:29:55.378948Z","steps":["trace[1477339888] 'agreement among raft nodes before linearized reading' (duration: 129.496959ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:30:05.104478Z","caller":"traceutil/trace.go:171","msg":"trace[684498884] linearizableReadLoop","detail":"{readStateIndex:372; appliedIndex:371; }","duration":"147.136001ms","start":"2026-02-25T19:30:04.957298Z","end":"2026-02-25T19:30:05.104434Z","steps":["trace[684498884] 'read index received' (duration: 146.871454ms)","trace[684498884] 'applied index is now lower than readState.Index' (duration: 263.627µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:30:05.104514Z","caller":"traceutil/trace.go:171","msg":"trace[262664542] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"170.191031ms","start":"2026-02-25T19:30:04.934291Z","end":"2026-02-25T19:30:05.104482Z","steps":["trace[262664542] 'process raft request' (duration: 169.977486ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:05.104824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.515231ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:30:05.104905Z","caller":"traceutil/trace.go:171","msg":"trace[1399579303] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:360; }","duration":"147.611873ms","start":"2026-02-25T19:30:04.957284Z","end":"2026-02-25T19:30:05.104896Z","steps":["trace[1399579303] 'agreement among raft nodes before linearized reading' (duration: 147.5027ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:30:05.638533Z","caller":"traceutil/trace.go:171","msg":"trace[881110528] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"522.073279ms","start":"2026-02-25T19:30:05.116433Z","end":"2026-02-25T19:30:05.638506Z","steps":["trace[881110528] 'process raft request' (duration: 521.573637ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:05.639812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:05.116412Z","time spent":"522.241402ms","remote":"127.0.0.1:40154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T19:30:06.44776Z","caller":"traceutil/trace.go:171","msg":"trace[1312874094] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"233.604627ms","start":"2026-02-25T19:30:06.214125Z","end":"2026-02-25T19:30:06.447729Z","steps":["trace[1312874094] 'process raft request' (duration: 190.087412ms)","trace[1312874094] 'compare' (duration: 43.391382ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:30:06.737295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.177709ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T19:30:06.737451Z","caller":"traceutil/trace.go:171","msg":"trace[1111308344] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"206.587234ms","start":"2026-02-25T19:30:06.530819Z","end":"2026-02-25T19:30:06.737406Z","steps":["trace[1111308344] 'process raft request' (duration: 40.142588ms)","trace[1111308344] 'compare' (duration: 146.466564ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:30:06.961306Z","caller":"traceutil/trace.go:171","msg":"trace[1388195909] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"219.65393ms","start":"2026-02-25T19:30:06.741586Z","end":"2026-02-25T19:30:06.96124Z","steps":["trace[1388195909] 'process raft request' (duration: 218.694484ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:30:07.999659Z","caller":"traceutil/trace.go:171","msg":"trace[1930139528] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"160.37158ms","start":"2026-02-25T19:30:07.83927Z","end":"2026-02-25T19:30:07.999642Z","steps":["trace[1930139528] 'process raft request' (duration: 160.220336ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:08.207276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.341461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4792"} {"level":"info","ts":"2026-02-25T19:30:08.207362Z","caller":"traceutil/trace.go:171","msg":"trace[898658315] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:371; }","duration":"157.480586ms","start":"2026-02-25T19:30:08.049861Z","end":"2026-02-25T19:30:08.207342Z","steps":["trace[898658315] 'range keys from in-memory index tree' (duration: 157.163247ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:26.264154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.718332ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T19:30:26.26431Z","caller":"traceutil/trace.go:171","msg":"trace[1134123418] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:495; }","duration":"499.235634ms","start":"2026-02-25T19:30:25.765052Z","end":"2026-02-25T19:30:26.264288Z","steps":["trace[1134123418] 'read index received' (duration: 229.221914ms)","trace[1134123418] 'applied index is now lower than readState.Index' (duration: 270.0124ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:30:26.26549Z","caller":"traceutil/trace.go:171","msg":"trace[1605774730] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"512.954965ms","start":"2026-02-25T19:30:25.752496Z","end":"2026-02-25T19:30:26.265451Z","steps":["trace[1605774730] 'process raft request' (duration: 241.781246ms)","trace[1605774730] 'compare' (duration: 269.511597ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:30:26.265658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:25.752475Z","time spent":"513.072408ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T19:30:26.265927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.870975ms","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-25T19:30:26.265988Z","caller":"traceutil/trace.go:171","msg":"trace[254009843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:480; }","duration":"500.954868ms","start":"2026-02-25T19:30:25.765015Z","end":"2026-02-25T19:30:26.265969Z","steps":["trace[254009843] 'agreement among raft nodes before linearized reading' (duration: 500.857765ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:26.266073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:25.764999Z","time spent":"501.0607ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T19:30:26.26617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.065224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T19:30:26.266211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.331749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.54\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-25T19:30:26.266263Z","caller":"traceutil/trace.go:171","msg":"trace[730269244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:480; }","duration":"491.199008ms","start":"2026-02-25T19:30:25.775043Z","end":"2026-02-25T19:30:26.266242Z","steps":["trace[730269244] 'agreement among raft nodes before linearized reading' (duration: 491.058534ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:30:26.266276Z","caller":"traceutil/trace.go:171","msg":"trace[1774748248] range","detail":"{range_begin:/registry/masterleases/199.19.213.54; range_end:; response_count:1; response_revision:480; }","duration":"112.464703ms","start":"2026-02-25T19:30:26.153796Z","end":"2026-02-25T19:30:26.266261Z","steps":["trace[1774748248] 'agreement among raft nodes before linearized reading' (duration: 112.302378ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:26.266306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:25.775024Z","time spent":"491.272511ms","remote":"127.0.0.1:39966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T19:30:26.630649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.362775ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-02-25T19:30:26.630746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:26.267685Z","time spent":"363.057444ms","remote":"127.0.0.1:40000","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-25T19:30:26.715073Z","caller":"traceutil/trace.go:171","msg":"trace[1989049957] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"444.855911ms","start":"2026-02-25T19:30:26.270186Z","end":"2026-02-25T19:30:26.715042Z","steps":["trace[1989049957] 'process raft request' (duration: 444.624294ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:26.715233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:26.270164Z","time spent":"444.990844ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T19:30:27.080102Z","caller":"traceutil/trace.go:171","msg":"trace[652857416] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"176.224296ms","start":"2026-02-25T19:30:26.903855Z","end":"2026-02-25T19:30:27.080079Z","steps":["trace[652857416] 'process raft request' (duration: 176.055142ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:33.900974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.597428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:30:33.901083Z","caller":"traceutil/trace.go:171","msg":"trace[104362687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:502; }","duration":"123.831484ms","start":"2026-02-25T19:30:33.777228Z","end":"2026-02-25T19:30:33.901059Z","steps":["trace[104362687] 'range keys from in-memory index tree' (duration: 123.507236ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:36.27913Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9609446399183094876,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T19:30:36.60123Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.452529185s","expected-duration":"1s"} {"level":"info","ts":"2026-02-25T19:30:36.601666Z","caller":"traceutil/trace.go:171","msg":"trace[31037209] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"1.453027737s","start":"2026-02-25T19:30:35.14861Z","end":"2026-02-25T19:30:36.601638Z","steps":["trace[31037209] 'process raft request' (duration: 1.452834432s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:36.60192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:35.148595Z","time spent":"1.453134919s","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T19:30:36.681829Z","caller":"traceutil/trace.go:171","msg":"trace[1591717412] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:522; }","duration":"903.804482ms","start":"2026-02-25T19:30:35.777997Z","end":"2026-02-25T19:30:36.681802Z","steps":["trace[1591717412] 'read index received' (duration: 823.480493ms)","trace[1591717412] 'applied index is now lower than readState.Index' (duration: 80.322469ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:30:36.681685Z","caller":"traceutil/trace.go:171","msg":"trace[1322438131] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"1.489885391s","start":"2026-02-25T19:30:35.191776Z","end":"2026-02-25T19:30:36.681661Z","steps":["trace[1322438131] 'process raft request' (duration: 1.480181013s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:36.682473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:35.191755Z","time spent":"1.49061119s","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T19:30:36.682119Z","caller":"traceutil/trace.go:171","msg":"trace[1182361194] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"778.424849ms","start":"2026-02-25T19:30:35.903659Z","end":"2026-02-25T19:30:36.682084Z","steps":["trace[1182361194] 'process raft request' (duration: 777.960197ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:36.682809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.789851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.54\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-02-25T19:30:36.682916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.537991ms","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-25T19:30:36.682966Z","caller":"traceutil/trace.go:171","msg":"trace[1819580115] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:507; }","duration":"346.640035ms","start":"2026-02-25T19:30:36.336314Z","end":"2026-02-25T19:30:36.682954Z","steps":["trace[1819580115] 'agreement among raft nodes before linearized reading' (duration: 346.466349ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:36.683003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:36.33629Z","time spent":"346.706626ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-25T19:30:36.683242Z","caller":"traceutil/trace.go:171","msg":"trace[1574149637] range","detail":"{range_begin:/registry/masterleases/199.19.213.54; range_end:; response_count:1; response_revision:507; }","duration":"528.977506ms","start":"2026-02-25T19:30:36.153968Z","end":"2026-02-25T19:30:36.682945Z","steps":["trace[1574149637] 'agreement among raft nodes before linearized reading' (duration: 528.691379ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:36.683438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:36.153947Z","time spent":"529.434318ms","remote":"127.0.0.1:40000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.54\" "} {"level":"warn","ts":"2026-02-25T19:30:36.682746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:35.903623Z","time spent":"778.965703ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T19:30:36.682183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.168771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:30:36.683742Z","caller":"traceutil/trace.go:171","msg":"trace[1765062735] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:507; }","duration":"905.767933ms","start":"2026-02-25T19:30:35.777946Z","end":"2026-02-25T19:30:36.683714Z","steps":["trace[1765062735] 'agreement among raft nodes before linearized reading' (duration: 904.174712ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:36.683823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:35.777927Z","time spent":"905.880155ms","remote":"127.0.0.1:39966","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-25T19:30:38.613103Z","caller":"traceutil/trace.go:171","msg":"trace[1022424338] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"195.597802ms","start":"2026-02-25T19:30:38.417472Z","end":"2026-02-25T19:30:38.61307Z","steps":["trace[1022424338] 'process raft request' (duration: 195.453178ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:55.409659Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9609446399183095231,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-25T19:30:55.522848Z","caller":"traceutil/trace.go:171","msg":"trace[2056657995] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"835.599783ms","start":"2026-02-25T19:30:54.687201Z","end":"2026-02-25T19:30:55.522801Z","steps":["trace[2056657995] 'process raft request' (duration: 835.427149ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:55.522988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.738692ms","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-25T19:30:55.523069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:54.687171Z","time spent":"835.778788ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T19:30:55.523037Z","caller":"traceutil/trace.go:171","msg":"trace[1117378845] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:698; }","duration":"622.814893ms","start":"2026-02-25T19:30:54.900211Z","end":"2026-02-25T19:30:55.523026Z","steps":["trace[1117378845] 'agreement among raft nodes before linearized reading' (duration: 622.65949ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:30:55.522796Z","caller":"traceutil/trace.go:171","msg":"trace[489878049] linearizableReadLoop","detail":"{readStateIndex:722; appliedIndex:721; }","duration":"622.530676ms","start":"2026-02-25T19:30:54.900242Z","end":"2026-02-25T19:30:55.522773Z","steps":["trace[489878049] 'read index received' (duration: 622.356312ms)","trace[489878049] 'applied index is now lower than readState.Index' (duration: 173.214µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:30:55.523401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:54.900197Z","time spent":"623.195874ms","remote":"127.0.0.1:40238","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-25T19:30:55.523575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.989318ms","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-25T19:30:55.523609Z","caller":"traceutil/trace.go:171","msg":"trace[723552203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:698; }","duration":"616.05485ms","start":"2026-02-25T19:30:54.907542Z","end":"2026-02-25T19:30:55.523597Z","steps":["trace[723552203] 'agreement among raft nodes before linearized reading' (duration: 615.924117ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:55.523638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:54.907532Z","time spent":"616.098461ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T19:30:55.523627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.390544ms","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-25T19:30:55.523668Z","caller":"traceutil/trace.go:171","msg":"trace[63343816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:698; }","duration":"591.461056ms","start":"2026-02-25T19:30:54.932199Z","end":"2026-02-25T19:30:55.52366Z","steps":["trace[63343816] 'agreement among raft nodes before linearized reading' (duration: 591.386594ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:55.523688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:54.932182Z","time spent":"591.501876ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-25T19:30:56.179144Z","caller":"traceutil/trace.go:171","msg":"trace[242339390] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"652.958941ms","start":"2026-02-25T19:30:55.526163Z","end":"2026-02-25T19:30:56.179122Z","steps":["trace[242339390] 'process raft request' (duration: 587.472393ms)","trace[242339390] 'compare' (duration: 65.306734ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:30:56.179251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:55.526147Z","time spent":"653.042785ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T19:30:56.191806Z","caller":"traceutil/trace.go:171","msg":"trace[1723688001] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"663.667648ms","start":"2026-02-25T19:30:55.528119Z","end":"2026-02-25T19:30:56.191787Z","steps":["trace[1723688001] 'process raft request' (duration: 663.383251ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:56.191921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:55.528086Z","time spent":"663.781921ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T19:30:56.191983Z","caller":"traceutil/trace.go:171","msg":"trace[1453932215] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"663.622817ms","start":"2026-02-25T19:30:55.52833Z","end":"2026-02-25T19:30:56.191952Z","steps":["trace[1453932215] 'process raft request' (duration: 663.298249ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:56.192074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:55.528317Z","time spent":"663.715729ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T19:30:56.192203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.140527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:30:56.192259Z","caller":"traceutil/trace.go:171","msg":"trace[144490050] linearizableReadLoop","detail":"{readStateIndex:725; appliedIndex:722; }","duration":"415.228359ms","start":"2026-02-25T19:30:55.777009Z","end":"2026-02-25T19:30:56.192238Z","steps":["trace[144490050] 'read index received' (duration: 336.620122ms)","trace[144490050] 'applied index is now lower than readState.Index' (duration: 78.29046ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:30:56.192268Z","caller":"traceutil/trace.go:171","msg":"trace[2043772621] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:701; }","duration":"415.276671ms","start":"2026-02-25T19:30:55.776975Z","end":"2026-02-25T19:30:56.192252Z","steps":["trace[2043772621] 'agreement among raft nodes before linearized reading' (duration: 415.140647ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:30:56.192311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:30:55.776931Z","time spent":"415.372233ms","remote":"127.0.0.1:39966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T19:31:18.692125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.607669ms","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-25T19:31:18.692255Z","caller":"traceutil/trace.go:171","msg":"trace[1343642471] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:772; }","duration":"118.794124ms","start":"2026-02-25T19:31:18.573436Z","end":"2026-02-25T19:31:18.69223Z","steps":["trace[1343642471] 'count revisions from in-memory index tree' (duration: 118.480485ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:31:19.737798Z","caller":"traceutil/trace.go:171","msg":"trace[1675488059] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"113.353994ms","start":"2026-02-25T19:31:19.623986Z","end":"2026-02-25T19:31:19.73734Z","steps":["trace[1675488059] 'process raft request' (duration: 113.178378ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:31:20.351006Z","caller":"traceutil/trace.go:171","msg":"trace[1132242618] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"324.801378ms","start":"2026-02-25T19:31:20.026167Z","end":"2026-02-25T19:31:20.350969Z","steps":["trace[1132242618] 'process raft request' (duration: 324.521601ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:20.351221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:20.026137Z","time spent":"324.981412ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T19:31:20.862391Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9609446399183095457,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T19:31:21.285502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.140661ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T19:31:21.285713Z","caller":"traceutil/trace.go:171","msg":"trace[1048662233] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:803; }","duration":"924.171038ms","start":"2026-02-25T19:31:20.361504Z","end":"2026-02-25T19:31:21.285675Z","steps":["trace[1048662233] 'read index received' (duration: 535.609255ms)","trace[1048662233] 'applied index is now lower than readState.Index' (duration: 388.560533ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:31:21.285783Z","caller":"traceutil/trace.go:171","msg":"trace[474982959] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"929.249428ms","start":"2026-02-25T19:31:20.356526Z","end":"2026-02-25T19:31:21.285775Z","steps":["trace[474982959] 'process raft request' (duration: 540.570953ms)","trace[474982959] 'compare' (duration: 387.66989ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:31:21.285831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:20.35649Z","time spent":"929.31618ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T19:31:21.286001Z","caller":"traceutil/trace.go:171","msg":"trace[1679649574] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"929.262118ms","start":"2026-02-25T19:31:20.356632Z","end":"2026-02-25T19:31:21.285894Z","steps":["trace[1679649574] 'process raft request' (duration: 928.964771ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:21.286097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.572528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-25T19:31:21.286176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:20.356603Z","time spent":"929.481685ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T19:31:21.286181Z","caller":"traceutil/trace.go:171","msg":"trace[342189458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:776; }","duration":"924.692182ms","start":"2026-02-25T19:31:20.361468Z","end":"2026-02-25T19:31:21.28616Z","steps":["trace[342189458] 'agreement among raft nodes before linearized reading' (duration: 924.480757ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:21.286242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:20.361452Z","time spent":"924.776063ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-25T19:31:21.401282Z","caller":"traceutil/trace.go:171","msg":"trace[232847472] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:805; }","duration":"115.513319ms","start":"2026-02-25T19:31:21.285744Z","end":"2026-02-25T19:31:21.401258Z","steps":["trace[232847472] 'read index received' (duration: 60.184532ms)","trace[232847472] 'applied index is now lower than readState.Index' (duration: 55.327027ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:31:21.401523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"996.009851ms","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-25T19:31:21.40157Z","caller":"traceutil/trace.go:171","msg":"trace[179441906] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:776; }","duration":"996.119634ms","start":"2026-02-25T19:31:20.405439Z","end":"2026-02-25T19:31:21.401559Z","steps":["trace[179441906] 'agreement among raft nodes before linearized reading' (duration: 995.924668ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:21.401608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:20.405419Z","time spent":"996.180806ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-25T19:31:21.401768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.159829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:31:21.401897Z","caller":"traceutil/trace.go:171","msg":"trace[357511287] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:776; }","duration":"624.732924ms","start":"2026-02-25T19:31:20.777139Z","end":"2026-02-25T19:31:21.401872Z","steps":["trace[357511287] 'agreement among raft nodes before linearized reading' (duration: 624.136439ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:21.401982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:20.777119Z","time spent":"624.849867ms","remote":"127.0.0.1:39966","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-25T19:31:21.402667Z","caller":"traceutil/trace.go:171","msg":"trace[965004174] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"111.466885ms","start":"2026-02-25T19:31:21.291163Z","end":"2026-02-25T19:31:21.40263Z","steps":["trace[965004174] 'process raft request' (duration: 109.982697ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:31:35.829156Z","caller":"traceutil/trace.go:171","msg":"trace[203458384] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"478.273026ms","start":"2026-02-25T19:31:35.350863Z","end":"2026-02-25T19:31:35.829136Z","steps":["trace[203458384] 'process raft request' (duration: 478.07048ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:35.829317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:35.350851Z","time spent":"478.378359ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T19:31:35.82933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.521635ms","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-25T19:31:35.829116Z","caller":"traceutil/trace.go:171","msg":"trace[2056803050] linearizableReadLoop","detail":"{readStateIndex:898; appliedIndex:897; }","duration":"475.30109ms","start":"2026-02-25T19:31:35.353792Z","end":"2026-02-25T19:31:35.829093Z","steps":["trace[2056803050] 'read index received' (duration: 475.044592ms)","trace[2056803050] 'applied index is now lower than readState.Index' (duration: 255.518µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:31:35.829374Z","caller":"traceutil/trace.go:171","msg":"trace[116708748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:864; }","duration":"475.586797ms","start":"2026-02-25T19:31:35.353775Z","end":"2026-02-25T19:31:35.829362Z","steps":["trace[116708748] 'agreement among raft nodes before linearized reading' (duration: 475.424983ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:35.829415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:35.353768Z","time spent":"475.638108ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T19:31:35.829611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.589056ms","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-25T19:31:35.829668Z","caller":"traceutil/trace.go:171","msg":"trace[1191640304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:864; }","duration":"373.659787ms","start":"2026-02-25T19:31:35.455994Z","end":"2026-02-25T19:31:35.829654Z","steps":["trace[1191640304] 'agreement among raft nodes before linearized reading' (duration: 373.462922ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:35.8297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:35.45595Z","time spent":"373.743149ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T19:31:35.829822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.158702ms","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-25T19:31:35.829846Z","caller":"traceutil/trace.go:171","msg":"trace[1743059961] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:864; }","duration":"362.220864ms","start":"2026-02-25T19:31:35.467619Z","end":"2026-02-25T19:31:35.82984Z","steps":["trace[1743059961] 'agreement among raft nodes before linearized reading' (duration: 362.159142ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:35.829862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:35.467598Z","time spent":"362.259634ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-25T19:31:48.102647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.969124ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T19:31:48.102746Z","caller":"traceutil/trace.go:171","msg":"trace[131238822] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"186.918101ms","start":"2026-02-25T19:31:47.915813Z","end":"2026-02-25T19:31:48.102731Z","steps":["trace[131238822] 'process raft request' (duration: 61.803244ms)","trace[131238822] 'compare' (duration: 124.889502ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:31:52.383377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.113601ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-25T19:31:52.383489Z","caller":"traceutil/trace.go:171","msg":"trace[622316055] linearizableReadLoop","detail":"{readStateIndex:967; appliedIndex:966; }","duration":"706.904663ms","start":"2026-02-25T19:31:51.676563Z","end":"2026-02-25T19:31:52.383468Z","steps":["trace[622316055] 'read index received' (duration: 83.730979ms)","trace[622316055] 'applied index is now lower than readState.Index' (duration: 623.172154ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:31:52.383629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.063047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-25T19:31:52.383679Z","caller":"traceutil/trace.go:171","msg":"trace[242580622] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:929; }","duration":"707.163069ms","start":"2026-02-25T19:31:51.676498Z","end":"2026-02-25T19:31:52.383662Z","steps":["trace[242580622] 'agreement among raft nodes before linearized reading' (duration: 707.076917ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:52.383675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.745713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:31:52.38375Z","caller":"traceutil/trace.go:171","msg":"trace[999239101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:929; }","duration":"605.878067ms","start":"2026-02-25T19:31:51.777854Z","end":"2026-02-25T19:31:52.383732Z","steps":["trace[999239101] 'agreement among raft nodes before linearized reading' (duration: 605.754834ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:52.383744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:51.676473Z","time spent":"707.249901ms","remote":"127.0.0.1:40388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":30,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:31:52.383788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:51.777831Z","time spent":"605.95165ms","remote":"127.0.0.1:39966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T19:31:52.383796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.612517ms","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-25T19:31:52.383869Z","caller":"traceutil/trace.go:171","msg":"trace[741441518] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:929; }","duration":"463.72682ms","start":"2026-02-25T19:31:51.920124Z","end":"2026-02-25T19:31:52.38385Z","steps":["trace[741441518] 'agreement among raft nodes before linearized reading' (duration: 463.508535ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:52.38392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:51.920107Z","time spent":"463.804722ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-25T19:31:52.383963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.248723ms","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-25T19:31:52.384087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.815852ms","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-25T19:31:52.384115Z","caller":"traceutil/trace.go:171","msg":"trace[165583302] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:929; }","duration":"482.898285ms","start":"2026-02-25T19:31:51.90121Z","end":"2026-02-25T19:31:52.384108Z","steps":["trace[165583302] 'agreement among raft nodes before linearized reading' (duration: 482.841823ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:31:52.384101Z","caller":"traceutil/trace.go:171","msg":"trace[1278337320] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:929; }","duration":"267.425228ms","start":"2026-02-25T19:31:52.116643Z","end":"2026-02-25T19:31:52.384068Z","steps":["trace[1278337320] 'agreement among raft nodes before linearized reading' (duration: 267.032278ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:52.384137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:51.901176Z","time spent":"482.956696ms","remote":"127.0.0.1:40238","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-25T19:31:52.38419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.947725ms","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-25T19:31:52.384231Z","caller":"traceutil/trace.go:171","msg":"trace[1737466430] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:929; }","duration":"450.013387ms","start":"2026-02-25T19:31:51.934208Z","end":"2026-02-25T19:31:52.384221Z","steps":["trace[1737466430] 'agreement among raft nodes before linearized reading' (duration: 449.898224ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:52.384035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.244436ms","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-25T19:31:52.384298Z","caller":"traceutil/trace.go:171","msg":"trace[1941321168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:929; }","duration":"466.552884ms","start":"2026-02-25T19:31:51.917733Z","end":"2026-02-25T19:31:52.384286Z","steps":["trace[1941321168] 'agreement among raft nodes before linearized reading' (duration: 466.210505ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:52.384333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:51.917707Z","time spent":"466.617346ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T19:31:52.384263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:51.934191Z","time spent":"450.062708ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-25T19:31:52.504768Z","caller":"traceutil/trace.go:171","msg":"trace[868006764] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"114.35791ms","start":"2026-02-25T19:31:52.390387Z","end":"2026-02-25T19:31:52.504745Z","steps":["trace[868006764] 'process raft request' (duration: 114.312399ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:31:52.505029Z","caller":"traceutil/trace.go:171","msg":"trace[2047548157] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"115.775715ms","start":"2026-02-25T19:31:52.389239Z","end":"2026-02-25T19:31:52.505015Z","steps":["trace[2047548157] 'process raft request' (duration: 97.035872ms)","trace[2047548157] 'compare' (duration: 18.175029ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:31:52.505056Z","caller":"traceutil/trace.go:171","msg":"trace[1355831463] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"115.761045ms","start":"2026-02-25T19:31:52.389273Z","end":"2026-02-25T19:31:52.505034Z","steps":["trace[1355831463] 'process raft request' (duration: 115.344665ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:31:52.50519Z","caller":"traceutil/trace.go:171","msg":"trace[1600093757] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"115.814626ms","start":"2026-02-25T19:31:52.389322Z","end":"2026-02-25T19:31:52.505137Z","steps":["trace[1600093757] 'process raft request' (duration: 115.345375ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:31:54.811431Z","caller":"traceutil/trace.go:171","msg":"trace[1108807448] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"247.379821ms","start":"2026-02-25T19:31:54.564023Z","end":"2026-02-25T19:31:54.811403Z","steps":["trace[1108807448] 'process raft request' (duration: 210.202131ms)","trace[1108807448] 'compare' (duration: 37.077867ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:31:55.087729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.237032ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T19:31:55.088253Z","caller":"traceutil/trace.go:171","msg":"trace[188396325] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"521.984124ms","start":"2026-02-25T19:31:54.56625Z","end":"2026-02-25T19:31:55.088234Z","steps":["trace[188396325] 'process raft request' (duration: 521.687307ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:31:55.088369Z","caller":"traceutil/trace.go:171","msg":"trace[1783762456] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"522.110817ms","start":"2026-02-25T19:31:54.566145Z","end":"2026-02-25T19:31:55.088256Z","steps":["trace[1783762456] 'process raft request' (duration: 363.27817ms)","trace[1783762456] 'compare' (duration: 157.823011ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:31:55.088506Z","caller":"traceutil/trace.go:171","msg":"trace[965985323] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"521.85385ms","start":"2026-02-25T19:31:54.566631Z","end":"2026-02-25T19:31:55.088485Z","steps":["trace[965985323] 'process raft request' (duration: 521.563863ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:31:55.088533Z","caller":"traceutil/trace.go:171","msg":"trace[1449400857] linearizableReadLoop","detail":"{readStateIndex:984; appliedIndex:981; }","duration":"313.504055ms","start":"2026-02-25T19:31:54.774971Z","end":"2026-02-25T19:31:55.088475Z","steps":["trace[1449400857] 'read index received' (duration: 154.410482ms)","trace[1449400857] 'applied index is now lower than readState.Index' (duration: 159.091343ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:31:55.088617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:54.56662Z","time spent":"521.946372ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T19:31:55.088734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.705441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T19:31:55.088742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:54.566111Z","time spent":"522.402304ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T19:31:55.088878Z","caller":"traceutil/trace.go:171","msg":"trace[1565509296] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:946; }","duration":"313.871236ms","start":"2026-02-25T19:31:54.77491Z","end":"2026-02-25T19:31:55.088781Z","steps":["trace[1565509296] 'agreement among raft nodes before linearized reading' (duration: 313.720513ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:31:55.089013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:54.774889Z","time spent":"314.03775ms","remote":"127.0.0.1:39966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T19:31:55.089872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:31:54.566245Z","time spent":"522.056876ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T19:32:05.242704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.292536ms","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-25T19:32:05.242798Z","caller":"traceutil/trace.go:171","msg":"trace[1221268099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1011; }","duration":"111.419799ms","start":"2026-02-25T19:32:05.131351Z","end":"2026-02-25T19:32:05.24277Z","steps":["trace[1221268099] 'range keys from in-memory index tree' (duration: 111.13198ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:32:05.242928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.079844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"warn","ts":"2026-02-25T19:32:05.242778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.929957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-25T19:32:05.243006Z","caller":"traceutil/trace.go:171","msg":"trace[1118946312] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1011; }","duration":"259.180376ms","start":"2026-02-25T19:32:04.983804Z","end":"2026-02-25T19:32:05.242984Z","steps":["trace[1118946312] 'range keys from in-memory index tree' (duration: 258.911649ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:32:05.243011Z","caller":"traceutil/trace.go:171","msg":"trace[2139812983] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1011; }","duration":"111.164182ms","start":"2026-02-25T19:32:05.131829Z","end":"2026-02-25T19:32:05.242993Z","steps":["trace[2139812983] 'range keys from in-memory index tree' (duration: 110.806572ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:32:05.243298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.874948ms","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-25T19:32:05.243487Z","caller":"traceutil/trace.go:171","msg":"trace[660185305] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1011; }","duration":"114.992881ms","start":"2026-02-25T19:32:05.128348Z","end":"2026-02-25T19:32:05.243341Z","steps":["trace[660185305] 'range keys from in-memory index tree' (duration: 114.468118ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:32:05.75615Z","caller":"traceutil/trace.go:171","msg":"trace[753433660] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"509.054709ms","start":"2026-02-25T19:32:05.247072Z","end":"2026-02-25T19:32:05.756126Z","steps":["trace[753433660] 'process raft request' (duration: 508.909246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:32:05.756296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:32:05.247049Z","time spent":"509.173782ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T19:32:05.776646Z","caller":"traceutil/trace.go:171","msg":"trace[1531300706] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"528.979144ms","start":"2026-02-25T19:32:05.247643Z","end":"2026-02-25T19:32:05.776622Z","steps":["trace[1531300706] 'process raft request' (duration: 528.931903ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:32:05.776678Z","caller":"traceutil/trace.go:171","msg":"trace[933938656] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"529.416215ms","start":"2026-02-25T19:32:05.24723Z","end":"2026-02-25T19:32:05.776646Z","steps":["trace[933938656] 'process raft request' (duration: 529.172109ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:32:05.776773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:32:05.247629Z","time spent":"529.080937ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T19:32:05.776827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:32:05.2472Z","time spent":"529.546058ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T19:32:05.777Z","caller":"traceutil/trace.go:171","msg":"trace[2069449308] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"529.422956ms","start":"2026-02-25T19:32:05.247558Z","end":"2026-02-25T19:32:05.776981Z","steps":["trace[2069449308] 'process raft request' (duration: 528.977624ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:32:05.77708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:32:05.247549Z","time spent":"529.491578ms","remote":"127.0.0.1:40238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}