{"level":"warn","ts":"2026-02-24T06:13:04.650281Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-24T06:13:04.650387Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.12:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.12:2380","--initial-cluster=instance=https://162.253.55.12:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.12:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.12:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-02-24T06:13:04.65046Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-24T06:13:04.650469Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.12:2380"]} {"level":"info","ts":"2026-02-24T06:13:04.650486Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-24T06:13:04.651284Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"]} {"level":"info","ts":"2026-02-24T06:13:04.651358Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.12:2380"],"listen-peer-urls":["https://162.253.55.12:2380"],"advertise-client-urls":["https://162.253.55.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.12:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-02-24T06:13:04.658625Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.873344ms"} {"level":"info","ts":"2026-02-24T06:13:04.667661Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b4c6dc24a78438ca","cluster-id":"587227f9a3f73e98"} {"level":"info","ts":"2026-02-24T06:13:04.667751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=()"} {"level":"info","ts":"2026-02-24T06:13:04.667774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became follower at term 0"} {"level":"info","ts":"2026-02-24T06:13:04.667791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b4c6dc24a78438ca [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-24T06:13:04.667804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became follower at term 1"} {"level":"info","ts":"2026-02-24T06:13:04.667844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=(13026341022203132106)"} {"level":"warn","ts":"2026-02-24T06:13:04.682712Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-24T06:13:04.685659Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-24T06:13:04.687161Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-02-24T06:13:04.689997Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b4c6dc24a78438ca","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-24T06:13:04.690573Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-24T06:13:04.691416Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-24T06:13:04.691427Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-24T06:13:04.690566Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b4c6dc24a78438ca","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-24T06:13:04.692766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=(13026341022203132106)"} {"level":"info","ts":"2026-02-24T06:13:04.692875Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"587227f9a3f73e98","local-member-id":"b4c6dc24a78438ca","added-peer-id":"b4c6dc24a78438ca","added-peer-peer-urls":["https://162.253.55.12:2380"]} {"level":"info","ts":"2026-02-24T06:13:04.696298Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-24T06:13:04.696541Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.12:2380"} {"level":"info","ts":"2026-02-24T06:13:04.696563Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.12:2380"} {"level":"info","ts":"2026-02-24T06:13:04.696475Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b4c6dc24a78438ca","initial-advertise-peer-urls":["https://162.253.55.12:2380"],"listen-peer-urls":["https://162.253.55.12:2380"],"advertise-client-urls":["https://162.253.55.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-24T06:13:04.696598Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-24T06:13:04.868143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca is starting a new election at term 1"} {"level":"info","ts":"2026-02-24T06:13:04.86823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became pre-candidate at term 1"} {"level":"info","ts":"2026-02-24T06:13:04.868257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca received MsgPreVoteResp from b4c6dc24a78438ca at term 1"} {"level":"info","ts":"2026-02-24T06:13:04.868271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became candidate at term 2"} {"level":"info","ts":"2026-02-24T06:13:04.868279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca received MsgVoteResp from b4c6dc24a78438ca at term 2"} {"level":"info","ts":"2026-02-24T06:13:04.86829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became leader at term 2"} {"level":"info","ts":"2026-02-24T06:13:04.868301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b4c6dc24a78438ca elected leader b4c6dc24a78438ca at term 2"} {"level":"warn","ts":"2026-02-24T06:13:06.148503Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.052106178s","expected-duration":"1s"} {"level":"info","ts":"2026-02-24T06:13:06.148826Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-24T06:13:06.248809Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b4c6dc24a78438ca","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.12:2379]}","request-path":"/0/members/b4c6dc24a78438ca/attributes","cluster-id":"587227f9a3f73e98","publish-timeout":"7s"} {"level":"info","ts":"2026-02-24T06:13:06.248818Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-24T06:13:06.248887Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-24T06:13:06.249125Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-24T06:13:06.249159Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-24T06:13:06.252357Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.12:2379"} {"level":"info","ts":"2026-02-24T06:13:06.25279Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-24T06:13:06.521423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.244704ms","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-02-24T06:13:06.521498Z","caller":"traceutil/trace.go:171","msg":"trace[674965615] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; }","duration":"118.428227ms","start":"2026-02-24T06:13:06.403057Z","end":"2026-02-24T06:13:06.521485Z","steps":["trace[674965615] 'agreement among raft nodes before linearized reading' (duration: 118.343256ms)"],"step_count":1} 2026/02/24 06:13:06 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-24T06:13:06.521359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.308374ms","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-02-24T06:13:06.521791Z","caller":"traceutil/trace.go:171","msg":"trace[1595053147] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; }","duration":"118.717833ms","start":"2026-02-24T06:13:06.402966Z","end":"2026-02-24T06:13:06.521684Z","steps":["trace[1595053147] 'agreement among raft nodes before linearized reading' (duration: 118.319494ms)"],"step_count":1} 2026/02/24 06:13:06 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-02-24T06:13:06.68934Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"587227f9a3f73e98","local-member-id":"b4c6dc24a78438ca","cluster-version":"3.5"} {"level":"info","ts":"2026-02-24T06:13:06.689579Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-24T06:13:06.689626Z","caller":"traceutil/trace.go:171","msg":"trace[911080100] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"388.043073ms","start":"2026-02-24T06:13:06.30157Z","end":"2026-02-24T06:13:06.689613Z","steps":["trace[911080100] 'read index received' (duration: 387.718876ms)","trace[911080100] 'applied index is now lower than readState.Index' (duration: 323.217µs)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:13:06.689663Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-02-24T06:13:06.68985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.255667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.689884Z","caller":"traceutil/trace.go:171","msg":"trace[982657304] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"388.308398ms","start":"2026-02-24T06:13:06.301563Z","end":"2026-02-24T06:13:06.689871Z","steps":["trace[982657304] 'agreement among raft nodes before linearized reading' (duration: 388.167655ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.689905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.301546Z","time spent":"388.3536ms","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":121,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 "} {"level":"warn","ts":"2026-02-24T06:13:06.689978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.204006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.690087Z","caller":"traceutil/trace.go:171","msg":"trace[1742052052] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"388.354649ms","start":"2026-02-24T06:13:06.301709Z","end":"2026-02-24T06:13:06.690064Z","steps":["trace[1742052052] 'agreement among raft nodes before linearized reading' (duration: 388.042443ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.690169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.301677Z","time spent":"388.475881ms","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-02-24T06:13:06.691129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.800953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.691244Z","caller":"traceutil/trace.go:171","msg":"trace[1571408527] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"116.915856ms","start":"2026-02-24T06:13:06.574297Z","end":"2026-02-24T06:13:06.691213Z","steps":["trace[1571408527] 'agreement among raft nodes before linearized reading' (duration: 116.813154ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.691338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.31899ms","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":"warn","ts":"2026-02-24T06:13:06.691368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.864394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.691407Z","caller":"traceutil/trace.go:171","msg":"trace[962090922] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"336.918386ms","start":"2026-02-24T06:13:06.354479Z","end":"2026-02-24T06:13:06.691398Z","steps":["trace[962090922] 'agreement among raft nodes before linearized reading' (duration: 336.836854ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:06.691406Z","caller":"traceutil/trace.go:171","msg":"trace[1285674872] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"325.433104ms","start":"2026-02-24T06:13:06.365956Z","end":"2026-02-24T06:13:06.691389Z","steps":["trace[1285674872] 'agreement among raft nodes before linearized reading' (duration: 325.342702ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.691431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.35447Z","time spent":"336.956556ms","remote":"127.0.0.1:53258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 "} {"level":"warn","ts":"2026-02-24T06:13:06.691448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.365926Z","time spent":"325.512166ms","remote":"127.0.0.1:53270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 "} {"level":"warn","ts":"2026-02-24T06:13:06.691517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.644698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.691545Z","caller":"traceutil/trace.go:171","msg":"trace[715951728] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"325.69728ms","start":"2026-02-24T06:13:06.365841Z","end":"2026-02-24T06:13:06.691538Z","steps":["trace[715951728] 'agreement among raft nodes before linearized reading' (duration: 325.662799ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.691558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.365823Z","time spent":"325.73134ms","remote":"127.0.0.1:53270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-02-24T06:13:06.691613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.12216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.691648Z","caller":"traceutil/trace.go:171","msg":"trace[29321939] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"337.180791ms","start":"2026-02-24T06:13:06.354458Z","end":"2026-02-24T06:13:06.691639Z","steps":["trace[29321939] 'agreement among raft nodes before linearized reading' (duration: 337.13067ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.691677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.354447Z","time spent":"337.222241ms","remote":"127.0.0.1:53258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-02-24T06:13:06.691692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.502987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.691808Z","caller":"traceutil/trace.go:171","msg":"trace[473098869] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"117.683632ms","start":"2026-02-24T06:13:06.5741Z","end":"2026-02-24T06:13:06.691784Z","steps":["trace[473098869] 'agreement among raft nodes before linearized reading' (duration: 117.501078ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.691996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.637844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.692073Z","caller":"traceutil/trace.go:171","msg":"trace[1383712583] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"129.738256ms","start":"2026-02-24T06:13:06.562324Z","end":"2026-02-24T06:13:06.692063Z","steps":["trace[1383712583] 'agreement among raft nodes before linearized reading' (duration: 129.642174ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.690269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.654801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:06.692111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.402958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.692136Z","caller":"traceutil/trace.go:171","msg":"trace[736524971] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"183.546291ms","start":"2026-02-24T06:13:06.508584Z","end":"2026-02-24T06:13:06.69213Z","steps":["trace[736524971] 'agreement among raft nodes before linearized reading' (duration: 181.649171ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:06.69215Z","caller":"traceutil/trace.go:171","msg":"trace[1328774099] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"183.462699ms","start":"2026-02-24T06:13:06.508677Z","end":"2026-02-24T06:13:06.69214Z","steps":["trace[1328774099] 'agreement among raft nodes before linearized reading' (duration: 183.400408ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.690312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.892451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.692233Z","caller":"traceutil/trace.go:171","msg":"trace[99857121] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"261.870613ms","start":"2026-02-24T06:13:06.430358Z","end":"2026-02-24T06:13:06.692229Z","steps":["trace[99857121] 'agreement among raft nodes before linearized reading' (duration: 259.933732ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.691838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.951296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.69229Z","caller":"traceutil/trace.go:171","msg":"trace[934103898] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"346.466487ms","start":"2026-02-24T06:13:06.345811Z","end":"2026-02-24T06:13:06.692277Z","steps":["trace[934103898] 'agreement among raft nodes before linearized reading' (duration: 346.004037ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.6923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.939994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:06.690343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.936946ms","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-02-24T06:13:06.692522Z","caller":"traceutil/trace.go:171","msg":"trace[1985552696] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"193.132713ms","start":"2026-02-24T06:13:06.499385Z","end":"2026-02-24T06:13:06.692517Z","steps":["trace[1985552696] 'agreement among raft nodes before linearized reading' (duration: 190.942537ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:06.692521Z","caller":"traceutil/trace.go:171","msg":"trace[1439546713] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"171.16409ms","start":"2026-02-24T06:13:06.52134Z","end":"2026-02-24T06:13:06.692504Z","steps":["trace[1439546713] 'agreement among raft nodes before linearized reading' (duration: 170.938345ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.692091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.877128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.69266Z","caller":"traceutil/trace.go:171","msg":"trace[705519322] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"130.510932ms","start":"2026-02-24T06:13:06.562138Z","end":"2026-02-24T06:13:06.692649Z","steps":["trace[705519322] 'agreement among raft nodes before linearized reading' (duration: 129.891949ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.692097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.70589ms","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":"info","ts":"2026-02-24T06:13:06.692691Z","caller":"traceutil/trace.go:171","msg":"trace[1084483807] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"171.309453ms","start":"2026-02-24T06:13:06.521376Z","end":"2026-02-24T06:13:06.692686Z","steps":["trace[1084483807] 'agreement among raft nodes before linearized reading' (duration: 170.70246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.690459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.395488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:06.690428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.792256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.692786Z","caller":"traceutil/trace.go:171","msg":"trace[463200646] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"214.730708ms","start":"2026-02-24T06:13:06.478052Z","end":"2026-02-24T06:13:06.692782Z","steps":["trace[463200646] 'agreement among raft nodes before linearized reading' (duration: 212.384308ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:06.692803Z","caller":"traceutil/trace.go:171","msg":"trace[763212242] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"205.172117ms","start":"2026-02-24T06:13:06.487621Z","end":"2026-02-24T06:13:06.692793Z","steps":["trace[763212242] 'agreement among raft nodes before linearized reading' (duration: 202.796416ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.690482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.526742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.692881Z","caller":"traceutil/trace.go:171","msg":"trace[1995563397] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"214.932622ms","start":"2026-02-24T06:13:06.477941Z","end":"2026-02-24T06:13:06.692873Z","steps":["trace[1995563397] 'agreement among raft nodes before linearized reading' (duration: 212.527112ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.69052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.542461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:06.690543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.620163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.692967Z","caller":"traceutil/trace.go:171","msg":"trace[41599328] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"224.007774ms","start":"2026-02-24T06:13:06.468949Z","end":"2026-02-24T06:13:06.692957Z","steps":["trace[41599328] 'agreement among raft nodes before linearized reading' (duration: 221.541162ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:06.692977Z","caller":"traceutil/trace.go:171","msg":"trace[393196477] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"224.053704ms","start":"2026-02-24T06:13:06.468918Z","end":"2026-02-24T06:13:06.692972Z","steps":["trace[393196477] 'agreement among raft nodes before linearized reading' (duration: 221.613283ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.690565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.247157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:06.690603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.333759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.693058Z","caller":"traceutil/trace.go:171","msg":"trace[1203496545] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"234.803712ms","start":"2026-02-24T06:13:06.458251Z","end":"2026-02-24T06:13:06.693054Z","steps":["trace[1203496545] 'agreement among raft nodes before linearized reading' (duration: 232.33968ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:06.693058Z","caller":"traceutil/trace.go:171","msg":"trace[1764870741] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"234.761591ms","start":"2026-02-24T06:13:06.458289Z","end":"2026-02-24T06:13:06.693051Z","steps":["trace[1764870741] 'agreement among raft nodes before linearized reading' (duration: 232.262108ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.690622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.648032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.693133Z","caller":"traceutil/trace.go:171","msg":"trace[1670188632] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"250.182426ms","start":"2026-02-24T06:13:06.442947Z","end":"2026-02-24T06:13:06.69313Z","steps":["trace[1670188632] 'agreement among raft nodes before linearized reading' (duration: 247.663272ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.690644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.783845ms","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":"warn","ts":"2026-02-24T06:13:06.690685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.421682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:06.690667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.394115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.693244Z","caller":"traceutil/trace.go:171","msg":"trace[577721316] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"250.3854ms","start":"2026-02-24T06:13:06.442846Z","end":"2026-02-24T06:13:06.693232Z","steps":["trace[577721316] 'agreement among raft nodes before linearized reading' (duration: 247.786025ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:06.693265Z","caller":"traceutil/trace.go:171","msg":"trace[1791855390] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"313.00616ms","start":"2026-02-24T06:13:06.38025Z","end":"2026-02-24T06:13:06.693256Z","steps":["trace[1791855390] 'agreement among raft nodes before linearized reading' (duration: 310.406605ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.693287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.380221Z","time spent":"313.057141ms","remote":"127.0.0.1:53276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 "} {"level":"warn","ts":"2026-02-24T06:13:06.690768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.123406ms","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-02-24T06:13:06.693364Z","caller":"traceutil/trace.go:171","msg":"trace[1691449049] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"299.757922ms","start":"2026-02-24T06:13:06.393603Z","end":"2026-02-24T06:13:06.693361Z","steps":["trace[1691449049] 'agreement among raft nodes before linearized reading' (duration: 297.151336ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:06.693298Z","caller":"traceutil/trace.go:171","msg":"trace[1434845007] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"262.994266ms","start":"2026-02-24T06:13:06.430248Z","end":"2026-02-24T06:13:06.693242Z","steps":["trace[1434845007] 'agreement among raft nodes before linearized reading' (duration: 260.427282ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.690791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.237828ms","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":"warn","ts":"2026-02-24T06:13:06.690747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.964998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.693443Z","caller":"traceutil/trace.go:171","msg":"trace[343396202] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"299.906204ms","start":"2026-02-24T06:13:06.393534Z","end":"2026-02-24T06:13:06.69344Z","steps":["trace[343396202] 'agreement among raft nodes before linearized reading' (duration: 297.242088ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:06.693461Z","caller":"traceutil/trace.go:171","msg":"trace[1504226663] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"277.688916ms","start":"2026-02-24T06:13:06.415761Z","end":"2026-02-24T06:13:06.693449Z","steps":["trace[1504226663] 'agreement among raft nodes before linearized reading' (duration: 274.976199ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.691006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.332878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:06.691252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.951427ms","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":"warn","ts":"2026-02-24T06:13:06.692507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.345791Z","time spent":"346.705242ms","remote":"127.0.0.1:53244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":27,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-02-24T06:13:06.691093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.479151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.693561Z","caller":"traceutil/trace.go:171","msg":"trace[411315378] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"104.947613ms","start":"2026-02-24T06:13:06.588605Z","end":"2026-02-24T06:13:06.693553Z","steps":["trace[411315378] 'agreement among raft nodes before linearized reading' (duration: 102.43757ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.690368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.981587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.693593Z","caller":"traceutil/trace.go:171","msg":"trace[1923849164] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"313.378787ms","start":"2026-02-24T06:13:06.380211Z","end":"2026-02-24T06:13:06.69359Z","steps":["trace[1923849164] 'agreement among raft nodes before linearized reading' (duration: 310.917726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.693611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.380199Z","time spent":"313.406709ms","remote":"127.0.0.1:53276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-02-24T06:13:06.69361Z","caller":"traceutil/trace.go:171","msg":"trace[1281473316] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"194.255216ms","start":"2026-02-24T06:13:06.499346Z","end":"2026-02-24T06:13:06.693601Z","steps":["trace[1281473316] 'agreement among raft nodes before linearized reading' (duration: 191.008017ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:06.693664Z","caller":"traceutil/trace.go:171","msg":"trace[718337699] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"105.024774ms","start":"2026-02-24T06:13:06.588634Z","end":"2026-02-24T06:13:06.693659Z","steps":["trace[718337699] 'agreement among raft nodes before linearized reading' (duration: 102.338668ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.690708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.838515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.693745Z","caller":"traceutil/trace.go:171","msg":"trace[2129009080] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"277.89611ms","start":"2026-02-24T06:13:06.41584Z","end":"2026-02-24T06:13:06.693736Z","steps":["trace[2129009080] 'agreement among raft nodes before linearized reading' (duration: 274.855806ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:06.690392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.721695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:06.693794Z","caller":"traceutil/trace.go:171","msg":"trace[1145501230] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"206.131227ms","start":"2026-02-24T06:13:06.487659Z","end":"2026-02-24T06:13:06.69379Z","steps":["trace[1145501230] 'agreement among raft nodes before linearized reading' (duration: 202.717135ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.275702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.405598ms","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-02-24T06:13:07.275735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.413075ms","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":"warn","ts":"2026-02-24T06:13:07.275766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.036755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:07.275871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.223357ms","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":"warn","ts":"2026-02-24T06:13:07.275921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.13315ms","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-02-24T06:13:07.27594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.232522ms","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":"warn","ts":"2026-02-24T06:13:07.275911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.379747ms","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-02-24T06:13:07.276008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.422041ms","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":"warn","ts":"2026-02-24T06:13:07.27602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.151029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:07.275981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.201901ms","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":"warn","ts":"2026-02-24T06:13:07.27598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.222441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:07.276068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.772028ms","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-02-24T06:13:07.276091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.624773ms","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-02-24T06:13:07.276106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.733805ms","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-02-24T06:13:07.276158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.384138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:07.276164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.386234ms","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-02-24T06:13:07.276196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.505734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:07.276184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.978422ms","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-02-24T06:13:07.276205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.314813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:07.276289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.835402ms","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":"warn","ts":"2026-02-24T06:13:07.276289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.059809ms","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":"warn","ts":"2026-02-24T06:13:07.276231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.666686ms","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":"warn","ts":"2026-02-24T06:13:07.276322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.694356ms","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":"warn","ts":"2026-02-24T06:13:07.276261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.792951ms","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":"warn","ts":"2026-02-24T06:13:07.276204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.375404ms","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":"warn","ts":"2026-02-24T06:13:07.276359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.198932ms","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":"warn","ts":"2026-02-24T06:13:07.276351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.540192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:07.276386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.220473ms","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":"warn","ts":"2026-02-24T06:13:07.276387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.270128ms","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":"warn","ts":"2026-02-24T06:13:07.27641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.849457ms","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":"warn","ts":"2026-02-24T06:13:07.276424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.778536ms","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":"warn","ts":"2026-02-24T06:13:07.276447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.612719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-24T06:13:07.276456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.288065ms","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-02-24T06:13:07.276454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.155667ms","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":"warn","ts":"2026-02-24T06:13:07.276503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.438333ms","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":"warn","ts":"2026-02-24T06:13:07.27647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.065235ms","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":"warn","ts":"2026-02-24T06:13:07.276507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.180292ms","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":"warn","ts":"2026-02-24T06:13:07.276537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.472398ms","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-02-24T06:13:07.276592Z","caller":"traceutil/trace.go:171","msg":"trace[92409113] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1; }","duration":"145.577851ms","start":"2026-02-24T06:13:07.130984Z","end":"2026-02-24T06:13:07.276562Z","steps":["trace[92409113] 'count revisions from in-memory index tree' (duration: 145.345645ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:07.276612Z","caller":"traceutil/trace.go:171","msg":"trace[1255972898] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1; }","duration":"144.606579ms","start":"2026-02-24T06:13:07.131219Z","end":"2026-02-24T06:13:07.275826Z","steps":["trace[1255972898] 'range keys from in-memory index tree' (duration: 144.15766ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:07.276607Z","caller":"traceutil/trace.go:171","msg":"trace[155941559] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1; }","duration":"367.560242ms","start":"2026-02-24T06:13:06.908229Z","end":"2026-02-24T06:13:07.275789Z","steps":["trace[155941559] 'count revisions from in-memory index tree' (duration: 367.343807ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.276697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.908223Z","time spent":"368.458471ms","remote":"127.0.0.1:53588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-02-24T06:13:07.276792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.669147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-24T06:13:07.276832Z","caller":"traceutil/trace.go:171","msg":"trace[965237856] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1; }","duration":"472.219828ms","start":"2026-02-24T06:13:06.803642Z","end":"2026-02-24T06:13:07.275862Z","steps":["trace[965237856] 'count revisions from in-memory index tree' (duration: 471.876351ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.277046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.803623Z","time spent":"473.387683ms","remote":"127.0.0.1:53562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-02-24T06:13:07.276926Z","caller":"traceutil/trace.go:171","msg":"trace[2076175607] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1; }","duration":"445.783401ms","start":"2026-02-24T06:13:06.831099Z","end":"2026-02-24T06:13:07.276883Z","steps":["trace[2076175607] 'count revisions from in-memory index tree' (duration: 444.581946ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:07.277047Z","caller":"traceutil/trace.go:171","msg":"trace[661201135] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1; }","duration":"508.283188ms","start":"2026-02-24T06:13:06.767629Z","end":"2026-02-24T06:13:07.275912Z","steps":["trace[661201135] 'range keys from in-memory index tree' (duration: 508.156976ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.277164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.831093Z","time spent":"446.056267ms","remote":"127.0.0.1:53566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"info","ts":"2026-02-24T06:13:07.277214Z","caller":"traceutil/trace.go:171","msg":"trace[1161811100] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1; }","duration":"403.599872ms","start":"2026-02-24T06:13:06.872442Z","end":"2026-02-24T06:13:07.276042Z","steps":["trace[1161811100] 'range keys from in-memory index tree' (duration: 403.270534ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.277308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.87243Z","time spent":"404.828178ms","remote":"127.0.0.1:53578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":27,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" limit:10000 "} {"level":"warn","ts":"2026-02-24T06:13:07.277251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.767603Z","time spent":"509.625597ms","remote":"127.0.0.1:53524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" limit:10000 "} {"level":"info","ts":"2026-02-24T06:13:07.277405Z","caller":"traceutil/trace.go:171","msg":"trace[1164960121] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1; }","duration":"484.198351ms","start":"2026-02-24T06:13:06.791846Z","end":"2026-02-24T06:13:07.276045Z","steps":["trace[1164960121] 'count revisions from in-memory index tree' (duration: 484.055338ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:07.277084Z","caller":"traceutil/trace.go:171","msg":"trace[711876240] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1; }","duration":"493.193811ms","start":"2026-02-24T06:13:06.782758Z","end":"2026-02-24T06:13:07.275952Z","steps":["trace[711876240] 'count revisions from in-memory index tree' (duration: 493.032417ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.277469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.791838Z","time spent":"485.612071ms","remote":"127.0.0.1:53546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-02-24T06:13:07.277497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.782747Z","time spent":"494.735784ms","remote":"127.0.0.1:53530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"info","ts":"2026-02-24T06:13:07.277567Z","caller":"traceutil/trace.go:171","msg":"trace[631035006] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1; }","duration":"521.312984ms","start":"2026-02-24T06:13:06.754749Z","end":"2026-02-24T06:13:07.276062Z","steps":["trace[631035006] 'range keys from in-memory index tree' (duration: 521.117869ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.277646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.754735Z","time spent":"522.884298ms","remote":"127.0.0.1:53522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" limit:10000 "} {"level":"info","ts":"2026-02-24T06:13:07.277152Z","caller":"traceutil/trace.go:171","msg":"trace[121432078] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1; }","duration":"521.278353ms","start":"2026-02-24T06:13:06.754686Z","end":"2026-02-24T06:13:07.275964Z","steps":["trace[121432078] 'count revisions from in-memory index tree' (duration: 521.205571ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:07.277526Z","caller":"traceutil/trace.go:171","msg":"trace[1939392960] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1; }","duration":"508.476543ms","start":"2026-02-24T06:13:06.767558Z","end":"2026-02-24T06:13:07.276035Z","steps":["trace[1939392960] 'count revisions from in-memory index tree' (duration: 508.33024ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:07.277856Z","caller":"traceutil/trace.go:171","msg":"trace[1426048968] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1; }","duration":"277.821659ms","start":"2026-02-24T06:13:06.998268Z","end":"2026-02-24T06:13:07.27609Z","steps":["trace[1426048968] 'range keys from in-memory index tree' (duration: 277.679346ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.277881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.767547Z","time spent":"510.317482ms","remote":"127.0.0.1:53524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-24T06:13:07.277908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.754676Z","time spent":"523.186114ms","remote":"127.0.0.1:53522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"info","ts":"2026-02-24T06:13:07.277827Z","caller":"traceutil/trace.go:171","msg":"trace[1077823894] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1; }","duration":"493.344114ms","start":"2026-02-24T06:13:06.782725Z","end":"2026-02-24T06:13:07.27607Z","steps":["trace[1077823894] 'range keys from in-memory index tree' (duration: 493.094719ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.27819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.782713Z","time spent":"495.417378ms","remote":"127.0.0.1:53530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":27,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" limit:10000 "} {"level":"info","ts":"2026-02-24T06:13:07.278245Z","caller":"traceutil/trace.go:171","msg":"trace[1416505906] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1; }","duration":"367.778616ms","start":"2026-02-24T06:13:06.908351Z","end":"2026-02-24T06:13:07.27613Z","steps":["trace[1416505906] 'range keys from in-memory index tree' (duration: 367.682444ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.278305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.908343Z","time spent":"369.943621ms","remote":"127.0.0.1:53588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":27,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" limit:10000 "} {"level":"info","ts":"2026-02-24T06:13:07.278433Z","caller":"traceutil/trace.go:171","msg":"trace[1815289055] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1; }","duration":"403.661713ms","start":"2026-02-24T06:13:06.872455Z","end":"2026-02-24T06:13:07.276117Z","steps":["trace[1815289055] 'count revisions from in-memory index tree' (duration: 403.5353ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.278508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.87243Z","time spent":"406.061334ms","remote":"127.0.0.1:53578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-02-24T06:13:07.278614Z","caller":"traceutil/trace.go:171","msg":"trace[61708782] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1; }","duration":"460.43973ms","start":"2026-02-24T06:13:06.81574Z","end":"2026-02-24T06:13:07.27618Z","steps":["trace[61708782] 'range keys from in-memory index tree' (duration: 460.330097ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.27868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.815725Z","time spent":"462.945432ms","remote":"127.0.0.1:53564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":27,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" limit:10000 "} {"level":"info","ts":"2026-02-24T06:13:07.278761Z","caller":"traceutil/trace.go:171","msg":"trace[1909578086] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1; }","duration":"355.429365ms","start":"2026-02-24T06:13:06.920755Z","end":"2026-02-24T06:13:07.276185Z","steps":["trace[1909578086] 'count revisions from in-memory index tree' (duration: 355.334893ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:07.279038Z","caller":"traceutil/trace.go:171","msg":"trace[196237368] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1; }","duration":"472.560055ms","start":"2026-02-24T06:13:06.803658Z","end":"2026-02-24T06:13:07.276218Z","steps":["trace[196237368] 'range keys from in-memory index tree' (duration: 472.369901ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.278828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.920748Z","time spent":"358.06158ms","remote":"127.0.0.1:53594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-02-24T06:13:07.279117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.803556Z","time spent":"475.551468ms","remote":"127.0.0.1:53562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" limit:10000 "} {"level":"info","ts":"2026-02-24T06:13:07.279282Z","caller":"traceutil/trace.go:171","msg":"trace[464583545] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1; }","duration":"379.243878ms","start":"2026-02-24T06:13:06.896986Z","end":"2026-02-24T06:13:07.27623Z","steps":["trace[464583545] 'count revisions from in-memory index tree' (duration: 378.898111ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.279358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.896953Z","time spent":"382.390264ms","remote":"127.0.0.1:53582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-02-24T06:13:07.279481Z","caller":"traceutil/trace.go:171","msg":"trace[2027200652] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1; }","duration":"484.470846ms","start":"2026-02-24T06:13:06.79184Z","end":"2026-02-24T06:13:07.276311Z","steps":["trace[2027200652] 'range keys from in-memory index tree' (duration: 484.218431ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.279545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.79183Z","time spent":"487.705545ms","remote":"127.0.0.1:53546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":0,"response size":27,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" limit:10000 "} {"level":"info","ts":"2026-02-24T06:13:07.279642Z","caller":"traceutil/trace.go:171","msg":"trace[1355726142] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1; }","duration":"317.871823ms","start":"2026-02-24T06:13:06.958447Z","end":"2026-02-24T06:13:07.276319Z","steps":["trace[1355726142] 'count revisions from in-memory index tree' (duration: 317.762291ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.279703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.958427Z","time spent":"321.267726ms","remote":"127.0.0.1:53612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"info","ts":"2026-02-24T06:13:07.279809Z","caller":"traceutil/trace.go:171","msg":"trace[1523562763] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1; }","duration":"329.161531ms","start":"2026-02-24T06:13:06.947167Z","end":"2026-02-24T06:13:07.276328Z","steps":["trace[1523562763] 'range keys from in-memory index tree' (duration: 328.969677ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.279862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.947156Z","time spent":"332.690947ms","remote":"127.0.0.1:53608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" limit:10000 "} {"level":"info","ts":"2026-02-24T06:13:07.279996Z","caller":"traceutil/trace.go:171","msg":"trace[144081449] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1; }","duration":"341.794088ms","start":"2026-02-24T06:13:06.934544Z","end":"2026-02-24T06:13:07.276338Z","steps":["trace[144081449] 'count revisions from in-memory index tree' (duration: 341.624025ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.280042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.934536Z","time spent":"345.498607ms","remote":"127.0.0.1:53596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-02-24T06:13:07.28016Z","caller":"traceutil/trace.go:171","msg":"trace[1514931706] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1; }","duration":"341.749707ms","start":"2026-02-24T06:13:06.934592Z","end":"2026-02-24T06:13:07.276342Z","steps":["trace[1514931706] 'range keys from in-memory index tree' (duration: 341.656895ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.280201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.934584Z","time spent":"345.609869ms","remote":"127.0.0.1:53596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" limit:10000 "} {"level":"info","ts":"2026-02-24T06:13:07.280325Z","caller":"traceutil/trace.go:171","msg":"trace[1764442267] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1; }","duration":"317.910764ms","start":"2026-02-24T06:13:06.958436Z","end":"2026-02-24T06:13:07.276347Z","steps":["trace[1764442267] 'range keys from in-memory index tree' (duration: 317.74585ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.280433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.958422Z","time spent":"322.002571ms","remote":"127.0.0.1:53612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":27,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" limit:10000 "} {"level":"info","ts":"2026-02-24T06:13:07.280956Z","caller":"traceutil/trace.go:171","msg":"trace[1203862727] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1; }","duration":"355.536077ms","start":"2026-02-24T06:13:06.92082Z","end":"2026-02-24T06:13:07.276357Z","steps":["trace[1203862727] 'range keys from in-memory index tree' (duration: 355.331583ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.281019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.92079Z","time spent":"360.213997ms","remote":"127.0.0.1:53594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":27,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" limit:10000 "} {"level":"info","ts":"2026-02-24T06:13:07.282043Z","caller":"traceutil/trace.go:171","msg":"trace[1430426000] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1; }","duration":"329.249823ms","start":"2026-02-24T06:13:06.947132Z","end":"2026-02-24T06:13:07.276382Z","steps":["trace[1430426000] 'count revisions from in-memory index tree' (duration: 329.1037ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.282089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.947121Z","time spent":"334.950104ms","remote":"127.0.0.1:53608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-02-24T06:13:07.283497Z","caller":"traceutil/trace.go:171","msg":"trace[496271200] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1; }","duration":"460.640894ms","start":"2026-02-24T06:13:06.81575Z","end":"2026-02-24T06:13:07.276391Z","steps":["trace[496271200] 'count revisions from in-memory index tree' (duration: 460.44407ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.283538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.81571Z","time spent":"467.815666ms","remote":"127.0.0.1:53564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"info","ts":"2026-02-24T06:13:07.28516Z","caller":"traceutil/trace.go:171","msg":"trace[1605869801] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"228.226043ms","start":"2026-02-24T06:13:07.04831Z","end":"2026-02-24T06:13:07.276536Z","steps":["trace[1605869801] 'count revisions from in-memory index tree' (duration: 228.146072ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:07.285459Z","caller":"traceutil/trace.go:171","msg":"trace[628370367] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1; }","duration":"242.486404ms","start":"2026-02-24T06:13:07.034041Z","end":"2026-02-24T06:13:07.276527Z","steps":["trace[628370367] 'range keys from in-memory index tree' (duration: 242.406253ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:07.285468Z","caller":"traceutil/trace.go:171","msg":"trace[271836344] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1; }","duration":"266.880328ms","start":"2026-02-24T06:13:07.009553Z","end":"2026-02-24T06:13:07.276434Z","steps":["trace[271836344] 'range keys from in-memory index tree' (duration: 266.793016ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:07.285534Z","caller":"traceutil/trace.go:171","msg":"trace[873638617] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1; }","duration":"255.254133ms","start":"2026-02-24T06:13:07.021155Z","end":"2026-02-24T06:13:07.276409Z","steps":["trace[873638617] 'range keys from in-memory index tree' (duration: 255.120561ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:07.295391Z","caller":"traceutil/trace.go:171","msg":"trace[2065485351] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1; }","duration":"242.163898ms","start":"2026-02-24T06:13:07.034372Z","end":"2026-02-24T06:13:07.276536Z","steps":["trace[2065485351] 'count revisions from in-memory index tree' (duration: 242.001654ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:07.295666Z","caller":"traceutil/trace.go:171","msg":"trace[992129026] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1; }","duration":"266.841658ms","start":"2026-02-24T06:13:07.009599Z","end":"2026-02-24T06:13:07.27644Z","steps":["trace[992129026] 'count revisions from in-memory index tree' (duration: 266.704205ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:07.295812Z","caller":"traceutil/trace.go:171","msg":"trace[35440792] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1; }","duration":"255.337526ms","start":"2026-02-24T06:13:07.021144Z","end":"2026-02-24T06:13:07.276481Z","steps":["trace[35440792] 'count revisions from in-memory index tree' (duration: 255.209683ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:07.295902Z","caller":"traceutil/trace.go:171","msg":"trace[544645287] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1; }","duration":"379.378091ms","start":"2026-02-24T06:13:06.897037Z","end":"2026-02-24T06:13:07.276415Z","steps":["trace[544645287] 'range keys from in-memory index tree' (duration: 379.202607ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.295958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.897016Z","time spent":"398.922332ms","remote":"127.0.0.1:53582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":27,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" limit:10000 "} {"level":"info","ts":"2026-02-24T06:13:07.296145Z","caller":"traceutil/trace.go:171","msg":"trace[56709609] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1; }","duration":"445.65028ms","start":"2026-02-24T06:13:06.830826Z","end":"2026-02-24T06:13:07.276476Z","steps":["trace[56709609] 'range keys from in-memory index tree' (duration: 445.536576ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:07.296248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:06.830799Z","time spent":"465.400765ms","remote":"127.0.0.1:53566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":27,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" limit:10000 "} {"level":"info","ts":"2026-02-24T06:13:07.296382Z","caller":"traceutil/trace.go:171","msg":"trace[1149086713] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1; }","duration":"278.225588ms","start":"2026-02-24T06:13:06.998267Z","end":"2026-02-24T06:13:07.276493Z","steps":["trace[1149086713] 'count revisions from in-memory index tree' (duration: 278.020322ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:36.429488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.674733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-02-24T06:13:36.429586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.167704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:36.429634Z","caller":"traceutil/trace.go:171","msg":"trace[430403850] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:542; }","duration":"194.856998ms","start":"2026-02-24T06:13:36.234731Z","end":"2026-02-24T06:13:36.429588Z","steps":["trace[430403850] 'range keys from in-memory index tree' (duration: 194.567611ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:36.429631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.412201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-24T06:13:36.429689Z","caller":"traceutil/trace.go:171","msg":"trace[1685558341] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:542; }","duration":"133.322778ms","start":"2026-02-24T06:13:36.296343Z","end":"2026-02-24T06:13:36.429665Z","steps":["trace[1685558341] 'range keys from in-memory index tree' (duration: 133.078792ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:36.429729Z","caller":"traceutil/trace.go:171","msg":"trace[1051619386] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:542; }","duration":"216.565355ms","start":"2026-02-24T06:13:36.213143Z","end":"2026-02-24T06:13:36.429708Z","steps":["trace[1051619386] 'range keys from in-memory index tree' (duration: 216.294609ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:36.737025Z","caller":"traceutil/trace.go:171","msg":"trace[1594949090] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"303.469414ms","start":"2026-02-24T06:13:36.433536Z","end":"2026-02-24T06:13:36.737005Z","steps":["trace[1594949090] 'process raft request' (duration: 303.347531ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:36.73752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:36.433519Z","time spent":"303.564667ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:13:36.739674Z","caller":"traceutil/trace.go:171","msg":"trace[766657297] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"306.08063ms","start":"2026-02-24T06:13:36.433578Z","end":"2026-02-24T06:13:36.739659Z","steps":["trace[766657297] 'process raft request' (duration: 305.969787ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:36.739799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:36.433556Z","time spent":"306.176712ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:13:36.739926Z","caller":"traceutil/trace.go:171","msg":"trace[515304369] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:558; }","duration":"244.244582ms","start":"2026-02-24T06:13:36.495662Z","end":"2026-02-24T06:13:36.739907Z","steps":["trace[515304369] 'read index received' (duration: 241.218046ms)","trace[515304369] 'applied index is now lower than readState.Index' (duration: 3.025626ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:13:36.739969Z","caller":"traceutil/trace.go:171","msg":"trace[1713210420] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"306.06668ms","start":"2026-02-24T06:13:36.433884Z","end":"2026-02-24T06:13:36.739951Z","steps":["trace[1713210420] 'process raft request' (duration: 305.752442ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:36.740034Z","caller":"traceutil/trace.go:171","msg":"trace[1773517075] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"306.018448ms","start":"2026-02-24T06:13:36.433976Z","end":"2026-02-24T06:13:36.739995Z","steps":["trace[1773517075] 'process raft request' (duration: 305.857304ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:36.740101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:36.433872Z","time spent":"306.124351ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T06:13:36.740111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.428407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:36.740189Z","caller":"traceutil/trace.go:171","msg":"trace[459267322] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:546; }","duration":"244.56122ms","start":"2026-02-24T06:13:36.495612Z","end":"2026-02-24T06:13:36.740173Z","steps":["trace[459267322] 'agreement among raft nodes before linearized reading' (duration: 244.387156ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:36.740204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:36.433967Z","time spent":"306.147531ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:13:38.28162Z","caller":"traceutil/trace.go:171","msg":"trace[1112370771] linearizableReadLoop","detail":"{readStateIndex:567; appliedIndex:566; }","duration":"185.977994ms","start":"2026-02-24T06:13:38.095615Z","end":"2026-02-24T06:13:38.281593Z","steps":["trace[1112370771] 'read index received' (duration: 185.603925ms)","trace[1112370771] 'applied index is now lower than readState.Index' (duration: 372.959µs)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:13:38.281713Z","caller":"traceutil/trace.go:171","msg":"trace[1145185388] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"214.169505ms","start":"2026-02-24T06:13:38.067519Z","end":"2026-02-24T06:13:38.281688Z","steps":["trace[1145185388] 'process raft request' (duration: 213.790955ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:38.281773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.135939ms","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-02-24T06:13:38.28181Z","caller":"traceutil/trace.go:171","msg":"trace[1218790305] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:551; }","duration":"186.236401ms","start":"2026-02-24T06:13:38.095561Z","end":"2026-02-24T06:13:38.281797Z","steps":["trace[1218790305] 'agreement among raft nodes before linearized reading' (duration: 186.138699ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:39.24193Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255346320482156,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-24T06:13:39.466184Z","caller":"traceutil/trace.go:171","msg":"trace[271400152] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"743.051267ms","start":"2026-02-24T06:13:38.723106Z","end":"2026-02-24T06:13:39.466158Z","steps":["trace[271400152] 'process raft request' (duration: 742.895703ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:39.466316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:38.723077Z","time spent":"743.181141ms","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-24T06:13:39.47103Z","caller":"traceutil/trace.go:171","msg":"trace[1902632204] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:570; }","duration":"730.070141ms","start":"2026-02-24T06:13:38.740918Z","end":"2026-02-24T06:13:39.470988Z","steps":["trace[1902632204] 'read index received' (duration: 725.171447ms)","trace[1902632204] 'applied index is now lower than readState.Index' (duration: 4.897684ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:13:39.471103Z","caller":"traceutil/trace.go:171","msg":"trace[204203837] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"548.845176ms","start":"2026-02-24T06:13:38.92222Z","end":"2026-02-24T06:13:39.471065Z","steps":["trace[204203837] 'process raft request' (duration: 548.523198ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:39.471261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:38.922182Z","time spent":"549.00154ms","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-24T06:13:39.471372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.443791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-24T06:13:39.471441Z","caller":"traceutil/trace.go:171","msg":"trace[294404890] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:556; }","duration":"730.566094ms","start":"2026-02-24T06:13:38.740863Z","end":"2026-02-24T06:13:39.471429Z","steps":["trace[294404890] 'agreement among raft nodes before linearized reading' (duration: 730.297987ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:39.471483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.804919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-02-24T06:13:39.471504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:38.740835Z","time spent":"730.658236ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-24T06:13:39.471522Z","caller":"traceutil/trace.go:171","msg":"trace[1613018243] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:556; }","duration":"728.884961ms","start":"2026-02-24T06:13:38.742626Z","end":"2026-02-24T06:13:39.471511Z","steps":["trace[1613018243] 'agreement among raft nodes before linearized reading' (duration: 728.784099ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:39.471555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:38.742612Z","time spent":"728.936402ms","remote":"127.0.0.1:53442","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-02-24T06:13:39.471618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.565061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-02-24T06:13:39.47166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.830683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-02-24T06:13:39.471669Z","caller":"traceutil/trace.go:171","msg":"trace[1790326368] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:556; }","duration":"354.653384ms","start":"2026-02-24T06:13:39.117004Z","end":"2026-02-24T06:13:39.471657Z","steps":["trace[1790326368] 'agreement among raft nodes before linearized reading' (duration: 354.532821ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:39.471693Z","caller":"traceutil/trace.go:171","msg":"trace[142930861] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:556; }","duration":"374.908664ms","start":"2026-02-24T06:13:39.096774Z","end":"2026-02-24T06:13:39.471683Z","steps":["trace[142930861] 'agreement among raft nodes before linearized reading' (duration: 374.852343ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:39.471707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:39.116979Z","time spent":"354.720305ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-24T06:13:39.471721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:39.096744Z","time spent":"374.971116ms","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9343,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"warn","ts":"2026-02-24T06:13:39.471901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.250739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-24T06:13:39.471938Z","caller":"traceutil/trace.go:171","msg":"trace[963759537] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:556; }","duration":"727.31403ms","start":"2026-02-24T06:13:38.744615Z","end":"2026-02-24T06:13:39.471929Z","steps":["trace[963759537] 'agreement among raft nodes before linearized reading' (duration: 727.250039ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:39.471966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:38.744577Z","time spent":"727.383012ms","remote":"127.0.0.1:53442","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-02-24T06:13:39.472026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.812658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-02-24T06:13:39.472068Z","caller":"traceutil/trace.go:171","msg":"trace[1420551790] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:556; }","duration":"175.89199ms","start":"2026-02-24T06:13:39.296166Z","end":"2026-02-24T06:13:39.472058Z","steps":["trace[1420551790] 'agreement among raft nodes before linearized reading' (duration: 175.788017ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:39.471933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.263279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-24T06:13:39.472421Z","caller":"traceutil/trace.go:171","msg":"trace[1814815790] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:556; }","duration":"727.774892ms","start":"2026-02-24T06:13:38.744632Z","end":"2026-02-24T06:13:39.472407Z","steps":["trace[1814815790] 'agreement among raft nodes before linearized reading' (duration: 727.155017ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:39.472505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:38.744616Z","time spent":"727.873584ms","remote":"127.0.0.1:53442","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-02-24T06:13:43.266189Z","caller":"traceutil/trace.go:171","msg":"trace[1437584778] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"228.511887ms","start":"2026-02-24T06:13:43.03765Z","end":"2026-02-24T06:13:43.266162Z","steps":["trace[1437584778] 'process raft request' (duration: 228.347873ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:13:43.848017Z","caller":"traceutil/trace.go:171","msg":"trace[317552010] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"347.316139ms","start":"2026-02-24T06:13:43.500674Z","end":"2026-02-24T06:13:43.847991Z","steps":["trace[317552010] 'process raft request' (duration: 334.539578ms)","trace[317552010] 'compare' (duration: 12.479204ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T06:13:43.848154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:43.500663Z","time spent":"347.418312ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:13:43.848256Z","caller":"traceutil/trace.go:171","msg":"trace[50636527] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"347.313589ms","start":"2026-02-24T06:13:43.500924Z","end":"2026-02-24T06:13:43.848238Z","steps":["trace[50636527] 'process raft request' (duration: 347.016032ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:43.848372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:43.50091Z","time spent":"347.403121ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:13:43.848541Z","caller":"traceutil/trace.go:171","msg":"trace[909824421] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:596; }","duration":"343.145395ms","start":"2026-02-24T06:13:43.505386Z","end":"2026-02-24T06:13:43.848531Z","steps":["trace[909824421] 'read index received' (duration: 3.96896ms)","trace[909824421] 'applied index is now lower than readState.Index' (duration: 339.175765ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:13:43.848594Z","caller":"traceutil/trace.go:171","msg":"trace[416983434] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"347.108764ms","start":"2026-02-24T06:13:43.501461Z","end":"2026-02-24T06:13:43.84857Z","steps":["trace[416983434] 'process raft request' (duration: 346.691842ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:43.84865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.513904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:43.848679Z","caller":"traceutil/trace.go:171","msg":"trace[1428829321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"210.576405ms","start":"2026-02-24T06:13:43.638093Z","end":"2026-02-24T06:13:43.84867Z","steps":["trace[1428829321] 'agreement among raft nodes before linearized reading' (duration: 210.504203ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:43.848691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:43.501435Z","time spent":"347.212637ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T06:13:43.848706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.310479ms","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-02-24T06:13:43.848766Z","caller":"traceutil/trace.go:171","msg":"trace[1737664747] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:582; }","duration":"343.39014ms","start":"2026-02-24T06:13:43.505365Z","end":"2026-02-24T06:13:43.848755Z","steps":["trace[1737664747] 'agreement among raft nodes before linearized reading' (duration: 343.211446ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:43.848799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:43.505356Z","time spent":"343.435962ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-24T06:13:45.168512Z","caller":"traceutil/trace.go:171","msg":"trace[132203136] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"330.102066ms","start":"2026-02-24T06:13:44.83837Z","end":"2026-02-24T06:13:45.168472Z","steps":["trace[132203136] 'read index received' (duration: 293.243057ms)","trace[132203136] 'applied index is now lower than readState.Index' (duration: 36.809087ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T06:13:45.168528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.121806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:45.168624Z","caller":"traceutil/trace.go:171","msg":"trace[203676192] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:583; }","duration":"330.266259ms","start":"2026-02-24T06:13:44.83834Z","end":"2026-02-24T06:13:45.168607Z","steps":["trace[203676192] 'agreement among raft nodes before linearized reading' (duration: 330.088955ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:45.168775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.2985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:45.168817Z","caller":"traceutil/trace.go:171","msg":"trace[1415324462] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:583; }","duration":"330.385452ms","start":"2026-02-24T06:13:44.838419Z","end":"2026-02-24T06:13:45.168804Z","steps":["trace[1415324462] 'agreement among raft nodes before linearized reading' (duration: 330.28683ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:45.168846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:44.838319Z","time spent":"330.496585ms","remote":"127.0.0.1:47030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 "} {"level":"warn","ts":"2026-02-24T06:13:45.168914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.09083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:45.168951Z","caller":"traceutil/trace.go:171","msg":"trace[1367923537] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:583; }","duration":"273.142311ms","start":"2026-02-24T06:13:44.8958Z","end":"2026-02-24T06:13:45.168942Z","steps":["trace[1367923537] 'agreement among raft nodes before linearized reading' (duration: 273.09269ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:45.168858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:44.838403Z","time spent":"330.442744ms","remote":"127.0.0.1:47030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-02-24T06:13:45.169227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.30855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:45.169266Z","caller":"traceutil/trace.go:171","msg":"trace[54553729] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:583; }","duration":"274.368941ms","start":"2026-02-24T06:13:44.894888Z","end":"2026-02-24T06:13:45.169257Z","steps":["trace[54553729] 'agreement among raft nodes before linearized reading' (duration: 274.31305ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:45.169313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.150029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:45.169354Z","caller":"traceutil/trace.go:171","msg":"trace[1366791517] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:583; }","duration":"292.2046ms","start":"2026-02-24T06:13:44.877137Z","end":"2026-02-24T06:13:45.169342Z","steps":["trace[1366791517] 'agreement among raft nodes before linearized reading' (duration: 292.136499ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:45.169397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.242271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:45.169427Z","caller":"traceutil/trace.go:171","msg":"trace[416618401] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:583; }","duration":"313.288962ms","start":"2026-02-24T06:13:44.856129Z","end":"2026-02-24T06:13:45.169418Z","steps":["trace[416618401] 'agreement among raft nodes before linearized reading' (duration: 313.243531ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:45.169467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:44.856121Z","time spent":"313.336853ms","remote":"127.0.0.1:47032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "} {"level":"warn","ts":"2026-02-24T06:13:45.169594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.752161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-24T06:13:45.169644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.350349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:45.169686Z","caller":"traceutil/trace.go:171","msg":"trace[2110694568] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:583; }","duration":"314.41619ms","start":"2026-02-24T06:13:44.85526Z","end":"2026-02-24T06:13:45.169676Z","steps":["trace[2110694568] 'agreement among raft nodes before linearized reading' (duration: 314.340808ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:45.169723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:44.855248Z","time spent":"314.466702ms","remote":"127.0.0.1:47032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"info","ts":"2026-02-24T06:13:45.169637Z","caller":"traceutil/trace.go:171","msg":"trace[1190412189] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:583; }","duration":"274.819082ms","start":"2026-02-24T06:13:44.894807Z","end":"2026-02-24T06:13:45.169626Z","steps":["trace[1190412189] 'agreement among raft nodes before linearized reading' (duration: 274.751891ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:45.169861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.649546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:45.169899Z","caller":"traceutil/trace.go:171","msg":"trace[794083002] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:583; }","duration":"314.696567ms","start":"2026-02-24T06:13:44.855192Z","end":"2026-02-24T06:13:45.169889Z","steps":["trace[794083002] 'agreement among raft nodes before linearized reading' (duration: 314.644446ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:45.169936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:44.855185Z","time spent":"314.742238ms","remote":"127.0.0.1:47032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-02-24T06:13:45.170068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.630048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:45.170098Z","caller":"traceutil/trace.go:171","msg":"trace[1655618610] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:583; }","duration":"330.6888ms","start":"2026-02-24T06:13:44.839401Z","end":"2026-02-24T06:13:45.17009Z","steps":["trace[1655618610] 'agreement among raft nodes before linearized reading' (duration: 330.644439ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:45.170126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:13:44.839382Z","time spent":"330.736581ms","remote":"127.0.0.1:47030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 "} {"level":"warn","ts":"2026-02-24T06:13:45.170234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.269502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:45.170301Z","caller":"traceutil/trace.go:171","msg":"trace[1875681993] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:583; }","duration":"292.493208ms","start":"2026-02-24T06:13:44.877796Z","end":"2026-02-24T06:13:45.170289Z","steps":["trace[1875681993] 'agreement among raft nodes before linearized reading' (duration: 292.264252ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:45.170569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.040441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:45.170614Z","caller":"traceutil/trace.go:171","msg":"trace[446899577] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"293.096953ms","start":"2026-02-24T06:13:44.877504Z","end":"2026-02-24T06:13:45.170601Z","steps":["trace[446899577] 'agreement among raft nodes before linearized reading' (duration: 293.032101ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:13:45.170835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.567475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:13:45.170883Z","caller":"traceutil/trace.go:171","msg":"trace[502251860] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:583; }","duration":"293.631916ms","start":"2026-02-24T06:13:44.877237Z","end":"2026-02-24T06:13:45.170869Z","steps":["trace[502251860] 'agreement among raft nodes before linearized reading' (duration: 293.568945ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:06.422469Z","caller":"traceutil/trace.go:171","msg":"trace[282285156] linearizableReadLoop","detail":"{readStateIndex:759; appliedIndex:758; }","duration":"457.396773ms","start":"2026-02-24T06:14:05.965053Z","end":"2026-02-24T06:14:06.42245Z","steps":["trace[282285156] 'read index received' (duration: 457.334451ms)","trace[282285156] 'applied index is now lower than readState.Index' (duration: 61.512µs)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:14:06.422571Z","caller":"traceutil/trace.go:171","msg":"trace[279897247] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"734.966795ms","start":"2026-02-24T06:14:05.687549Z","end":"2026-02-24T06:14:06.422515Z","steps":["trace[279897247] 'process raft request' (duration: 734.78305ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:06.422649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.585697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-24T06:14:06.422688Z","caller":"traceutil/trace.go:171","msg":"trace[1972898773] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:735; }","duration":"457.666849ms","start":"2026-02-24T06:14:05.965006Z","end":"2026-02-24T06:14:06.422673Z","steps":["trace[1972898773] 'agreement among raft nodes before linearized reading' (duration: 457.540906ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:06.422724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:05.964985Z","time spent":"457.732762ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-24T06:14:06.422743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:05.687531Z","time spent":"735.121879ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:14:06.927337Z","caller":"traceutil/trace.go:171","msg":"trace[1700997556] linearizableReadLoop","detail":"{readStateIndex:760; appliedIndex:759; }","duration":"504.784447ms","start":"2026-02-24T06:14:06.422525Z","end":"2026-02-24T06:14:06.92731Z","steps":["trace[1700997556] 'read index received' (duration: 492.619631ms)","trace[1700997556] 'applied index is now lower than readState.Index' (duration: 12.163196ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:14:06.927427Z","caller":"traceutil/trace.go:171","msg":"trace[1785739947] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"675.056226ms","start":"2026-02-24T06:14:06.252364Z","end":"2026-02-24T06:14:06.92742Z","steps":["trace[1785739947] 'process raft request' (duration: 662.768807ms)","trace[1785739947] 'compare' (duration: 11.781437ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T06:14:06.927499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:06.252341Z","time spent":"675.103618ms","remote":"127.0.0.1:53244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":817,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-24T06:14:06.927744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.370387ms","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-02-24T06:14:06.927767Z","caller":"traceutil/trace.go:171","msg":"trace[236253040] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:736; }","duration":"924.420908ms","start":"2026-02-24T06:14:06.00334Z","end":"2026-02-24T06:14:06.927761Z","steps":["trace[236253040] 'agreement among raft nodes before linearized reading' (duration: 924.299505ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:06.927788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:06.003331Z","time spent":"924.451828ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-24T06:14:06.927951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.305256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-24T06:14:06.928006Z","caller":"traceutil/trace.go:171","msg":"trace[393675232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:736; }","duration":"959.366738ms","start":"2026-02-24T06:14:05.968625Z","end":"2026-02-24T06:14:06.927991Z","steps":["trace[393675232] 'agreement among raft nodes before linearized reading' (duration: 959.200203ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:06.92803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:05.968604Z","time spent":"959.422189ms","remote":"127.0.0.1:53442","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-02-24T06:14:06.928071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.549298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-24T06:14:06.928148Z","caller":"traceutil/trace.go:171","msg":"trace[1859058506] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:736; }","duration":"958.65753ms","start":"2026-02-24T06:14:05.96947Z","end":"2026-02-24T06:14:06.928127Z","steps":["trace[1859058506] 'agreement among raft nodes before linearized reading' (duration: 958.384883ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:06.928191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:05.969461Z","time spent":"958.722312ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-24T06:14:06.942258Z","caller":"traceutil/trace.go:171","msg":"trace[1330261110] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"515.826925ms","start":"2026-02-24T06:14:06.426411Z","end":"2026-02-24T06:14:06.942238Z","steps":["trace[1330261110] 'process raft request' (duration: 515.645581ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:06.942395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:06.426385Z","time spent":"515.936488ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:14:07.195514Z","caller":"traceutil/trace.go:171","msg":"trace[1161278181] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"264.107505ms","start":"2026-02-24T06:14:06.931389Z","end":"2026-02-24T06:14:07.195496Z","steps":["trace[1161278181] 'process raft request' (duration: 263.962232ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:07.195748Z","caller":"traceutil/trace.go:171","msg":"trace[1798704577] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"264.313671ms","start":"2026-02-24T06:14:06.931412Z","end":"2026-02-24T06:14:07.195726Z","steps":["trace[1798704577] 'process raft request' (duration: 264.059145ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:07.195827Z","caller":"traceutil/trace.go:171","msg":"trace[1171717107] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"264.118706ms","start":"2026-02-24T06:14:06.931689Z","end":"2026-02-24T06:14:07.195808Z","steps":["trace[1171717107] 'process raft request' (duration: 263.987723ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:07.195835Z","caller":"traceutil/trace.go:171","msg":"trace[691544591] linearizableReadLoop","detail":"{readStateIndex:764; appliedIndex:761; }","duration":"253.019226ms","start":"2026-02-24T06:14:06.942788Z","end":"2026-02-24T06:14:07.195808Z","steps":["trace[691544591] 'read index received' (duration: 252.549554ms)","trace[691544591] 'applied index is now lower than readState.Index' (duration: 468.172µs)"],"step_count":2} {"level":"warn","ts":"2026-02-24T06:14:07.195953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.141099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:14:07.195985Z","caller":"traceutil/trace.go:171","msg":"trace[405312082] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:740; }","duration":"253.209841ms","start":"2026-02-24T06:14:06.942766Z","end":"2026-02-24T06:14:07.195975Z","steps":["trace[405312082] 'agreement among raft nodes before linearized reading' (duration: 253.140199ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:25.735441Z","caller":"traceutil/trace.go:171","msg":"trace[1842805134] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"344.011158ms","start":"2026-02-24T06:14:25.391402Z","end":"2026-02-24T06:14:25.735413Z","steps":["trace[1842805134] 'process raft request' (duration: 343.833094ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:25.735613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:25.39138Z","time spent":"344.143242ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:14:25.854562Z","caller":"traceutil/trace.go:171","msg":"trace[831162885] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:824; }","duration":"426.164298ms","start":"2026-02-24T06:14:25.428372Z","end":"2026-02-24T06:14:25.854537Z","steps":["trace[831162885] 'read index received' (duration: 306.845672ms)","trace[831162885] 'applied index is now lower than readState.Index' (duration: 119.317326ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T06:14:25.854838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.402483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:14:25.854988Z","caller":"traceutil/trace.go:171","msg":"trace[533793600] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:797; }","duration":"426.594188ms","start":"2026-02-24T06:14:25.428351Z","end":"2026-02-24T06:14:25.854946Z","steps":["trace[533793600] 'agreement among raft nodes before linearized reading' (duration: 426.300551ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:25.855111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:25.428269Z","time spent":"426.817824ms","remote":"127.0.0.1:53336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"info","ts":"2026-02-24T06:14:25.855293Z","caller":"traceutil/trace.go:171","msg":"trace[1531744042] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"462.873123ms","start":"2026-02-24T06:14:25.392355Z","end":"2026-02-24T06:14:25.855228Z","steps":["trace[1531744042] 'process raft request' (duration: 445.532845ms)","trace[1531744042] 'compare' (duration: 16.445925ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T06:14:25.855722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:25.392341Z","time spent":"463.080849ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:14:26.695771Z","caller":"traceutil/trace.go:171","msg":"trace[1092830683] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"169.85987ms","start":"2026-02-24T06:14:26.525865Z","end":"2026-02-24T06:14:26.695725Z","steps":["trace[1092830683] 'process raft request' (duration: 169.603943ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:27.557888Z","caller":"traceutil/trace.go:171","msg":"trace[103769490] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"160.281939ms","start":"2026-02-24T06:14:27.397581Z","end":"2026-02-24T06:14:27.557863Z","steps":["trace[103769490] 'process raft request' (duration: 160.088074ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:28.218511Z","caller":"traceutil/trace.go:171","msg":"trace[2002459890] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:830; }","duration":"337.75748ms","start":"2026-02-24T06:14:27.880728Z","end":"2026-02-24T06:14:28.218486Z","steps":["trace[2002459890] 'read index received' (duration: 337.597876ms)","trace[2002459890] 'applied index is now lower than readState.Index' (duration: 158.384µs)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:14:28.218535Z","caller":"traceutil/trace.go:171","msg":"trace[1446257042] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"353.984609ms","start":"2026-02-24T06:14:27.864519Z","end":"2026-02-24T06:14:28.218503Z","steps":["trace[1446257042] 'process raft request' (duration: 353.821805ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:28.21867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.924123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:14:28.218857Z","caller":"traceutil/trace.go:171","msg":"trace[1311973393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:802; }","duration":"338.157709ms","start":"2026-02-24T06:14:27.880687Z","end":"2026-02-24T06:14:28.218844Z","steps":["trace[1311973393] 'agreement among raft nodes before linearized reading' (duration: 337.902123ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:28.218896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:27.880671Z","time spent":"338.214161ms","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-24T06:14:28.218996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:27.864498Z","time spent":"354.242225ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:14:36.469471Z","caller":"traceutil/trace.go:171","msg":"trace[1220185062] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"166.181737ms","start":"2026-02-24T06:14:36.303268Z","end":"2026-02-24T06:14:36.46945Z","steps":["trace[1220185062] 'process raft request' (duration: 166.037853ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:36.469534Z","caller":"traceutil/trace.go:171","msg":"trace[445109093] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"167.062979ms","start":"2026-02-24T06:14:36.302443Z","end":"2026-02-24T06:14:36.469506Z","steps":["trace[445109093] 'process raft request' (duration: 72.488657ms)","trace[445109093] 'compare' (duration: 94.241544ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:14:36.479049Z","caller":"traceutil/trace.go:171","msg":"trace[1291292280] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"172.269911ms","start":"2026-02-24T06:14:36.306759Z","end":"2026-02-24T06:14:36.479028Z","steps":["trace[1291292280] 'process raft request' (duration: 172.143198ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:36.479116Z","caller":"traceutil/trace.go:171","msg":"trace[714791544] linearizableReadLoop","detail":"{readStateIndex:892; appliedIndex:887; }","duration":"169.221873ms","start":"2026-02-24T06:14:36.309872Z","end":"2026-02-24T06:14:36.479094Z","steps":["trace[714791544] 'read index received' (duration: 65.10164ms)","trace[714791544] 'applied index is now lower than readState.Index' (duration: 104.119413ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:14:36.47931Z","caller":"traceutil/trace.go:171","msg":"trace[1780785224] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"172.528197ms","start":"2026-02-24T06:14:36.306709Z","end":"2026-02-24T06:14:36.479237Z","steps":["trace[1780785224] 'process raft request' (duration: 172.128978ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:36.479362Z","caller":"traceutil/trace.go:171","msg":"trace[648245597] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"166.31075ms","start":"2026-02-24T06:14:36.313041Z","end":"2026-02-24T06:14:36.479351Z","steps":["trace[648245597] 'process raft request' (duration: 165.925381ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:36.479498Z","caller":"traceutil/trace.go:171","msg":"trace[570234262] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"164.913425ms","start":"2026-02-24T06:14:36.314579Z","end":"2026-02-24T06:14:36.479492Z","steps":["trace[570234262] 'process raft request' (duration: 164.492134ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:36.479358Z","caller":"traceutil/trace.go:171","msg":"trace[420304218] transaction","detail":"{read_only:false; response_revision:859; number_of_response:1; }","duration":"170.819804ms","start":"2026-02-24T06:14:36.308304Z","end":"2026-02-24T06:14:36.479124Z","steps":["trace[420304218] 'process raft request' (duration: 170.618479ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:36.479635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.751457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-vpq52\" ","response":"range_response_count:1 size:9629"} {"level":"info","ts":"2026-02-24T06:14:36.479664Z","caller":"traceutil/trace.go:171","msg":"trace[1233181604] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-vpq52; range_end:; response_count:1; response_revision:861; }","duration":"169.816149ms","start":"2026-02-24T06:14:36.30984Z","end":"2026-02-24T06:14:36.479656Z","steps":["trace[1233181604] 'agreement among raft nodes before linearized reading' (duration: 169.721307ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:36.541318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.170725ms","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:7"} {"level":"info","ts":"2026-02-24T06:14:36.541396Z","caller":"traceutil/trace.go:171","msg":"trace[1826257948] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:864; }","duration":"156.268177ms","start":"2026-02-24T06:14:36.385108Z","end":"2026-02-24T06:14:36.541376Z","steps":["trace[1826257948] 'agreement among raft nodes before linearized reading' (duration: 156.109703ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:38.753614Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255346320482870,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-24T06:14:38.845569Z","caller":"traceutil/trace.go:171","msg":"trace[1636734626] linearizableReadLoop","detail":"{readStateIndex:913; appliedIndex:912; }","duration":"591.969337ms","start":"2026-02-24T06:14:38.253578Z","end":"2026-02-24T06:14:38.845547Z","steps":["trace[1636734626] 'read index received' (duration: 591.788552ms)","trace[1636734626] 'applied index is now lower than readState.Index' (duration: 179.835µs)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:14:38.845665Z","caller":"traceutil/trace.go:171","msg":"trace[119910604] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"982.692851ms","start":"2026-02-24T06:14:37.862956Z","end":"2026-02-24T06:14:38.845649Z","steps":["trace[119910604] 'process raft request' (duration: 982.473866ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:38.845742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.145261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-24T06:14:38.845753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.893681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-02-24T06:14:38.84577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:37.862929Z","time spent":"982.769783ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:14:38.84578Z","caller":"traceutil/trace.go:171","msg":"trace[845951235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:880; }","duration":"573.944341ms","start":"2026-02-24T06:14:38.271829Z","end":"2026-02-24T06:14:38.845773Z","steps":["trace[845951235] 'agreement among raft nodes before linearized reading' (duration: 573.826168ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:38.84578Z","caller":"traceutil/trace.go:171","msg":"trace[1525154043] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:880; }","duration":"592.226043ms","start":"2026-02-24T06:14:38.253544Z","end":"2026-02-24T06:14:38.84577Z","steps":["trace[1525154043] 'agreement among raft nodes before linearized reading' (duration: 592.10695ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:38.8458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:38.271817Z","time spent":"573.977383ms","remote":"127.0.0.1:53442","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-02-24T06:14:38.845804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:38.253526Z","time spent":"592.271844ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":7,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-02-24T06:14:40.380504Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255346320482889,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-24T06:14:40.720297Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.113144577s","expected-duration":"1s"} {"level":"info","ts":"2026-02-24T06:14:40.7207Z","caller":"traceutil/trace.go:171","msg":"trace[702833752] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"1.1136166s","start":"2026-02-24T06:14:39.607056Z","end":"2026-02-24T06:14:40.720673Z","steps":["trace[702833752] 'process raft request' (duration: 1.113461786s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:40.720825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:39.60698Z","time spent":"1.113766274s","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:14:41.400229Z","caller":"traceutil/trace.go:171","msg":"trace[1128709052] linearizableReadLoop","detail":"{readStateIndex:920; appliedIndex:918; }","duration":"1.520650726s","start":"2026-02-24T06:14:39.87956Z","end":"2026-02-24T06:14:41.40021Z","steps":["trace[1128709052] 'read index received' (duration: 840.953769ms)","trace[1128709052] 'applied index is now lower than readState.Index' (duration: 679.696057ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:14:41.400328Z","caller":"traceutil/trace.go:171","msg":"trace[1264681605] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"1.508528401s","start":"2026-02-24T06:14:39.891762Z","end":"2026-02-24T06:14:41.40029Z","steps":["trace[1264681605] 'process raft request' (duration: 1.508308545s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:41.400422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.631655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-24T06:14:41.400456Z","caller":"traceutil/trace.go:171","msg":"trace[106161241] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:886; }","duration":"550.696977ms","start":"2026-02-24T06:14:40.849747Z","end":"2026-02-24T06:14:41.400444Z","steps":["trace[106161241] 'agreement among raft nodes before linearized reading' (duration: 550.589334ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:41.400464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.160715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-02-24T06:14:41.400489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:40.849726Z","time spent":"550.754238ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-24T06:14:41.400494Z","caller":"traceutil/trace.go:171","msg":"trace[629351161] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:886; }","duration":"285.212617ms","start":"2026-02-24T06:14:41.115271Z","end":"2026-02-24T06:14:41.400483Z","steps":["trace[629351161] 'agreement among raft nodes before linearized reading' (duration: 285.140645ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:41.400521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:39.891739Z","time spent":"1.508684045s","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T06:14:41.400635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.331086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-24T06:14:41.40037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.5207911s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:14:41.400666Z","caller":"traceutil/trace.go:171","msg":"trace[234818713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:886; }","duration":"546.407068ms","start":"2026-02-24T06:14:40.854251Z","end":"2026-02-24T06:14:41.400658Z","steps":["trace[234818713] 'agreement among raft nodes before linearized reading' (duration: 546.323356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:41.40064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.651819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-02-24T06:14:41.400693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:40.854217Z","time spent":"546.46876ms","remote":"127.0.0.1:53442","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":"info","ts":"2026-02-24T06:14:41.40069Z","caller":"traceutil/trace.go:171","msg":"trace[1719343940] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:886; }","duration":"1.521158668s","start":"2026-02-24T06:14:39.879519Z","end":"2026-02-24T06:14:41.400678Z","steps":["trace[1719343940] 'agreement among raft nodes before linearized reading' (duration: 1.520791519s)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:41.400717Z","caller":"traceutil/trace.go:171","msg":"trace[1124800909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:886; }","duration":"543.779412ms","start":"2026-02-24T06:14:40.856918Z","end":"2026-02-24T06:14:41.400697Z","steps":["trace[1124800909] 'agreement among raft nodes before linearized reading' (duration: 543.569637ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:41.400732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:39.879501Z","time spent":"1.521221681s","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-24T06:14:41.400765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:40.856895Z","time spent":"543.859973ms","remote":"127.0.0.1:53442","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-02-24T06:14:43.612581Z","caller":"traceutil/trace.go:171","msg":"trace[715625598] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"192.150831ms","start":"2026-02-24T06:14:43.420402Z","end":"2026-02-24T06:14:43.612552Z","steps":["trace[715625598] 'process raft request' (duration: 111.442348ms)","trace[715625598] 'compare' (duration: 80.518039ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:14:43.612647Z","caller":"traceutil/trace.go:171","msg":"trace[1756001278] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"192.086589ms","start":"2026-02-24T06:14:43.420538Z","end":"2026-02-24T06:14:43.612625Z","steps":["trace[1756001278] 'process raft request' (duration: 191.990717ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:43.612593Z","caller":"traceutil/trace.go:171","msg":"trace[1372708361] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"192.12099ms","start":"2026-02-24T06:14:43.420453Z","end":"2026-02-24T06:14:43.612574Z","steps":["trace[1372708361] 'process raft request' (duration: 192.025317ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:53.8512Z","caller":"traceutil/trace.go:171","msg":"trace[1395483713] linearizableReadLoop","detail":"{readStateIndex:958; appliedIndex:957; }","duration":"178.766965ms","start":"2026-02-24T06:14:53.672401Z","end":"2026-02-24T06:14:53.851168Z","steps":["trace[1395483713] 'read index received' (duration: 178.55539ms)","trace[1395483713] 'applied index is now lower than readState.Index' (duration: 210.655µs)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:14:53.851456Z","caller":"traceutil/trace.go:171","msg":"trace[1841896909] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"189.365761ms","start":"2026-02-24T06:14:53.662079Z","end":"2026-02-24T06:14:53.851445Z","steps":["trace[1841896909] 'process raft request' (duration: 188.969371ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:53.851776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.35682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-24T06:14:53.851818Z","caller":"traceutil/trace.go:171","msg":"trace[492853295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:922; }","duration":"179.429701ms","start":"2026-02-24T06:14:53.672378Z","end":"2026-02-24T06:14:53.851808Z","steps":["trace[492853295] 'agreement among raft nodes before linearized reading' (duration: 179.299378ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:53.852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.544753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-24T06:14:53.852033Z","caller":"traceutil/trace.go:171","msg":"trace[743661810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:922; }","duration":"179.595245ms","start":"2026-02-24T06:14:53.67243Z","end":"2026-02-24T06:14:53.852025Z","steps":["trace[743661810] 'agreement among raft nodes before linearized reading' (duration: 179.514533ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:58.74105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.239829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-24T06:14:58.741114Z","caller":"traceutil/trace.go:171","msg":"trace[1490567892] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:951; }","duration":"822.368291ms","start":"2026-02-24T06:14:57.918731Z","end":"2026-02-24T06:14:58.741099Z","steps":["trace[1490567892] 'range keys from in-memory index tree' (duration: 822.084034ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:58.741141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:57.918714Z","time spent":"822.421192ms","remote":"127.0.0.1:53442","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-02-24T06:14:58.741394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.128601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-24T06:14:58.741468Z","caller":"traceutil/trace.go:171","msg":"trace[2024547009] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:951; }","duration":"877.235133ms","start":"2026-02-24T06:14:57.864212Z","end":"2026-02-24T06:14:58.741447Z","steps":["trace[2024547009] 'range keys from in-memory index tree' (duration: 876.943966ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:58.741449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.601446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-02-24T06:14:58.74151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:57.864196Z","time spent":"877.305365ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-24T06:14:58.741525Z","caller":"traceutil/trace.go:171","msg":"trace[112237189] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:951; }","duration":"849.72074ms","start":"2026-02-24T06:14:57.891784Z","end":"2026-02-24T06:14:58.741505Z","steps":["trace[112237189] 'range keys from in-memory index tree' (duration: 849.379461ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:58.741566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:57.891762Z","time spent":"849.794122ms","remote":"127.0.0.1:53442","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-02-24T06:14:59.179156Z","caller":"traceutil/trace.go:171","msg":"trace[1439720615] linearizableReadLoop","detail":"{readStateIndex:991; appliedIndex:989; }","duration":"350.276296ms","start":"2026-02-24T06:14:58.828857Z","end":"2026-02-24T06:14:59.179133Z","steps":["trace[1439720615] 'read index received' (duration: 348.05572ms)","trace[1439720615] 'applied index is now lower than readState.Index' (duration: 2.219576ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:14:59.179568Z","caller":"traceutil/trace.go:171","msg":"trace[184086443] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"431.608825ms","start":"2026-02-24T06:14:58.747923Z","end":"2026-02-24T06:14:59.179532Z","steps":["trace[184086443] 'process raft request' (duration: 431.161544ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:14:59.179583Z","caller":"traceutil/trace.go:171","msg":"trace[1038759913] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"432.318413ms","start":"2026-02-24T06:14:58.747188Z","end":"2026-02-24T06:14:59.179506Z","steps":["trace[1038759913] 'process raft request' (duration: 429.816709ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:59.179922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.692477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:14:59.180019Z","caller":"traceutil/trace.go:171","msg":"trace[189877344] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:954; }","duration":"302.835261ms","start":"2026-02-24T06:14:58.877161Z","end":"2026-02-24T06:14:59.179997Z","steps":["trace[189877344] 'agreement among raft nodes before linearized reading' (duration: 302.665797ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:59.179642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.766999ms","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":"warn","ts":"2026-02-24T06:14:59.180079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:58.877146Z","time spent":"302.921753ms","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-24T06:14:59.180046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:58.747169Z","time spent":"432.792135ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:14:59.180132Z","caller":"traceutil/trace.go:171","msg":"trace[1767863797] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:954; }","duration":"351.288711ms","start":"2026-02-24T06:14:58.828821Z","end":"2026-02-24T06:14:59.180109Z","steps":["trace[1767863797] 'agreement among raft nodes before linearized reading' (duration: 350.708726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:14:59.180351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:58.828803Z","time spent":"351.496456ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-24T06:14:59.180797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:14:58.7479Z","time spent":"431.969884ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:14:59.358776Z","caller":"traceutil/trace.go:171","msg":"trace[2044647020] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"103.715503ms","start":"2026-02-24T06:14:59.255028Z","end":"2026-02-24T06:14:59.358744Z","steps":["trace[2044647020] 'process raft request' (duration: 27.880482ms)","trace[2044647020] 'compare' (duration: 75.708428ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T06:14:59.707818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.507454ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-24T06:14:59.708237Z","caller":"traceutil/trace.go:171","msg":"trace[222954865] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"271.790638ms","start":"2026-02-24T06:14:59.436427Z","end":"2026-02-24T06:14:59.708218Z","steps":["trace[222954865] 'process raft request' (duration: 112.666048ms)","trace[222954865] 'compare' (duration: 158.403642ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T06:15:00.471276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.347911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:15:00.471358Z","caller":"traceutil/trace.go:171","msg":"trace[1496630010] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:959; }","duration":"295.489195ms","start":"2026-02-24T06:15:00.175849Z","end":"2026-02-24T06:15:00.471339Z","steps":["trace[1496630010] 'range keys from in-memory index tree' (duration: 295.226248ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:15:00.791158Z","caller":"traceutil/trace.go:171","msg":"trace[771151994] linearizableReadLoop","detail":"{readStateIndex:999; appliedIndex:998; }","duration":"266.754882ms","start":"2026-02-24T06:15:00.524379Z","end":"2026-02-24T06:15:00.791134Z","steps":["trace[771151994] 'read index received' (duration: 180.761125ms)","trace[771151994] 'applied index is now lower than readState.Index' (duration: 85.992737ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:15:00.791177Z","caller":"traceutil/trace.go:171","msg":"trace[170800769] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"313.355806ms","start":"2026-02-24T06:15:00.477792Z","end":"2026-02-24T06:15:00.791148Z","steps":["trace[170800769] 'process raft request' (duration: 227.334528ms)","trace[170800769] 'compare' (duration: 85.896454ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T06:15:00.791315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:00.477769Z","time spent":"313.488389ms","remote":"127.0.0.1:53244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":790,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-24T06:15:00.791484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.08835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-24T06:15:00.791536Z","caller":"traceutil/trace.go:171","msg":"trace[893445904] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:961; }","duration":"267.181513ms","start":"2026-02-24T06:15:00.524341Z","end":"2026-02-24T06:15:00.791522Z","steps":["trace[893445904] 'agreement among raft nodes before linearized reading' (duration: 266.884186ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:15:00.850623Z","caller":"traceutil/trace.go:171","msg":"trace[581554332] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"323.270886ms","start":"2026-02-24T06:15:00.527324Z","end":"2026-02-24T06:15:00.850595Z","steps":["trace[581554332] 'process raft request' (duration: 323.078552ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:00.850744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.148248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-02-24T06:15:00.85084Z","caller":"traceutil/trace.go:171","msg":"trace[831409024] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:962; }","duration":"326.320393ms","start":"2026-02-24T06:15:00.524502Z","end":"2026-02-24T06:15:00.850822Z","steps":["trace[831409024] 'agreement among raft nodes before linearized reading' (duration: 326.062997ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:00.850887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:00.524478Z","time spent":"326.399284ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-24T06:15:00.850759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:00.527306Z","time spent":"323.384999ms","remote":"127.0.0.1:53244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":772,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-24T06:15:01.378444Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255346320483066,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-24T06:15:01.59008Z","caller":"traceutil/trace.go:171","msg":"trace[746241353] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"778.756102ms","start":"2026-02-24T06:15:00.811295Z","end":"2026-02-24T06:15:01.590051Z","steps":["trace[746241353] 'process raft request' (duration: 763.129758ms)","trace[746241353] 'compare' (duration: 15.354318ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T06:15:01.59021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:00.811265Z","time spent":"778.880996ms","remote":"127.0.0.1:53244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":816,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-24T06:15:01.641167Z","caller":"traceutil/trace.go:171","msg":"trace[575275666] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"785.929364ms","start":"2026-02-24T06:15:00.855223Z","end":"2026-02-24T06:15:01.641152Z","steps":["trace[575275666] 'process raft request' (duration: 785.811961ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:01.641273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:00.855201Z","time spent":"786.013725ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:15:01.6414Z","caller":"traceutil/trace.go:171","msg":"trace[1009864216] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1000; }","duration":"763.692823ms","start":"2026-02-24T06:15:00.877681Z","end":"2026-02-24T06:15:01.641373Z","steps":["trace[1009864216] 'read index received' (duration: 696.770767ms)","trace[1009864216] 'applied index is now lower than readState.Index' (duration: 66.920916ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:15:01.641554Z","caller":"traceutil/trace.go:171","msg":"trace[1704122446] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"786.113539ms","start":"2026-02-24T06:15:00.855435Z","end":"2026-02-24T06:15:01.641548Z","steps":["trace[1704122446] 'process raft request' (duration: 785.688248ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:01.641592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:00.855429Z","time spent":"786.146089ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T06:15:01.641688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"763.992671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:15:01.641772Z","caller":"traceutil/trace.go:171","msg":"trace[307335657] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:965; }","duration":"764.127714ms","start":"2026-02-24T06:15:00.87763Z","end":"2026-02-24T06:15:01.641758Z","steps":["trace[307335657] 'agreement among raft nodes before linearized reading' (duration: 764.005131ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:01.641813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:00.877605Z","time spent":"764.200286ms","remote":"127.0.0.1:53150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-24T06:15:01.642156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.000703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:15:01.642203Z","caller":"traceutil/trace.go:171","msg":"trace[1703223133] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:965; }","duration":"478.104887ms","start":"2026-02-24T06:15:01.164088Z","end":"2026-02-24T06:15:01.642193Z","steps":["trace[1703223133] 'agreement among raft nodes before linearized reading' (duration: 478.024405ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:01.642238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:01.164063Z","time spent":"478.166958ms","remote":"127.0.0.1:47028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-02-24T06:15:01.642266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.497585ms","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":"warn","ts":"2026-02-24T06:15:01.642283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.77684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-24T06:15:01.642297Z","caller":"traceutil/trace.go:171","msg":"trace[142034822] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:965; }","duration":"370.560567ms","start":"2026-02-24T06:15:01.27173Z","end":"2026-02-24T06:15:01.64229Z","steps":["trace[142034822] 'agreement among raft nodes before linearized reading' (duration: 370.456565ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:01.642316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:01.271709Z","time spent":"370.603358ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-24T06:15:01.642319Z","caller":"traceutil/trace.go:171","msg":"trace[1964064747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:965; }","duration":"456.826951ms","start":"2026-02-24T06:15:01.185481Z","end":"2026-02-24T06:15:01.642308Z","steps":["trace[1964064747] 'agreement among raft nodes before linearized reading' (duration: 456.709248ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:01.64235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:01.185472Z","time spent":"456.871702ms","remote":"127.0.0.1:53442","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-02-24T06:15:01.64216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.940562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-24T06:15:01.642442Z","caller":"traceutil/trace.go:171","msg":"trace[1974077162] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:965; }","duration":"451.283471ms","start":"2026-02-24T06:15:01.191145Z","end":"2026-02-24T06:15:01.642428Z","steps":["trace[1974077162] 'agreement among raft nodes before linearized reading' (duration: 450.965843ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:01.642469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:01.19112Z","time spent":"451.341202ms","remote":"127.0.0.1:46982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-02-24T06:15:01.642464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.339763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-24T06:15:01.6425Z","caller":"traceutil/trace.go:171","msg":"trace[2027288785] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:965; }","duration":"457.398225ms","start":"2026-02-24T06:15:01.185093Z","end":"2026-02-24T06:15:01.642491Z","steps":["trace[2027288785] 'agreement among raft nodes before linearized reading' (duration: 457.286792ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:01.642535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:01.185078Z","time spent":"457.450586ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-24T06:15:01.752882Z","caller":"traceutil/trace.go:171","msg":"trace[830555273] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"106.33727ms","start":"2026-02-24T06:15:01.646527Z","end":"2026-02-24T06:15:01.752864Z","steps":["trace[830555273] 'process raft request' (duration: 63.568862ms)","trace[830555273] 'compare' (duration: 42.639624ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:15:01.753123Z","caller":"traceutil/trace.go:171","msg":"trace[653148309] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"105.852467ms","start":"2026-02-24T06:15:01.647265Z","end":"2026-02-24T06:15:01.753117Z","steps":["trace[653148309] 'process raft request' (duration: 105.55734ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:02.074599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.097751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:15:02.074678Z","caller":"traceutil/trace.go:171","msg":"trace[1798897737] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:969; }","duration":"198.227085ms","start":"2026-02-24T06:15:01.876434Z","end":"2026-02-24T06:15:02.074661Z","steps":["trace[1798897737] 'range keys from in-memory index tree' (duration: 198.010679ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:15:02.074691Z","caller":"traceutil/trace.go:171","msg":"trace[1352479195] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"169.732127ms","start":"2026-02-24T06:15:01.904931Z","end":"2026-02-24T06:15:02.074664Z","steps":["trace[1352479195] 'process raft request' (duration: 76.470417ms)","trace[1352479195] 'compare' (duration: 93.140807ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:15:03.35502Z","caller":"traceutil/trace.go:171","msg":"trace[1535943432] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1008; }","duration":"371.195324ms","start":"2026-02-24T06:15:02.983777Z","end":"2026-02-24T06:15:03.354973Z","steps":["trace[1535943432] 'read index received' (duration: 371.009449ms)","trace[1535943432] 'applied index is now lower than readState.Index' (duration: 185.095µs)"],"step_count":2} {"level":"warn","ts":"2026-02-24T06:15:03.35514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.340307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:15:03.355179Z","caller":"traceutil/trace.go:171","msg":"trace[50894513] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:971; }","duration":"371.437749ms","start":"2026-02-24T06:15:02.983731Z","end":"2026-02-24T06:15:03.355169Z","steps":["trace[50894513] 'agreement among raft nodes before linearized reading' (duration: 371.350967ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:03.355218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:02.983717Z","time spent":"371.488281ms","remote":"127.0.0.1:53416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"info","ts":"2026-02-24T06:15:03.355291Z","caller":"traceutil/trace.go:171","msg":"trace[904306699] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"431.425351ms","start":"2026-02-24T06:15:02.923828Z","end":"2026-02-24T06:15:03.355253Z","steps":["trace[904306699] 'process raft request' (duration: 431.0148ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:03.355484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:02.923801Z","time spent":"431.559774ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T06:15:03.771906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.497578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-24T06:15:03.771979Z","caller":"traceutil/trace.go:171","msg":"trace[942886528] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:971; }","duration":"126.57671ms","start":"2026-02-24T06:15:03.645383Z","end":"2026-02-24T06:15:03.77196Z","steps":["trace[942886528] 'range keys from in-memory index tree' (duration: 126.333434ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:04.400768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.534086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:15:04.400874Z","caller":"traceutil/trace.go:171","msg":"trace[1157716915] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:976; }","duration":"522.919006ms","start":"2026-02-24T06:15:03.877939Z","end":"2026-02-24T06:15:04.400858Z","steps":["trace[1157716915] 'range keys from in-memory index tree' (duration: 522.344212ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:04.400911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:15:03.877917Z","time spent":"522.984958ms","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-24T06:15:13.993933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.812951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:15:13.994031Z","caller":"traceutil/trace.go:171","msg":"trace[834222545] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1019; }","duration":"191.961065ms","start":"2026-02-24T06:15:13.802046Z","end":"2026-02-24T06:15:13.994007Z","steps":["trace[834222545] 'range keys from in-memory index tree' (duration: 191.732379ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:15:13.994795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.075688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:15:13.994994Z","caller":"traceutil/trace.go:171","msg":"trace[196056145] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1019; }","duration":"116.799857ms","start":"2026-02-24T06:15:13.878176Z","end":"2026-02-24T06:15:13.994976Z","steps":["trace[196056145] 'range keys from in-memory index tree' (duration: 116.022127ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:15:14.737879Z","caller":"traceutil/trace.go:171","msg":"trace[241209271] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"120.340645ms","start":"2026-02-24T06:15:14.617497Z","end":"2026-02-24T06:15:14.737838Z","steps":["trace[241209271] 'process raft request' (duration: 120.16922ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:16:22.53497Z","caller":"traceutil/trace.go:171","msg":"trace[797992762] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"155.365201ms","start":"2026-02-24T06:16:22.379578Z","end":"2026-02-24T06:16:22.534943Z","steps":["trace[797992762] 'process raft request' (duration: 155.203047ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:16:22.535316Z","caller":"traceutil/trace.go:171","msg":"trace[1024876670] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"155.651028ms","start":"2026-02-24T06:16:22.379637Z","end":"2026-02-24T06:16:22.535288Z","steps":["trace[1024876670] 'process raft request' (duration: 155.268179ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:16:22.535499Z","caller":"traceutil/trace.go:171","msg":"trace[2085902827] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"155.27033ms","start":"2026-02-24T06:16:22.380213Z","end":"2026-02-24T06:16:22.535483Z","steps":["trace[2085902827] 'process raft request' (duration: 154.881539ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:16:40.799106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.614887ms","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-02-24T06:16:40.799133Z","caller":"traceutil/trace.go:171","msg":"trace[895835688] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"120.229193ms","start":"2026-02-24T06:16:40.678878Z","end":"2026-02-24T06:16:40.799107Z","steps":["trace[895835688] 'process raft request' (duration: 40.337898ms)","trace[895835688] 'compare' (duration: 79.657769ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:16:40.799128Z","caller":"traceutil/trace.go:171","msg":"trace[89889971] linearizableReadLoop","detail":"{readStateIndex:1449; appliedIndex:1448; }","duration":"117.588357ms","start":"2026-02-24T06:16:40.681488Z","end":"2026-02-24T06:16:40.799076Z","steps":["trace[89889971] 'read index received' (duration: 37.692982ms)","trace[89889971] 'applied index is now lower than readState.Index' (duration: 79.893965ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:16:40.7992Z","caller":"traceutil/trace.go:171","msg":"trace[346356417] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1390; }","duration":"121.736591ms","start":"2026-02-24T06:16:40.677441Z","end":"2026-02-24T06:16:40.799178Z","steps":["trace[346356417] 'range keys from in-memory index tree' (duration: 121.383932ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:16:40.799258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.908975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-24T06:16:40.799292Z","caller":"traceutil/trace.go:171","msg":"trace[591263251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1390; }","duration":"121.963206ms","start":"2026-02-24T06:16:40.677318Z","end":"2026-02-24T06:16:40.799281Z","steps":["trace[591263251] 'range keys from in-memory index tree' (duration: 121.438663ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:16:40.799334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.835263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-02-24T06:16:40.799382Z","caller":"traceutil/trace.go:171","msg":"trace[247300598] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1391; }","duration":"117.896915ms","start":"2026-02-24T06:16:40.681468Z","end":"2026-02-24T06:16:40.799365Z","steps":["trace[247300598] 'agreement among raft nodes before linearized reading' (duration: 117.758421ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:17:23.261619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.877909ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-24T06:17:23.261732Z","caller":"traceutil/trace.go:171","msg":"trace[1217968675] transaction","detail":"{read_only:false; response_revision:1564; number_of_response:1; }","duration":"159.255576ms","start":"2026-02-24T06:17:23.102456Z","end":"2026-02-24T06:17:23.261712Z","steps":["trace[1217968675] 'process raft request' (duration: 49.204022ms)","trace[1217968675] 'compare' (duration: 109.775277ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:17:23.284739Z","caller":"traceutil/trace.go:171","msg":"trace[2096553722] transaction","detail":"{read_only:false; response_revision:1566; number_of_response:1; }","duration":"181.36156ms","start":"2026-02-24T06:17:23.103363Z","end":"2026-02-24T06:17:23.284725Z","steps":["trace[2096553722] 'process raft request' (duration: 181.325349ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:17:23.284814Z","caller":"traceutil/trace.go:171","msg":"trace[1672592778] transaction","detail":"{read_only:false; response_revision:1565; number_of_response:1; }","duration":"181.504213ms","start":"2026-02-24T06:17:23.103283Z","end":"2026-02-24T06:17:23.284787Z","steps":["trace[1672592778] 'process raft request' (duration: 181.336829ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:17:47.670267Z","caller":"traceutil/trace.go:171","msg":"trace[536746620] transaction","detail":"{read_only:false; response_revision:1666; number_of_response:1; }","duration":"108.464045ms","start":"2026-02-24T06:17:47.561773Z","end":"2026-02-24T06:17:47.670237Z","steps":["trace[536746620] 'process raft request' (duration: 33.428757ms)","trace[536746620] 'compare' (duration: 74.906644ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:17:53.635352Z","caller":"traceutil/trace.go:171","msg":"trace[508425710] transaction","detail":"{read_only:false; response_revision:1686; number_of_response:1; }","duration":"133.685306ms","start":"2026-02-24T06:17:53.501638Z","end":"2026-02-24T06:17:53.635323Z","steps":["trace[508425710] 'process raft request' (duration: 133.501762ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:17:55.847488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.150352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-24T06:17:55.847603Z","caller":"traceutil/trace.go:171","msg":"trace[1793841858] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1696; }","duration":"105.313906ms","start":"2026-02-24T06:17:55.742267Z","end":"2026-02-24T06:17:55.847581Z","steps":["trace[1793841858] 'range keys from in-memory index tree' (duration: 104.858806ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:18:01.821763Z","caller":"traceutil/trace.go:171","msg":"trace[490498742] transaction","detail":"{read_only:false; response_revision:1720; number_of_response:1; }","duration":"107.312345ms","start":"2026-02-24T06:18:01.71442Z","end":"2026-02-24T06:18:01.821733Z","steps":["trace[490498742] 'process raft request' (duration: 83.319755ms)","trace[490498742] 'compare' (duration: 23.473257ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:18:04.432935Z","caller":"traceutil/trace.go:171","msg":"trace[1275558800] transaction","detail":"{read_only:false; response_revision:1738; number_of_response:1; }","duration":"124.909476ms","start":"2026-02-24T06:18:04.308001Z","end":"2026-02-24T06:18:04.43291Z","steps":["trace[1275558800] 'process raft request' (duration: 80.405162ms)","trace[1275558800] 'compare' (duration: 44.389271ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T06:18:10.274441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.567443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-24T06:18:10.274523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.817961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-24T06:18:10.27458Z","caller":"traceutil/trace.go:171","msg":"trace[414606781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1778; }","duration":"408.930784ms","start":"2026-02-24T06:18:09.865635Z","end":"2026-02-24T06:18:10.274566Z","steps":["trace[414606781] 'range keys from in-memory index tree' (duration: 408.670047ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:18:10.274574Z","caller":"traceutil/trace.go:171","msg":"trace[1786016215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1778; }","duration":"378.777109ms","start":"2026-02-24T06:18:09.895772Z","end":"2026-02-24T06:18:10.274549Z","steps":["trace[1786016215] 'range keys from in-memory index tree' (duration: 378.387789ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:10.274611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:18:09.86561Z","time spent":"408.993515ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-24T06:18:10.274653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:18:09.895738Z","time spent":"378.886201ms","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-24T06:18:10.274667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.288746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-24T06:18:10.274754Z","caller":"traceutil/trace.go:171","msg":"trace[419486742] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1778; }","duration":"344.43895ms","start":"2026-02-24T06:18:09.930298Z","end":"2026-02-24T06:18:10.274737Z","steps":["trace[419486742] 'range keys from in-memory index tree' (duration: 343.930727ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:10.274721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.4289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-02-24T06:18:10.274804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:18:09.930277Z","time spent":"344.517691ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-24T06:18:10.274851Z","caller":"traceutil/trace.go:171","msg":"trace[12299944] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1778; }","duration":"384.629595ms","start":"2026-02-24T06:18:09.890192Z","end":"2026-02-24T06:18:10.274822Z","steps":["trace[12299944] 'range keys from in-memory index tree' (duration: 384.161154ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:10.27498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:18:09.890173Z","time spent":"384.791829ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-02-24T06:18:10.607715Z","caller":"traceutil/trace.go:171","msg":"trace[945538744] transaction","detail":"{read_only:false; response_revision:1779; number_of_response:1; }","duration":"328.892721ms","start":"2026-02-24T06:18:10.278797Z","end":"2026-02-24T06:18:10.607689Z","steps":["trace[945538744] 'process raft request' (duration: 328.769868ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:10.607876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:18:10.278772Z","time spent":"329.021654ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:18:10.664686Z","caller":"traceutil/trace.go:171","msg":"trace[397446407] transaction","detail":"{read_only:false; response_revision:1780; number_of_response:1; }","duration":"385.414754ms","start":"2026-02-24T06:18:10.279247Z","end":"2026-02-24T06:18:10.664662Z","steps":["trace[397446407] 'process raft request' (duration: 385.177348ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:18:10.664813Z","caller":"traceutil/trace.go:171","msg":"trace[2014267028] transaction","detail":"{read_only:false; response_revision:1781; number_of_response:1; }","duration":"385.328132ms","start":"2026-02-24T06:18:10.279461Z","end":"2026-02-24T06:18:10.664789Z","steps":["trace[2014267028] 'process raft request' (duration: 385.177649ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:10.664836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:18:10.279232Z","time spent":"385.524156ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T06:18:10.664935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:18:10.279451Z","time spent":"385.416904ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T06:18:10.664785Z","caller":"traceutil/trace.go:171","msg":"trace[1832423581] linearizableReadLoop","detail":"{readStateIndex:1858; appliedIndex:1855; }","duration":"104.642739ms","start":"2026-02-24T06:18:10.560116Z","end":"2026-02-24T06:18:10.664759Z","steps":["trace[1832423581] 'read index received' (duration: 47.55102ms)","trace[1832423581] 'applied index is now lower than readState.Index' (duration: 57.090979ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T06:18:10.664996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.864474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-02-24T06:18:10.665058Z","caller":"traceutil/trace.go:171","msg":"trace[2039518062] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1781; }","duration":"104.983207ms","start":"2026-02-24T06:18:10.560061Z","end":"2026-02-24T06:18:10.665045Z","steps":["trace[2039518062] 'agreement among raft nodes before linearized reading' (duration: 104.804722ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:18:16.67429Z","caller":"traceutil/trace.go:171","msg":"trace[59287463] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"110.822223ms","start":"2026-02-24T06:18:16.563431Z","end":"2026-02-24T06:18:16.674254Z","steps":["trace[59287463] 'process raft request' (duration: 110.501665ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:21.253658Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255346320485246,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-24T06:18:21.357225Z","caller":"traceutil/trace.go:171","msg":"trace[928311869] linearizableReadLoop","detail":"{readStateIndex:1905; appliedIndex:1904; }","duration":"604.504488ms","start":"2026-02-24T06:18:20.752696Z","end":"2026-02-24T06:18:21.357201Z","steps":["trace[928311869] 'read index received' (duration: 604.342414ms)","trace[928311869] 'applied index is now lower than readState.Index' (duration: 161.344µs)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:18:21.357348Z","caller":"traceutil/trace.go:171","msg":"trace[2065715900] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"668.406727ms","start":"2026-02-24T06:18:20.68893Z","end":"2026-02-24T06:18:21.357337Z","steps":["trace[2065715900] 'process raft request' (duration: 668.151611ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:21.357474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:18:20.688911Z","time spent":"668.471169ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T06:18:21.357763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.010428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-24T06:18:21.357964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.244436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-24T06:18:21.358032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.212772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T06:18:21.358077Z","caller":"traceutil/trace.go:171","msg":"trace[175489693] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1826; }","duration":"605.38932ms","start":"2026-02-24T06:18:20.752665Z","end":"2026-02-24T06:18:21.358054Z","steps":["trace[175489693] 'agreement among raft nodes before linearized reading' (duration: 605.031661ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:18:21.358134Z","caller":"traceutil/trace.go:171","msg":"trace[1230974476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1826; }","duration":"479.364046ms","start":"2026-02-24T06:18:20.878745Z","end":"2026-02-24T06:18:21.358109Z","steps":["trace[1230974476] 'agreement among raft nodes before linearized reading' (duration: 479.090249ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:21.358195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:18:20.878725Z","time spent":"479.460928ms","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-24T06:18:21.358217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:18:20.752654Z","time spent":"605.548043ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-24T06:18:21.358022Z","caller":"traceutil/trace.go:171","msg":"trace[245004785] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1826; }","duration":"115.135291ms","start":"2026-02-24T06:18:21.24269Z","end":"2026-02-24T06:18:21.357825Z","steps":["trace[245004785] 'agreement among raft nodes before linearized reading' (duration: 114.966237ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:21.358323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.636252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-24T06:18:21.358459Z","caller":"traceutil/trace.go:171","msg":"trace[1859575400] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1826; }","duration":"491.812407ms","start":"2026-02-24T06:18:20.866618Z","end":"2026-02-24T06:18:21.35843Z","steps":["trace[1859575400] 'agreement among raft nodes before linearized reading' (duration: 491.272674ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:21.35853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:18:20.866605Z","time spent":"491.909729ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-24T06:18:21.358583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.021898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-02-24T06:18:21.358737Z","caller":"traceutil/trace.go:171","msg":"trace[701336030] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1826; }","duration":"507.864029ms","start":"2026-02-24T06:18:20.850758Z","end":"2026-02-24T06:18:21.358622Z","steps":["trace[701336030] 'agreement among raft nodes before linearized reading' (duration: 506.876574ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:21.358906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T06:18:20.850729Z","time spent":"508.164178ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-02-24T06:18:43.629748Z","caller":"traceutil/trace.go:171","msg":"trace[738989491] linearizableReadLoop","detail":"{readStateIndex:2008; appliedIndex:2006; }","duration":"153.602277ms","start":"2026-02-24T06:18:43.476113Z","end":"2026-02-24T06:18:43.629715Z","steps":["trace[738989491] 'read index received' (duration: 39.983231ms)","trace[738989491] 'applied index is now lower than readState.Index' (duration: 113.617706ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T06:18:43.62987Z","caller":"traceutil/trace.go:171","msg":"trace[319467998] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"154.932431ms","start":"2026-02-24T06:18:43.474897Z","end":"2026-02-24T06:18:43.62983Z","steps":["trace[319467998] 'process raft request' (duration: 123.898713ms)","trace[319467998] 'compare' (duration: 30.76667ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T06:18:43.630124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.702014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/kube-proxy\" ","response":"range_response_count:1 size:317"} {"level":"warn","ts":"2026-02-24T06:18:43.63015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.874252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-24T06:18:43.630152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.830253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-24T06:18:43.630211Z","caller":"traceutil/trace.go:171","msg":"trace[516586576] range","detail":"{range_begin:/registry/roles/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1925; }","duration":"136.812896ms","start":"2026-02-24T06:18:43.493378Z","end":"2026-02-24T06:18:43.630191Z","steps":["trace[516586576] 'agreement among raft nodes before linearized reading' (duration: 136.664532ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:18:43.630228Z","caller":"traceutil/trace.go:171","msg":"trace[1195435047] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1925; }","duration":"153.915734ms","start":"2026-02-24T06:18:43.476292Z","end":"2026-02-24T06:18:43.630208Z","steps":["trace[1195435047] 'agreement among raft nodes before linearized reading' (duration: 153.74554ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:18:43.63022Z","caller":"traceutil/trace.go:171","msg":"trace[1559092728] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1925; }","duration":"107.982964ms","start":"2026-02-24T06:18:43.522219Z","end":"2026-02-24T06:18:43.630202Z","steps":["trace[1559092728] 'agreement among raft nodes before linearized reading' (duration: 107.80167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:43.630494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.695722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-24T06:18:43.63056Z","caller":"traceutil/trace.go:171","msg":"trace[55171149] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1925; }","duration":"107.068441ms","start":"2026-02-24T06:18:43.523477Z","end":"2026-02-24T06:18:43.630545Z","steps":["trace[55171149] 'agreement among raft nodes before linearized reading' (duration: 106.674441ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:43.630598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.020797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/kubeadm:kubeadm-certs\" ","response":"range_response_count:1 size:339"} {"level":"info","ts":"2026-02-24T06:18:43.630663Z","caller":"traceutil/trace.go:171","msg":"trace[467129566] range","detail":"{range_begin:/registry/roles/kube-system/kubeadm:kubeadm-certs; range_end:; response_count:1; response_revision:1925; }","duration":"134.102849ms","start":"2026-02-24T06:18:43.496527Z","end":"2026-02-24T06:18:43.63063Z","steps":["trace[467129566] 'agreement among raft nodes before linearized reading' (duration: 133.955585ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:43.63108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.96917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-24T06:18:43.631137Z","caller":"traceutil/trace.go:171","msg":"trace[1786865444] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1925; }","duration":"155.085984ms","start":"2026-02-24T06:18:43.476034Z","end":"2026-02-24T06:18:43.63112Z","steps":["trace[1786865444] 'agreement among raft nodes before linearized reading' (duration: 153.842963ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:52.354433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.631861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-xb8c8\" ","response":"range_response_count:1 size:13268"} {"level":"info","ts":"2026-02-24T06:18:52.354546Z","caller":"traceutil/trace.go:171","msg":"trace[1900423657] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-xb8c8; range_end:; response_count:1; response_revision:1963; }","duration":"126.795705ms","start":"2026-02-24T06:18:52.22773Z","end":"2026-02-24T06:18:52.354526Z","steps":["trace[1900423657] 'range keys from in-memory index tree' (duration: 126.451637ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T06:18:52.575141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.94879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-xb8c8\" ","response":"range_response_count:1 size:13268"} {"level":"warn","ts":"2026-02-24T06:18:52.575191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.349634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"} {"level":"info","ts":"2026-02-24T06:18:52.575234Z","caller":"traceutil/trace.go:171","msg":"trace[277037845] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-xb8c8; range_end:; response_count:1; response_revision:1964; }","duration":"119.098783ms","start":"2026-02-24T06:18:52.456111Z","end":"2026-02-24T06:18:52.57521Z","steps":["trace[277037845] 'range keys from in-memory index tree' (duration: 118.731404ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:18:52.575321Z","caller":"traceutil/trace.go:171","msg":"trace[787897391] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1964; }","duration":"118.536559ms","start":"2026-02-24T06:18:52.456758Z","end":"2026-02-24T06:18:52.575294Z","steps":["trace[787897391] 'range keys from in-memory index tree' (duration: 118.174279ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T06:18:53.857151Z","caller":"traceutil/trace.go:171","msg":"trace[19964965] transaction","detail":"{read_only:false; response_revision:1970; number_of_response:1; }","duration":"110.240161ms","start":"2026-02-24T06:18:53.746406Z","end":"2026-02-24T06:18:53.856646Z","steps":["trace[19964965] 'process raft request' (duration: 106.60851ms)"],"step_count":1}