{"level":"warn","ts":"2026-07-03T18:45:58.89472Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-03T18:45:58.894792Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229: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.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229: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-07-03T18:45:58.894876Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-03T18:45:58.894889Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-07-03T18:45:58.894945Z","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-07-03T18:45:58.895606Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-07-03T18:45:58.895709Z","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.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229: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-07-03T18:45:58.949904Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"53.886134ms"} {"level":"info","ts":"2026-07-03T18:45:58.98675Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-07-03T18:45:58.986908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-07-03T18:45:58.987054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-07-03T18:45:58.98709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-03T18:45:58.987107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-07-03T18:45:58.987278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-07-03T18:45:59.076399Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-03T18:45:59.081254Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-03T18:45:59.085276Z","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-07-03T18:45:59.101593Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-03T18:45:59.101882Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"warn","ts":"2026-07-03T18:45:59.102075Z","logger":"raft","caller":"etcdserver/zap_raft.go:85","msg":"3ba9ae53cc4335db cannot campaign at term 1 since there are still 1 pending configuration changes to apply"} {"level":"info","ts":"2026-07-03T18:45:59.102221Z","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-07-03T18:45:59.102371Z","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-07-03T18:45:59.102437Z","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-07-03T18:45:59.109734Z","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-07-03T18:45:59.109966Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-07-03T18:45:59.110019Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-07-03T18:45:59.110749Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-03T18:45:59.110799Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-03T18:45:59.117945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-07-03T18:45:59.118088Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-07-03T18:46:00.087788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-07-03T18:46:00.087873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-07-03T18:46:00.087897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-07-03T18:46:00.087916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-07-03T18:46:00.087927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-07-03T18:46:00.087948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-07-03T18:46:00.087961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-07-03T18:46:00.566937Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-03T18:46:01.108657Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-07-03T18:46:01.108674Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-03T18:46:01.108933Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-03T18:46:01.109277Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-03T18:46:01.109335Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-03T18:46:01.112269Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-07-03T18:46:01.112279Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-03T18:46:01.402184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.814316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-03T18:46:01.402254Z","caller":"traceutil/trace.go:171","msg":"trace[967962617] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; }","duration":"127.934157ms","start":"2026-07-03T18:46:01.27431Z","end":"2026-07-03T18:46:01.402244Z","steps":["trace[967962617] 'agreement among raft nodes before linearized reading' (duration: 127.845967ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.402387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.62821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-03T18:46:01.402437Z","caller":"traceutil/trace.go:171","msg":"trace[1048026369] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; }","duration":"129.736322ms","start":"2026-07-03T18:46:01.272688Z","end":"2026-07-03T18:46:01.402424Z","steps":["trace[1048026369] 'agreement among raft nodes before linearized reading' (duration: 129.676081ms)"],"step_count":1} 2026/07/03 18:46:01 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-07-03T18:46:01.516014Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-07-03T18:46:01.516135Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-03T18:46:01.516244Z","caller":"traceutil/trace.go:171","msg":"trace[786604289] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"361.286716ms","start":"2026-07-03T18:46:01.154935Z","end":"2026-07-03T18:46:01.516221Z","steps":["trace[786604289] 'read index received' (duration: 361.078214ms)","trace[786604289] 'applied index is now lower than readState.Index' (duration: 165.821µs)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:46:01.516226Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-07-03T18:46:01.516497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.532187ms","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-07-03T18:46:01.516596Z","caller":"traceutil/trace.go:171","msg":"trace[1324926205] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"361.652008ms","start":"2026-07-03T18:46:01.154928Z","end":"2026-07-03T18:46:01.51658Z","steps":["trace[1324926205] 'agreement among raft nodes before linearized reading' (duration: 361.401446ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.516663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.614463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:01.516696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.512492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:01.516728Z","caller":"traceutil/trace.go:171","msg":"trace[1296311299] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"191.706453ms","start":"2026-07-03T18:46:01.325011Z","end":"2026-07-03T18:46:01.516718Z","steps":["trace[1296311299] 'agreement among raft nodes before linearized reading' (duration: 191.623803ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.516675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.608393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:01.516682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.883178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:01.516779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.693634ms","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-07-03T18:46:01.516612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.955428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:01.51685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.178324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:01.516801Z","caller":"traceutil/trace.go:171","msg":"trace[189700822] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"191.602103ms","start":"2026-07-03T18:46:01.325122Z","end":"2026-07-03T18:46:01.516724Z","steps":["trace[189700822] 'agreement among raft nodes before linearized reading' (duration: 191.465682ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.51687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.953087ms","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-07-03T18:46:01.516846Z","caller":"traceutil/trace.go:171","msg":"trace[32480239] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"150.111459ms","start":"2026-07-03T18:46:01.36669Z","end":"2026-07-03T18:46:01.516802Z","steps":["trace[32480239] 'agreement among raft nodes before linearized reading' (duration: 149.755596ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:01.516881Z","caller":"traceutil/trace.go:171","msg":"trace[483544384] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"284.211244ms","start":"2026-07-03T18:46:01.232659Z","end":"2026-07-03T18:46:01.51687Z","steps":["trace[483544384] 'agreement among raft nodes before linearized reading' (duration: 284.175514ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:01.516895Z","caller":"traceutil/trace.go:171","msg":"trace[1905963217] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"205.014738ms","start":"2026-07-03T18:46:01.311873Z","end":"2026-07-03T18:46:01.516888Z","steps":["trace[1905963217] 'agreement among raft nodes before linearized reading' (duration: 204.930207ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.516916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.141378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:01.516951Z","caller":"traceutil/trace.go:171","msg":"trace[979644224] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"260.175568ms","start":"2026-07-03T18:46:01.25677Z","end":"2026-07-03T18:46:01.516946Z","steps":["trace[979644224] 'agreement among raft nodes before linearized reading' (duration: 260.130048ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.516662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.154906Z","time spent":"361.743669ms","remote":"127.0.0.1:55150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":121,"response count":0,"response size":26,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 "} {"level":"info","ts":"2026-07-03T18:46:01.516859Z","caller":"traceutil/trace.go:171","msg":"trace[604513881] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"232.23869ms","start":"2026-07-03T18:46:01.284608Z","end":"2026-07-03T18:46:01.516847Z","steps":["trace[604513881] 'agreement among raft nodes before linearized reading' (duration: 231.921998ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:01.516815Z","caller":"traceutil/trace.go:171","msg":"trace[57518489] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"114.733424ms","start":"2026-07-03T18:46:01.402071Z","end":"2026-07-03T18:46:01.516804Z","steps":["trace[57518489] 'agreement among raft nodes before linearized reading' (duration: 114.693484ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.516968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.762822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:01.51703Z","caller":"traceutil/trace.go:171","msg":"trace[374695220] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"124.865133ms","start":"2026-07-03T18:46:01.392158Z","end":"2026-07-03T18:46:01.517023Z","steps":["trace[374695220] 'agreement among raft nodes before linearized reading' (duration: 124.773372ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.516524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.437567ms","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-07-03T18:46:01.517062Z","caller":"traceutil/trace.go:171","msg":"trace[880606889] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"362.035251ms","start":"2026-07-03T18:46:01.155018Z","end":"2026-07-03T18:46:01.517054Z","steps":["trace[880606889] 'agreement among raft nodes before linearized reading' (duration: 361.389076ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.51709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.154995Z","time spent":"362.084792ms","remote":"127.0.0.1:55150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":0,"response size":26,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:01.517096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.31183ms","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-07-03T18:46:01.517123Z","caller":"traceutil/trace.go:171","msg":"trace[1454793174] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"205.36874ms","start":"2026-07-03T18:46:01.31175Z","end":"2026-07-03T18:46:01.517118Z","steps":["trace[1454793174] 'agreement among raft nodes before linearized reading' (duration: 205.170319ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.517118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.015504ms","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-07-03T18:46:01.517156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.177795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:01.517166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.275555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:01.517191Z","caller":"traceutil/trace.go:171","msg":"trace[239579377] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"220.242476ms","start":"2026-07-03T18:46:01.29694Z","end":"2026-07-03T18:46:01.517182Z","steps":["trace[239579377] 'agreement among raft nodes before linearized reading' (duration: 220.173245ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.517218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.110828ms","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":"warn","ts":"2026-07-03T18:46:01.517191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.46543ms","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-07-03T18:46:01.51724Z","caller":"traceutil/trace.go:171","msg":"trace[2092089001] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"273.140218ms","start":"2026-07-03T18:46:01.244094Z","end":"2026-07-03T18:46:01.517234Z","steps":["trace[2092089001] 'agreement among raft nodes before linearized reading' (duration: 273.109538ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:01.517209Z","caller":"traceutil/trace.go:171","msg":"trace[1062146266] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"139.325825ms","start":"2026-07-03T18:46:01.377864Z","end":"2026-07-03T18:46:01.51719Z","steps":["trace[1062146266] 'agreement among raft nodes before linearized reading' (duration: 139.276465ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.517253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.412107ms","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-07-03T18:46:01.517266Z","caller":"traceutil/trace.go:171","msg":"trace[2040273961] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"260.5538ms","start":"2026-07-03T18:46:01.256692Z","end":"2026-07-03T18:46:01.517245Z","steps":["trace[2040273961] 'agreement among raft nodes before linearized reading' (duration: 260.48123ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.517283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.199649ms","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-07-03T18:46:01.517283Z","caller":"traceutil/trace.go:171","msg":"trace[143948242] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"139.455348ms","start":"2026-07-03T18:46:01.377819Z","end":"2026-07-03T18:46:01.517274Z","steps":["trace[143948242] 'agreement among raft nodes before linearized reading' (duration: 139.411437ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:01.517299Z","caller":"traceutil/trace.go:171","msg":"trace[570137941] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"273.226879ms","start":"2026-07-03T18:46:01.244067Z","end":"2026-07-03T18:46:01.517293Z","steps":["trace[570137941] 'agreement among raft nodes before linearized reading' (duration: 273.202968ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:01.516788Z","caller":"traceutil/trace.go:171","msg":"trace[1002523255] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"114.716884ms","start":"2026-07-03T18:46:01.402043Z","end":"2026-07-03T18:46:01.51676Z","steps":["trace[1002523255] 'agreement among raft nodes before linearized reading' (duration: 114.551932ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.517292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.902937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:01.51716Z","caller":"traceutil/trace.go:171","msg":"trace[155485939] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"125.081215ms","start":"2026-07-03T18:46:01.392071Z","end":"2026-07-03T18:46:01.517152Z","steps":["trace[155485939] 'agreement among raft nodes before linearized reading' (duration: 124.921023ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.517336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.434707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:01.517365Z","caller":"traceutil/trace.go:171","msg":"trace[287896038] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"164.39285ms","start":"2026-07-03T18:46:01.352959Z","end":"2026-07-03T18:46:01.517352Z","steps":["trace[287896038] 'agreement among raft nodes before linearized reading' (duration: 163.934847ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.517399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.520601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:01.517426Z","caller":"traceutil/trace.go:171","msg":"trace[237363792] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"164.565512ms","start":"2026-07-03T18:46:01.352855Z","end":"2026-07-03T18:46:01.517421Z","steps":["trace[237363792] 'agreement among raft nodes before linearized reading' (duration: 164.528831ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.517543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.132026ms","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-07-03T18:46:01.517574Z","caller":"traceutil/trace.go:171","msg":"trace[669497700] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"233.187247ms","start":"2026-07-03T18:46:01.284376Z","end":"2026-07-03T18:46:01.517564Z","steps":["trace[669497700] 'agreement among raft nodes before linearized reading' (duration: 233.132256ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.517872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.766829ms","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-07-03T18:46:01.5179Z","caller":"traceutil/trace.go:171","msg":"trace[1450462138] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"180.826089ms","start":"2026-07-03T18:46:01.337067Z","end":"2026-07-03T18:46:01.517893Z","steps":["trace[1450462138] 'agreement among raft nodes before linearized reading' (duration: 180.776669ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.518067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.303209ms","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-07-03T18:46:01.517373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.238514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:01.518096Z","caller":"traceutil/trace.go:171","msg":"trace[751641588] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"151.34634ms","start":"2026-07-03T18:46:01.366743Z","end":"2026-07-03T18:46:01.518089Z","steps":["trace[751641588] 'agreement among raft nodes before linearized reading' (duration: 151.302049ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:01.518128Z","caller":"traceutil/trace.go:171","msg":"trace[1122402497] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"180.998942ms","start":"2026-07-03T18:46:01.337098Z","end":"2026-07-03T18:46:01.518097Z","steps":["trace[1122402497] 'agreement among raft nodes before linearized reading' (duration: 180.253105ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.518137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.757115ms","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-07-03T18:46:01.518169Z","caller":"traceutil/trace.go:171","msg":"trace[414565970] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"300.798605ms","start":"2026-07-03T18:46:01.217359Z","end":"2026-07-03T18:46:01.518158Z","steps":["trace[414565970] 'agreement among raft nodes before linearized reading' (duration: 300.742315ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.518198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.217355Z","time spent":"300.837375ms","remote":"127.0.0.1:55202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 "} {"level":"info","ts":"2026-07-03T18:46:01.517372Z","caller":"traceutil/trace.go:171","msg":"trace[2013241431] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"220.484017ms","start":"2026-07-03T18:46:01.296877Z","end":"2026-07-03T18:46:01.517361Z","steps":["trace[2013241431] 'agreement among raft nodes before linearized reading' (duration: 220.436247ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.518342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.690256ms","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-07-03T18:46:01.518367Z","caller":"traceutil/trace.go:171","msg":"trace[452936740] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"285.741537ms","start":"2026-07-03T18:46:01.232619Z","end":"2026-07-03T18:46:01.518361Z","steps":["trace[452936740] 'agreement among raft nodes before linearized reading' (duration: 285.696426ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.518789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.44121ms","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-07-03T18:46:01.518818Z","caller":"traceutil/trace.go:171","msg":"trace[785072250] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"301.49019ms","start":"2026-07-03T18:46:01.217322Z","end":"2026-07-03T18:46:01.518812Z","steps":["trace[785072250] 'agreement among raft nodes before linearized reading' (duration: 301.44014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.51884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.217313Z","time spent":"301.52169ms","remote":"127.0.0.1:55202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:01.518898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.49713ms","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-07-03T18:46:01.518943Z","caller":"traceutil/trace.go:171","msg":"trace[1548431597] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"315.57514ms","start":"2026-07-03T18:46:01.203357Z","end":"2026-07-03T18:46:01.518933Z","steps":["trace[1548431597] 'agreement among raft nodes before linearized reading' (duration: 315.507619ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:01.51898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.203337Z","time spent":"315.63366ms","remote":"127.0.0.1:55186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":26,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.106851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.029074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.106967Z","caller":"traceutil/trace.go:171","msg":"trace[759352509] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1; }","duration":"157.212436ms","start":"2026-07-03T18:46:01.949724Z","end":"2026-07-03T18:46:02.106937Z","steps":["trace[759352509] 'count revisions from in-memory index tree' (duration: 156.870593ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.107154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.968289ms","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-07-03T18:46:02.107208Z","caller":"traceutil/trace.go:171","msg":"trace[1293101132] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1; }","duration":"563.028209ms","start":"2026-07-03T18:46:01.544166Z","end":"2026-07-03T18:46:02.107194Z","steps":["trace[1293101132] 'range keys from in-memory index tree' (duration: 562.907028ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.107235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.544158Z","time spent":"563.07032ms","remote":"127.0.0.1:55388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":26,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.107309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.130125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:02.107331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.114429ms","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-07-03T18:46:02.107346Z","caller":"traceutil/trace.go:171","msg":"trace[457204042] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1; }","duration":"563.146209ms","start":"2026-07-03T18:46:01.544195Z","end":"2026-07-03T18:46:02.107342Z","steps":["trace[457204042] 'count revisions from in-memory index tree' (duration: 563.051039ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:02.107344Z","caller":"traceutil/trace.go:171","msg":"trace[1744050449] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1; }","duration":"402.165265ms","start":"2026-07-03T18:46:01.705167Z","end":"2026-07-03T18:46:02.107332Z","steps":["trace[1744050449] 'range keys from in-memory index tree' (duration: 402.072075ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.107361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.544186Z","time spent":"563.17076ms","remote":"127.0.0.1:55388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":26,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.107389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.70511Z","time spent":"402.260487ms","remote":"127.0.0.1:55484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":26,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.107427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.644135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.107441Z","caller":"traceutil/trace.go:171","msg":"trace[1581495652] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1; }","duration":"549.679655ms","start":"2026-07-03T18:46:01.557757Z","end":"2026-07-03T18:46:02.107437Z","steps":["trace[1581495652] 'count revisions from in-memory index tree' (duration: 549.594484ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.107461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.55775Z","time spent":"549.707785ms","remote":"127.0.0.1:55390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":26,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.107539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.660225ms","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-07-03T18:46:02.107541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.329958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.107557Z","caller":"traceutil/trace.go:171","msg":"trace[1756315056] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1; }","duration":"549.679855ms","start":"2026-07-03T18:46:01.557872Z","end":"2026-07-03T18:46:02.107552Z","steps":["trace[1756315056] 'range keys from in-memory index tree' (duration: 549.533954ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.107575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.557855Z","time spent":"549.711955ms","remote":"127.0.0.1:55390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":26,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" limit:10000 "} {"level":"info","ts":"2026-07-03T18:46:02.107574Z","caller":"traceutil/trace.go:171","msg":"trace[825914064] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1; }","duration":"356.375438ms","start":"2026-07-03T18:46:01.751184Z","end":"2026-07-03T18:46:02.10756Z","steps":["trace[825914064] 'range keys from in-memory index tree' (duration: 356.268347ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.10761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.751174Z","time spent":"356.419628ms","remote":"127.0.0.1:55490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":26,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.107648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.001248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.107671Z","caller":"traceutil/trace.go:171","msg":"trace[390591988] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1; }","duration":"536.044058ms","start":"2026-07-03T18:46:01.571617Z","end":"2026-07-03T18:46:02.107661Z","steps":["trace[390591988] 'range keys from in-memory index tree' (duration: 535.934588ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.107688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.571604Z","time spent":"536.080568ms","remote":"127.0.0.1:55400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":26,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.107757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.079119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.107778Z","caller":"traceutil/trace.go:171","msg":"trace[1142749338] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1; }","duration":"536.100219ms","start":"2026-07-03T18:46:01.571673Z","end":"2026-07-03T18:46:02.107773Z","steps":["trace[1142749338] 'count revisions from in-memory index tree' (duration: 536.035078ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.107786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.572094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:02.107814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.134038ms","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-07-03T18:46:02.107822Z","caller":"traceutil/trace.go:171","msg":"trace[1580217040] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1; }","duration":"345.621364ms","start":"2026-07-03T18:46:01.762186Z","end":"2026-07-03T18:46:02.107807Z","steps":["trace[1580217040] 'count revisions from in-memory index tree' (duration: 345.523854ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.107852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.233849ms","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-07-03T18:46:02.107867Z","caller":"traceutil/trace.go:171","msg":"trace[1842861460] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1; }","duration":"523.260519ms","start":"2026-07-03T18:46:01.584603Z","end":"2026-07-03T18:46:02.107864Z","steps":["trace[1842861460] 'range keys from in-memory index tree' (duration: 523.118158ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.107864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.762175Z","time spent":"345.679684ms","remote":"127.0.0.1:55498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":26,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.107895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.099679ms","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-07-03T18:46:02.107914Z","caller":"traceutil/trace.go:171","msg":"trace[679935163] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1; }","duration":"509.14513ms","start":"2026-07-03T18:46:01.598766Z","end":"2026-07-03T18:46:02.107911Z","steps":["trace[679935163] 'range keys from in-memory index tree' (duration: 509.049259ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.107927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.598751Z","time spent":"509.17215ms","remote":"127.0.0.1:55418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":26,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.108009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.161489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:02.10801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.842065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.108026Z","caller":"traceutil/trace.go:171","msg":"trace[301641223] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1; }","duration":"509.1817ms","start":"2026-07-03T18:46:01.598841Z","end":"2026-07-03T18:46:02.108022Z","steps":["trace[301641223] 'count revisions from in-memory index tree' (duration: 509.112549ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.108041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.598793Z","time spent":"509.24263ms","remote":"127.0.0.1:55418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":26,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-07-03T18:46:02.108042Z","caller":"traceutil/trace.go:171","msg":"trace[1341659335] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1; }","duration":"345.888167ms","start":"2026-07-03T18:46:01.762145Z","end":"2026-07-03T18:46:02.108033Z","steps":["trace[1341659335] 'range keys from in-memory index tree' (duration: 345.722935ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.108071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.762135Z","time spent":"345.927747ms","remote":"127.0.0.1:55498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":26,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.108098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.352442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.108115Z","caller":"traceutil/trace.go:171","msg":"trace[877999586] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1; }","duration":"495.377262ms","start":"2026-07-03T18:46:01.612733Z","end":"2026-07-03T18:46:02.10811Z","steps":["trace[877999586] 'count revisions from in-memory index tree' (duration: 495.318041ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.108135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.612726Z","time spent":"495.403052ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.108193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.541281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:02.108219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.560282ms","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-07-03T18:46:02.108238Z","caller":"traceutil/trace.go:171","msg":"trace[701359920] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1; }","duration":"482.578602ms","start":"2026-07-03T18:46:01.625655Z","end":"2026-07-03T18:46:02.108234Z","steps":["trace[701359920] 'range keys from in-memory index tree' (duration: 482.525981ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:02.108235Z","caller":"traceutil/trace.go:171","msg":"trace[331046154] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1; }","duration":"333.595061ms","start":"2026-07-03T18:46:01.774624Z","end":"2026-07-03T18:46:02.108219Z","steps":["trace[331046154] 'count revisions from in-memory index tree' (duration: 333.4811ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.108258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.625649Z","time spent":"482.602762ms","remote":"127.0.0.1:55432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":26,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.108267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.774577Z","time spent":"333.681341ms","remote":"127.0.0.1:55512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.108348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.648942ms","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-07-03T18:46:02.108365Z","caller":"traceutil/trace.go:171","msg":"trace[341654924] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1; }","duration":"482.690032ms","start":"2026-07-03T18:46:01.625671Z","end":"2026-07-03T18:46:02.108361Z","steps":["trace[341654924] 'count revisions from in-memory index tree' (duration: 482.613782ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.108381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.625662Z","time spent":"482.714042ms","remote":"127.0.0.1:55432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":26,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.108438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.972899ms","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-07-03T18:46:02.108453Z","caller":"traceutil/trace.go:171","msg":"trace[1277717933] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1; }","duration":"468.002319ms","start":"2026-07-03T18:46:01.640448Z","end":"2026-07-03T18:46:02.10845Z","steps":["trace[1277717933] 'range keys from in-memory index tree' (duration: 467.921148ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.108451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.656222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:02.108482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.826277ms","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-07-03T18:46:02.108488Z","caller":"traceutil/trace.go:171","msg":"trace[252926756] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1; }","duration":"333.723672ms","start":"2026-07-03T18:46:01.774755Z","end":"2026-07-03T18:46:02.108479Z","steps":["trace[252926756] 'range keys from in-memory index tree' (duration: 333.543871ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:02.108498Z","caller":"traceutil/trace.go:171","msg":"trace[1074488459] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1; }","duration":"467.855327ms","start":"2026-07-03T18:46:01.640639Z","end":"2026-07-03T18:46:02.108494Z","steps":["trace[1074488459] 'count revisions from in-memory index tree' (duration: 467.787577ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.108515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.640632Z","time spent":"467.879427ms","remote":"127.0.0.1:55438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.108526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.774732Z","time spent":"333.778032ms","remote":"127.0.0.1:55512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":26,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.108588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.112758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.108605Z","caller":"traceutil/trace.go:171","msg":"trace[960678281] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1; }","duration":"455.131638ms","start":"2026-07-03T18:46:01.65347Z","end":"2026-07-03T18:46:02.108601Z","steps":["trace[960678281] 'range keys from in-memory index tree' (duration: 455.039377ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.108624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.653449Z","time spent":"455.171158ms","remote":"127.0.0.1:55448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":26,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.108637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.393665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.10867Z","caller":"traceutil/trace.go:171","msg":"trace[1296749894] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1; }","duration":"321.437265ms","start":"2026-07-03T18:46:01.787224Z","end":"2026-07-03T18:46:02.108661Z","steps":["trace[1296749894] 'range keys from in-memory index tree' (duration: 321.343425ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.108693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.054136ms","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":"warn","ts":"2026-07-03T18:46:02.108703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.787199Z","time spent":"321.495735ms","remote":"127.0.0.1:55526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":26,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" limit:10000 "} {"level":"info","ts":"2026-07-03T18:46:02.108713Z","caller":"traceutil/trace.go:171","msg":"trace[1948990441] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1; }","duration":"455.097458ms","start":"2026-07-03T18:46:01.653611Z","end":"2026-07-03T18:46:02.108709Z","steps":["trace[1948990441] 'count revisions from in-memory index tree' (duration: 454.982576ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.108728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.653595Z","time spent":"455.128488ms","remote":"127.0.0.1:55448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":26,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.108784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.229366ms","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-07-03T18:46:02.1088Z","caller":"traceutil/trace.go:171","msg":"trace[1190216142] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1; }","duration":"442.273057ms","start":"2026-07-03T18:46:01.666523Z","end":"2026-07-03T18:46:02.108796Z","steps":["trace[1190216142] 'count revisions from in-memory index tree' (duration: 442.167616ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.108813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.666516Z","time spent":"442.293167ms","remote":"127.0.0.1:55452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":26,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.10884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.544126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.108875Z","caller":"traceutil/trace.go:171","msg":"trace[335056347] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1; }","duration":"321.589287ms","start":"2026-07-03T18:46:01.787277Z","end":"2026-07-03T18:46:02.108867Z","steps":["trace[335056347] 'count revisions from in-memory index tree' (duration: 321.479635ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.108894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.184886ms","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":"info","ts":"2026-07-03T18:46:02.108908Z","caller":"traceutil/trace.go:171","msg":"trace[2029790556] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1; }","duration":"442.250967ms","start":"2026-07-03T18:46:01.666653Z","end":"2026-07-03T18:46:02.108904Z","steps":["trace[2029790556] 'range keys from in-memory index tree' (duration: 442.079535ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.108909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.787268Z","time spent":"321.633237ms","remote":"127.0.0.1:55526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":26,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.10893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.666624Z","time spent":"442.301247ms","remote":"127.0.0.1:55452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":0,"response size":26,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.108987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.784898ms","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":"info","ts":"2026-07-03T18:46:02.109006Z","caller":"traceutil/trace.go:171","msg":"trace[480813171] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1; }","duration":"430.812578ms","start":"2026-07-03T18:46:01.678187Z","end":"2026-07-03T18:46:02.109Z","steps":["trace[480813171] 'range keys from in-memory index tree' (duration: 430.719117ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.109023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.678178Z","time spent":"430.841369ms","remote":"127.0.0.1:55460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.109019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.861789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.109046Z","caller":"traceutil/trace.go:171","msg":"trace[237315176] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1; }","duration":"308.922509ms","start":"2026-07-03T18:46:01.800116Z","end":"2026-07-03T18:46:02.109038Z","steps":["trace[237315176] 'range keys from in-memory index tree' (duration: 308.809548ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.109081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.800108Z","time spent":"308.965419ms","remote":"127.0.0.1:55534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":26,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.109101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.787378ms","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":"info","ts":"2026-07-03T18:46:02.109115Z","caller":"traceutil/trace.go:171","msg":"trace[220599205] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1; }","duration":"430.855589ms","start":"2026-07-03T18:46:01.678255Z","end":"2026-07-03T18:46:02.109111Z","steps":["trace[220599205] 'count revisions from in-memory index tree' (duration: 430.682387ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.109133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.67824Z","time spent":"430.88969ms","remote":"127.0.0.1:55460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.109193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.528773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.10921Z","caller":"traceutil/trace.go:171","msg":"trace[1410174851] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1; }","duration":"418.563583ms","start":"2026-07-03T18:46:01.690643Z","end":"2026-07-03T18:46:02.109206Z","steps":["trace[1410174851] 'range keys from in-memory index tree' (duration: 418.470673ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.109223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.690635Z","time spent":"418.584443ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":26,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.109234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.0295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.109272Z","caller":"traceutil/trace.go:171","msg":"trace[1327780169] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1; }","duration":"309.080531ms","start":"2026-07-03T18:46:01.800184Z","end":"2026-07-03T18:46:02.109265Z","steps":["trace[1327780169] 'count revisions from in-memory index tree' (duration: 308.986089ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.109297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.377802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:02.109305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.800172Z","time spent":"309.125691ms","remote":"127.0.0.1:55534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-07-03T18:46:02.109317Z","caller":"traceutil/trace.go:171","msg":"trace[1214532252] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1; }","duration":"418.448143ms","start":"2026-07-03T18:46:01.690863Z","end":"2026-07-03T18:46:02.109311Z","steps":["trace[1214532252] 'count revisions from in-memory index tree' (duration: 418.245001ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.109335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.690829Z","time spent":"418.502813ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.109412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.839551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.109442Z","caller":"traceutil/trace.go:171","msg":"trace[1963814508] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1; }","duration":"298.891151ms","start":"2026-07-03T18:46:01.81054Z","end":"2026-07-03T18:46:02.109431Z","steps":["trace[1963814508] 'range keys from in-memory index tree' (duration: 298.79029ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.109596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.062472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.109628Z","caller":"traceutil/trace.go:171","msg":"trace[695408629] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1; }","duration":"299.131432ms","start":"2026-07-03T18:46:01.810489Z","end":"2026-07-03T18:46:02.109621Z","steps":["trace[695408629] 'count revisions from in-memory index tree' (duration: 298.956261ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.107795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.571624Z","time spent":"536.167079ms","remote":"127.0.0.1:55400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":26,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.109744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.858844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.109807Z","caller":"traceutil/trace.go:171","msg":"trace[1175991965] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1; }","duration":"287.936475ms","start":"2026-07-03T18:46:01.821863Z","end":"2026-07-03T18:46:02.109799Z","steps":["trace[1175991965] 'range keys from in-memory index tree' (duration: 287.787444ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:02.107831Z","caller":"traceutil/trace.go:171","msg":"trace[1885818943] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1; }","duration":"523.168058ms","start":"2026-07-03T18:46:01.584659Z","end":"2026-07-03T18:46:02.107827Z","steps":["trace[1885818943] 'count revisions from in-memory index tree' (duration: 523.113298ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.109953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.58465Z","time spent":"525.292386ms","remote":"127.0.0.1:55408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":26,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.109989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.075976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.110055Z","caller":"traceutil/trace.go:171","msg":"trace[1809400190] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1; }","duration":"288.193827ms","start":"2026-07-03T18:46:01.821845Z","end":"2026-07-03T18:46:02.110038Z","steps":["trace[1809400190] 'count revisions from in-memory index tree' (duration: 287.952285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.10788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.584596Z","time spent":"523.279829ms","remote":"127.0.0.1:55408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":26,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.110222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.255638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:02.108205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.400202ms","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-07-03T18:46:02.110249Z","caller":"traceutil/trace.go:171","msg":"trace[187216806] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1; }","duration":"279.310108ms","start":"2026-07-03T18:46:01.830932Z","end":"2026-07-03T18:46:02.110242Z","steps":["trace[187216806] 'range keys from in-memory index tree' (duration: 279.192748ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:02.110266Z","caller":"traceutil/trace.go:171","msg":"trace[863471415] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1; }","duration":"497.470728ms","start":"2026-07-03T18:46:01.612777Z","end":"2026-07-03T18:46:02.110248Z","steps":["trace[863471415] 'range keys from in-memory index tree' (duration: 495.347022ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.108466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.640439Z","time spent":"468.023539ms","remote":"127.0.0.1:55438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.110313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.612764Z","time spent":"497.536619ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" limit:10000 "} {"level":"warn","ts":"2026-07-03T18:46:02.107752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.453468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:02.110391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.283108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.110419Z","caller":"traceutil/trace.go:171","msg":"trace[719303913] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1; }","duration":"279.337328ms","start":"2026-07-03T18:46:01.831074Z","end":"2026-07-03T18:46:02.110411Z","steps":["trace[719303913] 'count revisions from in-memory index tree' (duration: 279.211288ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.110457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.616392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.110494Z","caller":"traceutil/trace.go:171","msg":"trace[786422822] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1; }","duration":"160.705683ms","start":"2026-07-03T18:46:01.949781Z","end":"2026-07-03T18:46:02.110486Z","steps":["trace[786422822] 'range keys from in-memory index tree' (duration: 160.528691ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.110612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.311174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.110648Z","caller":"traceutil/trace.go:171","msg":"trace[1339384049] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1; }","duration":"267.348984ms","start":"2026-07-03T18:46:01.843293Z","end":"2026-07-03T18:46:02.110642Z","steps":["trace[1339384049] 'count revisions from in-memory index tree' (duration: 267.248974ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:02.110394Z","caller":"traceutil/trace.go:171","msg":"trace[1948896809] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1; }","duration":"359.125729ms","start":"2026-07-03T18:46:01.751261Z","end":"2026-07-03T18:46:02.110386Z","steps":["trace[1948896809] 'count revisions from in-memory index tree' (duration: 356.359858ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.110724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.751242Z","time spent":"359.470042ms","remote":"127.0.0.1:55490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.110802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.508495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.110833Z","caller":"traceutil/trace.go:171","msg":"trace[72876836] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1; }","duration":"267.557955ms","start":"2026-07-03T18:46:01.843269Z","end":"2026-07-03T18:46:02.110826Z","steps":["trace[72876836] 'range keys from in-memory index tree' (duration: 267.431784ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.110855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.011296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.110897Z","caller":"traceutil/trace.go:171","msg":"trace[2024125280] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1; }","duration":"247.066677ms","start":"2026-07-03T18:46:01.863821Z","end":"2026-07-03T18:46:02.110888Z","steps":["trace[2024125280] 'count revisions from in-memory index tree' (duration: 246.949875ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.110933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.518486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.110958Z","caller":"traceutil/trace.go:171","msg":"trace[1828385278] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1; }","duration":"258.586656ms","start":"2026-07-03T18:46:01.852366Z","end":"2026-07-03T18:46:02.110952Z","steps":["trace[1828385278] 'range keys from in-memory index tree' (duration: 258.379885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.106853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.729413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:02.111057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.585316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-03T18:46:02.111065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.291898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-03T18:46:02.11108Z","caller":"traceutil/trace.go:171","msg":"trace[294659473] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1; }","duration":"258.632586ms","start":"2026-07-03T18:46:01.852438Z","end":"2026-07-03T18:46:02.111071Z","steps":["trace[294659473] 'count revisions from in-memory index tree' (duration: 258.542426ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:02.111093Z","caller":"traceutil/trace.go:171","msg":"trace[1371288288] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1; }","duration":"247.335128ms","start":"2026-07-03T18:46:01.86375Z","end":"2026-07-03T18:46:02.111085Z","steps":["trace[1371288288] 'range keys from in-memory index tree' (duration: 247.257678ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:02.111053Z","caller":"traceutil/trace.go:171","msg":"trace[417282744] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1; }","duration":"405.954135ms","start":"2026-07-03T18:46:01.705069Z","end":"2026-07-03T18:46:02.111023Z","steps":["trace[417282744] 'count revisions from in-memory index tree' (duration: 401.653001ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:02.111136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:01.705057Z","time spent":"406.074375ms","remote":"127.0.0.1:55484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":26,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:46:02.110997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.443097ms","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-07-03T18:46:02.111218Z","caller":"traceutil/trace.go:171","msg":"trace[1216348011] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"234.671909ms","start":"2026-07-03T18:46:01.876534Z","end":"2026-07-03T18:46:02.111206Z","steps":["trace[1216348011] 'count revisions from in-memory index tree' (duration: 234.404017ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:04.099821Z","caller":"traceutil/trace.go:171","msg":"trace[811633929] transaction","detail":"{read_only:false; response_revision:140; number_of_response:1; }","duration":"309.583004ms","start":"2026-07-03T18:46:03.790194Z","end":"2026-07-03T18:46:04.099777Z","steps":["trace[811633929] 'process raft request' (duration: 210.464785ms)","trace[811633929] 'compare' (duration: 98.875137ms)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:46:04.100479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:03.790178Z","time spent":"309.749855ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":710,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-03T18:46:04.206402Z","caller":"traceutil/trace.go:171","msg":"trace[1606314026] transaction","detail":"{read_only:false; response_revision:141; number_of_response:1; }","duration":"100.464929ms","start":"2026-07-03T18:46:04.105914Z","end":"2026-07-03T18:46:04.206379Z","steps":["trace[1606314026] 'process raft request' (duration: 94.549894ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:27.778646Z","caller":"traceutil/trace.go:171","msg":"trace[940754171] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"221.087807ms","start":"2026-07-03T18:46:27.557529Z","end":"2026-07-03T18:46:27.778617Z","steps":["trace[940754171] 'process raft request' (duration: 220.895935ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:39.051061Z","caller":"traceutil/trace.go:171","msg":"trace[1154615686] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"107.868218ms","start":"2026-07-03T18:46:38.943155Z","end":"2026-07-03T18:46:39.051023Z","steps":["trace[1154615686] 'process raft request' (duration: 48.74908ms)","trace[1154615686] 'compare' (duration: 58.861747ms)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:46:39.051178Z","caller":"traceutil/trace.go:171","msg":"trace[2100820841] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"106.149267ms","start":"2026-07-03T18:46:38.944983Z","end":"2026-07-03T18:46:39.051132Z","steps":["trace[2100820841] 'process raft request' (duration: 105.955586ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:39.236208Z","caller":"traceutil/trace.go:171","msg":"trace[1200308186] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"179.421418ms","start":"2026-07-03T18:46:39.056761Z","end":"2026-07-03T18:46:39.236182Z","steps":["trace[1200308186] 'process raft request' (duration: 179.383278ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:39.236446Z","caller":"traceutil/trace.go:171","msg":"trace[1413626236] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"180.113701ms","start":"2026-07-03T18:46:39.056311Z","end":"2026-07-03T18:46:39.236425Z","steps":["trace[1413626236] 'process raft request' (duration: 179.784059ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:39.236212Z","caller":"traceutil/trace.go:171","msg":"trace[1785821737] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"179.905691ms","start":"2026-07-03T18:46:39.056267Z","end":"2026-07-03T18:46:39.236172Z","steps":["trace[1785821737] 'process raft request' (duration: 125.821742ms)","trace[1785821737] 'compare' (duration: 53.797917ms)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:46:39.465376Z","caller":"traceutil/trace.go:171","msg":"trace[431706152] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"133.455536ms","start":"2026-07-03T18:46:39.331892Z","end":"2026-07-03T18:46:39.465347Z","steps":["trace[431706152] 'process raft request' (duration: 68.096891ms)","trace[431706152] 'compare' (duration: 65.212135ms)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:46:39.950556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.23169ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-03T18:46:39.95084Z","caller":"traceutil/trace.go:171","msg":"trace[1137914470] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"616.974086ms","start":"2026-07-03T18:46:39.33384Z","end":"2026-07-03T18:46:39.950814Z","steps":["trace[1137914470] 'process raft request' (duration: 364.193906ms)","trace[1137914470] 'compare' (duration: 250.891609ms)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:46:39.950994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:39.333821Z","time spent":"617.082896ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-03T18:46:39.951004Z","caller":"traceutil/trace.go:171","msg":"trace[90304956] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"477.615234ms","start":"2026-07-03T18:46:39.47337Z","end":"2026-07-03T18:46:39.950985Z","steps":["trace[90304956] 'process raft request' (duration: 477.569554ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:39.950989Z","caller":"traceutil/trace.go:171","msg":"trace[587622105] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:529; }","duration":"563.733072ms","start":"2026-07-03T18:46:39.387221Z","end":"2026-07-03T18:46:39.950954Z","steps":["trace[587622105] 'read index received' (duration: 12.794685ms)","trace[587622105] 'applied index is now lower than readState.Index' (duration: 550.933077ms)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:46:39.951087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:39.473359Z","time spent":"477.685034ms","remote":"127.0.0.1:55578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-03T18:46:39.951251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.026143ms","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-07-03T18:46:39.951295Z","caller":"traceutil/trace.go:171","msg":"trace[1230033080] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:517; }","duration":"564.091464ms","start":"2026-07-03T18:46:39.387193Z","end":"2026-07-03T18:46:39.951285Z","steps":["trace[1230033080] 'agreement among raft nodes before linearized reading' (duration: 564.006003ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:39.951317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:39.387182Z","time spent":"564.130634ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-03T18:46:39.951366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.78735ms","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-07-03T18:46:39.951515Z","caller":"traceutil/trace.go:171","msg":"trace[442120280] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:517; }","duration":"472.023591ms","start":"2026-07-03T18:46:39.479475Z","end":"2026-07-03T18:46:39.951499Z","steps":["trace[442120280] 'agreement among raft nodes before linearized reading' (duration: 471.755449ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:39.951595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:39.479461Z","time spent":"472.118981ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-03T18:46:39.951734Z","caller":"traceutil/trace.go:171","msg":"trace[1665386126] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"477.953695ms","start":"2026-07-03T18:46:39.473137Z","end":"2026-07-03T18:46:39.951091Z","steps":["trace[1665386126] 'process raft request' (duration: 477.681534ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:39.951812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:39.473086Z","time spent":"478.698931ms","remote":"127.0.0.1:55534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3827,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-03T18:46:41.766654Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870503649005431,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-03T18:46:41.861426Z","caller":"traceutil/trace.go:171","msg":"trace[2056809655] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:557; }","duration":"594.751265ms","start":"2026-07-03T18:46:41.266619Z","end":"2026-07-03T18:46:41.86137Z","steps":["trace[2056809655] 'read index received' (duration: 594.488274ms)","trace[2056809655] 'applied index is now lower than readState.Index' (duration: 262.241µs)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:46:41.861462Z","caller":"traceutil/trace.go:171","msg":"trace[950244192] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"618.106943ms","start":"2026-07-03T18:46:41.243318Z","end":"2026-07-03T18:46:41.861425Z","steps":["trace[950244192] 'process raft request' (duration: 617.849571ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:41.86157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.921156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-03T18:46:41.861607Z","caller":"traceutil/trace.go:171","msg":"trace[1330000235] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:541; }","duration":"595.038407ms","start":"2026-07-03T18:46:41.266557Z","end":"2026-07-03T18:46:41.861595Z","steps":["trace[1330000235] 'agreement among raft nodes before linearized reading' (duration: 594.951486ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:41.861643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:41.266541Z","time spent":"595.092927ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-07-03T18:46:41.861634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:41.243307Z","time spent":"618.246843ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-03T18:46:42.910937Z","caller":"traceutil/trace.go:171","msg":"trace[259083117] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"170.673133ms","start":"2026-07-03T18:46:42.740239Z","end":"2026-07-03T18:46:42.910912Z","steps":["trace[259083117] 'process raft request' (duration: 131.494555ms)","trace[259083117] 'compare' (duration: 38.796986ms)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:46:42.910937Z","caller":"traceutil/trace.go:171","msg":"trace[530388490] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"154.689481ms","start":"2026-07-03T18:46:42.756222Z","end":"2026-07-03T18:46:42.910912Z","steps":["trace[530388490] 'process raft request' (duration: 154.612781ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:48.384077Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870503649005605,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-03T18:46:48.456834Z","caller":"traceutil/trace.go:171","msg":"trace[1009189317] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"573.261489ms","start":"2026-07-03T18:46:47.882866Z","end":"2026-07-03T18:46:48.456128Z","steps":["trace[1009189317] 'process raft request' (duration: 572.620658ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:48.457089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:47.882831Z","time spent":"574.106019ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-03T18:46:48.860217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.098779ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-03T18:46:48.860347Z","caller":"traceutil/trace.go:171","msg":"trace[1075244912] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:667; }","duration":"976.87556ms","start":"2026-07-03T18:46:47.883446Z","end":"2026-07-03T18:46:48.860322Z","steps":["trace[1075244912] 'read index received' (duration: 571.794759ms)","trace[1075244912] 'applied index is now lower than readState.Index' (duration: 405.079041ms)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:46:48.86044Z","caller":"traceutil/trace.go:171","msg":"trace[77179690] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"741.580629ms","start":"2026-07-03T18:46:48.118844Z","end":"2026-07-03T18:46:48.860425Z","steps":["trace[77179690] 'process raft request' (duration: 355.147834ms)","trace[77179690] 'compare' (duration: 385.970533ms)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:46:48.860527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:48.118813Z","time spent":"741.669244ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-03T18:46:48.860598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.144283ms","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-07-03T18:46:48.860658Z","caller":"traceutil/trace.go:171","msg":"trace[127667907] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"977.243948ms","start":"2026-07-03T18:46:47.883397Z","end":"2026-07-03T18:46:48.860641Z","steps":["trace[127667907] 'agreement among raft nodes before linearized reading' (duration: 977.114662ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:48.860698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:47.883376Z","time spent":"977.314031ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-03T18:46:48.870692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"863.956266ms","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-07-03T18:46:48.870771Z","caller":"traceutil/trace.go:171","msg":"trace[632498214] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:647; }","duration":"864.097152ms","start":"2026-07-03T18:46:48.006658Z","end":"2026-07-03T18:46:48.870755Z","steps":["trace[632498214] 'agreement among raft nodes before linearized reading' (duration: 863.945225ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:48.87081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:48.006636Z","time spent":"864.165576ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-03T18:46:48.870869Z","caller":"traceutil/trace.go:171","msg":"trace[1062513989] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"352.96805ms","start":"2026-07-03T18:46:48.517856Z","end":"2026-07-03T18:46:48.870825Z","steps":["trace[1062513989] 'process raft request' (duration: 352.632194ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:48.870936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.042308ms","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-07-03T18:46:48.870994Z","caller":"traceutil/trace.go:171","msg":"trace[50880662] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:647; }","duration":"855.140503ms","start":"2026-07-03T18:46:48.015841Z","end":"2026-07-03T18:46:48.870981Z","steps":["trace[50880662] 'agreement among raft nodes before linearized reading' (duration: 855.026758ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:48.871032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:48.015822Z","time spent":"855.200396ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-03T18:46:48.87105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.077876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9476v\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-07-03T18:46:48.871125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.30183ms","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-07-03T18:46:48.871214Z","caller":"traceutil/trace.go:171","msg":"trace[196097024] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9476v; range_end:; response_count:1; response_revision:647; }","duration":"302.273495ms","start":"2026-07-03T18:46:48.568921Z","end":"2026-07-03T18:46:48.871194Z","steps":["trace[196097024] 'agreement among raft nodes before linearized reading' (duration: 301.915048ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:48.870974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:48.517832Z","time spent":"353.095996ms","remote":"127.0.0.1:55432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-03T18:46:48.871301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:48.568899Z","time spent":"302.384531ms","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-9476v\" "} {"level":"info","ts":"2026-07-03T18:46:48.871244Z","caller":"traceutil/trace.go:171","msg":"trace[1949530675] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:647; }","duration":"855.446897ms","start":"2026-07-03T18:46:48.015765Z","end":"2026-07-03T18:46:48.871212Z","steps":["trace[1949530675] 'agreement among raft nodes before linearized reading' (duration: 855.145953ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:48.871517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:48.015753Z","time spent":"855.719061ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-03T18:46:48.870724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.043745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-03T18:46:48.871726Z","caller":"traceutil/trace.go:171","msg":"trace[1214782649] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"555.072305ms","start":"2026-07-03T18:46:48.316627Z","end":"2026-07-03T18:46:48.871699Z","steps":["trace[1214782649] 'agreement among raft nodes before linearized reading' (duration: 554.063286ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:48.871766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:48.316553Z","time spent":"555.205791ms","remote":"127.0.0.1:38172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-03T18:46:49.830917Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870503649005616,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-03T18:46:50.204865Z","caller":"traceutil/trace.go:171","msg":"trace[833027480] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"873.944178ms","start":"2026-07-03T18:46:49.330883Z","end":"2026-07-03T18:46:50.204827Z","steps":["trace[833027480] 'read index received' (duration: 869.162565ms)","trace[833027480] 'applied index is now lower than readState.Index' (duration: 4.780853ms)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:46:50.205008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.108137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-03T18:46:50.205059Z","caller":"traceutil/trace.go:171","msg":"trace[1976147538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"874.1785ms","start":"2026-07-03T18:46:49.330852Z","end":"2026-07-03T18:46:50.20503Z","steps":["trace[1976147538] 'agreement among raft nodes before linearized reading' (duration: 874.063755ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:50.205092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:49.330837Z","time spent":"874.247983ms","remote":"127.0.0.1:38160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-03T18:46:50.205321Z","caller":"traceutil/trace.go:171","msg":"trace[506137194] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"884.558892ms","start":"2026-07-03T18:46:49.320694Z","end":"2026-07-03T18:46:50.205252Z","steps":["trace[506137194] 'process raft request' (duration: 879.736476ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:50.205558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:46:49.320673Z","time spent":"884.756821ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-03T18:46:50.831615Z","caller":"traceutil/trace.go:171","msg":"trace[778450383] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"140.941432ms","start":"2026-07-03T18:46:50.690643Z","end":"2026-07-03T18:46:50.831584Z","steps":["trace[778450383] 'process raft request' (duration: 61.451889ms)","trace[778450383] 'compare' (duration: 79.108225ms)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:46:51.937149Z","caller":"traceutil/trace.go:171","msg":"trace[197081095] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"108.814444ms","start":"2026-07-03T18:46:51.828281Z","end":"2026-07-03T18:46:51.937096Z","steps":["trace[197081095] 'process raft request' (duration: 108.663067ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:55.236044Z","caller":"traceutil/trace.go:171","msg":"trace[528835497] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"160.249149ms","start":"2026-07-03T18:46:55.075771Z","end":"2026-07-03T18:46:55.23602Z","steps":["trace[528835497] 'process raft request' (duration: 160.089192ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:55.305311Z","caller":"traceutil/trace.go:171","msg":"trace[1993875347] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"207.223369ms","start":"2026-07-03T18:46:55.098059Z","end":"2026-07-03T18:46:55.305282Z","steps":["trace[1993875347] 'process raft request' (duration: 206.643224ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:55.64757Z","caller":"traceutil/trace.go:171","msg":"trace[600143796] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"204.024357ms","start":"2026-07-03T18:46:55.443523Z","end":"2026-07-03T18:46:55.647547Z","steps":["trace[600143796] 'process raft request' (duration: 203.797367ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:55.647613Z","caller":"traceutil/trace.go:171","msg":"trace[602354789] linearizableReadLoop","detail":"{readStateIndex:763; appliedIndex:762; }","duration":"223.047984ms","start":"2026-07-03T18:46:55.424544Z","end":"2026-07-03T18:46:55.647592Z","steps":["trace[602354789] 'read index received' (duration: 124.685761ms)","trace[602354789] 'applied index is now lower than readState.Index' (duration: 98.360283ms)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:46:55.6478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.234213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-07-03T18:46:55.648441Z","caller":"traceutil/trace.go:171","msg":"trace[1564932371] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:739; }","duration":"223.896803ms","start":"2026-07-03T18:46:55.424518Z","end":"2026-07-03T18:46:55.648415Z","steps":["trace[1564932371] 'agreement among raft nodes before linearized reading' (duration: 223.174871ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:46:55.672432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.035199ms","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-07-03T18:46:55.67255Z","caller":"traceutil/trace.go:171","msg":"trace[1369473817] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:740; }","duration":"229.202486ms","start":"2026-07-03T18:46:55.443331Z","end":"2026-07-03T18:46:55.672533Z","steps":["trace[1369473817] 'agreement among raft nodes before linearized reading' (duration: 228.984206ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:46:55.825502Z","caller":"traceutil/trace.go:171","msg":"trace[1701282133] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"114.449872ms","start":"2026-07-03T18:46:55.711011Z","end":"2026-07-03T18:46:55.82546Z","steps":["trace[1701282133] 'process raft request' (duration: 114.17577ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:07.064219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.291077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-03T18:47:07.064339Z","caller":"traceutil/trace.go:171","msg":"trace[858551867] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:819; }","duration":"523.497996ms","start":"2026-07-03T18:47:06.540821Z","end":"2026-07-03T18:47:07.064319Z","steps":["trace[858551867] 'count revisions from in-memory index tree' (duration: 523.178923ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:07.064391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:47:06.540792Z","time spent":"523.584469ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-07-03T18:47:07.0645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.23432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-03T18:47:07.064577Z","caller":"traceutil/trace.go:171","msg":"trace[272505949] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:819; }","duration":"747.367565ms","start":"2026-07-03T18:47:06.317194Z","end":"2026-07-03T18:47:07.064562Z","steps":["trace[272505949] 'range keys from in-memory index tree' (duration: 747.139466ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:07.064617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:47:06.31717Z","time spent":"747.433208ms","remote":"127.0.0.1:38160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-03T18:47:07.064765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.264035ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-03T18:47:07.064987Z","caller":"traceutil/trace.go:171","msg":"trace[42714483] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:819; }","duration":"262.466042ms","start":"2026-07-03T18:47:06.802462Z","end":"2026-07-03T18:47:07.064928Z","steps":["trace[42714483] 'range keys from in-memory index tree' (duration: 262.207333ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:47:07.258914Z","caller":"traceutil/trace.go:171","msg":"trace[1845513188] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"573.560124ms","start":"2026-07-03T18:47:06.685319Z","end":"2026-07-03T18:47:07.258879Z","steps":["trace[1845513188] 'process raft request' (duration: 573.391757ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:47:07.258938Z","caller":"traceutil/trace.go:171","msg":"trace[97609915] linearizableReadLoop","detail":"{readStateIndex:849; appliedIndex:849; }","duration":"284.569979ms","start":"2026-07-03T18:47:06.974334Z","end":"2026-07-03T18:47:07.258904Z","steps":["trace[97609915] 'read index received' (duration: 284.560118ms)","trace[97609915] 'applied index is now lower than readState.Index' (duration: 8.131µs)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:47:07.259092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:47:06.685289Z","time spent":"573.71765ms","remote":"127.0.0.1:55348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-03T18:47:07.259202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.129905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-03T18:47:07.259217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.87923ms","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-07-03T18:47:07.259269Z","caller":"traceutil/trace.go:171","msg":"trace[453096293] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:820; }","duration":"260.216418ms","start":"2026-07-03T18:47:06.999036Z","end":"2026-07-03T18:47:07.259252Z","steps":["trace[453096293] 'agreement among raft nodes before linearized reading' (duration: 260.085413ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:47:07.259275Z","caller":"traceutil/trace.go:171","msg":"trace[1455948973] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:820; }","duration":"285.006435ms","start":"2026-07-03T18:47:06.974257Z","end":"2026-07-03T18:47:07.259264Z","steps":["trace[1455948973] 'agreement among raft nodes before linearized reading' (duration: 284.738055ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:07.259393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.371975ms","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-07-03T18:47:07.259471Z","caller":"traceutil/trace.go:171","msg":"trace[1645943707] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:820; }","duration":"242.466578ms","start":"2026-07-03T18:47:07.016966Z","end":"2026-07-03T18:47:07.259433Z","steps":["trace[1645943707] 'agreement among raft nodes before linearized reading' (duration: 242.247189ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:07.259505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.207766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-03T18:47:07.259548Z","caller":"traceutil/trace.go:171","msg":"trace[537779286] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:820; }","duration":"249.285679ms","start":"2026-07-03T18:47:07.010255Z","end":"2026-07-03T18:47:07.25954Z","steps":["trace[537779286] 'agreement among raft nodes before linearized reading' (duration: 249.180595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:07.259565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.353933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-03T18:47:07.259663Z","caller":"traceutil/trace.go:171","msg":"trace[296011875] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:820; }","duration":"193.510359ms","start":"2026-07-03T18:47:07.066134Z","end":"2026-07-03T18:47:07.259645Z","steps":["trace[296011875] 'agreement among raft nodes before linearized reading' (duration: 193.338762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:07.259559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.564172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-03T18:47:07.259864Z","caller":"traceutil/trace.go:171","msg":"trace[569628344] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:820; }","duration":"242.925485ms","start":"2026-07-03T18:47:07.016921Z","end":"2026-07-03T18:47:07.259847Z","steps":["trace[569628344] 'agreement among raft nodes before linearized reading' (duration: 242.322243ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:31.8589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.408094ms","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-07-03T18:47:31.859064Z","caller":"traceutil/trace.go:171","msg":"trace[1594823979] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1027; }","duration":"301.650351ms","start":"2026-07-03T18:47:31.557393Z","end":"2026-07-03T18:47:31.859044Z","steps":["trace[1594823979] 'range keys from in-memory index tree' (duration: 301.237069ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:31.859119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.01908ms","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-07-03T18:47:31.859177Z","caller":"traceutil/trace.go:171","msg":"trace[123946877] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1027; }","duration":"305.136174ms","start":"2026-07-03T18:47:31.554028Z","end":"2026-07-03T18:47:31.859164Z","steps":["trace[123946877] 'range keys from in-memory index tree' (duration: 304.890616ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:31.859217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:47:31.554003Z","time spent":"305.202726ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-03T18:47:31.859275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:47:31.557372Z","time spent":"301.858457ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-03T18:47:31.859257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.857647ms","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-07-03T18:47:31.859451Z","caller":"traceutil/trace.go:171","msg":"trace[829649580] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1027; }","duration":"302.071814ms","start":"2026-07-03T18:47:31.557357Z","end":"2026-07-03T18:47:31.859429Z","steps":["trace[829649580] 'range keys from in-memory index tree' (duration: 301.667542ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:31.859502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:47:31.557314Z","time spent":"302.177947ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-03T18:47:32.109251Z","caller":"traceutil/trace.go:171","msg":"trace[2086841592] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"245.523046ms","start":"2026-07-03T18:47:31.8637Z","end":"2026-07-03T18:47:32.109223Z","steps":["trace[2086841592] 'process raft request' (duration: 245.358491ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:47:32.110789Z","caller":"traceutil/trace.go:171","msg":"trace[243867342] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"245.890956ms","start":"2026-07-03T18:47:31.864843Z","end":"2026-07-03T18:47:32.110734Z","steps":["trace[243867342] 'process raft request' (duration: 245.707711ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:47:32.11099Z","caller":"traceutil/trace.go:171","msg":"trace[1008773177] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"245.828973ms","start":"2026-07-03T18:47:31.86515Z","end":"2026-07-03T18:47:32.110979Z","steps":["trace[1008773177] 'process raft request' (duration: 245.542695ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:47:34.085277Z","caller":"traceutil/trace.go:171","msg":"trace[1018559811] linearizableReadLoop","detail":"{readStateIndex:1068; appliedIndex:1067; }","duration":"368.24952ms","start":"2026-07-03T18:47:33.716996Z","end":"2026-07-03T18:47:34.085246Z","steps":["trace[1018559811] 'read index received' (duration: 368.023773ms)","trace[1018559811] 'applied index is now lower than readState.Index' (duration: 224.427µs)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:47:34.08535Z","caller":"traceutil/trace.go:171","msg":"trace[542841326] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"601.385985ms","start":"2026-07-03T18:47:33.483938Z","end":"2026-07-03T18:47:34.085324Z","steps":["trace[542841326] 'process raft request' (duration: 601.117877ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:34.085474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.464576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-03T18:47:34.085672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:47:33.48391Z","time spent":"601.685652ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-03T18:47:34.085725Z","caller":"traceutil/trace.go:171","msg":"trace[661646908] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1033; }","duration":"368.778925ms","start":"2026-07-03T18:47:33.716936Z","end":"2026-07-03T18:47:34.085715Z","steps":["trace[661646908] 'agreement among raft nodes before linearized reading' (duration: 368.465026ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:34.085768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:47:33.716909Z","time spent":"368.837277ms","remote":"127.0.0.1:38160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-03T18:47:34.092957Z","caller":"traceutil/trace.go:171","msg":"trace[56771130] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"153.76557ms","start":"2026-07-03T18:47:33.93889Z","end":"2026-07-03T18:47:34.092656Z","steps":["trace[56771130] 'process raft request' (duration: 153.618355ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:47:39.563502Z","caller":"traceutil/trace.go:171","msg":"trace[343857817] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"128.41611ms","start":"2026-07-03T18:47:39.435037Z","end":"2026-07-03T18:47:39.563453Z","steps":["trace[343857817] 'process raft request' (duration: 128.112291ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:47:40.154537Z","caller":"traceutil/trace.go:171","msg":"trace[239298750] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"140.113449ms","start":"2026-07-03T18:47:40.014399Z","end":"2026-07-03T18:47:40.154513Z","steps":["trace[239298750] 'process raft request' (duration: 139.964255ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:47:40.261918Z","caller":"traceutil/trace.go:171","msg":"trace[940606160] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"122.041196ms","start":"2026-07-03T18:47:40.139846Z","end":"2026-07-03T18:47:40.261887Z","steps":["trace[940606160] 'process raft request' (duration: 70.23884ms)","trace[940606160] 'compare' (duration: 51.640382ms)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:47:40.261955Z","caller":"traceutil/trace.go:171","msg":"trace[200848940] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"103.642393ms","start":"2026-07-03T18:47:40.158283Z","end":"2026-07-03T18:47:40.261925Z","steps":["trace[200848940] 'process raft request' (duration: 103.580971ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:47:40.262077Z","caller":"traceutil/trace.go:171","msg":"trace[2069464495] linearizableReadLoop","detail":"{readStateIndex:1092; appliedIndex:1091; }","duration":"107.585929ms","start":"2026-07-03T18:47:40.154484Z","end":"2026-07-03T18:47:40.26207Z","steps":["trace[2069464495] 'read index received' (duration: 55.611558ms)","trace[2069464495] 'applied index is now lower than readState.Index' (duration: 51.973371ms)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:47:40.262233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.086723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-03T18:47:40.262255Z","caller":"traceutil/trace.go:171","msg":"trace[191623095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1057; }","duration":"117.137505ms","start":"2026-07-03T18:47:40.145111Z","end":"2026-07-03T18:47:40.262248Z","steps":["trace[191623095] 'agreement among raft nodes before linearized reading' (duration: 117.016591ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:40.262271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.776528ms","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-07-03T18:47:40.262312Z","caller":"traceutil/trace.go:171","msg":"trace[1534061676] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1057; }","duration":"118.86209ms","start":"2026-07-03T18:47:40.143437Z","end":"2026-07-03T18:47:40.262299Z","steps":["trace[1534061676] 'agreement among raft nodes before linearized reading' (duration: 118.723886ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:40.262431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.310765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-03T18:47:40.262456Z","caller":"traceutil/trace.go:171","msg":"trace[1900207192] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1057; }","duration":"118.377547ms","start":"2026-07-03T18:47:40.144069Z","end":"2026-07-03T18:47:40.262447Z","steps":["trace[1900207192] 'agreement among raft nodes before linearized reading' (duration: 118.307385ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:47:46.484443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.337823ms","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-07-03T18:47:46.484517Z","caller":"traceutil/trace.go:171","msg":"trace[1826268666] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1080; }","duration":"102.454976ms","start":"2026-07-03T18:47:46.382045Z","end":"2026-07-03T18:47:46.4845Z","steps":["trace[1826268666] 'range keys from in-memory index tree' (duration: 102.185349ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:47:46.628528Z","caller":"traceutil/trace.go:171","msg":"trace[556516205] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"139.265336ms","start":"2026-07-03T18:47:46.489245Z","end":"2026-07-03T18:47:46.62851Z","steps":["trace[556516205] 'process raft request' (duration: 96.016414ms)","trace[556516205] 'compare' (duration: 43.17653ms)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:47:46.628622Z","caller":"traceutil/trace.go:171","msg":"trace[1202394936] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"139.355218ms","start":"2026-07-03T18:47:46.489256Z","end":"2026-07-03T18:47:46.628611Z","steps":["trace[1202394936] 'process raft request' (duration: 139.233795ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:47:46.628703Z","caller":"traceutil/trace.go:171","msg":"trace[506227185] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"139.414029ms","start":"2026-07-03T18:47:46.489284Z","end":"2026-07-03T18:47:46.628698Z","steps":["trace[506227185] 'process raft request' (duration: 139.294926ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:47:52.441926Z","caller":"traceutil/trace.go:171","msg":"trace[1774038341] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"100.476629ms","start":"2026-07-03T18:47:52.341408Z","end":"2026-07-03T18:47:52.441885Z","steps":["trace[1774038341] 'process raft request' (duration: 100.275984ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:48:12.760371Z","caller":"traceutil/trace.go:171","msg":"trace[1096048468] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"114.27443ms","start":"2026-07-03T18:48:12.646081Z","end":"2026-07-03T18:48:12.760355Z","steps":["trace[1096048468] 'process raft request' (duration: 114.022225ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:48:15.012364Z","caller":"traceutil/trace.go:171","msg":"trace[95845418] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"247.847678ms","start":"2026-07-03T18:48:14.764488Z","end":"2026-07-03T18:48:15.012335Z","steps":["trace[95845418] 'process raft request' (duration: 247.628394ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:48:15.012238Z","caller":"traceutil/trace.go:171","msg":"trace[1115220873] linearizableReadLoop","detail":"{readStateIndex:1213; appliedIndex:1212; }","duration":"243.130745ms","start":"2026-07-03T18:48:14.769091Z","end":"2026-07-03T18:48:15.012222Z","steps":["trace[1115220873] 'read index received' (duration: 242.998902ms)","trace[1115220873] 'applied index is now lower than readState.Index' (duration: 131.333µs)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:48:15.012549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.446691ms","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-07-03T18:48:15.012589Z","caller":"traceutil/trace.go:171","msg":"trace[703964872] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1170; }","duration":"243.520841ms","start":"2026-07-03T18:48:14.769053Z","end":"2026-07-03T18:48:15.012573Z","steps":["trace[703964872] 'agreement among raft nodes before linearized reading' (duration: 243.413809ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:48:15.013039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.301363ms","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-07-03T18:48:15.013067Z","caller":"traceutil/trace.go:171","msg":"trace[1460052300] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1170; }","duration":"109.373155ms","start":"2026-07-03T18:48:14.903688Z","end":"2026-07-03T18:48:15.013061Z","steps":["trace[1460052300] 'agreement among raft nodes before linearized reading' (duration: 109.313594ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:48:15.318774Z","caller":"traceutil/trace.go:171","msg":"trace[362935903] linearizableReadLoop","detail":"{readStateIndex:1218; appliedIndex:1216; }","duration":"224.040993ms","start":"2026-07-03T18:48:15.094706Z","end":"2026-07-03T18:48:15.318747Z","steps":["trace[362935903] 'read index received' (duration: 13.713309ms)","trace[362935903] 'applied index is now lower than readState.Index' (duration: 210.326754ms)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:48:15.318937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.222126ms","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-07-03T18:48:15.319021Z","caller":"traceutil/trace.go:171","msg":"trace[440405411] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1175; }","duration":"224.382769ms","start":"2026-07-03T18:48:15.094625Z","end":"2026-07-03T18:48:15.319008Z","steps":["trace[440405411] 'agreement among raft nodes before linearized reading' (duration: 224.224496ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:48:15.318842Z","caller":"traceutil/trace.go:171","msg":"trace[218697500] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"239.14784ms","start":"2026-07-03T18:48:15.079651Z","end":"2026-07-03T18:48:15.318799Z","steps":["trace[218697500] 'process raft request' (duration: 181.262842ms)","trace[218697500] 'compare' (duration: 57.731425ms)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:48:17.187521Z","caller":"traceutil/trace.go:171","msg":"trace[826464826] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"112.165451ms","start":"2026-07-03T18:48:17.075332Z","end":"2026-07-03T18:48:17.187497Z","steps":["trace[826464826] 'process raft request' (duration: 52.765752ms)","trace[826464826] 'compare' (duration: 59.303187ms)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:48:17.193997Z","caller":"traceutil/trace.go:171","msg":"trace[157322966] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"117.794889ms","start":"2026-07-03T18:48:17.07611Z","end":"2026-07-03T18:48:17.193905Z","steps":["trace[157322966] 'process raft request' (duration: 117.520524ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:48:19.340802Z","caller":"traceutil/trace.go:171","msg":"trace[1558040837] linearizableReadLoop","detail":"{readStateIndex:1230; appliedIndex:1229; }","duration":"142.998846ms","start":"2026-07-03T18:48:19.197778Z","end":"2026-07-03T18:48:19.340777Z","steps":["trace[1558040837] 'read index received' (duration: 123.690078ms)","trace[1558040837] 'applied index is now lower than readState.Index' (duration: 19.307688ms)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:48:19.340859Z","caller":"traceutil/trace.go:171","msg":"trace[596457635] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"144.961074ms","start":"2026-07-03T18:48:19.195868Z","end":"2026-07-03T18:48:19.340829Z","steps":["trace[596457635] 'process raft request' (duration: 125.673386ms)","trace[596457635] 'compare' (duration: 19.134755ms)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:48:19.341025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-03T18:48:19.341104Z","caller":"traceutil/trace.go:171","msg":"trace[2049711492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1186; }","duration":"143.323842ms","start":"2026-07-03T18:48:19.197763Z","end":"2026-07-03T18:48:19.341087Z","steps":["trace[2049711492] 'agreement among raft nodes before linearized reading' (duration: 143.145258ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:48:23.556928Z","caller":"traceutil/trace.go:171","msg":"trace[680371991] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1243; }","duration":"151.420113ms","start":"2026-07-03T18:48:23.405489Z","end":"2026-07-03T18:48:23.556909Z","steps":["trace[680371991] 'read index received' (duration: 151.29621ms)","trace[680371991] 'applied index is now lower than readState.Index' (duration: 122.893µs)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:48:23.556999Z","caller":"traceutil/trace.go:171","msg":"trace[1601718597] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"167.027772ms","start":"2026-07-03T18:48:23.389935Z","end":"2026-07-03T18:48:23.556963Z","steps":["trace[1601718597] 'process raft request' (duration: 166.843658ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:48:23.557252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.290435ms","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-07-03T18:48:23.557327Z","caller":"traceutil/trace.go:171","msg":"trace[2138888014] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1199; }","duration":"114.406588ms","start":"2026-07-03T18:48:23.442908Z","end":"2026-07-03T18:48:23.557314Z","steps":["trace[2138888014] 'agreement among raft nodes before linearized reading' (duration: 114.244575ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:48:23.5578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.287558ms","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-07-03T18:48:23.557861Z","caller":"traceutil/trace.go:171","msg":"trace[2093186673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1199; }","duration":"152.38528ms","start":"2026-07-03T18:48:23.40546Z","end":"2026-07-03T18:48:23.557845Z","steps":["trace[2093186673] 'agreement among raft nodes before linearized reading' (duration: 151.637316ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:48:25.781169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.437883ms","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-07-03T18:48:25.781245Z","caller":"traceutil/trace.go:171","msg":"trace[762505127] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1205; }","duration":"197.538264ms","start":"2026-07-03T18:48:25.583689Z","end":"2026-07-03T18:48:25.781227Z","steps":["trace[762505127] 'range keys from in-memory index tree' (duration: 197.258929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:48:25.78127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.776486ms","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-07-03T18:48:25.781544Z","caller":"traceutil/trace.go:171","msg":"trace[1308425931] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"103.218474ms","start":"2026-07-03T18:48:25.678306Z","end":"2026-07-03T18:48:25.781524Z","steps":["trace[1308425931] 'process raft request' (duration: 62.117263ms)","trace[1308425931] 'compare' (duration: 40.961778ms)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:48:25.781648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.158305ms","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-07-03T18:48:25.781748Z","caller":"traceutil/trace.go:171","msg":"trace[758849738] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1205; }","duration":"204.357188ms","start":"2026-07-03T18:48:25.577373Z","end":"2026-07-03T18:48:25.78173Z","steps":["trace[758849738] 'range keys from in-memory index tree' (duration: 203.86329ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:48:25.781684Z","caller":"traceutil/trace.go:171","msg":"trace[1263928548] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1205; }","duration":"210.882387ms","start":"2026-07-03T18:48:25.570445Z","end":"2026-07-03T18:48:25.781328Z","steps":["trace[1263928548] 'range keys from in-memory index tree' (duration: 210.654973ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:48:25.781273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.205501ms","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-07-03T18:48:25.782435Z","caller":"traceutil/trace.go:171","msg":"trace[839599626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1205; }","duration":"219.423543ms","start":"2026-07-03T18:48:25.562983Z","end":"2026-07-03T18:48:25.782407Z","steps":["trace[839599626] 'range keys from in-memory index tree' (duration: 218.006847ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:48:52.04378Z","caller":"traceutil/trace.go:171","msg":"trace[2020868975] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"108.061739ms","start":"2026-07-03T18:48:51.935687Z","end":"2026-07-03T18:48:52.043749Z","steps":["trace[2020868975] 'process raft request' (duration: 107.882546ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:48:52.044208Z","caller":"traceutil/trace.go:171","msg":"trace[617669611] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"108.16694ms","start":"2026-07-03T18:48:51.936021Z","end":"2026-07-03T18:48:52.044188Z","steps":["trace[617669611] 'process raft request' (duration: 107.997938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:49:00.957759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.50391ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-03T18:49:01.859854Z","caller":"traceutil/trace.go:171","msg":"trace[1555022137] linearizableReadLoop","detail":"{readStateIndex:1415; appliedIndex:1414; }","duration":"255.163924ms","start":"2026-07-03T18:49:01.604664Z","end":"2026-07-03T18:49:01.859828Z","steps":["trace[1555022137] 'read index received' (duration: 254.973201ms)","trace[1555022137] 'applied index is now lower than readState.Index' (duration: 189.503µs)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:49:01.859936Z","caller":"traceutil/trace.go:171","msg":"trace[464096782] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"435.452319ms","start":"2026-07-03T18:49:01.424426Z","end":"2026-07-03T18:49:01.859878Z","steps":["trace[464096782] 'process raft request' (duration: 435.225945ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:49:01.860122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:49:01.424407Z","time spent":"435.605561ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-03T18:49:01.860285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.61903ms","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-07-03T18:49:01.860335Z","caller":"traceutil/trace.go:171","msg":"trace[980108112] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1360; }","duration":"255.730202ms","start":"2026-07-03T18:49:01.604591Z","end":"2026-07-03T18:49:01.860322Z","steps":["trace[980108112] 'agreement among raft nodes before linearized reading' (duration: 255.360887ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:49:12.408106Z","caller":"traceutil/trace.go:171","msg":"trace[1659481398] linearizableReadLoop","detail":"{readStateIndex:1458; appliedIndex:1457; }","duration":"253.50904ms","start":"2026-07-03T18:49:12.154571Z","end":"2026-07-03T18:49:12.40808Z","steps":["trace[1659481398] 'read index received' (duration: 253.353328ms)","trace[1659481398] 'applied index is now lower than readState.Index' (duration: 152.372µs)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:49:12.408237Z","caller":"traceutil/trace.go:171","msg":"trace[1503478389] transaction","detail":"{read_only:false; response_revision:1400; number_of_response:1; }","duration":"254.460854ms","start":"2026-07-03T18:49:12.153764Z","end":"2026-07-03T18:49:12.408225Z","steps":["trace[1503478389] 'process raft request' (duration: 254.15857ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:49:12.408383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.791714ms","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-07-03T18:49:12.408453Z","caller":"traceutil/trace.go:171","msg":"trace[383211913] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1400; }","duration":"253.903736ms","start":"2026-07-03T18:49:12.15453Z","end":"2026-07-03T18:49:12.408434Z","steps":["trace[383211913] 'agreement among raft nodes before linearized reading' (duration: 253.737794ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:49:12.570777Z","caller":"traceutil/trace.go:171","msg":"trace[2092387067] linearizableReadLoop","detail":"{readStateIndex:1459; appliedIndex:1458; }","duration":"162.557894ms","start":"2026-07-03T18:49:12.408188Z","end":"2026-07-03T18:49:12.570746Z","steps":["trace[2092387067] 'read index received' (duration: 85.565012ms)","trace[2092387067] 'applied index is now lower than readState.Index' (duration: 76.991581ms)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:49:12.571023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.353068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-03T18:49:12.571092Z","caller":"traceutil/trace.go:171","msg":"trace[1126201161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1401; }","duration":"416.46292ms","start":"2026-07-03T18:49:12.154613Z","end":"2026-07-03T18:49:12.571076Z","steps":["trace[1126201161] 'agreement among raft nodes before linearized reading' (duration: 416.250207ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:49:12.571142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:49:12.154599Z","time spent":"416.532831ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-03T18:49:12.571172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.932391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-03T18:49:12.571267Z","caller":"traceutil/trace.go:171","msg":"trace[1358505401] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1401; }","duration":"255.064073ms","start":"2026-07-03T18:49:12.316181Z","end":"2026-07-03T18:49:12.571245Z","steps":["trace[1358505401] 'agreement among raft nodes before linearized reading' (duration: 254.89774ms)"],"step_count":1} {"level":"info","ts":"2026-07-03T18:49:12.571269Z","caller":"traceutil/trace.go:171","msg":"trace[593225977] transaction","detail":"{read_only:false; response_revision:1401; number_of_response:1; }","duration":"414.870339ms","start":"2026-07-03T18:49:12.156366Z","end":"2026-07-03T18:49:12.571236Z","steps":["trace[593225977] 'process raft request' (duration: 337.376939ms)","trace[593225977] 'compare' (duration: 76.865301ms)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:49:12.571321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.310461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:pv-protection-controller\" ","response":"range_response_count:1 size:693"} {"level":"info","ts":"2026-07-03T18:49:12.571367Z","caller":"traceutil/trace.go:171","msg":"trace[648551152] range","detail":"{range_begin:/registry/clusterroles/system:controller:pv-protection-controller; range_end:; response_count:1; response_revision:1401; }","duration":"399.386913ms","start":"2026-07-03T18:49:12.171965Z","end":"2026-07-03T18:49:12.571352Z","steps":["trace[648551152] 'agreement among raft nodes before linearized reading' (duration: 399.309972ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:49:12.5714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:49:12.171952Z","time spent":"399.436213ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":715,"request content":"key:\"/registry/clusterroles/system:controller:pv-protection-controller\" "} {"level":"warn","ts":"2026-07-03T18:49:12.571375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.921298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:pod-garbage-collector\" ","response":"range_response_count:1 size:665"} {"level":"warn","ts":"2026-07-03T18:49:12.571425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:49:12.156352Z","time spent":"414.985141ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-03T18:49:12.571452Z","caller":"traceutil/trace.go:171","msg":"trace[1635870434] range","detail":"{range_begin:/registry/clusterroles/system:controller:pod-garbage-collector; range_end:; response_count:1; response_revision:1401; }","duration":"412.018059ms","start":"2026-07-03T18:49:12.159414Z","end":"2026-07-03T18:49:12.571432Z","steps":["trace[1635870434] 'agreement among raft nodes before linearized reading' (duration: 411.872007ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:49:12.571494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:49:12.159407Z","time spent":"412.07897ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":687,"request content":"key:\"/registry/clusterroles/system:controller:pod-garbage-collector\" "} {"level":"info","ts":"2026-07-03T18:49:12.717263Z","caller":"traceutil/trace.go:171","msg":"trace[1626172371] linearizableReadLoop","detail":"{readStateIndex:1460; appliedIndex:1459; }","duration":"144.271039ms","start":"2026-07-03T18:49:12.572967Z","end":"2026-07-03T18:49:12.717238Z","steps":["trace[1626172371] 'read index received' (duration: 126.46064ms)","trace[1626172371] 'applied index is now lower than readState.Index' (duration: 17.809199ms)"],"step_count":2} {"level":"info","ts":"2026-07-03T18:49:12.717321Z","caller":"traceutil/trace.go:171","msg":"trace[1803453344] transaction","detail":"{read_only:false; response_revision:1402; number_of_response:1; }","duration":"304.571352ms","start":"2026-07-03T18:49:12.412721Z","end":"2026-07-03T18:49:12.717292Z","steps":["trace[1803453344] 'process raft request' (duration: 286.522ms)","trace[1803453344] 'compare' (duration: 17.88886ms)"],"step_count":2} {"level":"warn","ts":"2026-07-03T18:49:12.717422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.438171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-03T18:49:12.717473Z","caller":"traceutil/trace.go:171","msg":"trace[1209313700] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1402; }","duration":"144.528573ms","start":"2026-07-03T18:49:12.572924Z","end":"2026-07-03T18:49:12.717452Z","steps":["trace[1209313700] 'agreement among raft nodes before linearized reading' (duration: 144.450232ms)"],"step_count":1} {"level":"warn","ts":"2026-07-03T18:49:12.717486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-03T18:49:12.412699Z","time spent":"304.684753ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-03T18:49:12.717647Z","caller":"traceutil/trace.go:171","msg":"trace[1403623071] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"140.536926ms","start":"2026-07-03T18:49:12.577099Z","end":"2026-07-03T18:49:12.717635Z","steps":["trace[1403623071] 'process raft request' (duration: 140.419505ms)"],"step_count":1}