{"level":"warn","ts":"2026-03-25T21:05:09.635319Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-25T21:05:09.635431Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.69: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.204.45.69:2380","--initial-cluster=instance=https://199.204.45.69:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.69:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.69: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-03-25T21:05:09.635533Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-25T21:05:09.635546Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.69:2380"]} {"level":"info","ts":"2026-03-25T21:05:09.63557Z","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-03-25T21:05:09.636522Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"]} {"level":"info","ts":"2026-03-25T21:05:09.636609Z","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.204.45.69:2380"],"listen-peer-urls":["https://199.204.45.69:2380"],"advertise-client-urls":["https://199.204.45.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.69: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-03-25T21:05:09.641713Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.831346ms"} {"level":"info","ts":"2026-03-25T21:05:09.653466Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fe334179879fd0aa","cluster-id":"d79a8cccc23ced73"} {"level":"info","ts":"2026-03-25T21:05:09.65359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=()"} {"level":"info","ts":"2026-03-25T21:05:09.653626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became follower at term 0"} {"level":"info","ts":"2026-03-25T21:05:09.653641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fe334179879fd0aa [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-25T21:05:09.653654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became follower at term 1"} {"level":"info","ts":"2026-03-25T21:05:09.653705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=(18317056099668185258)"} {"level":"warn","ts":"2026-03-25T21:05:09.664103Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-25T21:05:09.66594Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-25T21:05:09.668565Z","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-03-25T21:05:09.679501Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fe334179879fd0aa","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-25T21:05:09.679633Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fe334179879fd0aa","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-25T21:05:09.680394Z","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-03-25T21:05:09.680515Z","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-03-25T21:05:09.680537Z","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-03-25T21:05:09.681413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=(18317056099668185258)"} {"level":"info","ts":"2026-03-25T21:05:09.681899Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d79a8cccc23ced73","local-member-id":"fe334179879fd0aa","added-peer-id":"fe334179879fd0aa","added-peer-peer-urls":["https://199.204.45.69:2380"]} {"level":"info","ts":"2026-03-25T21:05:09.684284Z","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-03-25T21:05:09.684534Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fe334179879fd0aa","initial-advertise-peer-urls":["https://199.204.45.69:2380"],"listen-peer-urls":["https://199.204.45.69:2380"],"advertise-client-urls":["https://199.204.45.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-25T21:05:09.684568Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-25T21:05:09.684687Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.69:2380"} {"level":"info","ts":"2026-03-25T21:05:09.684706Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.69:2380"} {"level":"info","ts":"2026-03-25T21:05:10.554731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa is starting a new election at term 1"} {"level":"info","ts":"2026-03-25T21:05:10.554803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became pre-candidate at term 1"} {"level":"info","ts":"2026-03-25T21:05:10.554831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa received MsgPreVoteResp from fe334179879fd0aa at term 1"} {"level":"info","ts":"2026-03-25T21:05:10.554852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became candidate at term 2"} {"level":"info","ts":"2026-03-25T21:05:10.554863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa received MsgVoteResp from fe334179879fd0aa at term 2"} {"level":"info","ts":"2026-03-25T21:05:10.554878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became leader at term 2"} {"level":"info","ts":"2026-03-25T21:05:10.554893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fe334179879fd0aa elected leader fe334179879fd0aa at term 2"} {"level":"info","ts":"2026-03-25T21:05:10.55612Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fe334179879fd0aa","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.69:2379]}","request-path":"/0/members/fe334179879fd0aa/attributes","cluster-id":"d79a8cccc23ced73","publish-timeout":"7s"} {"level":"info","ts":"2026-03-25T21:05:10.556125Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-25T21:05:10.556125Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-25T21:05:10.556151Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-25T21:05:10.556487Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-25T21:05:10.556529Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-25T21:05:10.557164Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d79a8cccc23ced73","local-member-id":"fe334179879fd0aa","cluster-version":"3.5"} {"level":"info","ts":"2026-03-25T21:05:10.557288Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-25T21:05:10.557328Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-25T21:05:10.557905Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-25T21:05:10.561879Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.69:2379"} {"level":"warn","ts":"2026-03-25T21:05:11.294674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.574585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-25T21:05:11.294775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.46247ms","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":"warn","ts":"2026-03-25T21:05:11.294825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.010378ms","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":"warn","ts":"2026-03-25T21:05:11.294865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.930135ms","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":"warn","ts":"2026-03-25T21:05:11.29506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.732164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-25T21:05:11.295056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.206512ms","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":"warn","ts":"2026-03-25T21:05:11.295119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.035176ms","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-03-25T21:05:11.295141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.19841ms","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-03-25T21:05:11.295158Z","caller":"traceutil/trace.go:171","msg":"trace[593623639] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1; }","duration":"318.407768ms","start":"2026-03-25T21:05:10.97673Z","end":"2026-03-25T21:05:11.295137Z","steps":["trace[593623639] 'range keys from in-memory index tree' (duration: 318.069778ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.295224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.693996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-25T21:05:11.295228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.226071ms","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":"info","ts":"2026-03-25T21:05:11.29522Z","caller":"traceutil/trace.go:171","msg":"trace[312231446] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1; }","duration":"253.295072ms","start":"2026-03-25T21:05:11.041894Z","end":"2026-03-25T21:05:11.295189Z","steps":["trace[312231446] 'count revisions from in-memory index tree' (duration: 253.130728ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.295249Z","caller":"traceutil/trace.go:171","msg":"trace[1364297460] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"564.740597ms","start":"2026-03-25T21:05:10.730503Z","end":"2026-03-25T21:05:11.295243Z","steps":["trace[1364297460] 'count revisions from in-memory index tree' (duration: 564.617254ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.295257Z","caller":"traceutil/trace.go:171","msg":"trace[161209008] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1; }","duration":"167.256392ms","start":"2026-03-25T21:05:11.127992Z","end":"2026-03-25T21:05:11.295249Z","steps":["trace[161209008] 'count revisions from in-memory index tree' (duration: 167.14048ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.2953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.730463Z","time spent":"564.8023ms","remote":"127.0.0.1:37876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.295251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.976711Z","time spent":"318.51924ms","remote":"127.0.0.1:38018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.295489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.241362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:05:11.295522Z","caller":"traceutil/trace.go:171","msg":"trace[331816838] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"552.310014ms","start":"2026-03-25T21:05:10.743205Z","end":"2026-03-25T21:05:11.295515Z","steps":["trace[331816838] 'count revisions from in-memory index tree' (duration: 552.198601ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.295533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.056331ms","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":"warn","ts":"2026-03-25T21:05:11.295549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.743198Z","time spent":"552.343214ms","remote":"127.0.0.1:37880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:05:11.295574Z","caller":"traceutil/trace.go:171","msg":"trace[1549063009] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"483.123464ms","start":"2026-03-25T21:05:10.81244Z","end":"2026-03-25T21:05:11.295564Z","steps":["trace[1549063009] 'count revisions from in-memory index tree' (duration: 482.98597ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.295613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.81243Z","time spent":"483.173834ms","remote":"127.0.0.1:37920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.29567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.726912ms","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":"warn","ts":"2026-03-25T21:05:11.295756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.428707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:05:11.295768Z","caller":"traceutil/trace.go:171","msg":"trace[491645019] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1; }","duration":"306.858926ms","start":"2026-03-25T21:05:10.988896Z","end":"2026-03-25T21:05:11.295755Z","steps":["trace[491645019] 'range keys from in-memory index tree' (duration: 306.64252ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.295837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.356871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-25T21:05:11.295841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.988882Z","time spent":"306.947228ms","remote":"127.0.0.1:38030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.295847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.373179ms","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":"info","ts":"2026-03-25T21:05:11.295868Z","caller":"traceutil/trace.go:171","msg":"trace[1129653565] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"538.415162ms","start":"2026-03-25T21:05:10.757443Z","end":"2026-03-25T21:05:11.295858Z","steps":["trace[1129653565] 'count revisions from in-memory index tree' (duration: 537.278953ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.295891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.757429Z","time spent":"538.456543ms","remote":"127.0.0.1:37882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:05:11.295884Z","caller":"traceutil/trace.go:171","msg":"trace[476897760] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"483.436212ms","start":"2026-03-25T21:05:10.812436Z","end":"2026-03-25T21:05:11.295872Z","steps":["trace[476897760] 'range keys from in-memory index tree' (duration: 483.294287ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.295923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.812422Z","time spent":"483.490544ms","remote":"127.0.0.1:37920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.295969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.83629ms","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":"warn","ts":"2026-03-25T21:05:11.296015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.246182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:05:11.296023Z","caller":"traceutil/trace.go:171","msg":"trace[1006539300] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1; }","duration":"136.913522ms","start":"2026-03-25T21:05:11.159098Z","end":"2026-03-25T21:05:11.296011Z","steps":["trace[1006539300] 'range keys from in-memory index tree' (duration: 136.768829ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.296036Z","caller":"traceutil/trace.go:171","msg":"trace[342994749] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"522.269243ms","start":"2026-03-25T21:05:10.773761Z","end":"2026-03-25T21:05:11.29603Z","steps":["trace[342994749] 'range keys from in-memory index tree' (duration: 522.151879ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.296058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.773682Z","time spent":"522.370434ms","remote":"127.0.0.1:37894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":28,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.296088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.603014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-25T21:05:11.296904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.865248ms","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":"warn","ts":"2026-03-25T21:05:11.295178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.29716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:05:11.296972Z","caller":"traceutil/trace.go:171","msg":"trace[1520691272] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"580.110528ms","start":"2026-03-25T21:05:10.716855Z","end":"2026-03-25T21:05:11.296966Z","steps":["trace[1520691272] 'range keys from in-memory index tree' (duration: 578.166887ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.296969Z","caller":"traceutil/trace.go:171","msg":"trace[848781674] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"386.912409ms","start":"2026-03-25T21:05:10.910021Z","end":"2026-03-25T21:05:11.296934Z","steps":["trace[848781674] 'range keys from in-memory index tree' (duration: 386.752835ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.296997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.716843Z","time spent":"580.146579ms","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.297005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.910011Z","time spent":"386.984031ms","remote":"127.0.0.1:37972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.296187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.637577ms","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-03-25T21:05:11.297154Z","caller":"traceutil/trace.go:171","msg":"trace[166570221] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1; }","duration":"295.654084ms","start":"2026-03-25T21:05:11.001488Z","end":"2026-03-25T21:05:11.297142Z","steps":["trace[166570221] 'count revisions from in-memory index tree' (duration: 294.565956ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.295779Z","caller":"traceutil/trace.go:171","msg":"trace[1253447752] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"552.475818ms","start":"2026-03-25T21:05:10.743298Z","end":"2026-03-25T21:05:11.295773Z","steps":["trace[1253447752] 'range keys from in-memory index tree' (duration: 552.368676ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.297406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.743285Z","time spent":"554.107621ms","remote":"127.0.0.1:37880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.295156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.194088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:05:11.297956Z","caller":"traceutil/trace.go:171","msg":"trace[158063812] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"580.989771ms","start":"2026-03-25T21:05:10.716957Z","end":"2026-03-25T21:05:11.297947Z","steps":["trace[158063812] 'count revisions from in-memory index tree' (duration: 578.165487ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.298006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.716933Z","time spent":"581.046251ms","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.296088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.093661ms","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-03-25T21:05:11.298235Z","caller":"traceutil/trace.go:171","msg":"trace[1471028996] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1; }","duration":"309.308369ms","start":"2026-03-25T21:05:10.98892Z","end":"2026-03-25T21:05:11.298228Z","steps":["trace[1471028996] 'count revisions from in-memory index tree' (duration: 306.991579ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.298267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.988885Z","time spent":"309.371242ms","remote":"127.0.0.1:38030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.294927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.691967ms","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":"info","ts":"2026-03-25T21:05:11.298655Z","caller":"traceutil/trace.go:171","msg":"trace[1427583753] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1; }","duration":"246.455983ms","start":"2026-03-25T21:05:11.052191Z","end":"2026-03-25T21:05:11.298647Z","steps":["trace[1427583753] 'count revisions from in-memory index tree' (duration: 242.578374ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.294926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.464677ms","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-03-25T21:05:11.298849Z","caller":"traceutil/trace.go:171","msg":"trace[527859029] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1; }","duration":"217.394289ms","start":"2026-03-25T21:05:11.081447Z","end":"2026-03-25T21:05:11.298842Z","steps":["trace[527859029] 'range keys from in-memory index tree' (duration: 213.397305ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.294805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.026935ms","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-03-25T21:05:11.299289Z","caller":"traceutil/trace.go:171","msg":"trace[128672496] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1; }","duration":"257.541862ms","start":"2026-03-25T21:05:11.041739Z","end":"2026-03-25T21:05:11.299281Z","steps":["trace[128672496] 'range keys from in-memory index tree' (duration: 252.983393ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.294948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.213233ms","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":"info","ts":"2026-03-25T21:05:11.29945Z","caller":"traceutil/trace.go:171","msg":"trace[582881298] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1; }","duration":"231.737142ms","start":"2026-03-25T21:05:11.067701Z","end":"2026-03-25T21:05:11.299438Z","steps":["trace[582881298] 'range keys from in-memory index tree' (duration: 227.152541ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.29496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.529798ms","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-03-25T21:05:11.299615Z","caller":"traceutil/trace.go:171","msg":"trace[96562427] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1; }","duration":"218.208128ms","start":"2026-03-25T21:05:11.081399Z","end":"2026-03-25T21:05:11.299608Z","steps":["trace[96562427] 'count revisions from in-memory index tree' (duration: 213.421524ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.294975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.251029ms","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":"info","ts":"2026-03-25T21:05:11.299748Z","caller":"traceutil/trace.go:171","msg":"trace[719312779] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"500.049474ms","start":"2026-03-25T21:05:10.799692Z","end":"2026-03-25T21:05:11.299742Z","steps":["trace[719312779] 'range keys from in-memory index tree' (duration: 495.183637ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.299773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.799663Z","time spent":"500.100045ms","remote":"127.0.0.1:37918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.294998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.004776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:05:11.299924Z","caller":"traceutil/trace.go:171","msg":"trace[956842133] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"624.984015ms","start":"2026-03-25T21:05:10.674934Z","end":"2026-03-25T21:05:11.299918Z","steps":["trace[956842133] 'range keys from in-memory index tree' (duration: 619.903433ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.299926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.888123ms","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-03-25T21:05:11.299948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.674897Z","time spent":"625.043207ms","remote":"127.0.0.1:37842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":28,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 "} {"level":"info","ts":"2026-03-25T21:05:11.299969Z","caller":"traceutil/trace.go:171","msg":"trace[768743319] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1; }","duration":"171.960104ms","start":"2026-03-25T21:05:11.127998Z","end":"2026-03-25T21:05:11.299958Z","steps":["trace[768743319] 'range keys from in-memory index tree' (duration: 171.79844ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.294996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.640298ms","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-03-25T21:05:11.300105Z","caller":"traceutil/trace.go:171","msg":"trace[227840748] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1; }","duration":"201.780202ms","start":"2026-03-25T21:05:11.098318Z","end":"2026-03-25T21:05:11.300098Z","steps":["trace[227840748] 'range keys from in-memory index tree' (duration: 196.515404ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.300268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.324704ms","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-03-25T21:05:11.295017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.975026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:05:11.300306Z","caller":"traceutil/trace.go:171","msg":"trace[1752912348] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1; }","duration":"157.385977ms","start":"2026-03-25T21:05:11.142911Z","end":"2026-03-25T21:05:11.300297Z","steps":["trace[1752912348] 'range keys from in-memory index tree' (duration: 157.279223ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.300329Z","caller":"traceutil/trace.go:171","msg":"trace[1755771699] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"625.304733ms","start":"2026-03-25T21:05:10.675018Z","end":"2026-03-25T21:05:11.300322Z","steps":["trace[1755771699] 'count revisions from in-memory index tree' (duration: 619.901194ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.300364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.675005Z","time spent":"625.348605ms","remote":"127.0.0.1:37842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.295038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.091494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:05:11.300517Z","caller":"traceutil/trace.go:171","msg":"trace[1538990412] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"611.586387ms","start":"2026-03-25T21:05:10.688922Z","end":"2026-03-25T21:05:11.300508Z","steps":["trace[1538990412] 'range keys from in-memory index tree' (duration: 606.034103ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.300545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.688909Z","time spent":"611.625017ms","remote":"127.0.0.1:37852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.295038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.505055ms","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-03-25T21:05:11.300723Z","caller":"traceutil/trace.go:171","msg":"trace[1013101429] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1; }","duration":"202.219143ms","start":"2026-03-25T21:05:11.098497Z","end":"2026-03-25T21:05:11.300716Z","steps":["trace[1013101429] 'count revisions from in-memory index tree' (duration: 193.607249ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.295081Z","caller":"traceutil/trace.go:171","msg":"trace[1926181708] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1; }","duration":"318.401727ms","start":"2026-03-25T21:05:10.976669Z","end":"2026-03-25T21:05:11.295071Z","steps":["trace[1926181708] 'count revisions from in-memory index tree' (duration: 317.827571ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.300862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.976648Z","time spent":"324.204728ms","remote":"127.0.0.1:38018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:05:11.294874Z","caller":"traceutil/trace.go:171","msg":"trace[690204377] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1; }","duration":"179.613475ms","start":"2026-03-25T21:05:11.115243Z","end":"2026-03-25T21:05:11.294856Z","steps":["trace[690204377] 'range keys from in-memory index tree' (duration: 179.365479ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.295054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.956293ms","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-03-25T21:05:11.301222Z","caller":"traceutil/trace.go:171","msg":"trace[1626660965] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1; }","duration":"249.206475ms","start":"2026-03-25T21:05:11.052006Z","end":"2026-03-25T21:05:11.301213Z","steps":["trace[1626660965] 'range keys from in-memory index tree' (duration: 242.865812ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.295111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.37503ms","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-03-25T21:05:11.301451Z","caller":"traceutil/trace.go:171","msg":"trace[305383175] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"597.713965ms","start":"2026-03-25T21:05:10.703729Z","end":"2026-03-25T21:05:11.301442Z","steps":["trace[305383175] 'range keys from in-memory index tree' (duration: 591.33841ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.301482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.703709Z","time spent":"597.761668ms","remote":"127.0.0.1:37856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 "} {"level":"info","ts":"2026-03-25T21:05:11.295159Z","caller":"traceutil/trace.go:171","msg":"trace[1738872217] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1; }","duration":"152.083388ms","start":"2026-03-25T21:05:11.143067Z","end":"2026-03-25T21:05:11.29515Z","steps":["trace[1738872217] 'count revisions from in-memory index tree' (duration: 152.014466ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.295195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.790192ms","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-03-25T21:05:11.301663Z","caller":"traceutil/trace.go:171","msg":"trace[1543985601] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1; }","duration":"185.260471ms","start":"2026-03-25T21:05:11.116395Z","end":"2026-03-25T21:05:11.301655Z","steps":["trace[1543985601] 'count revisions from in-memory index tree' (duration: 178.72524ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.2952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.765778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:05:11.301774Z","caller":"traceutil/trace.go:171","msg":"trace[568750565] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"571.34164ms","start":"2026-03-25T21:05:10.730417Z","end":"2026-03-25T21:05:11.301759Z","steps":["trace[568750565] 'range keys from in-memory index tree' (duration: 564.737888ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.301807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.73041Z","time spent":"571.387401ms","remote":"127.0.0.1:37876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 "} {"level":"info","ts":"2026-03-25T21:05:11.294752Z","caller":"traceutil/trace.go:171","msg":"trace[191149677] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"634.714719ms","start":"2026-03-25T21:05:10.660025Z","end":"2026-03-25T21:05:11.29474Z","steps":["trace[191149677] 'count revisions from in-memory index tree' (duration: 634.510894ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.301972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.660002Z","time spent":"641.960737ms","remote":"127.0.0.1:37838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.296133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.951787ms","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-03-25T21:05:11.302177Z","caller":"traceutil/trace.go:171","msg":"trace[127909729] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"706.007454ms","start":"2026-03-25T21:05:10.596154Z","end":"2026-03-25T21:05:11.302161Z","steps":["trace[127909729] 'range keys from in-memory index tree' (duration: 699.924885ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.302208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.596148Z","time spent":"706.046905ms","remote":"127.0.0.1:37806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":121,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.296153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.057238ms","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-03-25T21:05:11.302445Z","caller":"traceutil/trace.go:171","msg":"trace[1083131240] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"706.346962ms","start":"2026-03-25T21:05:10.596091Z","end":"2026-03-25T21:05:11.302438Z","steps":["trace[1083131240] 'count revisions from in-memory index tree' (duration: 699.931175ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.302474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.596071Z","time spent":"706.393564ms","remote":"127.0.0.1:37806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.302988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.641851ms","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-03-25T21:05:11.303056Z","caller":"traceutil/trace.go:171","msg":"trace[602277813] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1; }","duration":"351.736614ms","start":"2026-03-25T21:05:10.951306Z","end":"2026-03-25T21:05:11.303042Z","steps":["trace[602277813] 'count revisions from in-memory index tree' (duration: 351.521808ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.303639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.951231Z","time spent":"352.384491ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":28,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.296149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.7097ms","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":"info","ts":"2026-03-25T21:05:11.303836Z","caller":"traceutil/trace.go:171","msg":"trace[2027582273] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1; }","duration":"302.437221ms","start":"2026-03-25T21:05:11.001378Z","end":"2026-03-25T21:05:11.303816Z","steps":["trace[2027582273] 'range keys from in-memory index tree' (duration: 294.601907ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.303916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.806559ms","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":"info","ts":"2026-03-25T21:05:11.30394Z","caller":"traceutil/trace.go:171","msg":"trace[1812085055] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"393.85461ms","start":"2026-03-25T21:05:10.910079Z","end":"2026-03-25T21:05:11.303933Z","steps":["trace[1812085055] 'count revisions from in-memory index tree' (duration: 393.704296ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.303958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.910064Z","time spent":"393.888851ms","remote":"127.0.0.1:37972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.304032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:11.001344Z","time spent":"302.573834ms","remote":"127.0.0.1:38042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.296179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.59683Z","time spent":"699.34662ms","remote":"127.0.0.1:37792","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-03-25T21:05:11.30431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.530727ms","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-03-25T21:05:11.304341Z","caller":"traceutil/trace.go:171","msg":"trace[549419815] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1; }","duration":"369.619129ms","start":"2026-03-25T21:05:10.934708Z","end":"2026-03-25T21:05:11.304327Z","steps":["trace[549419815] 'count revisions from in-memory index tree' (duration: 369.364113ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.304366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.934687Z","time spent":"369.67236ms","remote":"127.0.0.1:38002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.304475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.65569ms","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-03-25T21:05:11.304497Z","caller":"traceutil/trace.go:171","msg":"trace[287813688] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1; }","duration":"369.721932ms","start":"2026-03-25T21:05:10.934769Z","end":"2026-03-25T21:05:11.304491Z","steps":["trace[287813688] 'range keys from in-memory index tree' (duration: 369.506617ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.304513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.934743Z","time spent":"369.765113ms","remote":"127.0.0.1:38002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.30459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.51268ms","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-03-25T21:05:11.304608Z","caller":"traceutil/trace.go:171","msg":"trace[726544157] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1; }","duration":"353.578833ms","start":"2026-03-25T21:05:10.951025Z","end":"2026-03-25T21:05:11.304604Z","steps":["trace[726544157] 'range keys from in-memory index tree' (duration: 353.430808ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.304629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.951Z","time spent":"353.617933ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":28,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.296194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.178449ms","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":"info","ts":"2026-03-25T21:05:11.304824Z","caller":"traceutil/trace.go:171","msg":"trace[1621920940] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1; }","duration":"145.863897ms","start":"2026-03-25T21:05:11.158948Z","end":"2026-03-25T21:05:11.304812Z","steps":["trace[1621920940] 'count revisions from in-memory index tree' (duration: 137.071006ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.304894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.020713ms","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-03-25T21:05:11.304927Z","caller":"traceutil/trace.go:171","msg":"trace[1209541204] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1; }","duration":"339.083445ms","start":"2026-03-25T21:05:10.965836Z","end":"2026-03-25T21:05:11.30492Z","steps":["trace[1209541204] 'count revisions from in-memory index tree' (duration: 338.927111ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.304947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.965817Z","time spent":"339.124036ms","remote":"127.0.0.1:38016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.296214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.65316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:05:11.305131Z","caller":"traceutil/trace.go:171","msg":"trace[1085188724] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"665.624523ms","start":"2026-03-25T21:05:10.639497Z","end":"2026-03-25T21:05:11.305121Z","steps":["trace[1085188724] 'count revisions from in-memory index tree' (duration: 656.564967ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.305181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.639477Z","time spent":"665.690594ms","remote":"127.0.0.1:37820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":28,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.296246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.973658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:05:11.305403Z","caller":"traceutil/trace.go:171","msg":"trace[1167149501] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"656.139177ms","start":"2026-03-25T21:05:10.649239Z","end":"2026-03-25T21:05:11.305378Z","steps":["trace[1167149501] 'range keys from in-memory index tree' (duration: 646.891766ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.30547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.649221Z","time spent":"656.236109ms","remote":"127.0.0.1:37826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.296266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.758311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:05:11.305655Z","caller":"traceutil/trace.go:171","msg":"trace[1174240513] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"656.178457ms","start":"2026-03-25T21:05:10.649467Z","end":"2026-03-25T21:05:11.305645Z","steps":["trace[1174240513] 'count revisions from in-memory index tree' (duration: 646.68671ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.305701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.649446Z","time spent":"656.244989ms","remote":"127.0.0.1:37826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:05:11.294895Z","caller":"traceutil/trace.go:171","msg":"trace[1485989403] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1; }","duration":"227.103029ms","start":"2026-03-25T21:05:11.067785Z","end":"2026-03-25T21:05:11.294888Z","steps":["trace[1485989403] 'count revisions from in-memory index tree' (duration: 226.954186ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.296292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.285609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:05:11.305873Z","caller":"traceutil/trace.go:171","msg":"trace[1632044091] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"645.881669ms","start":"2026-03-25T21:05:10.65998Z","end":"2026-03-25T21:05:11.305862Z","steps":["trace[1632044091] 'range keys from in-memory index tree' (duration: 636.236328ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.296268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.878471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-25T21:05:11.296382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.46072ms","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-03-25T21:05:11.296327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.652304ms","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":"warn","ts":"2026-03-25T21:05:11.296472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.86145ms","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":"warn","ts":"2026-03-25T21:05:11.296495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.072524ms","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":"warn","ts":"2026-03-25T21:05:11.296517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.049464ms","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":"warn","ts":"2026-03-25T21:05:11.296551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.906562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-25T21:05:11.296581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.651522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-25T21:05:11.296662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.411934ms","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-03-25T21:05:11.296735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.469745ms","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":"warn","ts":"2026-03-25T21:05:11.29681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.666565ms","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":"warn","ts":"2026-03-25T21:05:11.296664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.269386ms","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-03-25T21:05:11.29685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.622165ms","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-03-25T21:05:11.295137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.354741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-25T21:05:11.296886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.372879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-25T21:05:11.304271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.402625ms","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":"warn","ts":"2026-03-25T21:05:11.304293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.212742ms","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-03-25T21:05:11.305872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.154847ms","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-03-25T21:05:11.305989Z","caller":"traceutil/trace.go:171","msg":"trace[169774091] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1; }","duration":"340.102081ms","start":"2026-03-25T21:05:10.965881Z","end":"2026-03-25T21:05:11.305983Z","steps":["trace[169774091] 'range keys from in-memory index tree' (duration: 339.012223ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.306022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.965854Z","time spent":"340.153263ms","remote":"127.0.0.1:38016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":28,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" limit:10000 "} {"level":"info","ts":"2026-03-25T21:05:11.306081Z","caller":"traceutil/trace.go:171","msg":"trace[585381443] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"532.20156ms","start":"2026-03-25T21:05:10.773873Z","end":"2026-03-25T21:05:11.306075Z","steps":["trace[585381443] 'count revisions from in-memory index tree' (duration: 522.523529ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.306018Z","caller":"traceutil/trace.go:171","msg":"trace[1884911790] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"506.389188ms","start":"2026-03-25T21:05:10.799616Z","end":"2026-03-25T21:05:11.306005Z","steps":["trace[1884911790] 'count revisions from in-memory index tree' (duration: 496.81968ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.306108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.77384Z","time spent":"532.261073ms","remote":"127.0.0.1:37894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:05:11.306158Z","caller":"traceutil/trace.go:171","msg":"trace[1637978056] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"471.268905ms","start":"2026-03-25T21:05:10.834881Z","end":"2026-03-25T21:05:11.30615Z","steps":["trace[1637978056] 'range keys from in-memory index tree' (duration: 461.375127ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.306187Z","caller":"traceutil/trace.go:171","msg":"trace[1962945662] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1; }","duration":"290.52318ms","start":"2026-03-25T21:05:11.015655Z","end":"2026-03-25T21:05:11.306178Z","steps":["trace[1962945662] 'range keys from in-memory index tree' (duration: 280.627273ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.306192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.834865Z","time spent":"471.319115ms","remote":"127.0.0.1:37934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" limit:10000 "} {"level":"info","ts":"2026-03-25T21:05:11.306205Z","caller":"traceutil/trace.go:171","msg":"trace[755918295] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"422.049434ms","start":"2026-03-25T21:05:10.884148Z","end":"2026-03-25T21:05:11.306198Z","steps":["trace[755918295] 'range keys from in-memory index tree' (duration: 412.021003ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.306233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.884103Z","time spent":"422.118686ms","remote":"127.0.0.1:37946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 "} {"level":"info","ts":"2026-03-25T21:05:11.295087Z","caller":"traceutil/trace.go:171","msg":"trace[333705229] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"605.792036ms","start":"2026-03-25T21:05:10.689287Z","end":"2026-03-25T21:05:11.295079Z","steps":["trace[333705229] 'count revisions from in-memory index tree' (duration: 605.688013ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.306266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.689278Z","time spent":"616.979217ms","remote":"127.0.0.1:37852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.306159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.799599Z","time spent":"506.539204ms","remote":"127.0.0.1:37918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:05:11.306336Z","caller":"traceutil/trace.go:171","msg":"trace[1977189385] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1; }","duration":"290.739057ms","start":"2026-03-25T21:05:11.015587Z","end":"2026-03-25T21:05:11.306326Z","steps":["trace[1977189385] 'count revisions from in-memory index tree' (duration: 280.754657ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.306372Z","caller":"traceutil/trace.go:171","msg":"trace[1953777599] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"408.289275ms","start":"2026-03-25T21:05:10.898072Z","end":"2026-03-25T21:05:11.306361Z","steps":["trace[1953777599] 'count revisions from in-memory index tree' (duration: 398.554403ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.306401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.898047Z","time spent":"408.345866ms","remote":"127.0.0.1:37958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.296342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.47254ms","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":"info","ts":"2026-03-25T21:05:11.306442Z","caller":"traceutil/trace.go:171","msg":"trace[732365664] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1; }","duration":"276.026404ms","start":"2026-03-25T21:05:11.030407Z","end":"2026-03-25T21:05:11.306434Z","steps":["trace[732365664] 'count revisions from in-memory index tree' (duration: 266.027893ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.306463Z","caller":"traceutil/trace.go:171","msg":"trace[5449453] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"471.644185ms","start":"2026-03-25T21:05:10.834807Z","end":"2026-03-25T21:05:11.306451Z","steps":["trace[5449453] 'count revisions from in-memory index tree' (duration: 461.437598ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.306472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.65997Z","time spent":"646.493885ms","remote":"127.0.0.1:37838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 "} {"level":"info","ts":"2026-03-25T21:05:11.306384Z","caller":"traceutil/trace.go:171","msg":"trace[1832790073] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"481.942033ms","start":"2026-03-25T21:05:10.824365Z","end":"2026-03-25T21:05:11.306307Z","steps":["trace[1832790073] 'range keys from in-memory index tree' (duration: 471.767418ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.306505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.834797Z","time spent":"471.696966ms","remote":"127.0.0.1:37934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:05:11.306539Z","caller":"traceutil/trace.go:171","msg":"trace[1720073975] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1; }","duration":"276.089914ms","start":"2026-03-25T21:05:11.03044Z","end":"2026-03-25T21:05:11.30653Z","steps":["trace[1720073975] 'range keys from in-memory index tree' (duration: 265.992661ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.306501Z","caller":"traceutil/trace.go:171","msg":"trace[1654851335] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"521.124873ms","start":"2026-03-25T21:05:10.785369Z","end":"2026-03-25T21:05:11.306494Z","steps":["trace[1654851335] 'count revisions from in-memory index tree' (duration: 511.222495ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.306585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.824354Z","time spent":"482.21029ms","remote":"127.0.0.1:37928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 "} {"level":"info","ts":"2026-03-25T21:05:11.306609Z","caller":"traceutil/trace.go:171","msg":"trace[825537708] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1; }","duration":"383.541501ms","start":"2026-03-25T21:05:10.923059Z","end":"2026-03-25T21:05:11.3066Z","steps":["trace[825537708] 'range keys from in-memory index tree' (duration: 381.159051ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.306688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.923052Z","time spent":"383.626004ms","remote":"127.0.0.1:37988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" limit:10000 "} {"level":"info","ts":"2026-03-25T21:05:11.306348Z","caller":"traceutil/trace.go:171","msg":"trace[2087385333] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"422.158417ms","start":"2026-03-25T21:05:10.884183Z","end":"2026-03-25T21:05:11.306341Z","steps":["trace[2087385333] 'count revisions from in-memory index tree' (duration: 412.281959ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.296916Z","caller":"traceutil/trace.go:171","msg":"trace[1135309556] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"472.471426ms","start":"2026-03-25T21:05:10.824435Z","end":"2026-03-25T21:05:11.296907Z","steps":["trace[1135309556] 'count revisions from in-memory index tree' (duration: 471.573333ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.306833Z","caller":"traceutil/trace.go:171","msg":"trace[1334886711] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"521.300518ms","start":"2026-03-25T21:05:10.785502Z","end":"2026-03-25T21:05:11.306802Z","steps":["trace[1334886711] 'range keys from in-memory index tree' (duration: 511.299447ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.306863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.785484Z","time spent":"521.367769ms","remote":"127.0.0.1:37904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.306877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.824431Z","time spent":"482.410075ms","remote":"127.0.0.1:37928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.295988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.05627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:05:11.306924Z","caller":"traceutil/trace.go:171","msg":"trace[990799798] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"550.012514ms","start":"2026-03-25T21:05:10.756904Z","end":"2026-03-25T21:05:11.306916Z","steps":["trace[990799798] 'range keys from in-memory index tree' (duration: 537.370106ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.306926Z","caller":"traceutil/trace.go:171","msg":"trace[1194180701] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"603.183048ms","start":"2026-03-25T21:05:10.703733Z","end":"2026-03-25T21:05:11.306916Z","steps":["trace[1194180701] 'count revisions from in-memory index tree' (duration: 591.289339ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.306944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.756877Z","time spent":"550.060195ms","remote":"127.0.0.1:37882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.306951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.703716Z","time spent":"603.227849ms","remote":"127.0.0.1:37856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.306813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.884154Z","time spent":"422.648919ms","remote":"127.0.0.1:37946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:05:11.306968Z","caller":"traceutil/trace.go:171","msg":"trace[1229554267] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1; }","duration":"384.133696ms","start":"2026-03-25T21:05:10.922826Z","end":"2026-03-25T21:05:11.30696Z","steps":["trace[1229554267] 'count revisions from in-memory index tree' (duration: 381.268872ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.306589Z","caller":"traceutil/trace.go:171","msg":"trace[71028465] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"408.358297ms","start":"2026-03-25T21:05:10.898156Z","end":"2026-03-25T21:05:11.306514Z","steps":["trace[71028465] 'range keys from in-memory index tree' (duration: 398.513981ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:11.306617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.785361Z","time spent":"521.245566ms","remote":"127.0.0.1:37904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:11.307034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.8981Z","time spent":"408.925743ms","remote":"127.0.0.1:37958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:05:11.307011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:10.922811Z","time spent":"384.191269ms","remote":"127.0.0.1:37988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:05:14.125615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.175384ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-25T21:05:14.1259Z","caller":"traceutil/trace.go:171","msg":"trace[635152163] transaction","detail":"{read_only:false; response_revision:192; number_of_response:1; }","duration":"466.410149ms","start":"2026-03-25T21:05:13.659435Z","end":"2026-03-25T21:05:14.125845Z","steps":["trace[635152163] 'process raft request' (duration: 55.499615ms)","trace[635152163] 'compare' (duration: 410.044661ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:05:14.126259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:13.659419Z","time spent":"466.744787ms","remote":"127.0.0.1:38074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":726,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-25T21:05:14.870855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.57274ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-25T21:05:14.871043Z","caller":"traceutil/trace.go:171","msg":"trace[2085803848] transaction","detail":"{read_only:false; response_revision:193; number_of_response:1; }","duration":"729.715301ms","start":"2026-03-25T21:05:14.141304Z","end":"2026-03-25T21:05:14.871019Z","steps":["trace[2085803848] 'process raft request' (duration: 372.672798ms)","trace[2085803848] 'compare' (duration: 356.406166ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:05:14.871138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:14.141278Z","time spent":"729.829203ms","remote":"127.0.0.1:37810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:05:15.409321Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003095966783204,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-25T21:05:15.910057Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003095966783204,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-25T21:05:16.085906Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.275055434s","expected-duration":"1s"} {"level":"info","ts":"2026-03-25T21:05:16.086447Z","caller":"traceutil/trace.go:171","msg":"trace[1562432078] transaction","detail":"{read_only:false; response_revision:194; number_of_response:1; }","duration":"1.484811803s","start":"2026-03-25T21:05:14.601609Z","end":"2026-03-25T21:05:16.086421Z","steps":["trace[1562432078] 'process raft request' (duration: 1.484550496s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:16.086584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:14.601576Z","time spent":"1.484945326s","remote":"127.0.0.1:37842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1068,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-25T21:05:16.089998Z","caller":"traceutil/trace.go:171","msg":"trace[1230620052] linearizableReadLoop","detail":"{readStateIndex:199; appliedIndex:197; }","duration":"1.18156546s","start":"2026-03-25T21:05:14.908409Z","end":"2026-03-25T21:05:16.089974Z","steps":["trace[1230620052] 'read index received' (duration: 1.177758361s)","trace[1230620052] 'applied index is now lower than readState.Index' (duration: 3.806109ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:05:16.090208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.181790247s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:05:16.090218Z","caller":"traceutil/trace.go:171","msg":"trace[2142494721] transaction","detail":"{read_only:false; response_revision:195; number_of_response:1; }","duration":"1.216995053s","start":"2026-03-25T21:05:14.8732Z","end":"2026-03-25T21:05:16.090195Z","steps":["trace[2142494721] 'process raft request' (duration: 1.216654854s)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:16.090249Z","caller":"traceutil/trace.go:171","msg":"trace[304971278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:195; }","duration":"1.181905241s","start":"2026-03-25T21:05:14.908331Z","end":"2026-03-25T21:05:16.090236Z","steps":["trace[304971278] 'agreement among raft nodes before linearized reading' (duration: 1.181715966s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:16.0903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:14.908299Z","time spent":"1.181992432s","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-25T21:05:16.09038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:14.873165Z","time spent":"1.217104095s","remote":"127.0.0.1:37920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":689,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-25T21:05:16.751976Z","caller":"traceutil/trace.go:171","msg":"trace[1659916473] linearizableReadLoop","detail":"{readStateIndex:228; appliedIndex:227; }","duration":"129.559422ms","start":"2026-03-25T21:05:16.622389Z","end":"2026-03-25T21:05:16.751948Z","steps":["trace[1659916473] 'read index received' (duration: 129.361466ms)","trace[1659916473] 'applied index is now lower than readState.Index' (duration: 196.736µs)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:05:16.752186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.780957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-03-25T21:05:16.752236Z","caller":"traceutil/trace.go:171","msg":"trace[82838174] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:222; }","duration":"129.884201ms","start":"2026-03-25T21:05:16.622339Z","end":"2026-03-25T21:05:16.752223Z","steps":["trace[82838174] 'agreement among raft nodes before linearized reading' (duration: 129.720257ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:16.75245Z","caller":"traceutil/trace.go:171","msg":"trace[25803293] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"250.740946ms","start":"2026-03-25T21:05:16.50168Z","end":"2026-03-25T21:05:16.75242Z","steps":["trace[25803293] 'process raft request' (duration: 250.135701ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:42.633276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.498853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-03-25T21:05:42.633394Z","caller":"traceutil/trace.go:171","msg":"trace[1209421872] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:509; }","duration":"229.674327ms","start":"2026-03-25T21:05:42.40369Z","end":"2026-03-25T21:05:42.633364Z","steps":["trace[1209421872] 'range keys from in-memory index tree' (duration: 229.227314ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:42.633551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.529085ms","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-03-25T21:05:42.633651Z","caller":"traceutil/trace.go:171","msg":"trace[1035132721] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:509; }","duration":"226.706992ms","start":"2026-03-25T21:05:42.406918Z","end":"2026-03-25T21:05:42.633625Z","steps":["trace[1035132721] 'range keys from in-memory index tree' (duration: 226.402751ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:42.644625Z","caller":"traceutil/trace.go:171","msg":"trace[141640555] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"226.68304ms","start":"2026-03-25T21:05:42.417927Z","end":"2026-03-25T21:05:42.64461Z","steps":["trace[141640555] 'process raft request' (duration: 226.594488ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:42.651099Z","caller":"traceutil/trace.go:171","msg":"trace[275988625] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"208.307245ms","start":"2026-03-25T21:05:42.442757Z","end":"2026-03-25T21:05:42.651064Z","steps":["trace[275988625] 'process raft request' (duration: 208.11462ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:42.651136Z","caller":"traceutil/trace.go:171","msg":"trace[1177837945] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"227.054191ms","start":"2026-03-25T21:05:42.424047Z","end":"2026-03-25T21:05:42.651101Z","steps":["trace[1177837945] 'process raft request' (duration: 226.707212ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:42.651216Z","caller":"traceutil/trace.go:171","msg":"trace[1109701462] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"200.267731ms","start":"2026-03-25T21:05:42.450904Z","end":"2026-03-25T21:05:42.651171Z","steps":["trace[1109701462] 'process raft request' (duration: 200.057585ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:42.651347Z","caller":"traceutil/trace.go:171","msg":"trace[988914294] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"200.484648ms","start":"2026-03-25T21:05:42.450852Z","end":"2026-03-25T21:05:42.651337Z","steps":["trace[988914294] 'process raft request' (duration: 200.059826ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:42.651401Z","caller":"traceutil/trace.go:171","msg":"trace[192728532] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:527; }","duration":"195.791681ms","start":"2026-03-25T21:05:42.455588Z","end":"2026-03-25T21:05:42.65138Z","steps":["trace[192728532] 'read index received' (duration: 189.016943ms)","trace[192728532] 'applied index is now lower than readState.Index' (duration: 6.773978ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:05:42.651422Z","caller":"traceutil/trace.go:171","msg":"trace[1826984383] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"200.566211ms","start":"2026-03-25T21:05:42.450847Z","end":"2026-03-25T21:05:42.651413Z","steps":["trace[1826984383] 'process raft request' (duration: 200.088216ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:42.651431Z","caller":"traceutil/trace.go:171","msg":"trace[681759305] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"223.348174ms","start":"2026-03-25T21:05:42.428066Z","end":"2026-03-25T21:05:42.651414Z","steps":["trace[681759305] 'process raft request' (duration: 222.775076ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:42.651504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.902684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-25T21:05:42.651528Z","caller":"traceutil/trace.go:171","msg":"trace[1685894530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:524; }","duration":"195.977707ms","start":"2026-03-25T21:05:42.455544Z","end":"2026-03-25T21:05:42.651522Z","steps":["trace[1685894530] 'agreement among raft nodes before linearized reading' (duration: 195.900364ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:42.651549Z","caller":"traceutil/trace.go:171","msg":"trace[764126750] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"178.483376ms","start":"2026-03-25T21:05:42.473058Z","end":"2026-03-25T21:05:42.651541Z","steps":["trace[764126750] 'process raft request' (duration: 177.93355ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:42.651629Z","caller":"traceutil/trace.go:171","msg":"trace[2026745435] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"152.79542ms","start":"2026-03-25T21:05:42.498826Z","end":"2026-03-25T21:05:42.651621Z","steps":["trace[2026745435] 'process raft request' (duration: 152.330335ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:42.651642Z","caller":"traceutil/trace.go:171","msg":"trace[1858149803] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"168.875507ms","start":"2026-03-25T21:05:42.482733Z","end":"2026-03-25T21:05:42.651608Z","steps":["trace[1858149803] 'process raft request' (duration: 168.383384ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:42.651707Z","caller":"traceutil/trace.go:171","msg":"trace[1455628251] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"172.652217ms","start":"2026-03-25T21:05:42.479047Z","end":"2026-03-25T21:05:42.6517Z","steps":["trace[1455628251] 'process raft request' (duration: 171.977958ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:47.72595Z","caller":"traceutil/trace.go:171","msg":"trace[227111993] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"467.437829ms","start":"2026-03-25T21:05:47.25848Z","end":"2026-03-25T21:05:47.725918Z","steps":["trace[227111993] 'process raft request' (duration: 466.668387ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:47.726152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:47.258437Z","time spent":"467.592054ms","remote":"127.0.0.1:37838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:05:48.901016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.882085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-25T21:05:48.901156Z","caller":"traceutil/trace.go:171","msg":"trace[1200417565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:615; }","duration":"194.064841ms","start":"2026-03-25T21:05:48.707064Z","end":"2026-03-25T21:05:48.901129Z","steps":["trace[1200417565] 'range keys from in-memory index tree' (duration: 193.687379ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:48.905268Z","caller":"traceutil/trace.go:171","msg":"trace[96026316] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"198.091018ms","start":"2026-03-25T21:05:48.707159Z","end":"2026-03-25T21:05:48.90525Z","steps":["trace[96026316] 'process raft request' (duration: 197.83601ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:49.333593Z","caller":"traceutil/trace.go:171","msg":"trace[214533993] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:638; }","duration":"448.20746ms","start":"2026-03-25T21:05:48.885351Z","end":"2026-03-25T21:05:49.333558Z","steps":["trace[214533993] 'read index received' (duration: 19.698873ms)","trace[214533993] 'applied index is now lower than readState.Index' (duration: 428.507577ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:05:49.333701Z","caller":"traceutil/trace.go:171","msg":"trace[1937846517] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"604.264904ms","start":"2026-03-25T21:05:48.729412Z","end":"2026-03-25T21:05:49.333677Z","steps":["trace[1937846517] 'process raft request' (duration: 603.488642ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:49.3338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.433856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pzb6z\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-03-25T21:05:49.333935Z","caller":"traceutil/trace.go:171","msg":"trace[199387254] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pzb6z; range_end:; response_count:1; response_revision:617; }","duration":"448.620372ms","start":"2026-03-25T21:05:48.885296Z","end":"2026-03-25T21:05:49.333916Z","steps":["trace[199387254] 'agreement among raft nodes before linearized reading' (duration: 448.421366ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:49.333963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:48.729354Z","time spent":"604.401418ms","remote":"127.0.0.1:37838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:05:49.333981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:48.885274Z","time spent":"448.694834ms","remote":"127.0.0.1:37918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-pzb6z\" "} {"level":"warn","ts":"2026-03-25T21:05:50.755648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.336815033s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-25T21:05:50.755885Z","caller":"traceutil/trace.go:171","msg":"trace[1797924807] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"1.849754128s","start":"2026-03-25T21:05:48.906106Z","end":"2026-03-25T21:05:50.75586Z","steps":["trace[1797924807] 'process raft request' (duration: 512.623985ms)","trace[1797924807] 'compare' (duration: 1.336512506s)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:05:50.755965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:48.906086Z","time spent":"1.849845621s","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:05:50.797953Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.378991341s","expected-duration":"1s"} {"level":"info","ts":"2026-03-25T21:05:50.803551Z","caller":"traceutil/trace.go:171","msg":"trace[1286175608] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"1.396173943s","start":"2026-03-25T21:05:49.407321Z","end":"2026-03-25T21:05:50.803495Z","steps":["trace[1286175608] 'process raft request' (duration: 1.39608157s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:50.803716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:49.40729Z","time spent":"1.396351168s","remote":"127.0.0.1:38102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-25T21:05:50.803976Z","caller":"traceutil/trace.go:171","msg":"trace[826007197] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:640; }","duration":"1.47027665s","start":"2026-03-25T21:05:49.333686Z","end":"2026-03-25T21:05:50.803962Z","steps":["trace[826007197] 'read index received' (duration: 85.200001ms)","trace[826007197] 'applied index is now lower than readState.Index' (duration: 1.385075399s)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:05:50.804404Z","caller":"traceutil/trace.go:171","msg":"trace[696907117] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"1.39885639s","start":"2026-03-25T21:05:49.405519Z","end":"2026-03-25T21:05:50.804375Z","steps":["trace[696907117] 'process raft request' (duration: 1.397581323s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:50.804576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:49.405483Z","time spent":"1.399014975s","remote":"127.0.0.1:37918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:05:50.804973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.839014036s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:05:50.805027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.696372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-03-25T21:05:50.805078Z","caller":"traceutil/trace.go:171","msg":"trace[300735275] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"508.820575ms","start":"2026-03-25T21:05:50.296245Z","end":"2026-03-25T21:05:50.805065Z","steps":["trace[300735275] 'agreement among raft nodes before linearized reading' (duration: 508.65521ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:50.805095Z","caller":"traceutil/trace.go:171","msg":"trace[1809567596] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"1.839190251s","start":"2026-03-25T21:05:48.965854Z","end":"2026-03-25T21:05:50.805045Z","steps":["trace[1809567596] 'agreement among raft nodes before linearized reading' (duration: 1.838971875s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:50.805197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:48.965829Z","time spent":"1.839355695s","remote":"127.0.0.1:37730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-25T21:05:50.805873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.867977ms","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-03-25T21:05:50.806097Z","caller":"traceutil/trace.go:171","msg":"trace[2055376075] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:620; }","duration":"101.166056ms","start":"2026-03-25T21:05:50.704916Z","end":"2026-03-25T21:05:50.806082Z","steps":["trace[2055376075] 'agreement among raft nodes before linearized reading' (duration: 100.762684ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:05:50.805118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:05:50.296199Z","time spent":"508.908749ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-25T21:05:55.276741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.322708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-03-25T21:05:55.276847Z","caller":"traceutil/trace.go:171","msg":"trace[716305590] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:701; }","duration":"116.512613ms","start":"2026-03-25T21:05:55.160308Z","end":"2026-03-25T21:05:55.27682Z","steps":["trace[716305590] 'range keys from in-memory index tree' (duration: 116.102291ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:06:06.213875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.417432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:06:06.21402Z","caller":"traceutil/trace.go:171","msg":"trace[2077591956] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:781; }","duration":"249.632429ms","start":"2026-03-25T21:06:05.964362Z","end":"2026-03-25T21:06:06.213995Z","steps":["trace[2077591956] 'range keys from in-memory index tree' (duration: 249.230888ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:06:06.213898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.492527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-t8q2l\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-03-25T21:06:06.214196Z","caller":"traceutil/trace.go:171","msg":"trace[520670637] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-t8q2l; range_end:; response_count:1; response_revision:781; }","duration":"212.873817ms","start":"2026-03-25T21:06:06.001292Z","end":"2026-03-25T21:06:06.214166Z","steps":["trace[520670637] 'range keys from in-memory index tree' (duration: 212.190859ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:06:06.865304Z","caller":"traceutil/trace.go:171","msg":"trace[1430608713] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"643.237529ms","start":"2026-03-25T21:06:06.222043Z","end":"2026-03-25T21:06:06.865281Z","steps":["trace[1430608713] 'process raft request' (duration: 643.050754ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:06:06.865483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:06:06.222024Z","time spent":"643.350192ms","remote":"127.0.0.1:37918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:06:43.36553Z","caller":"traceutil/trace.go:171","msg":"trace[2035662192] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"300.344265ms","start":"2026-03-25T21:06:43.065159Z","end":"2026-03-25T21:06:43.365504Z","steps":["trace[2035662192] 'process raft request' (duration: 300.181551ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:06:43.36569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:06:43.065129Z","time spent":"300.474108ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:06:43.855327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.076581ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-25T21:06:43.855486Z","caller":"traceutil/trace.go:171","msg":"trace[2139215926] linearizableReadLoop","detail":"{readStateIndex:1041; appliedIndex:1039; }","duration":"763.855455ms","start":"2026-03-25T21:06:43.091611Z","end":"2026-03-25T21:06:43.855467Z","steps":["trace[2139215926] 'read index received' (duration: 273.747505ms)","trace[2139215926] 'applied index is now lower than readState.Index' (duration: 490.10725ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:06:43.855574Z","caller":"traceutil/trace.go:171","msg":"trace[2070073199] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"585.139091ms","start":"2026-03-25T21:06:43.270407Z","end":"2026-03-25T21:06:43.855546Z","steps":["trace[2070073199] 'process raft request' (duration: 585.013987ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:06:43.855644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.034669ms","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-03-25T21:06:43.855666Z","caller":"traceutil/trace.go:171","msg":"trace[1172053128] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1005; }","duration":"764.112132ms","start":"2026-03-25T21:06:43.091547Z","end":"2026-03-25T21:06:43.855659Z","steps":["trace[1172053128] 'agreement among raft nodes before linearized reading' (duration: 764.01201ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:06:43.855695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:06:43.091513Z","time spent":"764.176534ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-25T21:06:43.855697Z","caller":"traceutil/trace.go:171","msg":"trace[21298626] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"788.924355ms","start":"2026-03-25T21:06:43.066752Z","end":"2026-03-25T21:06:43.855677Z","steps":["trace[21298626] 'process raft request' (duration: 353.430992ms)","trace[21298626] 'compare' (duration: 434.801304ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:06:43.855751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:06:43.270381Z","time spent":"585.281254ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:06:43.855892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"756.853541ms","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-03-25T21:06:43.855919Z","caller":"traceutil/trace.go:171","msg":"trace[886034147] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1005; }","duration":"756.901052ms","start":"2026-03-25T21:06:43.099012Z","end":"2026-03-25T21:06:43.855913Z","steps":["trace[886034147] 'agreement among raft nodes before linearized reading' (duration: 756.83779ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:06:43.855937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:06:43.099003Z","time spent":"756.929492ms","remote":"127.0.0.1:38014","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-03-25T21:06:43.855947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.548553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:06:43.856002Z","caller":"traceutil/trace.go:171","msg":"trace[1141277815] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1005; }","duration":"229.663735ms","start":"2026-03-25T21:06:43.626322Z","end":"2026-03-25T21:06:43.855986Z","steps":["trace[1141277815] 'agreement among raft nodes before linearized reading' (duration: 229.543352ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:06:43.855815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:06:43.066733Z","time spent":"789.036528ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:06:43.856397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.233944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-03-25T21:06:43.856517Z","caller":"traceutil/trace.go:171","msg":"trace[2030627781] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1005; }","duration":"669.387177ms","start":"2026-03-25T21:06:43.187082Z","end":"2026-03-25T21:06:43.856469Z","steps":["trace[2030627781] 'agreement among raft nodes before linearized reading' (duration: 668.817442ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:06:43.856582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:06:43.187051Z","time spent":"669.517892ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-25T21:07:06.071735Z","caller":"traceutil/trace.go:171","msg":"trace[772054394] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"199.120602ms","start":"2026-03-25T21:07:05.872564Z","end":"2026-03-25T21:07:06.071684Z","steps":["trace[772054394] 'read index received' (duration: 198.920377ms)","trace[772054394] 'applied index is now lower than readState.Index' (duration: 198.305µs)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:07:06.071918Z","caller":"traceutil/trace.go:171","msg":"trace[71700155] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"586.407797ms","start":"2026-03-25T21:07:05.485465Z","end":"2026-03-25T21:07:06.071873Z","steps":["trace[71700155] 'process raft request' (duration: 586.040168ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:06.072003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.41285ms","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-03-25T21:07:06.072047Z","caller":"traceutil/trace.go:171","msg":"trace[1828767470] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1077; }","duration":"199.533523ms","start":"2026-03-25T21:07:05.872501Z","end":"2026-03-25T21:07:06.072034Z","steps":["trace[1828767470] 'agreement among raft nodes before linearized reading' (duration: 199.373248ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:06.07212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:05.485445Z","time spent":"586.567202ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:07:06.075681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.404035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:07:06.075722Z","caller":"traceutil/trace.go:171","msg":"trace[1004111327] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1078; }","duration":"112.473856ms","start":"2026-03-25T21:07:05.963238Z","end":"2026-03-25T21:07:06.075712Z","steps":["trace[1004111327] 'agreement among raft nodes before linearized reading' (duration: 112.385343ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:06.075836Z","caller":"traceutil/trace.go:171","msg":"trace[552584066] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"119.226485ms","start":"2026-03-25T21:07:05.956599Z","end":"2026-03-25T21:07:06.075826Z","steps":["trace[552584066] 'process raft request' (duration: 118.887536ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:08.634016Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003095966785075,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-25T21:07:08.644059Z","caller":"traceutil/trace.go:171","msg":"trace[2141097205] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"564.332935ms","start":"2026-03-25T21:07:08.079687Z","end":"2026-03-25T21:07:08.64402Z","steps":["trace[2141097205] 'process raft request' (duration: 564.119159ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:08.64423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:08.079657Z","time spent":"564.466339ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:07:08.942333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.973835ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-25T21:07:08.942473Z","caller":"traceutil/trace.go:171","msg":"trace[1912597747] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1124; }","duration":"809.227934ms","start":"2026-03-25T21:07:08.133221Z","end":"2026-03-25T21:07:08.942449Z","steps":["trace[1912597747] 'read index received' (duration: 510.646269ms)","trace[1912597747] 'applied index is now lower than readState.Index' (duration: 298.579655ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:07:08.942602Z","caller":"traceutil/trace.go:171","msg":"trace[435262651] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"862.14436ms","start":"2026-03-25T21:07:08.080444Z","end":"2026-03-25T21:07:08.942588Z","steps":["trace[435262651] 'process raft request' (duration: 733.789955ms)","trace[435262651] 'compare' (duration: 127.494572ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:07:08.942684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:08.080421Z","time spent":"862.219993ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:07:08.942957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.294937ms","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-03-25T21:07:08.942994Z","caller":"traceutil/trace.go:171","msg":"trace[1583289429] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1084; }","duration":"809.348468ms","start":"2026-03-25T21:07:08.133636Z","end":"2026-03-25T21:07:08.942984Z","steps":["trace[1583289429] 'agreement among raft nodes before linearized reading' (duration: 809.189264ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:08.943026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:08.133625Z","time spent":"809.394558ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-25T21:07:08.943028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.235005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-03-25T21:07:08.94304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.774609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-25T21:07:08.943086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.752448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-03-25T21:07:08.943147Z","caller":"traceutil/trace.go:171","msg":"trace[1818310481] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1084; }","duration":"809.397389ms","start":"2026-03-25T21:07:08.13372Z","end":"2026-03-25T21:07:08.943117Z","steps":["trace[1818310481] 'agreement among raft nodes before linearized reading' (duration: 809.05411ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:08.943167Z","caller":"traceutil/trace.go:171","msg":"trace[696772416] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1084; }","duration":"809.953644ms","start":"2026-03-25T21:07:08.133187Z","end":"2026-03-25T21:07:08.94314Z","steps":["trace[696772416] 'agreement among raft nodes before linearized reading' (duration: 809.581084ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:08.943168Z","caller":"traceutil/trace.go:171","msg":"trace[1850867822] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1084; }","duration":"809.944904ms","start":"2026-03-25T21:07:08.133189Z","end":"2026-03-25T21:07:08.943134Z","steps":["trace[1850867822] 'agreement among raft nodes before linearized reading' (duration: 809.589234ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:08.943204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:08.133706Z","time spent":"809.487911ms","remote":"127.0.0.1:38014","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-03-25T21:07:08.943206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:08.133167Z","time spent":"810.028335ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-25T21:07:08.943227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:08.133177Z","time spent":"810.039716ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-25T21:07:09.724283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.013688ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-03-25T21:07:09.73404Z","caller":"traceutil/trace.go:171","msg":"trace[1985634151] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"255.719655ms","start":"2026-03-25T21:07:09.478294Z","end":"2026-03-25T21:07:09.734013Z","steps":["trace[1985634151] 'process raft request' (duration: 255.568401ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:10.232537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.357789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:07:10.232641Z","caller":"traceutil/trace.go:171","msg":"trace[867294897] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1089; }","duration":"268.541384ms","start":"2026-03-25T21:07:09.964076Z","end":"2026-03-25T21:07:10.232617Z","steps":["trace[867294897] 'range keys from in-memory index tree' (duration: 268.241105ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:23.54363Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003095966785298,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-25T21:07:23.882168Z","caller":"traceutil/trace.go:171","msg":"trace[1520225777] linearizableReadLoop","detail":"{readStateIndex:1228; appliedIndex:1227; }","duration":"838.725712ms","start":"2026-03-25T21:07:23.043386Z","end":"2026-03-25T21:07:23.882112Z","steps":["trace[1520225777] 'read index received' (duration: 838.508986ms)","trace[1520225777] 'applied index is now lower than readState.Index' (duration: 215.175µs)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:07:23.882293Z","caller":"traceutil/trace.go:171","msg":"trace[832733702] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"871.322423ms","start":"2026-03-25T21:07:23.010914Z","end":"2026-03-25T21:07:23.882236Z","steps":["trace[832733702] 'process raft request' (duration: 870.997004ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:23.882508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.076362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-03-25T21:07:23.882553Z","caller":"traceutil/trace.go:171","msg":"trace[2066132773] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1181; }","duration":"839.178755ms","start":"2026-03-25T21:07:23.043361Z","end":"2026-03-25T21:07:23.88254Z","steps":["trace[2066132773] 'agreement among raft nodes before linearized reading' (duration: 838.96924ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:23.882596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:23.043347Z","time spent":"839.238656ms","remote":"127.0.0.1:38014","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-03-25T21:07:23.882625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.020551ms","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-03-25T21:07:23.8827Z","caller":"traceutil/trace.go:171","msg":"trace[1486284802] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1181; }","duration":"839.133783ms","start":"2026-03-25T21:07:23.043548Z","end":"2026-03-25T21:07:23.882682Z","steps":["trace[1486284802] 'agreement among raft nodes before linearized reading' (duration: 838.929278ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:23.882728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:23.043541Z","time spent":"839.181654ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-25T21:07:23.88283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.276829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-25T21:07:23.882849Z","caller":"traceutil/trace.go:171","msg":"trace[1554033402] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1181; }","duration":"778.35508ms","start":"2026-03-25T21:07:23.10449Z","end":"2026-03-25T21:07:23.882845Z","steps":["trace[1554033402] 'agreement among raft nodes before linearized reading' (duration: 778.314219ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:23.882863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:23.10445Z","time spent":"778.40945ms","remote":"127.0.0.1:38226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":31,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:07:23.882913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.873638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-03-25T21:07:23.882963Z","caller":"traceutil/trace.go:171","msg":"trace[1381603594] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1181; }","duration":"835.936979ms","start":"2026-03-25T21:07:23.047013Z","end":"2026-03-25T21:07:23.88295Z","steps":["trace[1381603594] 'agreement among raft nodes before linearized reading' (duration: 835.815956ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:23.882998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:23.047004Z","time spent":"835.98743ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-25T21:07:23.883141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.682208ms","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-03-25T21:07:23.883253Z","caller":"traceutil/trace.go:171","msg":"trace[1179733256] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1181; }","duration":"836.834792ms","start":"2026-03-25T21:07:23.046393Z","end":"2026-03-25T21:07:23.883228Z","steps":["trace[1179733256] 'agreement among raft nodes before linearized reading' (duration: 836.484693ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:23.88331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:23.046382Z","time spent":"836.918476ms","remote":"127.0.0.1:38014","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-03-25T21:07:23.883358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:23.010896Z","time spent":"871.486236ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:07:24.171178Z","caller":"traceutil/trace.go:171","msg":"trace[1583495944] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"283.539118ms","start":"2026-03-25T21:07:23.88761Z","end":"2026-03-25T21:07:24.171149Z","steps":["trace[1583495944] 'process raft request' (duration: 278.615379ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:24.18258Z","caller":"traceutil/trace.go:171","msg":"trace[43157148] linearizableReadLoop","detail":"{readStateIndex:1232; appliedIndex:1228; }","duration":"218.271196ms","start":"2026-03-25T21:07:23.964296Z","end":"2026-03-25T21:07:24.182567Z","steps":["trace[43157148] 'read index received' (duration: 201.976057ms)","trace[43157148] 'applied index is now lower than readState.Index' (duration: 16.294689ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:07:24.182903Z","caller":"traceutil/trace.go:171","msg":"trace[1186228958] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"294.59992ms","start":"2026-03-25T21:07:23.888265Z","end":"2026-03-25T21:07:24.182865Z","steps":["trace[1186228958] 'process raft request' (duration: 294.23631ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:24.182948Z","caller":"traceutil/trace.go:171","msg":"trace[475108632] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"294.699883ms","start":"2026-03-25T21:07:23.888198Z","end":"2026-03-25T21:07:24.182898Z","steps":["trace[475108632] 'process raft request' (duration: 294.210381ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:24.183015Z","caller":"traceutil/trace.go:171","msg":"trace[186487056] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"294.416976ms","start":"2026-03-25T21:07:23.888571Z","end":"2026-03-25T21:07:24.182988Z","steps":["trace[186487056] 'process raft request' (duration: 293.962454ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:24.182913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.585325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:07:24.18312Z","caller":"traceutil/trace.go:171","msg":"trace[46310900] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1185; }","duration":"218.879423ms","start":"2026-03-25T21:07:23.96423Z","end":"2026-03-25T21:07:24.183109Z","steps":["trace[46310900] 'agreement among raft nodes before linearized reading' (duration: 218.554774ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:39.209523Z","caller":"traceutil/trace.go:171","msg":"trace[1549982868] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"162.170108ms","start":"2026-03-25T21:07:39.047331Z","end":"2026-03-25T21:07:39.209501Z","steps":["trace[1549982868] 'process raft request' (duration: 162.062455ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:40.284401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.653512ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-25T21:07:40.284671Z","caller":"traceutil/trace.go:171","msg":"trace[1411218898] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"341.96514ms","start":"2026-03-25T21:07:39.94267Z","end":"2026-03-25T21:07:40.284635Z","steps":["trace[1411218898] 'process raft request' (duration: 341.906299ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:40.284651Z","caller":"traceutil/trace.go:171","msg":"trace[1702973258] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"766.746774ms","start":"2026-03-25T21:07:39.517867Z","end":"2026-03-25T21:07:40.284613Z","steps":["trace[1702973258] 'process raft request' (duration: 435.798965ms)","trace[1702973258] 'compare' (duration: 330.513148ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:07:40.284754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:39.942638Z","time spent":"342.081372ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:07:40.284859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:39.517849Z","time spent":"766.890627ms","remote":"127.0.0.1:37894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":914,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:07:40.285037Z","caller":"traceutil/trace.go:171","msg":"trace[169391293] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"759.470702ms","start":"2026-03-25T21:07:39.525528Z","end":"2026-03-25T21:07:40.284999Z","steps":["trace[169391293] 'process raft request' (duration: 758.975518ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:40.285209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:39.525493Z","time spent":"759.621717ms","remote":"127.0.0.1:38226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9375,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:07:40.321999Z","caller":"traceutil/trace.go:171","msg":"trace[89049422] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"262.129224ms","start":"2026-03-25T21:07:40.059845Z","end":"2026-03-25T21:07:40.321974Z","steps":["trace[89049422] 'process raft request' (duration: 261.971469ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:40.914025Z","caller":"traceutil/trace.go:171","msg":"trace[2035132935] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"586.89589ms","start":"2026-03-25T21:07:40.327099Z","end":"2026-03-25T21:07:40.913995Z","steps":["trace[2035132935] 'process raft request' (duration: 586.717636ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:40.914286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:40.327081Z","time spent":"587.110596ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:07:41.002942Z","caller":"traceutil/trace.go:171","msg":"trace[322926045] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"674.761619ms","start":"2026-03-25T21:07:40.328156Z","end":"2026-03-25T21:07:41.002917Z","steps":["trace[322926045] 'process raft request' (duration: 674.707237ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:41.003076Z","caller":"traceutil/trace.go:171","msg":"trace[382771483] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1306; }","duration":"104.439935ms","start":"2026-03-25T21:07:40.898618Z","end":"2026-03-25T21:07:41.003058Z","steps":["trace[382771483] 'read index received' (duration: 15.302204ms)","trace[382771483] 'applied index is now lower than readState.Index' (duration: 89.133901ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:07:41.003096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:40.328126Z","time spent":"674.886761ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:07:41.003005Z","caller":"traceutil/trace.go:171","msg":"trace[92239370] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"675.016834ms","start":"2026-03-25T21:07:40.327932Z","end":"2026-03-25T21:07:41.002949Z","steps":["trace[92239370] 'process raft request' (duration: 623.549197ms)","trace[92239370] 'compare' (duration: 51.032766ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:07:41.003242Z","caller":"traceutil/trace.go:171","msg":"trace[1760086396] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"673.613698ms","start":"2026-03-25T21:07:40.329617Z","end":"2026-03-25T21:07:41.003231Z","steps":["trace[1760086396] 'process raft request' (duration: 673.278239ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:41.003311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:40.329601Z","time spent":"673.670269ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:07:41.003403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:40.327924Z","time spent":"675.295763ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:07:41.003571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.963919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-25T21:07:41.003602Z","caller":"traceutil/trace.go:171","msg":"trace[1350019723] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1259; }","duration":"105.05678ms","start":"2026-03-25T21:07:40.898536Z","end":"2026-03-25T21:07:41.003593Z","steps":["trace[1350019723] 'agreement among raft nodes before linearized reading' (duration: 104.933337ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:41.994924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.28114ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-25T21:07:41.99538Z","caller":"traceutil/trace.go:171","msg":"trace[1718482557] linearizableReadLoop","detail":"{readStateIndex:1315; appliedIndex:1314; }","duration":"378.283237ms","start":"2026-03-25T21:07:41.617073Z","end":"2026-03-25T21:07:41.995356Z","steps":["trace[1718482557] 'read index received' (duration: 110.450073ms)","trace[1718482557] 'applied index is now lower than readState.Index' (duration: 267.830704ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:07:41.995522Z","caller":"traceutil/trace.go:171","msg":"trace[410218328] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"379.472158ms","start":"2026-03-25T21:07:41.616001Z","end":"2026-03-25T21:07:41.995473Z","steps":["trace[410218328] 'process raft request' (duration: 111.556472ms)","trace[410218328] 'compare' (duration: 266.784967ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:07:41.995584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.490294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:07:41.995683Z","caller":"traceutil/trace.go:171","msg":"trace[1755135454] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1264; }","duration":"378.631777ms","start":"2026-03-25T21:07:41.617033Z","end":"2026-03-25T21:07:41.995664Z","steps":["trace[1755135454] 'agreement among raft nodes before linearized reading' (duration: 378.452612ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:41.995732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:41.617012Z","time spent":"378.711699ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-03-25T21:07:41.99595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:41.615976Z","time spent":"379.778718ms","remote":"127.0.0.1:37820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-25T21:07:42.700792Z","caller":"traceutil/trace.go:171","msg":"trace[188862952] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"700.097126ms","start":"2026-03-25T21:07:42.00063Z","end":"2026-03-25T21:07:42.700727Z","steps":["trace[188862952] 'process raft request' (duration: 688.395817ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:42.700961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:42.0006Z","time spent":"700.28303ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-25T21:07:42.747817Z","caller":"traceutil/trace.go:171","msg":"trace[335058524] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"457.482257ms","start":"2026-03-25T21:07:42.290321Z","end":"2026-03-25T21:07:42.747804Z","steps":["trace[335058524] 'process raft request' (duration: 457.174749ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:42.747983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:42.290287Z","time spent":"457.593299ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:07:42.748059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.113986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:07:42.748158Z","caller":"traceutil/trace.go:171","msg":"trace[471319249] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1266; }","duration":"380.317281ms","start":"2026-03-25T21:07:42.367819Z","end":"2026-03-25T21:07:42.748137Z","steps":["trace[471319249] 'agreement among raft nodes before linearized reading' (duration: 380.073114ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:42.748216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:42.367788Z","time spent":"380.415845ms","remote":"127.0.0.1:44986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:07:42.747741Z","caller":"traceutil/trace.go:171","msg":"trace[1056949570] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1315; }","duration":"379.831978ms","start":"2026-03-25T21:07:42.367885Z","end":"2026-03-25T21:07:42.747717Z","steps":["trace[1056949570] 'read index received' (duration: 321.166621ms)","trace[1056949570] 'applied index is now lower than readState.Index' (duration: 58.664117ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:07:42.787347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.996793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:07:42.78743Z","caller":"traceutil/trace.go:171","msg":"trace[1802248383] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1267; }","duration":"137.099157ms","start":"2026-03-25T21:07:42.650311Z","end":"2026-03-25T21:07:42.78741Z","steps":["trace[1802248383] 'agreement among raft nodes before linearized reading' (duration: 136.940822ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:45.063579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.070256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:07:45.063703Z","caller":"traceutil/trace.go:171","msg":"trace[623795497] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1274; }","duration":"595.216809ms","start":"2026-03-25T21:07:44.468449Z","end":"2026-03-25T21:07:45.063666Z","steps":["trace[623795497] 'count revisions from in-memory index tree' (duration: 594.964583ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:45.063698Z","caller":"traceutil/trace.go:171","msg":"trace[82732102] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1326; }","duration":"118.930426ms","start":"2026-03-25T21:07:44.944733Z","end":"2026-03-25T21:07:45.063663Z","steps":["trace[82732102] 'read index received' (duration: 72.652255ms)","trace[82732102] 'applied index is now lower than readState.Index' (duration: 46.276241ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:07:45.063758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:44.468377Z","time spent":"595.369205ms","remote":"127.0.0.1:38212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:07:45.063749Z","caller":"traceutil/trace.go:171","msg":"trace[282445765] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"310.031976ms","start":"2026-03-25T21:07:44.753687Z","end":"2026-03-25T21:07:45.063719Z","steps":["trace[282445765] 'process raft request' (duration: 263.764577ms)","trace[282445765] 'compare' (duration: 45.976592ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:07:45.063885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:44.753659Z","time spent":"310.152151ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:07:45.063916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.185735ms","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-03-25T21:07:45.063961Z","caller":"traceutil/trace.go:171","msg":"trace[1312937355] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1275; }","duration":"119.280626ms","start":"2026-03-25T21:07:44.944668Z","end":"2026-03-25T21:07:45.063949Z","steps":["trace[1312937355] 'agreement among raft nodes before linearized reading' (duration: 119.136742ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:45.490673Z","caller":"traceutil/trace.go:171","msg":"trace[530940391] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"421.58203ms","start":"2026-03-25T21:07:45.069061Z","end":"2026-03-25T21:07:45.490643Z","steps":["trace[530940391] 'process raft request' (duration: 366.395124ms)","trace[530940391] 'compare' (duration: 55.050432ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:07:45.490828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:45.069035Z","time spent":"421.704884ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:07:45.658663Z","caller":"traceutil/trace.go:171","msg":"trace[1893593306] linearizableReadLoop","detail":"{readStateIndex:1329; appliedIndex:1327; }","duration":"565.64103ms","start":"2026-03-25T21:07:45.092994Z","end":"2026-03-25T21:07:45.658635Z","steps":["trace[1893593306] 'read index received' (duration: 342.455063ms)","trace[1893593306] 'applied index is now lower than readState.Index' (duration: 223.184917ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:07:45.658734Z","caller":"traceutil/trace.go:171","msg":"trace[132894574] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"589.231201ms","start":"2026-03-25T21:07:45.069434Z","end":"2026-03-25T21:07:45.658666Z","steps":["trace[132894574] 'process raft request' (duration: 572.613654ms)","trace[132894574] 'compare' (duration: 16.427572ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:07:45.658805Z","caller":"traceutil/trace.go:171","msg":"trace[1073764916] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"266.49986ms","start":"2026-03-25T21:07:45.392293Z","end":"2026-03-25T21:07:45.658793Z","steps":["trace[1073764916] 'process raft request' (duration: 266.304124ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:45.658975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:45.069408Z","time spent":"589.438267ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:07:45.659338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.291827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-03-25T21:07:45.659429Z","caller":"traceutil/trace.go:171","msg":"trace[1893494060] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1278; }","duration":"566.39295ms","start":"2026-03-25T21:07:45.093011Z","end":"2026-03-25T21:07:45.659404Z","steps":["trace[1893494060] 'agreement among raft nodes before linearized reading' (duration: 566.161924ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:45.659476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:45.092954Z","time spent":"566.513242ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-25T21:07:45.659682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.660879ms","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-03-25T21:07:45.659723Z","caller":"traceutil/trace.go:171","msg":"trace[1782565288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1278; }","duration":"557.723601ms","start":"2026-03-25T21:07:45.101987Z","end":"2026-03-25T21:07:45.65971Z","steps":["trace[1782565288] 'agreement among raft nodes before linearized reading' (duration: 557.531806ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:45.659759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:45.101968Z","time spent":"557.779172ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-25T21:07:45.662191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.175923ms","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-03-25T21:07:45.662245Z","caller":"traceutil/trace.go:171","msg":"trace[1354916800] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1278; }","duration":"569.288826ms","start":"2026-03-25T21:07:45.092943Z","end":"2026-03-25T21:07:45.662232Z","steps":["trace[1354916800] 'agreement among raft nodes before linearized reading' (duration: 565.992548ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:45.662283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:45.092926Z","time spent":"569.348506ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-25T21:07:46.026796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.0786ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-25T21:07:46.027113Z","caller":"traceutil/trace.go:171","msg":"trace[983758196] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"360.631652ms","start":"2026-03-25T21:07:45.666468Z","end":"2026-03-25T21:07:46.0271Z","steps":["trace[983758196] 'process raft request' (duration: 360.584851ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:46.027163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:45.666461Z","time spent":"360.673373ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:07:46.027306Z","caller":"traceutil/trace.go:171","msg":"trace[1233520939] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"360.937361ms","start":"2026-03-25T21:07:45.666363Z","end":"2026-03-25T21:07:46.0273Z","steps":["trace[1233520939] 'process raft request' (duration: 169.213394ms)","trace[1233520939] 'compare' (duration: 190.960326ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:07:46.027332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:45.666334Z","time spent":"360.984462ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:07:47.606642Z","caller":"traceutil/trace.go:171","msg":"trace[2064920826] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"107.914306ms","start":"2026-03-25T21:07:47.498691Z","end":"2026-03-25T21:07:47.606606Z","steps":["trace[2064920826] 'process raft request' (duration: 107.737652ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:56.2182Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003095966785657,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-25T21:07:56.529287Z","caller":"traceutil/trace.go:171","msg":"trace[606286754] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"879.909101ms","start":"2026-03-25T21:07:55.649335Z","end":"2026-03-25T21:07:56.529244Z","steps":["trace[606286754] 'process raft request' (duration: 879.609123ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:56.529644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:55.649308Z","time spent":"880.204189ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:07:56.709411Z","caller":"traceutil/trace.go:171","msg":"trace[707734459] linearizableReadLoop","detail":"{readStateIndex:1405; appliedIndex:1403; }","duration":"992.242012ms","start":"2026-03-25T21:07:55.717132Z","end":"2026-03-25T21:07:56.709374Z","steps":["trace[707734459] 'read index received' (duration: 811.655276ms)","trace[707734459] 'applied index is now lower than readState.Index' (duration: 180.585236ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:07:56.70975Z","caller":"traceutil/trace.go:171","msg":"trace[1778823659] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"932.63885ms","start":"2026-03-25T21:07:55.777094Z","end":"2026-03-25T21:07:56.709733Z","steps":["trace[1778823659] 'process raft request' (duration: 890.727309ms)","trace[1778823659] 'compare' (duration: 41.377837ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:07:56.709895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:55.777064Z","time spent":"932.728643ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:07:56.710389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.2677ms","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-03-25T21:07:56.710436Z","caller":"traceutil/trace.go:171","msg":"trace[1054720201] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1351; }","duration":"993.372913ms","start":"2026-03-25T21:07:55.717052Z","end":"2026-03-25T21:07:56.710425Z","steps":["trace[1054720201] 'agreement among raft nodes before linearized reading' (duration: 993.206798ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:56.71047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:55.717021Z","time spent":"993.440754ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-25T21:07:56.710849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.362587ms","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-03-25T21:07:56.710888Z","caller":"traceutil/trace.go:171","msg":"trace[2022507502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1351; }","duration":"635.458359ms","start":"2026-03-25T21:07:56.07542Z","end":"2026-03-25T21:07:56.710879Z","steps":["trace[2022507502] 'agreement among raft nodes before linearized reading' (duration: 635.354226ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:56.710917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:56.075392Z","time spent":"635.518872ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-25T21:07:56.711009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.227095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:07:56.711102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.893711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-03-25T21:07:56.711125Z","caller":"traceutil/trace.go:171","msg":"trace[1458882901] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1351; }","duration":"747.411951ms","start":"2026-03-25T21:07:55.963681Z","end":"2026-03-25T21:07:56.711093Z","steps":["trace[1458882901] 'agreement among raft nodes before linearized reading' (duration: 747.181775ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:56.711136Z","caller":"traceutil/trace.go:171","msg":"trace[320606592] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1351; }","duration":"891.975444ms","start":"2026-03-25T21:07:55.819151Z","end":"2026-03-25T21:07:56.711126Z","steps":["trace[320606592] 'agreement among raft nodes before linearized reading' (duration: 891.889732ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:56.711174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:55.819127Z","time spent":"892.039605ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-03-25T21:07:56.711177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:55.963652Z","time spent":"747.515464ms","remote":"127.0.0.1:37740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-25T21:07:56.711164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.567493ms","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-03-25T21:07:56.711246Z","caller":"traceutil/trace.go:171","msg":"trace[715463526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1351; }","duration":"635.663235ms","start":"2026-03-25T21:07:56.07556Z","end":"2026-03-25T21:07:56.711223Z","steps":["trace[715463526] 'agreement among raft nodes before linearized reading' (duration: 635.334856ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:56.711334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:56.075459Z","time spent":"635.86417ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-25T21:07:56.712408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.193532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-03-25T21:07:56.712949Z","caller":"traceutil/trace.go:171","msg":"trace[82762350] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1351; }","duration":"946.4547ms","start":"2026-03-25T21:07:55.76607Z","end":"2026-03-25T21:07:56.712525Z","steps":["trace[82762350] 'agreement among raft nodes before linearized reading' (duration: 944.399074ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:56.713332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:55.766042Z","time spent":"946.970882ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-25T21:07:57.465881Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003095966785662,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-25T21:07:57.604786Z","caller":"traceutil/trace.go:171","msg":"trace[185448823] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"886.828285ms","start":"2026-03-25T21:07:56.717912Z","end":"2026-03-25T21:07:57.60474Z","steps":["trace[185448823] 'process raft request' (duration: 886.207308ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:57.605062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:56.717895Z","time spent":"887.039142ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:07:57.615313Z","caller":"traceutil/trace.go:171","msg":"trace[375304767] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"897.238913ms","start":"2026-03-25T21:07:56.71802Z","end":"2026-03-25T21:07:57.615259Z","steps":["trace[375304767] 'process raft request' (duration: 897.064548ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:57.615478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:56.717993Z","time spent":"897.394658ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:07:57.616178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.286492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:07:57.616734Z","caller":"traceutil/trace.go:171","msg":"trace[442641648] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"897.720067ms","start":"2026-03-25T21:07:56.718099Z","end":"2026-03-25T21:07:57.615819Z","steps":["trace[442641648] 'process raft request' (duration: 897.11934ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:57.616635Z","caller":"traceutil/trace.go:171","msg":"trace[90099435] linearizableReadLoop","detail":"{readStateIndex:1411; appliedIndex:1406; }","duration":"650.82109ms","start":"2026-03-25T21:07:56.964865Z","end":"2026-03-25T21:07:57.615686Z","steps":["trace[90099435] 'read index received' (duration: 639.850146ms)","trace[90099435] 'applied index is now lower than readState.Index' (duration: 10.969534ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:07:57.617221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:56.718087Z","time spent":"898.959769ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:07:57.617304Z","caller":"traceutil/trace.go:171","msg":"trace[1100171342] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"897.432399ms","start":"2026-03-25T21:07:56.718406Z","end":"2026-03-25T21:07:57.615838Z","steps":["trace[1100171342] 'process raft request' (duration: 897.199693ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:57.617393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.660588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-03-25T21:07:57.617254Z","caller":"traceutil/trace.go:171","msg":"trace[121702356] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"897.636605ms","start":"2026-03-25T21:07:56.718182Z","end":"2026-03-25T21:07:57.615818Z","steps":["trace[121702356] 'process raft request' (duration: 897.322086ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:07:57.617448Z","caller":"traceutil/trace.go:171","msg":"trace[1557969199] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1357; }","duration":"646.794352ms","start":"2026-03-25T21:07:56.970635Z","end":"2026-03-25T21:07:57.617429Z","steps":["trace[1557969199] 'agreement among raft nodes before linearized reading' (duration: 646.544136ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:57.617479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:56.71816Z","time spent":"899.282988ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:07:57.617492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:56.970603Z","time spent":"646.879995ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-03-25T21:07:57.617539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:56.718395Z","time spent":"899.034552ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:07:57.617653Z","caller":"traceutil/trace.go:171","msg":"trace[850448250] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"511.754514ms","start":"2026-03-25T21:07:57.104093Z","end":"2026-03-25T21:07:57.615848Z","steps":["trace[850448250] 'process raft request' (duration: 511.550879ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:57.617711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:57.104043Z","time spent":"513.633394ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:07:57.617945Z","caller":"traceutil/trace.go:171","msg":"trace[2049605035] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1357; }","duration":"651.672542ms","start":"2026-03-25T21:07:56.964804Z","end":"2026-03-25T21:07:57.616476Z","steps":["trace[2049605035] 'agreement among raft nodes before linearized reading' (duration: 651.170629ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:07:57.617975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:07:56.964779Z","time spent":"653.188414ms","remote":"127.0.0.1:37740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-25T21:10:42.639033Z","caller":"traceutil/trace.go:171","msg":"trace[201157989] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"145.155846ms","start":"2026-03-25T21:10:42.493539Z","end":"2026-03-25T21:10:42.638695Z","steps":["trace[201157989] 'process raft request' (duration: 144.901009ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:10:42.862918Z","caller":"traceutil/trace.go:171","msg":"trace[99286138] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"137.440161ms","start":"2026-03-25T21:10:42.725431Z","end":"2026-03-25T21:10:42.862871Z","steps":["trace[99286138] 'process raft request' (duration: 93.982774ms)","trace[99286138] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/plndr-svcs-lock; req_size:420; } (duration: 43.301163ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:11:08.309254Z","caller":"traceutil/trace.go:171","msg":"trace[861981669] transaction","detail":"{read_only:false; response_revision:2251; number_of_response:1; }","duration":"139.490636ms","start":"2026-03-25T21:11:08.169735Z","end":"2026-03-25T21:11:08.309225Z","steps":["trace[861981669] 'process raft request' (duration: 139.303192ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:11:14.680366Z","caller":"traceutil/trace.go:171","msg":"trace[495442910] transaction","detail":"{read_only:false; response_revision:2286; number_of_response:1; }","duration":"406.901761ms","start":"2026-03-25T21:11:14.27344Z","end":"2026-03-25T21:11:14.680342Z","steps":["trace[495442910] 'process raft request' (duration: 384.565579ms)","trace[495442910] 'compare' (duration: 22.181898ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:11:14.680509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:11:14.273417Z","time spent":"407.015334ms","remote":"127.0.0.1:37778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:11:14.684666Z","caller":"traceutil/trace.go:171","msg":"trace[478981679] transaction","detail":"{read_only:false; response_revision:2287; number_of_response:1; }","duration":"252.840695ms","start":"2026-03-25T21:11:14.431776Z","end":"2026-03-25T21:11:14.684617Z","steps":["trace[478981679] 'process raft request' (duration: 252.66451ms)"],"step_count":1}