{"level":"warn","ts":"2026-07-25T06:32:22.596895Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T06:32:22.597027Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.163:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.163:2380","--initial-cluster=instance=https://199.19.213.163:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.163:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.163:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-25T06:32:22.59711Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T06:32:22.597147Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.163:2380"]} {"level":"info","ts":"2026-07-25T06:32:22.597181Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-25T06:32:22.597896Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.163:2379"]} {"level":"info","ts":"2026-07-25T06:32:22.597991Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.163:2380"],"listen-peer-urls":["https://199.19.213.163:2380"],"advertise-client-urls":["https://199.19.213.163:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.163:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.163:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-25T06:32:22.607624Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.41935ms"} {"level":"info","ts":"2026-07-25T06:32:22.624702Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e7941a908d261618","cluster-id":"5b6cb15db6ea8c10"} {"level":"info","ts":"2026-07-25T06:32:22.624936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 switched to configuration voters=()"} {"level":"info","ts":"2026-07-25T06:32:22.62503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became follower at term 0"} {"level":"info","ts":"2026-07-25T06:32:22.625102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e7941a908d261618 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-25T06:32:22.62518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became follower at term 1"} {"level":"info","ts":"2026-07-25T06:32:22.625283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 switched to configuration voters=(16686991727460226584)"} {"level":"warn","ts":"2026-07-25T06:32:22.637913Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-25T06:32:22.639948Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-25T06:32:22.64234Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-25T06:32:22.644984Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e7941a908d261618","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-25T06:32:22.645289Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e7941a908d261618","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-25T06:32:22.645449Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-25T06:32:22.645524Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-25T06:32:22.645539Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-25T06:32:22.64731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 switched to configuration voters=(16686991727460226584)"} {"level":"info","ts":"2026-07-25T06:32:22.647703Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5b6cb15db6ea8c10","local-member-id":"e7941a908d261618","added-peer-id":"e7941a908d261618","added-peer-peer-urls":["https://199.19.213.163:2380"]} {"level":"info","ts":"2026-07-25T06:32:22.651089Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-25T06:32:22.651231Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.163:2380"} {"level":"info","ts":"2026-07-25T06:32:22.65127Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.163:2380"} {"level":"info","ts":"2026-07-25T06:32:22.65168Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e7941a908d261618","initial-advertise-peer-urls":["https://199.19.213.163:2380"],"listen-peer-urls":["https://199.19.213.163:2380"],"advertise-client-urls":["https://199.19.213.163:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.163:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-25T06:32:22.651762Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-25T06:32:23.126335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 is starting a new election at term 1"} {"level":"info","ts":"2026-07-25T06:32:23.126425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-25T06:32:23.126498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 received MsgPreVoteResp from e7941a908d261618 at term 1"} {"level":"info","ts":"2026-07-25T06:32:23.126578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became candidate at term 2"} {"level":"info","ts":"2026-07-25T06:32:23.126598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 received MsgVoteResp from e7941a908d261618 at term 2"} {"level":"info","ts":"2026-07-25T06:32:23.126658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became leader at term 2"} {"level":"info","ts":"2026-07-25T06:32:23.126722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e7941a908d261618 elected leader e7941a908d261618 at term 2"} {"level":"info","ts":"2026-07-25T06:32:23.127895Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e7941a908d261618","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.163:2379]}","request-path":"/0/members/e7941a908d261618/attributes","cluster-id":"5b6cb15db6ea8c10","publish-timeout":"7s"} {"level":"info","ts":"2026-07-25T06:32:23.127958Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T06:32:23.127907Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T06:32:23.128076Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T06:32:23.128742Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-25T06:32:23.128776Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-25T06:32:23.129484Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5b6cb15db6ea8c10","local-member-id":"e7941a908d261618","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T06:32:23.129628Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T06:32:23.129675Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T06:32:23.132277Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.163:2379"} {"level":"info","ts":"2026-07-25T06:32:23.13375Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-25T06:32:26.194315Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.808949231s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-25T06:32:26.195319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.810051816s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T06:32:26.195339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.810342371s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T06:32:26.195423Z","caller":"traceutil/trace.go:171","msg":"trace[1673345378] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2; }","duration":"1.810198693s","start":"2026-07-25T06:32:24.385192Z","end":"2026-07-25T06:32:26.195391Z","steps":["trace[1673345378] 'agreement among raft nodes before linearized reading' (duration: 1.809873957s)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:26.195486Z","caller":"traceutil/trace.go:171","msg":"trace[1359114474] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:2; }","duration":"1.810534381s","start":"2026-07-25T06:32:24.384928Z","end":"2026-07-25T06:32:26.195462Z","steps":["trace[1359114474] 'agreement among raft nodes before linearized reading' (duration: 1.810293479s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:26.195515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.385178Z","time spent":"1.81032689s","remote":"127.0.0.1:57672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T06:32:26.195702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.384918Z","time spent":"1.810767872s","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"info","ts":"2026-07-25T06:32:26.19576Z","caller":"traceutil/trace.go:171","msg":"trace[769748083] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"1.810389993s","start":"2026-07-25T06:32:24.385284Z","end":"2026-07-25T06:32:26.195673Z","steps":["trace[769748083] 'process raft request' (duration: 1.809432276s)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:26.195092Z","caller":"traceutil/trace.go:171","msg":"trace[1490104252] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"1.809739832s","start":"2026-07-25T06:32:24.38531Z","end":"2026-07-25T06:32:26.19505Z","steps":["trace[1490104252] 'read index received' (duration: 261.513µs)","trace[1490104252] 'applied index is now lower than readState.Index' (duration: 1.809477128s)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:26.196695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.385273Z","time spent":"1.810613994s","remote":"127.0.0.1:57742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:32:26.696697Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592197943351271810,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-25T06:32:27.072448Z","caller":"traceutil/trace.go:171","msg":"trace[1638307974] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"2.611000437s","start":"2026-07-25T06:32:24.4614Z","end":"2026-07-25T06:32:27.0724Z","steps":["trace[1638307974] 'process raft request' (duration: 2.610814118s)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:27.07248Z","caller":"traceutil/trace.go:171","msg":"trace[1452234106] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:5; }","duration":"876.151053ms","start":"2026-07-25T06:32:26.196304Z","end":"2026-07-25T06:32:27.072455Z","steps":["trace[1452234106] 'read index received' (duration: 861.793961ms)","trace[1452234106] 'applied index is now lower than readState.Index' (duration: 14.356102ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:27.072604Z","caller":"traceutil/trace.go:171","msg":"trace[141843407] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"2.599128886s","start":"2026-07-25T06:32:24.473449Z","end":"2026-07-25T06:32:27.072578Z","steps":["trace[141843407] 'process raft request' (duration: 2.598964948s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.0726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.461389Z","time spent":"2.611139553s","remote":"127.0.0.1:58132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:27.073042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.612632588s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T06:32:27.073111Z","caller":"traceutil/trace.go:171","msg":"trace[1748855165] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"2.606742365s","start":"2026-07-25T06:32:24.46636Z","end":"2026-07-25T06:32:27.073102Z","steps":["trace[1748855165] 'process raft request' (duration: 2.605972687s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.073153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.712001831s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T06:32:27.073204Z","caller":"traceutil/trace.go:171","msg":"trace[1227072336] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.612757474s","start":"2026-07-25T06:32:24.460378Z","end":"2026-07-25T06:32:27.073136Z","steps":["trace[1227072336] 'agreement among raft nodes before linearized reading' (duration: 2.612330223s)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:27.073155Z","caller":"traceutil/trace.go:171","msg":"trace[979942445] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"2.606260741s","start":"2026-07-25T06:32:24.466883Z","end":"2026-07-25T06:32:27.073144Z","steps":["trace[979942445] 'process raft request' (duration: 2.605479372s)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:27.073246Z","caller":"traceutil/trace.go:171","msg":"trace[2043254028] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"2.606635569s","start":"2026-07-25T06:32:24.466602Z","end":"2026-07-25T06:32:27.073237Z","steps":["trace[2043254028] 'process raft request' (duration: 2.605707383s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.073275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.639873463s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T06:32:27.073303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.466594Z","time spent":"2.606686992s","remote":"127.0.0.1:58206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:27.073316Z","caller":"traceutil/trace.go:171","msg":"trace[986688686] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"2.606803088s","start":"2026-07-25T06:32:24.466499Z","end":"2026-07-25T06:32:27.073302Z","steps":["trace[986688686] 'process raft request' (duration: 2.605756406s)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:27.073296Z","caller":"traceutil/trace.go:171","msg":"trace[1916423948] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"2.600407189s","start":"2026-07-25T06:32:24.472845Z","end":"2026-07-25T06:32:27.073252Z","steps":["trace[1916423948] 'process raft request' (duration: 2.599541656s)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:27.073239Z","caller":"traceutil/trace.go:171","msg":"trace[1903569115] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"2.606699712s","start":"2026-07-25T06:32:24.466499Z","end":"2026-07-25T06:32:27.073199Z","steps":["trace[1903569115] 'process raft request' (duration: 2.605784567s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.073381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.639906955s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T06:32:27.073324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.460369Z","time spent":"2.612939393s","remote":"127.0.0.1:57784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-25T06:32:27.073442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.466469Z","time spent":"2.606933444s","remote":"127.0.0.1:58206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:27.073432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.466472Z","time spent":"2.606890882s","remote":"127.0.0.1:58206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:27.073492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.680951488s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T06:32:27.073338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.466877Z","time spent":"2.606401477s","remote":"127.0.0.1:58206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:27.073405Z","caller":"traceutil/trace.go:171","msg":"trace[1599279879] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.639929536s","start":"2026-07-25T06:32:24.433468Z","end":"2026-07-25T06:32:27.073398Z","steps":["trace[1599279879] 'agreement among raft nodes before linearized reading' (duration: 2.639897465s)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:27.073536Z","caller":"traceutil/trace.go:171","msg":"trace[191993048] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"2.68100076s","start":"2026-07-25T06:32:24.392525Z","end":"2026-07-25T06:32:27.073526Z","steps":["trace[191993048] 'agreement among raft nodes before linearized reading' (duration: 2.680950607s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.073556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.433424Z","time spent":"2.640117455s","remote":"127.0.0.1:57784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-25T06:32:27.073579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.39252Z","time spent":"2.681049003s","remote":"127.0.0.1:58064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-07-25T06:32:27.073608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.924788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T06:32:27.07361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.430517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T06:32:27.073206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.466345Z","time spent":"2.606807198s","remote":"127.0.0.1:58206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:27.073696Z","caller":"traceutil/trace.go:171","msg":"trace[320222070] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"820.578544ms","start":"2026-07-25T06:32:26.253103Z","end":"2026-07-25T06:32:27.073681Z","steps":["trace[320222070] 'agreement among raft nodes before linearized reading' (duration: 820.434087ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.073486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.472833Z","time spent":"2.600567537s","remote":"127.0.0.1:57844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:27.07331Z","caller":"traceutil/trace.go:171","msg":"trace[929029429] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.639908226s","start":"2026-07-25T06:32:24.433394Z","end":"2026-07-25T06:32:27.073302Z","steps":["trace[929029429] 'agreement among raft nodes before linearized reading' (duration: 2.639862483s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.073769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:26.253072Z","time spent":"820.655378ms","remote":"127.0.0.1:57784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-25T06:32:27.073798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.433378Z","time spent":"2.64041437s","remote":"127.0.0.1:57784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-25T06:32:27.073118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.711046304s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T06:32:27.073878Z","caller":"traceutil/trace.go:171","msg":"trace[2111373169] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:11; }","duration":"1.711806251s","start":"2026-07-25T06:32:25.362058Z","end":"2026-07-25T06:32:27.073864Z","steps":["trace[2111373169] 'agreement among raft nodes before linearized reading' (duration: 1.711032763s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.073937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:25.36198Z","time spent":"1.711943108s","remote":"127.0.0.1:58026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-07-25T06:32:27.073074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.473415Z","time spent":"2.599351917s","remote":"127.0.0.1:57922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:27.073054Z","caller":"traceutil/trace.go:171","msg":"trace[595587461] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"2.685274873s","start":"2026-07-25T06:32:24.38775Z","end":"2026-07-25T06:32:27.073025Z","steps":["trace[595587461] 'process raft request' (duration: 2.670340192s)","trace[595587461] 'compare' (duration: 13.897129ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:27.074153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.387741Z","time spent":"2.686367808s","remote":"127.0.0.1:57748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:32:27.073218Z","caller":"traceutil/trace.go:171","msg":"trace[1850111211] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:11; }","duration":"1.712134078s","start":"2026-07-25T06:32:25.361059Z","end":"2026-07-25T06:32:27.073193Z","steps":["trace[1850111211] 'agreement among raft nodes before linearized reading' (duration: 1.712078105s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.07436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:25.361024Z","time spent":"1.713326158s","remote":"127.0.0.1:58038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-07-25T06:32:27.073227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.556450691s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T06:32:27.074524Z","caller":"traceutil/trace.go:171","msg":"trace[608452318] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.557774308s","start":"2026-07-25T06:32:24.516738Z","end":"2026-07-25T06:32:27.074512Z","steps":["trace[608452318] 'agreement among raft nodes before linearized reading' (duration: 2.556440301s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.07458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.516726Z","time spent":"2.55783841s","remote":"127.0.0.1:57784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-25T06:32:27.073346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.613575765s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.163\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T06:32:27.074811Z","caller":"traceutil/trace.go:171","msg":"trace[188177807] range","detail":"{range_begin:/registry/masterleases/199.19.213.163; range_end:; response_count:0; response_revision:11; }","duration":"2.615055878s","start":"2026-07-25T06:32:24.459743Z","end":"2026-07-25T06:32:27.074799Z","steps":["trace[188177807] 'agreement among raft nodes before linearized reading' (duration: 2.613587295s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.074853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.459735Z","time spent":"2.615106711s","remote":"127.0.0.1:57702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.163\" "} {"level":"warn","ts":"2026-07-25T06:32:27.073029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.611289141s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T06:32:27.07505Z","caller":"traceutil/trace.go:171","msg":"trace[792261215] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"2.613364024s","start":"2026-07-25T06:32:24.461675Z","end":"2026-07-25T06:32:27.075039Z","steps":["trace[792261215] 'agreement among raft nodes before linearized reading' (duration: 2.610990076s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.075113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:24.46167Z","time spent":"2.613410446s","remote":"127.0.0.1:57758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-07-25T06:32:27.073656Z","caller":"traceutil/trace.go:171","msg":"trace[1212026200] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11; }","duration":"748.019403ms","start":"2026-07-25T06:32:26.325626Z","end":"2026-07-25T06:32:27.073645Z","steps":["trace[1212026200] 'agreement among raft nodes before linearized reading' (duration: 747.938319ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.075286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:26.325598Z","time spent":"749.678866ms","remote":"127.0.0.1:57672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-25T06:32:27.581691Z","caller":"traceutil/trace.go:171","msg":"trace[1030341793] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"504.172202ms","start":"2026-07-25T06:32:27.077491Z","end":"2026-07-25T06:32:27.581663Z","steps":["trace[1030341793] 'process raft request' (duration: 489.481924ms)","trace[1030341793] 'compare' (duration: 14.532401ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:27.581833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.077475Z","time spent":"504.295298ms","remote":"127.0.0.1:58132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:27.587013Z","caller":"traceutil/trace.go:171","msg":"trace[377363080] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"507.460885ms","start":"2026-07-25T06:32:27.079525Z","end":"2026-07-25T06:32:27.586986Z","steps":["trace[377363080] 'process raft request' (duration: 507.315618ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:27.587086Z","caller":"traceutil/trace.go:171","msg":"trace[1574301124] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"507.176301ms","start":"2026-07-25T06:32:27.079865Z","end":"2026-07-25T06:32:27.587042Z","steps":["trace[1574301124] 'process raft request' (duration: 507.079516ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.587145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.079511Z","time spent":"507.55861ms","remote":"127.0.0.1:58206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:27.5872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.079858Z","time spent":"507.270125ms","remote":"127.0.0.1:58206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:27.587286Z","caller":"traceutil/trace.go:171","msg":"trace[1804317055] linearizableReadLoop","detail":"{readStateIndex:18; appliedIndex:14; }","duration":"507.34153ms","start":"2026-07-25T06:32:27.07993Z","end":"2026-07-25T06:32:27.587271Z","steps":["trace[1804317055] 'read index received' (duration: 487.056964ms)","trace[1804317055] 'applied index is now lower than readState.Index' (duration: 20.283726ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:27.587427Z","caller":"traceutil/trace.go:171","msg":"trace[108684412] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"506.170572ms","start":"2026-07-25T06:32:27.081248Z","end":"2026-07-25T06:32:27.587419Z","steps":["trace[108684412] 'process raft request' (duration: 505.72446ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:27.587451Z","caller":"traceutil/trace.go:171","msg":"trace[2096641247] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"505.977322ms","start":"2026-07-25T06:32:27.081398Z","end":"2026-07-25T06:32:27.587375Z","steps":["trace[2096641247] 'process raft request' (duration: 505.632865ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:27.587509Z","caller":"traceutil/trace.go:171","msg":"trace[1342164938] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"506.14027ms","start":"2026-07-25T06:32:27.081344Z","end":"2026-07-25T06:32:27.587484Z","steps":["trace[1342164938] 'process raft request' (duration: 505.654736ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.587547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.081292Z","time spent":"506.216493ms","remote":"127.0.0.1:58038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:27.587643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.081336Z","time spent":"506.229394ms","remote":"127.0.0.1:58064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:27.58747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.081229Z","time spent":"506.218054ms","remote":"127.0.0.1:58206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:27.587473Z","caller":"traceutil/trace.go:171","msg":"trace[1065017981] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"507.839224ms","start":"2026-07-25T06:32:27.079622Z","end":"2026-07-25T06:32:27.587461Z","steps":["trace[1065017981] 'process raft request' (duration: 507.289937ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.587768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.770451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T06:32:27.587793Z","caller":"traceutil/trace.go:171","msg":"trace[2029789328] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"506.258546ms","start":"2026-07-25T06:32:27.081524Z","end":"2026-07-25T06:32:27.587782Z","steps":["trace[2029789328] 'process raft request' (duration: 505.54264ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.587795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.079585Z","time spent":"508.186481ms","remote":"127.0.0.1:57784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:27.587831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.081512Z","time spent":"506.303029ms","remote":"127.0.0.1:58206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:27.587815Z","caller":"traceutil/trace.go:171","msg":"trace[1464100500] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"506.14305ms","start":"2026-07-25T06:32:27.081649Z","end":"2026-07-25T06:32:27.587792Z","steps":["trace[1464100500] 'process raft request' (duration: 505.507719ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:27.587866Z","caller":"traceutil/trace.go:171","msg":"trace[601450970] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21; }","duration":"507.943569ms","start":"2026-07-25T06:32:27.079904Z","end":"2026-07-25T06:32:27.587848Z","steps":["trace[601450970] 'agreement among raft nodes before linearized reading' (duration: 507.75669ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:27.587896Z","caller":"traceutil/trace.go:171","msg":"trace[1620501923] transaction","detail":"{read_only:false; number_of_response:0; response_revision:19; }","duration":"506.303888ms","start":"2026-07-25T06:32:27.081577Z","end":"2026-07-25T06:32:27.587881Z","steps":["trace[1620501923] 'process raft request' (duration: 505.54475ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.587925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.08164Z","time spent":"506.228894ms","remote":"127.0.0.1:58206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:27.587933Z","caller":"traceutil/trace.go:171","msg":"trace[1935455583] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"505.477057ms","start":"2026-07-25T06:32:27.082447Z","end":"2026-07-25T06:32:27.587924Z","steps":["trace[1935455583] 'process raft request' (duration: 504.778092ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.587953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.079896Z","time spent":"508.043354ms","remote":"127.0.0.1:57660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T06:32:27.587972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.081568Z","time spent":"506.365761ms","remote":"127.0.0.1:57784","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:27.587986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.082435Z","time spent":"505.519959ms","remote":"127.0.0.1:57844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:32:27.594073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.731847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T06:32:27.594087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.948714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T06:32:27.594121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.936923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-25T06:32:27.594118Z","caller":"traceutil/trace.go:171","msg":"trace[199743735] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:22; }","duration":"512.79055ms","start":"2026-07-25T06:32:27.081318Z","end":"2026-07-25T06:32:27.594109Z","steps":["trace[199743735] 'agreement among raft nodes before linearized reading' (duration: 512.688825ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:27.59415Z","caller":"traceutil/trace.go:171","msg":"trace[2076404240] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:22; }","duration":"311.0542ms","start":"2026-07-25T06:32:27.283082Z","end":"2026-07-25T06:32:27.594136Z","steps":["trace[2076404240] 'agreement among raft nodes before linearized reading' (duration: 310.959115ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:27.594158Z","caller":"traceutil/trace.go:171","msg":"trace[237311895] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:22; }","duration":"454.009366ms","start":"2026-07-25T06:32:27.140139Z","end":"2026-07-25T06:32:27.594149Z","steps":["trace[237311895] 'agreement among raft nodes before linearized reading' (duration: 453.855238ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.594177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.081313Z","time spent":"512.856243ms","remote":"127.0.0.1:58036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"warn","ts":"2026-07-25T06:32:27.594197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.283068Z","time spent":"311.122483ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-07-25T06:32:27.594182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.140126Z","time spent":"454.051908ms","remote":"127.0.0.1:57784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-25T06:32:27.594271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.060703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-zsw5h\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-07-25T06:32:27.594308Z","caller":"traceutil/trace.go:171","msg":"trace[1786705405] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-zsw5h; range_end:; response_count:1; response_revision:22; }","duration":"513.152308ms","start":"2026-07-25T06:32:27.081145Z","end":"2026-07-25T06:32:27.594298Z","steps":["trace[1786705405] 'agreement among raft nodes before linearized reading' (duration: 512.877564ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:27.594425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:27.081128Z","time spent":"513.275684ms","remote":"127.0.0.1:57922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-zsw5h\" "} {"level":"info","ts":"2026-07-25T06:32:28.830914Z","caller":"traceutil/trace.go:171","msg":"trace[2098033124] transaction","detail":"{read_only:false; response_revision:166; number_of_response:1; }","duration":"122.676393ms","start":"2026-07-25T06:32:28.708203Z","end":"2026-07-25T06:32:28.83088Z","steps":["trace[2098033124] 'process raft request' (duration: 51.998774ms)","trace[2098033124] 'compare' (duration: 70.283209ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:30.419647Z","caller":"traceutil/trace.go:171","msg":"trace[299263062] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"175.079338ms","start":"2026-07-25T06:32:30.244525Z","end":"2026-07-25T06:32:30.419604Z","steps":["trace[299263062] 'process raft request' (duration: 174.767792ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:31.062507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.209836ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:32:31.062709Z","caller":"traceutil/trace.go:171","msg":"trace[828861986] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"188.469445ms","start":"2026-07-25T06:32:30.874222Z","end":"2026-07-25T06:32:31.062691Z","steps":["trace[828861986] 'process raft request' (duration: 188.406422ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:31.062879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.168288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:32:31.062931Z","caller":"traceutil/trace.go:171","msg":"trace[350718537] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:238; }","duration":"191.278014ms","start":"2026-07-25T06:32:30.87164Z","end":"2026-07-25T06:32:31.062918Z","steps":["trace[350718537] 'agreement among raft nodes before linearized reading' (duration: 191.154348ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:31.062677Z","caller":"traceutil/trace.go:171","msg":"trace[920680350] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"207.365869ms","start":"2026-07-25T06:32:30.855271Z","end":"2026-07-25T06:32:31.062637Z","steps":["trace[920680350] 'process raft request' (duration: 24.789644ms)","trace[920680350] 'compare' (duration: 182.041528ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:31.062754Z","caller":"traceutil/trace.go:171","msg":"trace[2064359483] linearizableReadLoop","detail":"{readStateIndex:243; appliedIndex:242; }","duration":"191.036082ms","start":"2026-07-25T06:32:30.871697Z","end":"2026-07-25T06:32:31.062733Z","steps":["trace[2064359483] 'read index received' (duration: 8.322061ms)","trace[2064359483] 'applied index is now lower than readState.Index' (duration: 182.712251ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:31.219394Z","caller":"traceutil/trace.go:171","msg":"trace[776515019] transaction","detail":"{read_only:false; number_of_response:0; response_revision:238; }","duration":"252.139181ms","start":"2026-07-25T06:32:30.96723Z","end":"2026-07-25T06:32:31.219369Z","steps":["trace[776515019] 'process raft request' (duration: 246.991577ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:31.236304Z","caller":"traceutil/trace.go:171","msg":"trace[1022340495] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"241.250053ms","start":"2026-07-25T06:32:30.994997Z","end":"2026-07-25T06:32:31.236247Z","steps":["trace[1022340495] 'process raft request' (duration: 241.026922ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:31.236408Z","caller":"traceutil/trace.go:171","msg":"trace[330309018] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"168.558267ms","start":"2026-07-25T06:32:31.06784Z","end":"2026-07-25T06:32:31.236399Z","steps":["trace[330309018] 'process raft request' (duration: 168.514125ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:31.236408Z","caller":"traceutil/trace.go:171","msg":"trace[170406232] transaction","detail":"{read_only:false; number_of_response:0; response_revision:240; }","duration":"240.358669ms","start":"2026-07-25T06:32:30.996005Z","end":"2026-07-25T06:32:31.236364Z","steps":["trace[170406232] 'process raft request' (duration: 240.189401ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:31.236492Z","caller":"traceutil/trace.go:171","msg":"trace[517517936] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"240.269345ms","start":"2026-07-25T06:32:30.996187Z","end":"2026-07-25T06:32:31.236457Z","steps":["trace[517517936] 'process raft request' (duration: 240.037593ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:31.23635Z","caller":"traceutil/trace.go:171","msg":"trace[12034172] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"240.713576ms","start":"2026-07-25T06:32:30.995616Z","end":"2026-07-25T06:32:31.236329Z","steps":["trace[12034172] 'process raft request' (duration: 240.529327ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:31.236558Z","caller":"traceutil/trace.go:171","msg":"trace[711777577] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"168.993168ms","start":"2026-07-25T06:32:31.067449Z","end":"2026-07-25T06:32:31.236442Z","steps":["trace[711777577] 'process raft request' (duration: 168.872812ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:31.236628Z","caller":"traceutil/trace.go:171","msg":"trace[1158028011] transaction","detail":"{read_only:false; response_revision:242; number_of_response:1; }","duration":"239.209082ms","start":"2026-07-25T06:32:30.99737Z","end":"2026-07-25T06:32:31.23658Z","steps":["trace[1158028011] 'process raft request' (duration: 238.882236ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:31.236713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.977725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-25T06:32:31.236742Z","caller":"traceutil/trace.go:171","msg":"trace[476667148] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:244; }","duration":"363.021417ms","start":"2026-07-25T06:32:30.873711Z","end":"2026-07-25T06:32:31.236733Z","steps":["trace[476667148] 'agreement among raft nodes before linearized reading' (duration: 362.930603ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:31.236763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:30.873704Z","time spent":"363.053979ms","remote":"127.0.0.1:57784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-25T06:32:31.237021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.302221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-07-25T06:32:31.237087Z","caller":"traceutil/trace.go:171","msg":"trace[1870798043] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:244; }","duration":"364.417817ms","start":"2026-07-25T06:32:30.872651Z","end":"2026-07-25T06:32:31.237069Z","steps":["trace[1870798043] 'agreement among raft nodes before linearized reading' (duration: 364.205216ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:31.236408Z","caller":"traceutil/trace.go:171","msg":"trace[584736033] linearizableReadLoop","detail":"{readStateIndex:250; appliedIndex:244; }","duration":"173.272659ms","start":"2026-07-25T06:32:31.063111Z","end":"2026-07-25T06:32:31.236384Z","steps":["trace[584736033] 'read index received' (duration: 151.253722ms)","trace[584736033] 'applied index is now lower than readState.Index' (duration: 22.018057ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:31.237217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:30.872635Z","time spent":"364.479839ms","remote":"127.0.0.1:58064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-07-25T06:32:31.237318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.753175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-07-25T06:32:31.237376Z","caller":"traceutil/trace.go:171","msg":"trace[1228546724] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:244; }","duration":"170.85434ms","start":"2026-07-25T06:32:31.066506Z","end":"2026-07-25T06:32:31.23736Z","steps":["trace[1228546724] 'agreement among raft nodes before linearized reading' (duration: 170.735314ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:31.417838Z","caller":"traceutil/trace.go:171","msg":"trace[437535008] linearizableReadLoop","detail":"{readStateIndex:259; appliedIndex:257; }","duration":"109.65631ms","start":"2026-07-25T06:32:31.308156Z","end":"2026-07-25T06:32:31.417812Z","steps":["trace[437535008] 'read index received' (duration: 64.442049ms)","trace[437535008] 'applied index is now lower than readState.Index' (duration: 45.212921ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:31.417905Z","caller":"traceutil/trace.go:171","msg":"trace[14378957] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"140.26647ms","start":"2026-07-25T06:32:31.277588Z","end":"2026-07-25T06:32:31.417855Z","steps":["trace[14378957] 'process raft request' (duration: 94.993937ms)","trace[14378957] 'compare' (duration: 45.022041ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:31.418081Z","caller":"traceutil/trace.go:171","msg":"trace[618884942] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"138.348035ms","start":"2026-07-25T06:32:31.279669Z","end":"2026-07-25T06:32:31.418017Z","steps":["trace[618884942] 'process raft request' (duration: 138.081982ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:31.418411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.904188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-07-25T06:32:31.418491Z","caller":"traceutil/trace.go:171","msg":"trace[809361356] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:251; }","duration":"147.023924ms","start":"2026-07-25T06:32:31.271444Z","end":"2026-07-25T06:32:31.418467Z","steps":["trace[809361356] 'agreement among raft nodes before linearized reading' (duration: 146.509828ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:31.423728Z","caller":"traceutil/trace.go:171","msg":"trace[230891681] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"111.88505ms","start":"2026-07-25T06:32:31.311813Z","end":"2026-07-25T06:32:31.423698Z","steps":["trace[230891681] 'process raft request' (duration: 111.69796ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:32.985043Z","caller":"traceutil/trace.go:171","msg":"trace[2126338029] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"168.128566ms","start":"2026-07-25T06:32:32.816893Z","end":"2026-07-25T06:32:32.985021Z","steps":["trace[2126338029] 'process raft request' (duration: 167.973148ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:33.219369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.986837ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:32:33.219498Z","caller":"traceutil/trace.go:171","msg":"trace[107081954] linearizableReadLoop","detail":"{readStateIndex:294; appliedIndex:293; }","duration":"231.075667ms","start":"2026-07-25T06:32:32.988398Z","end":"2026-07-25T06:32:33.219474Z","steps":["trace[107081954] 'read index received' (duration: 58.87515ms)","trace[107081954] 'applied index is now lower than readState.Index' (duration: 172.198147ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:33.21958Z","caller":"traceutil/trace.go:171","msg":"trace[250817920] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"394.029618ms","start":"2026-07-25T06:32:32.825524Z","end":"2026-07-25T06:32:33.219553Z","steps":["trace[250817920] 'process raft request' (duration: 221.775618ms)","trace[250817920] 'compare' (duration: 171.717114ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:33.219666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.253506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6964"} {"level":"warn","ts":"2026-07-25T06:32:33.21968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:32.8255Z","time spent":"394.133173ms","remote":"127.0.0.1:57868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":217,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:33.219733Z","caller":"traceutil/trace.go:171","msg":"trace[310316666] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:282; }","duration":"231.349941ms","start":"2026-07-25T06:32:32.988365Z","end":"2026-07-25T06:32:33.219715Z","steps":["trace[310316666] 'agreement among raft nodes before linearized reading' (duration: 231.171682ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:33.427055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.213369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:32:33.427221Z","caller":"traceutil/trace.go:171","msg":"trace[1656187432] linearizableReadLoop","detail":"{readStateIndex:295; appliedIndex:294; }","duration":"196.674823ms","start":"2026-07-25T06:32:33.230522Z","end":"2026-07-25T06:32:33.427197Z","steps":["trace[1656187432] 'read index received' (duration: 90.059334ms)","trace[1656187432] 'applied index is now lower than readState.Index' (duration: 106.613629ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:33.427374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.850101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-25T06:32:33.427417Z","caller":"traceutil/trace.go:171","msg":"trace[798614025] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:283; }","duration":"196.912584ms","start":"2026-07-25T06:32:33.230493Z","end":"2026-07-25T06:32:33.427405Z","steps":["trace[798614025] 'agreement among raft nodes before linearized reading' (duration: 196.83112ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:33.427379Z","caller":"traceutil/trace.go:171","msg":"trace[1779702625] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"198.611508ms","start":"2026-07-25T06:32:33.228727Z","end":"2026-07-25T06:32:33.427338Z","steps":["trace[1779702625] 'process raft request' (duration: 91.991389ms)","trace[1779702625] 'compare' (duration: 106.02788ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:33.427481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.722234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:32:33.427746Z","caller":"traceutil/trace.go:171","msg":"trace[240588432] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:283; }","duration":"120.026589ms","start":"2026-07-25T06:32:33.307686Z","end":"2026-07-25T06:32:33.427713Z","steps":["trace[240588432] 'agreement among raft nodes before linearized reading' (duration: 119.714254ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:35.730669Z","caller":"traceutil/trace.go:171","msg":"trace[160458387] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"124.006963ms","start":"2026-07-25T06:32:35.606627Z","end":"2026-07-25T06:32:35.730634Z","steps":["trace[160458387] 'process raft request' (duration: 101.233244ms)","trace[160458387] 'compare' (duration: 22.59207ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:35.748236Z","caller":"traceutil/trace.go:171","msg":"trace[582077120] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"140.128575ms","start":"2026-07-25T06:32:35.60809Z","end":"2026-07-25T06:32:35.748219Z","steps":["trace[582077120] 'process raft request' (duration: 139.82634ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:35.74851Z","caller":"traceutil/trace.go:171","msg":"trace[290277954] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"140.03557ms","start":"2026-07-25T06:32:35.608389Z","end":"2026-07-25T06:32:35.748424Z","steps":["trace[290277954] 'process raft request' (duration: 139.691223ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:35.750543Z","caller":"traceutil/trace.go:171","msg":"trace[270987820] linearizableReadLoop","detail":"{readStateIndex:334; appliedIndex:329; }","duration":"126.660983ms","start":"2026-07-25T06:32:35.623813Z","end":"2026-07-25T06:32:35.750474Z","steps":["trace[270987820] 'read index received' (duration: 84.06163ms)","trace[270987820] 'applied index is now lower than readState.Index' (duration: 42.421144ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:35.75022Z","caller":"traceutil/trace.go:171","msg":"trace[257791980] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"138.284494ms","start":"2026-07-25T06:32:35.611873Z","end":"2026-07-25T06:32:35.750157Z","steps":["trace[257791980] 'process raft request' (duration: 136.316908ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:35.750903Z","caller":"traceutil/trace.go:171","msg":"trace[1693321640] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"138.457012ms","start":"2026-07-25T06:32:35.612417Z","end":"2026-07-25T06:32:35.750874Z","steps":["trace[1693321640] 'process raft request' (duration: 137.223252ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:35.75521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.373284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-07-25T06:32:35.756202Z","caller":"traceutil/trace.go:171","msg":"trace[1833819218] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:322; }","duration":"131.605376ms","start":"2026-07-25T06:32:35.623775Z","end":"2026-07-25T06:32:35.75538Z","steps":["trace[1833819218] 'agreement among raft nodes before linearized reading' (duration: 127.509655ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:36.608172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.37924ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:32:36.608512Z","caller":"traceutil/trace.go:171","msg":"trace[2066773873] linearizableReadLoop","detail":"{readStateIndex:359; appliedIndex:355; }","duration":"156.694652ms","start":"2026-07-25T06:32:36.451795Z","end":"2026-07-25T06:32:36.60849Z","steps":["trace[2066773873] 'read index received' (duration: 145.773196ms)","trace[2066773873] 'applied index is now lower than readState.Index' (duration: 10.920065ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:36.608504Z","caller":"traceutil/trace.go:171","msg":"trace[805727801] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"674.197255ms","start":"2026-07-25T06:32:35.934257Z","end":"2026-07-25T06:32:36.608455Z","steps":["trace[805727801] 'process raft request' (duration: 195.426905ms)","trace[805727801] 'compare' (duration: 478.220333ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:36.608567Z","caller":"traceutil/trace.go:171","msg":"trace[1080416515] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"668.318167ms","start":"2026-07-25T06:32:35.940217Z","end":"2026-07-25T06:32:36.608535Z","steps":["trace[1080416515] 'process raft request' (duration: 668.159909ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:36.60855Z","caller":"traceutil/trace.go:171","msg":"trace[315699647] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"668.307706ms","start":"2026-07-25T06:32:35.940178Z","end":"2026-07-25T06:32:36.608485Z","steps":["trace[315699647] 'process raft request' (duration: 668.130638ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:36.608634Z","caller":"traceutil/trace.go:171","msg":"trace[1830969801] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"576.600062ms","start":"2026-07-25T06:32:36.032022Z","end":"2026-07-25T06:32:36.608622Z","steps":["trace[1830969801] 'process raft request' (duration: 576.412023ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:36.60869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:35.940208Z","time spent":"668.404781ms","remote":"127.0.0.1:57850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:32:36.608696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:35.934246Z","time spent":"674.348253ms","remote":"127.0.0.1:58154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3759,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:32:36.608714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:36.03199Z","time spent":"576.680586ms","remote":"127.0.0.1:57850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7096,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:32:36.60881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:35.940171Z","time spent":"668.485045ms","remote":"127.0.0.1:57756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:36.608898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.518974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-25T06:32:36.608939Z","caller":"traceutil/trace.go:171","msg":"trace[958976966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:347; }","duration":"143.609529ms","start":"2026-07-25T06:32:36.465316Z","end":"2026-07-25T06:32:36.608925Z","steps":["trace[958976966] 'agreement among raft nodes before linearized reading' (duration: 143.525325ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:36.608945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.161565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-25T06:32:36.608983Z","caller":"traceutil/trace.go:171","msg":"trace[1780522894] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:347; }","duration":"157.252149ms","start":"2026-07-25T06:32:36.451718Z","end":"2026-07-25T06:32:36.60897Z","steps":["trace[1780522894] 'agreement among raft nodes before linearized reading' (duration: 157.178286ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:37.169588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.76528ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:32:37.169708Z","caller":"traceutil/trace.go:171","msg":"trace[224229561] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"553.90856ms","start":"2026-07-25T06:32:36.615781Z","end":"2026-07-25T06:32:37.16969Z","steps":["trace[224229561] 'process raft request' (duration: 169.954522ms)","trace[224229561] 'compare' (duration: 383.619092ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:37.169772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:36.615751Z","time spent":"553.992375ms","remote":"127.0.0.1:57934","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-07-25T06:32:37.210705Z","caller":"traceutil/trace.go:171","msg":"trace[673515284] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"593.911362ms","start":"2026-07-25T06:32:36.616768Z","end":"2026-07-25T06:32:37.210679Z","steps":["trace[673515284] 'process raft request' (duration: 593.85324ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:37.210867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:36.616762Z","time spent":"594.018547ms","remote":"127.0.0.1:58154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:32:37.211358Z","caller":"traceutil/trace.go:171","msg":"trace[1160488799] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"594.069491ms","start":"2026-07-25T06:32:36.616695Z","end":"2026-07-25T06:32:37.210765Z","steps":["trace[1160488799] 'process raft request' (duration: 593.783437ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:37.211988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:36.616675Z","time spent":"594.832948ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:32:37.610592Z","caller":"traceutil/trace.go:171","msg":"trace[434560919] linearizableReadLoop","detail":"{readStateIndex:363; appliedIndex:362; }","duration":"140.536611ms","start":"2026-07-25T06:32:37.470032Z","end":"2026-07-25T06:32:37.610568Z","steps":["trace[434560919] 'read index received' (duration: 135.264943ms)","trace[434560919] 'applied index is now lower than readState.Index' (duration: 5.270778ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:37.610721Z","caller":"traceutil/trace.go:171","msg":"trace[259739051] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"392.351071ms","start":"2026-07-25T06:32:37.218345Z","end":"2026-07-25T06:32:37.610696Z","steps":["trace[259739051] 'process raft request' (duration: 386.971747ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:37.610828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:37.21832Z","time spent":"392.433004ms","remote":"127.0.0.1:58136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:32:37.611104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.040756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/coredns-7c96b6546b-sr4k5.18c574b6d31de248\" ","response":"range_response_count:1 size:845"} {"level":"info","ts":"2026-07-25T06:32:37.611218Z","caller":"traceutil/trace.go:171","msg":"trace[652672308] range","detail":"{range_begin:/registry/events/kube-system/coredns-7c96b6546b-sr4k5.18c574b6d31de248; range_end:; response_count:1; response_revision:351; }","duration":"141.197184ms","start":"2026-07-25T06:32:37.469993Z","end":"2026-07-25T06:32:37.61119Z","steps":["trace[652672308] 'agreement among raft nodes before linearized reading' (duration: 141.011795ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:37.832759Z","caller":"traceutil/trace.go:171","msg":"trace[407884213] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"142.929479ms","start":"2026-07-25T06:32:37.689802Z","end":"2026-07-25T06:32:37.832731Z","steps":["trace[407884213] 'process raft request' (duration: 58.419184ms)","trace[407884213] 'compare' (duration: 84.314315ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:37.832987Z","caller":"traceutil/trace.go:171","msg":"trace[1503443459] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"124.227922ms","start":"2026-07-25T06:32:37.708729Z","end":"2026-07-25T06:32:37.832956Z","steps":["trace[1503443459] 'process raft request' (duration: 123.955118ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:39.090098Z","caller":"traceutil/trace.go:171","msg":"trace[1004395729] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"157.782867ms","start":"2026-07-25T06:32:38.932295Z","end":"2026-07-25T06:32:39.090078Z","steps":["trace[1004395729] 'process raft request' (duration: 157.683722ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:40.531412Z","caller":"traceutil/trace.go:171","msg":"trace[1058766874] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"112.535724ms","start":"2026-07-25T06:32:40.418852Z","end":"2026-07-25T06:32:40.531387Z","steps":["trace[1058766874] 'process raft request' (duration: 112.376816ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:41.07114Z","caller":"traceutil/trace.go:171","msg":"trace[2108309427] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"165.538943ms","start":"2026-07-25T06:32:40.905571Z","end":"2026-07-25T06:32:41.07111Z","steps":["trace[2108309427] 'process raft request' (duration: 165.374415ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:45.806016Z","caller":"traceutil/trace.go:171","msg":"trace[1058038133] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"103.058681ms","start":"2026-07-25T06:32:45.702931Z","end":"2026-07-25T06:32:45.80599Z","steps":["trace[1058038133] 'process raft request' (duration: 46.147148ms)","trace[1058038133] 'compare' (duration: 56.813098ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:47.835215Z","caller":"traceutil/trace.go:171","msg":"trace[1549603602] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"127.889901ms","start":"2026-07-25T06:32:47.707282Z","end":"2026-07-25T06:32:47.835172Z","steps":["trace[1549603602] 'process raft request' (duration: 127.620948ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:54.971775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.293242ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-25T06:32:59.43253Z","caller":"traceutil/trace.go:171","msg":"trace[956335891] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"132.394957ms","start":"2026-07-25T06:32:59.300113Z","end":"2026-07-25T06:32:59.432508Z","steps":["trace[956335891] 'process raft request' (duration: 94.629843ms)","trace[956335891] 'compare' (duration: 37.665899ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:01.679828Z","caller":"traceutil/trace.go:171","msg":"trace[1309960359] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"104.764388ms","start":"2026-07-25T06:33:01.575036Z","end":"2026-07-25T06:33:01.6798Z","steps":["trace[1309960359] 'process raft request' (duration: 104.526316ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:01.876613Z","caller":"traceutil/trace.go:171","msg":"trace[577885435] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"192.508004ms","start":"2026-07-25T06:33:01.684071Z","end":"2026-07-25T06:33:01.876579Z","steps":["trace[577885435] 'process raft request' (duration: 165.07962ms)","trace[577885435] 'compare' (duration: 27.157851ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:02.085464Z","caller":"traceutil/trace.go:171","msg":"trace[99609500] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"111.004427ms","start":"2026-07-25T06:33:01.974437Z","end":"2026-07-25T06:33:02.085441Z","steps":["trace[99609500] 'process raft request' (duration: 109.525176ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:03.79883Z","caller":"traceutil/trace.go:171","msg":"trace[412790801] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"111.601294ms","start":"2026-07-25T06:33:03.687205Z","end":"2026-07-25T06:33:03.798806Z","steps":["trace[412790801] 'process raft request' (duration: 111.410974ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:04.006791Z","caller":"traceutil/trace.go:171","msg":"trace[734274279] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"121.930882ms","start":"2026-07-25T06:33:03.884833Z","end":"2026-07-25T06:33:04.006764Z","steps":["trace[734274279] 'process raft request' (duration: 101.063825ms)","trace[734274279] 'compare' (duration: 20.749041ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:04.479859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.396536ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:33:04.479953Z","caller":"traceutil/trace.go:171","msg":"trace[348426333] linearizableReadLoop","detail":"{readStateIndex:477; appliedIndex:476; }","duration":"354.85211ms","start":"2026-07-25T06:33:04.125088Z","end":"2026-07-25T06:33:04.479941Z","steps":["trace[348426333] 'read index received' (duration: 44.184491ms)","trace[348426333] 'applied index is now lower than readState.Index' (duration: 310.666779ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:04.480008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.928354ms","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-07-25T06:33:04.480024Z","caller":"traceutil/trace.go:171","msg":"trace[68383970] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:458; }","duration":"354.985037ms","start":"2026-07-25T06:33:04.125033Z","end":"2026-07-25T06:33:04.480018Z","steps":["trace[68383970] 'agreement among raft nodes before linearized reading' (duration: 354.940945ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:04.480011Z","caller":"traceutil/trace.go:171","msg":"trace[251317242] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"385.855615ms","start":"2026-07-25T06:33:04.094118Z","end":"2026-07-25T06:33:04.479974Z","steps":["trace[251317242] 'process raft request' (duration: 75.268599ms)","trace[251317242] 'compare' (duration: 310.305842ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:04.480187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:04.094102Z","time spent":"385.990632ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:33:04.48005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:04.125014Z","time spent":"355.030708ms","remote":"127.0.0.1:57934","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-07-25T06:33:04.76034Z","caller":"traceutil/trace.go:171","msg":"trace[996766914] linearizableReadLoop","detail":"{readStateIndex:478; appliedIndex:477; }","duration":"223.845852ms","start":"2026-07-25T06:33:04.536468Z","end":"2026-07-25T06:33:04.760314Z","steps":["trace[996766914] 'read index received' (duration: 222.542889ms)","trace[996766914] 'applied index is now lower than readState.Index' (duration: 1.301993ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:04.760421Z","caller":"traceutil/trace.go:171","msg":"trace[536088800] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"276.344754ms","start":"2026-07-25T06:33:04.484056Z","end":"2026-07-25T06:33:04.760401Z","steps":["trace[536088800] 'process raft request' (duration: 274.985339ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:04.76202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.537334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:33:04.762243Z","caller":"traceutil/trace.go:171","msg":"trace[858097514] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:459; }","duration":"225.795166ms","start":"2026-07-25T06:33:04.536421Z","end":"2026-07-25T06:33:04.762216Z","steps":["trace[858097514] 'agreement among raft nodes before linearized reading' (duration: 223.975428ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:06.07308Z","caller":"traceutil/trace.go:171","msg":"trace[1024476822] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"265.707105ms","start":"2026-07-25T06:33:05.807339Z","end":"2026-07-25T06:33:06.073046Z","steps":["trace[1024476822] 'process raft request' (duration: 265.312866ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:06.366879Z","caller":"traceutil/trace.go:171","msg":"trace[1213086698] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"289.721958ms","start":"2026-07-25T06:33:06.077055Z","end":"2026-07-25T06:33:06.366777Z","steps":["trace[1213086698] 'process raft request' (duration: 242.570127ms)","trace[1213086698] 'compare' (duration: 46.955112ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:06.796439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.616048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:33:06.796528Z","caller":"traceutil/trace.go:171","msg":"trace[4132010] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:461; }","duration":"259.736824ms","start":"2026-07-25T06:33:06.53677Z","end":"2026-07-25T06:33:06.796507Z","steps":["trace[4132010] 'range keys from in-memory index tree' (duration: 259.482432ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:06.796502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.914279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-25T06:33:06.796605Z","caller":"traceutil/trace.go:171","msg":"trace[2032566760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:461; }","duration":"312.073446ms","start":"2026-07-25T06:33:06.484509Z","end":"2026-07-25T06:33:06.796582Z","steps":["trace[2032566760] 'range keys from in-memory index tree' (duration: 311.808283ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:06.796661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:06.48449Z","time spent":"312.16044ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-25T06:33:07.18618Z","caller":"traceutil/trace.go:171","msg":"trace[1306315388] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"385.467019ms","start":"2026-07-25T06:33:06.800681Z","end":"2026-07-25T06:33:07.186148Z","steps":["trace[1306315388] 'process raft request' (duration: 385.298951ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:07.186393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:06.800655Z","time spent":"385.636117ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:33:07.205192Z","caller":"traceutil/trace.go:171","msg":"trace[1534198242] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"404.225002ms","start":"2026-07-25T06:33:06.800948Z","end":"2026-07-25T06:33:07.205173Z","steps":["trace[1534198242] 'process raft request' (duration: 401.778755ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:07.205312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:06.800926Z","time spent":"404.310437ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:33:09.139926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.422898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12673"} {"level":"info","ts":"2026-07-25T06:33:09.140064Z","caller":"traceutil/trace.go:171","msg":"trace[1733413187] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:466; }","duration":"178.579486ms","start":"2026-07-25T06:33:08.961428Z","end":"2026-07-25T06:33:09.140007Z","steps":["trace[1733413187] 'range keys from in-memory index tree' (duration: 178.198578ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:09.477244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.09438ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:33:09.47747Z","caller":"traceutil/trace.go:171","msg":"trace[1917655935] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"206.511759ms","start":"2026-07-25T06:33:09.270934Z","end":"2026-07-25T06:33:09.477445Z","steps":["trace[1917655935] 'process raft request' (duration: 206.434345ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:09.477471Z","caller":"traceutil/trace.go:171","msg":"trace[1821142420] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"226.208667ms","start":"2026-07-25T06:33:09.251238Z","end":"2026-07-25T06:33:09.477447Z","steps":["trace[1821142420] 'process raft request' (duration: 105.806822ms)","trace[1821142420] 'compare' (duration: 119.931863ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:09.477503Z","caller":"traceutil/trace.go:171","msg":"trace[594122232] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:488; }","duration":"207.35273ms","start":"2026-07-25T06:33:09.270124Z","end":"2026-07-25T06:33:09.477477Z","steps":["trace[594122232] 'read index received' (duration: 86.875491ms)","trace[594122232] 'applied index is now lower than readState.Index' (duration: 120.474569ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:09.477648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.512587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12673"} {"level":"info","ts":"2026-07-25T06:33:09.477683Z","caller":"traceutil/trace.go:171","msg":"trace[1888822913] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:469; }","duration":"207.580941ms","start":"2026-07-25T06:33:09.270089Z","end":"2026-07-25T06:33:09.47767Z","steps":["trace[1888822913] 'agreement among raft nodes before linearized reading' (duration: 207.457105ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:10.412324Z","caller":"traceutil/trace.go:171","msg":"trace[1725616596] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:490; }","duration":"256.69887ms","start":"2026-07-25T06:33:10.1556Z","end":"2026-07-25T06:33:10.412299Z","steps":["trace[1725616596] 'read index received' (duration: 256.519551ms)","trace[1725616596] 'applied index is now lower than readState.Index' (duration: 178.329µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:10.41239Z","caller":"traceutil/trace.go:171","msg":"trace[197850257] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"319.25631ms","start":"2026-07-25T06:33:10.093102Z","end":"2026-07-25T06:33:10.412359Z","steps":["trace[197850257] 'process raft request' (duration: 319.071251ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:10.412486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.866498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:33:10.412537Z","caller":"traceutil/trace.go:171","msg":"trace[514340605] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:0; response_revision:470; }","duration":"257.022126ms","start":"2026-07-25T06:33:10.155502Z","end":"2026-07-25T06:33:10.412524Z","steps":["trace[514340605] 'agreement among raft nodes before linearized reading' (duration: 256.91046ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:10.412537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:10.093082Z","time spent":"319.377515ms","remote":"127.0.0.1:57934","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-07-25T06:33:10.639735Z","caller":"traceutil/trace.go:171","msg":"trace[1338608506] linearizableReadLoop","detail":"{readStateIndex:492; appliedIndex:491; }","duration":"222.323296ms","start":"2026-07-25T06:33:10.417382Z","end":"2026-07-25T06:33:10.639705Z","steps":["trace[1338608506] 'read index received' (duration: 222.000221ms)","trace[1338608506] 'applied index is now lower than readState.Index' (duration: 319.455µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:10.639882Z","caller":"traceutil/trace.go:171","msg":"trace[585940752] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"223.339906ms","start":"2026-07-25T06:33:10.416504Z","end":"2026-07-25T06:33:10.639844Z","steps":["trace[585940752] 'process raft request' (duration: 222.980259ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:10.639904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.499335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/cilium-config\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:33:10.63996Z","caller":"traceutil/trace.go:171","msg":"trace[2119747189] range","detail":"{range_begin:/registry/configmaps/kube-system/cilium-config; range_end:; response_count:0; response_revision:471; }","duration":"222.575769ms","start":"2026-07-25T06:33:10.417367Z","end":"2026-07-25T06:33:10.639943Z","steps":["trace[2119747189] 'agreement among raft nodes before linearized reading' (duration: 222.456983ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:10.850575Z","caller":"traceutil/trace.go:171","msg":"trace[1039946104] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"116.017762ms","start":"2026-07-25T06:33:10.73453Z","end":"2026-07-25T06:33:10.850548Z","steps":["trace[1039946104] 'process raft request' (duration: 115.701987ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:11.858678Z","caller":"traceutil/trace.go:171","msg":"trace[989752714] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:526; }","duration":"320.856451ms","start":"2026-07-25T06:33:11.537794Z","end":"2026-07-25T06:33:11.858651Z","steps":["trace[989752714] 'read index received' (duration: 320.530716ms)","trace[989752714] 'applied index is now lower than readState.Index' (duration: 324.725µs)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:11.858818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.998968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:33:11.858793Z","caller":"traceutil/trace.go:171","msg":"trace[1284770635] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"372.328147ms","start":"2026-07-25T06:33:11.486415Z","end":"2026-07-25T06:33:11.858743Z","steps":["trace[1284770635] 'process raft request' (duration: 371.996101ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:11.858862Z","caller":"traceutil/trace.go:171","msg":"trace[209794124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:506; }","duration":"321.108723ms","start":"2026-07-25T06:33:11.537741Z","end":"2026-07-25T06:33:11.858849Z","steps":["trace[209794124] 'agreement among raft nodes before linearized reading' (duration: 321.025309ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:11.858898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:11.53772Z","time spent":"321.170066ms","remote":"127.0.0.1:57672","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-07-25T06:33:11.858968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:11.486381Z","time spent":"372.500065ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:33:13.362068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.848846ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:33:13.362273Z","caller":"traceutil/trace.go:171","msg":"trace[1673213484] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"212.821449ms","start":"2026-07-25T06:33:13.149431Z","end":"2026-07-25T06:33:13.362252Z","steps":["trace[1673213484] 'process raft request' (duration: 69.669738ms)","trace[1673213484] 'compare' (duration: 142.675728ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:13.364775Z","caller":"traceutil/trace.go:171","msg":"trace[1056210106] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"204.532801ms","start":"2026-07-25T06:33:13.159664Z","end":"2026-07-25T06:33:13.364197Z","steps":["trace[1056210106] 'process raft request' (duration: 204.281279ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:13.369549Z","caller":"traceutil/trace.go:171","msg":"trace[1431874181] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"194.090589ms","start":"2026-07-25T06:33:13.175421Z","end":"2026-07-25T06:33:13.369511Z","steps":["trace[1431874181] 'process raft request' (duration: 188.738352ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:13.370548Z","caller":"traceutil/trace.go:171","msg":"trace[898629838] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"182.980835ms","start":"2026-07-25T06:33:13.187447Z","end":"2026-07-25T06:33:13.370427Z","steps":["trace[898629838] 'process raft request' (duration: 182.353225ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:13.976345Z","caller":"traceutil/trace.go:171","msg":"trace[1144407214] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"598.296849ms","start":"2026-07-25T06:33:13.378018Z","end":"2026-07-25T06:33:13.976314Z","steps":["trace[1144407214] 'process raft request' (duration: 549.042491ms)","trace[1144407214] 'compare' (duration: 49.058958ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:13.976488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:13.378Z","time spent":"598.423715ms","remote":"127.0.0.1:58206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:33:14.213654Z","caller":"traceutil/trace.go:171","msg":"trace[1886495955] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"835.431814ms","start":"2026-07-25T06:33:13.378195Z","end":"2026-07-25T06:33:14.213627Z","steps":["trace[1886495955] 'process raft request' (duration: 835.183812ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:14.213837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:13.37818Z","time spent":"835.55982ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:33:14.213989Z","caller":"traceutil/trace.go:171","msg":"trace[474649607] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"813.819925ms","start":"2026-07-25T06:33:13.400123Z","end":"2026-07-25T06:33:14.213943Z","steps":["trace[474649607] 'process raft request' (duration: 813.433526ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:14.214195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:13.400102Z","time spent":"813.969162ms","remote":"127.0.0.1:57726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:33:14.214221Z","caller":"traceutil/trace.go:171","msg":"trace[1462136262] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"814.017845ms","start":"2026-07-25T06:33:13.40019Z","end":"2026-07-25T06:33:14.214208Z","steps":["trace[1462136262] 'process raft request' (duration: 813.648577ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:14.214215Z","caller":"traceutil/trace.go:171","msg":"trace[1008869476] linearizableReadLoop","detail":"{readStateIndex:583; appliedIndex:578; }","duration":"675.264636ms","start":"2026-07-25T06:33:13.538924Z","end":"2026-07-25T06:33:14.214189Z","steps":["trace[1008869476] 'read index received' (duration: 388.238582ms)","trace[1008869476] 'applied index is now lower than readState.Index' (duration: 287.024874ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:14.214301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:13.400186Z","time spent":"814.067017ms","remote":"127.0.0.1:57726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65190,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:33:14.214295Z","caller":"traceutil/trace.go:171","msg":"trace[1420113761] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"753.177821ms","start":"2026-07-25T06:33:13.461053Z","end":"2026-07-25T06:33:14.214231Z","steps":["trace[1420113761] 'process raft request' (duration: 753.065305ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:14.214423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.474125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T06:33:14.214496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.211459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-25T06:33:14.214534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:13.461031Z","time spent":"753.37996ms","remote":"127.0.0.1:57726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:33:14.214552Z","caller":"traceutil/trace.go:171","msg":"trace[1950074867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:558; }","duration":"675.611642ms","start":"2026-07-25T06:33:13.538909Z","end":"2026-07-25T06:33:14.214521Z","steps":["trace[1950074867] 'agreement among raft nodes before linearized reading' (duration: 675.381221ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:14.214618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:13.538858Z","time spent":"675.749289ms","remote":"127.0.0.1:57672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-25T06:33:14.214692Z","caller":"traceutil/trace.go:171","msg":"trace[2025598679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:558; }","duration":"351.340305ms","start":"2026-07-25T06:33:13.863196Z","end":"2026-07-25T06:33:14.214536Z","steps":["trace[2025598679] 'agreement among raft nodes before linearized reading' (duration: 351.152176ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:14.214742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:13.863176Z","time spent":"351.553896ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-25T06:33:14.544793Z","caller":"traceutil/trace.go:171","msg":"trace[103006859] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"275.384543ms","start":"2026-07-25T06:33:14.269366Z","end":"2026-07-25T06:33:14.544751Z","steps":["trace[103006859] 'process raft request' (duration: 275.222565ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:14.545078Z","caller":"traceutil/trace.go:171","msg":"trace[1163244426] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"301.095988ms","start":"2026-07-25T06:33:14.243925Z","end":"2026-07-25T06:33:14.545021Z","steps":["trace[1163244426] 'process raft request' (duration: 220.161279ms)","trace[1163244426] 'compare' (duration: 80.236715ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:14.545383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:14.243901Z","time spent":"301.306499ms","remote":"127.0.0.1:57726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:33:14.81523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.513904ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:33:14.81545Z","caller":"traceutil/trace.go:171","msg":"trace[1283046470] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"240.883905ms","start":"2026-07-25T06:33:14.574539Z","end":"2026-07-25T06:33:14.815423Z","steps":["trace[1283046470] 'process raft request' (duration: 132.082247ms)","trace[1283046470] 'compare' (duration: 108.282394ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:14.816114Z","caller":"traceutil/trace.go:171","msg":"trace[1123735562] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"224.089798ms","start":"2026-07-25T06:33:14.592009Z","end":"2026-07-25T06:33:14.816099Z","steps":["trace[1123735562] 'process raft request' (duration: 223.385174ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:14.816361Z","caller":"traceutil/trace.go:171","msg":"trace[2012584256] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"189.462404ms","start":"2026-07-25T06:33:14.626872Z","end":"2026-07-25T06:33:14.816334Z","steps":["trace[2012584256] 'process raft request' (duration: 189.237473ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:14.859957Z","caller":"traceutil/trace.go:171","msg":"trace[300723727] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:588; }","duration":"204.443804ms","start":"2026-07-25T06:33:14.655491Z","end":"2026-07-25T06:33:14.859934Z","steps":["trace[300723727] 'read index received' (duration: 51.145327ms)","trace[300723727] 'applied index is now lower than readState.Index' (duration: 153.296707ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:14.860175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.657865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-25T06:33:14.860268Z","caller":"traceutil/trace.go:171","msg":"trace[199587357] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:566; }","duration":"204.794071ms","start":"2026-07-25T06:33:14.655456Z","end":"2026-07-25T06:33:14.86025Z","steps":["trace[199587357] 'agreement among raft nodes before linearized reading' (duration: 204.55761ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:16.038244Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592197943351272908,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T06:33:16.538964Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592197943351272908,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T06:33:17.039558Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592197943351272908,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T06:33:17.258644Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.944214108s","expected-duration":"1s"} {"level":"info","ts":"2026-07-25T06:33:17.33348Z","caller":"traceutil/trace.go:171","msg":"trace[1726640357] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"2.019126415s","start":"2026-07-25T06:33:15.314309Z","end":"2026-07-25T06:33:17.333435Z","steps":["trace[1726640357] 'process raft request' (duration: 1.944548245s)","trace[1726640357] 'compare' (duration: 74.284036ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:17.333774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:15.31428Z","time spent":"2.019292393s","remote":"127.0.0.1:57726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:33:17.528955Z","caller":"traceutil/trace.go:171","msg":"trace[1046296412] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:608; }","duration":"1.991015289s","start":"2026-07-25T06:33:15.537885Z","end":"2026-07-25T06:33:17.5289Z","steps":["trace[1046296412] 'read index received' (duration: 1.720956063s)","trace[1046296412] 'applied index is now lower than readState.Index' (duration: 270.053656ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:17.52907Z","caller":"traceutil/trace.go:171","msg":"trace[782173414] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"2.126024025s","start":"2026-07-25T06:33:15.40298Z","end":"2026-07-25T06:33:17.529004Z","steps":["trace[782173414] 'process raft request' (duration: 2.111796352s)","trace[782173414] 'compare' (duration: 13.152211ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:17.529366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:15.402959Z","time spent":"2.126271767s","remote":"127.0.0.1:57726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:33:17.52977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99185972s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:33:17.52986Z","caller":"traceutil/trace.go:171","msg":"trace[245653163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"1.991992876s","start":"2026-07-25T06:33:15.537849Z","end":"2026-07-25T06:33:17.529842Z","steps":["trace[245653163] 'agreement among raft nodes before linearized reading' (duration: 1.991205998s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:17.530828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.996594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-25T06:33:17.531043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:15.537835Z","time spent":"1.993158303s","remote":"127.0.0.1:57672","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-07-25T06:33:17.531113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.312145971s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-25T06:33:17.531078Z","caller":"traceutil/trace.go:171","msg":"trace[1129571966] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:585; }","duration":"942.237395ms","start":"2026-07-25T06:33:16.588767Z","end":"2026-07-25T06:33:17.531004Z","steps":["trace[1129571966] 'agreement among raft nodes before linearized reading' (duration: 940.454909ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:17.531128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.300303321s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-25T06:33:17.531198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:16.588741Z","time spent":"942.435874ms","remote":"127.0.0.1:57934","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-07-25T06:33:17.531272Z","caller":"traceutil/trace.go:171","msg":"trace[285552034] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:585; }","duration":"1.300469309s","start":"2026-07-25T06:33:16.230743Z","end":"2026-07-25T06:33:17.531212Z","steps":["trace[285552034] 'agreement among raft nodes before linearized reading' (duration: 1.298525766s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:17.531353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:16.230718Z","time spent":"1.300618057s","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-25T06:33:17.530831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.074561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-25T06:33:17.531846Z","caller":"traceutil/trace.go:171","msg":"trace[2036202278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:585; }","duration":"637.060899ms","start":"2026-07-25T06:33:16.894685Z","end":"2026-07-25T06:33:17.531746Z","steps":["trace[2036202278] 'agreement among raft nodes before linearized reading' (duration: 634.490815ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:17.531931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:16.894664Z","time spent":"637.244238ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-25T06:33:17.531209Z","caller":"traceutil/trace.go:171","msg":"trace[1134498262] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"1.312253026s","start":"2026-07-25T06:33:16.218907Z","end":"2026-07-25T06:33:17.53116Z","steps":["trace[1134498262] 'agreement among raft nodes before linearized reading' (duration: 1.310246939s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:17.532619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:16.218886Z","time spent":"1.313707565s","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-25T06:33:19.673802Z","caller":"traceutil/trace.go:171","msg":"trace[898576059] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:626; }","duration":"122.32391ms","start":"2026-07-25T06:33:19.551442Z","end":"2026-07-25T06:33:19.673766Z","steps":["trace[898576059] 'read index received' (duration: 786.448µs)","trace[898576059] 'applied index is now lower than readState.Index' (duration: 121.535572ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:19.673879Z","caller":"traceutil/trace.go:171","msg":"trace[1468343575] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"122.503218ms","start":"2026-07-25T06:33:19.551348Z","end":"2026-07-25T06:33:19.673851Z","steps":["trace[1468343575] 'process raft request' (duration: 83.483286ms)","trace[1468343575] 'compare' (duration: 38.782461ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:19.674261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.795592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-25T06:33:19.674353Z","caller":"traceutil/trace.go:171","msg":"trace[269985049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:601; }","duration":"122.933439ms","start":"2026-07-25T06:33:19.551401Z","end":"2026-07-25T06:33:19.674335Z","steps":["trace[269985049] 'agreement among raft nodes before linearized reading' (duration: 122.564962ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:19.682941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.390423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-25T06:33:19.683031Z","caller":"traceutil/trace.go:171","msg":"trace[637508168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:602; }","duration":"127.52702ms","start":"2026-07-25T06:33:19.555484Z","end":"2026-07-25T06:33:19.683011Z","steps":["trace[637508168] 'agreement among raft nodes before linearized reading' (duration: 127.183814ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:22.990477Z","caller":"traceutil/trace.go:171","msg":"trace[1128373803] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"259.4129ms","start":"2026-07-25T06:33:22.731038Z","end":"2026-07-25T06:33:22.990451Z","steps":["trace[1128373803] 'process raft request' (duration: 258.900585ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:23.178617Z","caller":"traceutil/trace.go:171","msg":"trace[801706255] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"120.431564ms","start":"2026-07-25T06:33:23.05813Z","end":"2026-07-25T06:33:23.178561Z","steps":["trace[801706255] 'process raft request' (duration: 120.366961ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:23.178668Z","caller":"traceutil/trace.go:171","msg":"trace[1760394084] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"397.823165ms","start":"2026-07-25T06:33:22.780808Z","end":"2026-07-25T06:33:23.178632Z","steps":["trace[1760394084] 'process raft request' (duration: 313.931773ms)","trace[1760394084] 'compare' (duration: 83.575277ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:23.178779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:22.78079Z","time spent":"397.929431ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:33:24.223711Z","caller":"traceutil/trace.go:171","msg":"trace[770137694] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"481.138355ms","start":"2026-07-25T06:33:23.742541Z","end":"2026-07-25T06:33:24.22368Z","steps":["trace[770137694] 'process raft request' (duration: 480.904954ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:24.223827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:23.742529Z","time spent":"481.24703ms","remote":"127.0.0.1:57850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:33:24.223848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.656225ms","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-07-25T06:33:24.223909Z","caller":"traceutil/trace.go:171","msg":"trace[1829134630] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:628; }","duration":"479.76891ms","start":"2026-07-25T06:33:23.744126Z","end":"2026-07-25T06:33:24.223895Z","steps":["trace[1829134630] 'agreement among raft nodes before linearized reading' (duration: 479.638303ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:24.22396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:23.744111Z","time spent":"479.838473ms","remote":"127.0.0.1:57824","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-07-25T06:33:24.22371Z","caller":"traceutil/trace.go:171","msg":"trace[17398116] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"479.488386ms","start":"2026-07-25T06:33:23.744167Z","end":"2026-07-25T06:33:24.223655Z","steps":["trace[17398116] 'read index received' (duration: 479.276756ms)","trace[17398116] 'applied index is now lower than readState.Index' (duration: 210.51µs)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:24.43061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.413667ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:33:24.430724Z","caller":"traceutil/trace.go:171","msg":"trace[1178359663] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"201.489328ms","start":"2026-07-25T06:33:24.229213Z","end":"2026-07-25T06:33:24.430703Z","steps":["trace[1178359663] 'process raft request' (duration: 68.913423ms)","trace[1178359663] 'compare' (duration: 132.239479ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:24.61508Z","caller":"traceutil/trace.go:171","msg":"trace[782020797] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"381.59563ms","start":"2026-07-25T06:33:24.233462Z","end":"2026-07-25T06:33:24.615058Z","steps":["trace[782020797] 'process raft request' (duration: 381.512626ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:24.615302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:24.23345Z","time spent":"381.721107ms","remote":"127.0.0.1:57756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:33:24.615047Z","caller":"traceutil/trace.go:171","msg":"trace[1090168221] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"383.616937ms","start":"2026-07-25T06:33:24.2314Z","end":"2026-07-25T06:33:24.615017Z","steps":["trace[1090168221] 'process raft request' (duration: 378.730503ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:24.615726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:24.231374Z","time spent":"384.251729ms","remote":"127.0.0.1:57906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:33:24.615865Z","caller":"traceutil/trace.go:171","msg":"trace[2054778959] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"381.645403ms","start":"2026-07-25T06:33:24.233936Z","end":"2026-07-25T06:33:24.615581Z","steps":["trace[2054778959] 'process raft request' (duration: 381.092437ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:24.616283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:24.233922Z","time spent":"382.242071ms","remote":"127.0.0.1:57850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:33:25.371594Z","caller":"traceutil/trace.go:171","msg":"trace[1244821005] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"247.074091ms","start":"2026-07-25T06:33:25.124497Z","end":"2026-07-25T06:33:25.371571Z","steps":["trace[1244821005] 'read index received' (duration: 246.786477ms)","trace[1244821005] 'applied index is now lower than readState.Index' (duration: 286.764µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:25.371691Z","caller":"traceutil/trace.go:171","msg":"trace[354643714] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"298.761167ms","start":"2026-07-25T06:33:25.072898Z","end":"2026-07-25T06:33:25.371659Z","steps":["trace[354643714] 'process raft request' (duration: 298.493354ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:25.371746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.232288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T06:33:25.371786Z","caller":"traceutil/trace.go:171","msg":"trace[29139831] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:636; }","duration":"247.327633ms","start":"2026-07-25T06:33:25.124449Z","end":"2026-07-25T06:33:25.371777Z","steps":["trace[29139831] 'agreement among raft nodes before linearized reading' (duration: 247.237508ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:25.371974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.426179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:33:25.373987Z","caller":"traceutil/trace.go:171","msg":"trace[1965686064] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:636; }","duration":"104.480368ms","start":"2026-07-25T06:33:25.269483Z","end":"2026-07-25T06:33:25.373964Z","steps":["trace[1965686064] 'agreement among raft nodes before linearized reading' (duration: 102.396298ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:26.137378Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592197943351273059,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-25T06:33:26.407448Z","caller":"traceutil/trace.go:171","msg":"trace[1848631485] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"770.780073ms","start":"2026-07-25T06:33:25.636645Z","end":"2026-07-25T06:33:26.407425Z","steps":["trace[1848631485] 'read index received' (duration: 770.600874ms)","trace[1848631485] 'applied index is now lower than readState.Index' (duration: 178.339µs)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:26.407933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.981512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-25T06:33:26.408016Z","caller":"traceutil/trace.go:171","msg":"trace[1215592274] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"704.070936ms","start":"2026-07-25T06:33:25.703925Z","end":"2026-07-25T06:33:26.407996Z","steps":["trace[1215592274] 'agreement among raft nodes before linearized reading' (duration: 703.857266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:26.408065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:25.703866Z","time spent":"704.191542ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-25T06:33:26.408248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.598722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T06:33:26.408285Z","caller":"traceutil/trace.go:171","msg":"trace[1677737570] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:637; }","duration":"771.678346ms","start":"2026-07-25T06:33:25.636598Z","end":"2026-07-25T06:33:26.408276Z","steps":["trace[1677737570] 'agreement among raft nodes before linearized reading' (duration: 771.620203ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:26.40832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:25.636572Z","time spent":"771.740408ms","remote":"127.0.0.1:57936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-07-25T06:33:26.40848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.666143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T06:33:26.408517Z","caller":"traceutil/trace.go:171","msg":"trace[1006491096] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:637; }","duration":"311.740007ms","start":"2026-07-25T06:33:26.096769Z","end":"2026-07-25T06:33:26.408509Z","steps":["trace[1006491096] 'agreement among raft nodes before linearized reading' (duration: 311.686344ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:26.408547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:26.09675Z","time spent":"311.786709ms","remote":"127.0.0.1:58150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":2,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"info","ts":"2026-07-25T06:33:26.408667Z","caller":"traceutil/trace.go:171","msg":"trace[1903358447] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"792.290904ms","start":"2026-07-25T06:33:25.616356Z","end":"2026-07-25T06:33:26.408647Z","steps":["trace[1903358447] 'process raft request' (duration: 790.942279ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:26.408719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.404964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-25T06:33:26.408755Z","caller":"traceutil/trace.go:171","msg":"trace[1188868805] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"679.464227ms","start":"2026-07-25T06:33:25.729282Z","end":"2026-07-25T06:33:26.408746Z","steps":["trace[1188868805] 'agreement among raft nodes before linearized reading' (duration: 679.375713ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:26.408786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:25.72927Z","time spent":"679.509109ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-25T06:33:26.408804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:25.616334Z","time spent":"792.391498ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:33:26.408943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.861608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-25T06:33:26.408982Z","caller":"traceutil/trace.go:171","msg":"trace[501391410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"697.89653ms","start":"2026-07-25T06:33:25.711075Z","end":"2026-07-25T06:33:26.408971Z","steps":["trace[501391410] 'agreement among raft nodes before linearized reading' (duration: 697.812206ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:26.409012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:25.71104Z","time spent":"697.965664ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-25T06:33:27.095564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.09765ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:33:27.095667Z","caller":"traceutil/trace.go:171","msg":"trace[673299244] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"682.763062ms","start":"2026-07-25T06:33:26.412885Z","end":"2026-07-25T06:33:27.095648Z","steps":["trace[673299244] 'process raft request' (duration: 474.478664ms)","trace[673299244] 'compare' (duration: 208.006465ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:27.095822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:26.412869Z","time spent":"682.881448ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:33:27.100947Z","caller":"traceutil/trace.go:171","msg":"trace[606745187] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"686.988355ms","start":"2026-07-25T06:33:26.413941Z","end":"2026-07-25T06:33:27.10093Z","steps":["trace[606745187] 'process raft request' (duration: 686.823787ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:27.101076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:26.413909Z","time spent":"687.083189ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:33:27.101646Z","caller":"traceutil/trace.go:171","msg":"trace[1604105642] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"685.349286ms","start":"2026-07-25T06:33:26.416271Z","end":"2026-07-25T06:33:27.101621Z","steps":["trace[1604105642] 'process raft request' (duration: 684.611611ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:27.101793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:26.416257Z","time spent":"685.460792ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:33:27.102745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.588513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:33:27.102814Z","caller":"traceutil/trace.go:171","msg":"trace[447230723] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"563.722649ms","start":"2026-07-25T06:33:26.539077Z","end":"2026-07-25T06:33:27.1028Z","steps":["trace[447230723] 'agreement among raft nodes before linearized reading' (duration: 563.344581ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:27.102954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:26.53905Z","time spent":"563.850526ms","remote":"127.0.0.1:57660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-25T06:33:27.101559Z","caller":"traceutil/trace.go:171","msg":"trace[22157219] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:665; }","duration":"562.392856ms","start":"2026-07-25T06:33:26.539149Z","end":"2026-07-25T06:33:27.101542Z","steps":["trace[22157219] 'read index received' (duration: 348.196444ms)","trace[22157219] 'applied index is now lower than readState.Index' (duration: 214.195532ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:28.515894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.765624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-25T06:33:28.515954Z","caller":"traceutil/trace.go:171","msg":"trace[485416081] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:644; }","duration":"101.870559ms","start":"2026-07-25T06:33:28.41407Z","end":"2026-07-25T06:33:28.515941Z","steps":["trace[485416081] 'range keys from in-memory index tree' (duration: 101.590496ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:29.235615Z","caller":"traceutil/trace.go:171","msg":"trace[1865264905] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"129.712291ms","start":"2026-07-25T06:33:29.105878Z","end":"2026-07-25T06:33:29.235591Z","steps":["trace[1865264905] 'process raft request' (duration: 129.547423ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:29.23592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.744851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-25T06:33:29.235984Z","caller":"traceutil/trace.go:171","msg":"trace[1323829035] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:665; }","duration":"130.848526ms","start":"2026-07-25T06:33:29.105118Z","end":"2026-07-25T06:33:29.235967Z","steps":["trace[1323829035] 'agreement among raft nodes before linearized reading' (duration: 130.644846ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:29.235699Z","caller":"traceutil/trace.go:171","msg":"trace[1734926915] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:694; }","duration":"121.879607ms","start":"2026-07-25T06:33:29.113786Z","end":"2026-07-25T06:33:29.235665Z","steps":["trace[1734926915] 'read index received' (duration: 121.869776ms)","trace[1734926915] 'applied index is now lower than readState.Index' (duration: 7.831µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:29.261354Z","caller":"traceutil/trace.go:171","msg":"trace[2085113463] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"144.09508ms","start":"2026-07-25T06:33:29.117238Z","end":"2026-07-25T06:33:29.261333Z","steps":["trace[2085113463] 'process raft request' (duration: 143.946823ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:29.564217Z","caller":"traceutil/trace.go:171","msg":"trace[1444203579] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"147.397118ms","start":"2026-07-25T06:33:29.416755Z","end":"2026-07-25T06:33:29.564152Z","steps":["trace[1444203579] 'process raft request' (duration: 147.127335ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:33.792439Z","caller":"traceutil/trace.go:171","msg":"trace[1695563032] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"105.775521ms","start":"2026-07-25T06:33:33.686631Z","end":"2026-07-25T06:33:33.792407Z","steps":["trace[1695563032] 'process raft request' (duration: 105.497058ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:43.667453Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592197943351273446,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-25T06:33:43.857328Z","caller":"traceutil/trace.go:171","msg":"trace[1734674147] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"930.522318ms","start":"2026-07-25T06:33:42.926778Z","end":"2026-07-25T06:33:43.857301Z","steps":["trace[1734674147] 'process raft request' (duration: 930.374281ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:43.85748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:42.926754Z","time spent":"930.646504ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:33:43.903606Z","caller":"traceutil/trace.go:171","msg":"trace[1326877309] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:828; }","duration":"736.879224ms","start":"2026-07-25T06:33:43.16664Z","end":"2026-07-25T06:33:43.903519Z","steps":["trace[1326877309] 'read index received' (duration: 690.513378ms)","trace[1326877309] 'applied index is now lower than readState.Index' (duration: 46.364806ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:43.903726Z","caller":"traceutil/trace.go:171","msg":"trace[2007029082] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"541.881785ms","start":"2026-07-25T06:33:43.361831Z","end":"2026-07-25T06:33:43.903713Z","steps":["trace[2007029082] 'process raft request' (duration: 541.536189ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:43.90385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:43.36181Z","time spent":"541.944668ms","remote":"127.0.0.1:57934","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-07-25T06:33:43.903959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.14546ms","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-07-25T06:33:43.903977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.323305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-48ksm\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-25T06:33:43.904055Z","caller":"traceutil/trace.go:171","msg":"trace[2058796448] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-48ksm; range_end:; response_count:1; response_revision:796; }","duration":"737.446331ms","start":"2026-07-25T06:33:43.166594Z","end":"2026-07-25T06:33:43.90404Z","steps":["trace[2058796448] 'agreement among raft nodes before linearized reading' (duration: 737.195509ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:43.904061Z","caller":"traceutil/trace.go:171","msg":"trace[247917574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:796; }","duration":"722.307678ms","start":"2026-07-25T06:33:43.181722Z","end":"2026-07-25T06:33:43.904029Z","steps":["trace[247917574] 'agreement among raft nodes before linearized reading' (duration: 722.065466ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:43.904099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:43.166577Z","time spent":"737.508114ms","remote":"127.0.0.1:57850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-48ksm\" "} {"level":"warn","ts":"2026-07-25T06:33:43.90397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.650554ms","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-07-25T06:33:43.904115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:43.181701Z","time spent":"722.393582ms","remote":"127.0.0.1:57934","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-07-25T06:33:43.904176Z","caller":"traceutil/trace.go:171","msg":"trace[374520364] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:796; }","duration":"582.933607ms","start":"2026-07-25T06:33:43.321218Z","end":"2026-07-25T06:33:43.904152Z","steps":["trace[374520364] 'agreement among raft nodes before linearized reading' (duration: 582.57312ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:43.904129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.417076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-25T06:33:43.904234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:43.321193Z","time spent":"583.028082ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-25T06:33:43.904256Z","caller":"traceutil/trace.go:171","msg":"trace[209220374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:796; }","duration":"585.549022ms","start":"2026-07-25T06:33:43.318683Z","end":"2026-07-25T06:33:43.904232Z","steps":["trace[209220374] 'agreement among raft nodes before linearized reading' (duration: 585.127922ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:43.904574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:43.318624Z","time spent":"585.934431ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-25T06:33:51.094916Z","caller":"traceutil/trace.go:171","msg":"trace[662964609] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"100.96102ms","start":"2026-07-25T06:33:50.993922Z","end":"2026-07-25T06:33:51.094883Z","steps":["trace[662964609] 'process raft request' (duration: 100.788481ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:34:24.53705Z","caller":"traceutil/trace.go:171","msg":"trace[694865350] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"151.505951ms","start":"2026-07-25T06:34:24.385517Z","end":"2026-07-25T06:34:24.537023Z","steps":["trace[694865350] 'process raft request' (duration: 151.455599ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:34:24.537604Z","caller":"traceutil/trace.go:171","msg":"trace[856689014] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"152.837354ms","start":"2026-07-25T06:34:24.384631Z","end":"2026-07-25T06:34:24.537468Z","steps":["trace[856689014] 'process raft request' (duration: 144.667765ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:34:30.783445Z","caller":"traceutil/trace.go:171","msg":"trace[1544927739] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"102.828059ms","start":"2026-07-25T06:34:30.6806Z","end":"2026-07-25T06:34:30.783428Z","steps":["trace[1544927739] 'process raft request' (duration: 102.464322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:35:48.811823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.995235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cfe7923b-3c99-4752-a572-a9e62d79e2d3\" ","response":"range_response_count:1 size:3579"} {"level":"info","ts":"2026-07-25T06:35:48.811902Z","caller":"traceutil/trace.go:171","msg":"trace[534075160] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cfe7923b-3c99-4752-a572-a9e62d79e2d3; range_end:; response_count:1; response_revision:1348; }","duration":"220.095659ms","start":"2026-07-25T06:35:48.591789Z","end":"2026-07-25T06:35:48.811884Z","steps":["trace[534075160] 'range keys from in-memory index tree' (duration: 219.769804ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:35:49.21815Z","caller":"traceutil/trace.go:171","msg":"trace[413372076] linearizableReadLoop","detail":"{readStateIndex:1411; appliedIndex:1410; }","duration":"138.503104ms","start":"2026-07-25T06:35:49.079631Z","end":"2026-07-25T06:35:49.218134Z","steps":["trace[413372076] 'read index received' (duration: 138.344687ms)","trace[413372076] 'applied index is now lower than readState.Index' (duration: 157.677µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:35:49.218233Z","caller":"traceutil/trace.go:171","msg":"trace[1057815062] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"397.847923ms","start":"2026-07-25T06:35:48.820363Z","end":"2026-07-25T06:35:49.218211Z","steps":["trace[1057815062] 'process raft request' (duration: 397.655204ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:35:49.218398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:35:48.820333Z","time spent":"397.986229ms","remote":"127.0.0.1:57850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3684,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:35:49.21848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.852891ms","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-07-25T06:35:49.218551Z","caller":"traceutil/trace.go:171","msg":"trace[1991882961] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1349; }","duration":"138.941315ms","start":"2026-07-25T06:35:49.079579Z","end":"2026-07-25T06:35:49.21852Z","steps":["trace[1991882961] 'agreement among raft nodes before linearized reading' (duration: 138.756696ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:35:49.218635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.976106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-25T06:35:49.218683Z","caller":"traceutil/trace.go:171","msg":"trace[1409955151] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1349; }","duration":"131.043739ms","start":"2026-07-25T06:35:49.087629Z","end":"2026-07-25T06:35:49.218673Z","steps":["trace[1409955151] 'agreement among raft nodes before linearized reading' (duration: 130.889512ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:35:49.398191Z","caller":"traceutil/trace.go:171","msg":"trace[1750916138] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"116.095528ms","start":"2026-07-25T06:35:49.282066Z","end":"2026-07-25T06:35:49.398161Z","steps":["trace[1750916138] 'process raft request' (duration: 67.116536ms)","trace[1750916138] 'compare' (duration: 48.675588ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:35:49.56198Z","caller":"traceutil/trace.go:171","msg":"trace[1553196249] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"158.179192ms","start":"2026-07-25T06:35:49.403763Z","end":"2026-07-25T06:35:49.561942Z","steps":["trace[1553196249] 'process raft request' (duration: 138.700304ms)","trace[1553196249] 'compare' (duration: 18.971004ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:35:52.726618Z","caller":"traceutil/trace.go:171","msg":"trace[1631255625] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"109.096165ms","start":"2026-07-25T06:35:52.6175Z","end":"2026-07-25T06:35:52.726596Z","steps":["trace[1631255625] 'process raft request' (duration: 108.966729ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:35:59.764724Z","caller":"traceutil/trace.go:171","msg":"trace[1452233376] linearizableReadLoop","detail":"{readStateIndex:1468; appliedIndex:1467; }","duration":"223.940962ms","start":"2026-07-25T06:35:59.540755Z","end":"2026-07-25T06:35:59.764696Z","steps":["trace[1452233376] 'read index received' (duration: 199.966201ms)","trace[1452233376] 'applied index is now lower than readState.Index' (duration: 23.973671ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:35:59.764818Z","caller":"traceutil/trace.go:171","msg":"trace[1088981500] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"277.43268ms","start":"2026-07-25T06:35:59.487359Z","end":"2026-07-25T06:35:59.764792Z","steps":["trace[1088981500] 'process raft request' (duration: 253.476729ms)","trace[1088981500] 'compare' (duration: 23.71914ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:35:59.765014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.231607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-25T06:35:59.765089Z","caller":"traceutil/trace.go:171","msg":"trace[1197171122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1403; }","duration":"224.373214ms","start":"2026-07-25T06:35:59.540703Z","end":"2026-07-25T06:35:59.765076Z","steps":["trace[1197171122] 'agreement among raft nodes before linearized reading' (duration: 224.100641ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:35:59.918918Z","caller":"traceutil/trace.go:171","msg":"trace[2146765660] transaction","detail":"{read_only:false; response_revision:1406; number_of_response:1; }","duration":"149.74398ms","start":"2026-07-25T06:35:59.769147Z","end":"2026-07-25T06:35:59.918891Z","steps":["trace[2146765660] 'process raft request' (duration: 149.689958ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:35:59.919099Z","caller":"traceutil/trace.go:171","msg":"trace[1627905892] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"149.812944ms","start":"2026-07-25T06:35:59.769192Z","end":"2026-07-25T06:35:59.919005Z","steps":["trace[1627905892] 'process raft request' (duration: 122.801848ms)","trace[1627905892] 'compare' (duration: 26.698471ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:36:02.241278Z","caller":"traceutil/trace.go:171","msg":"trace[1135178579] transaction","detail":"{read_only:false; response_revision:1417; number_of_response:1; }","duration":"289.059743ms","start":"2026-07-25T06:36:01.952174Z","end":"2026-07-25T06:36:02.241233Z","steps":["trace[1135178579] 'process raft request' (duration: 288.620352ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:36:02.241682Z","caller":"traceutil/trace.go:171","msg":"trace[1210668906] linearizableReadLoop","detail":"{readStateIndex:1482; appliedIndex:1481; }","duration":"140.282959ms","start":"2026-07-25T06:36:02.101351Z","end":"2026-07-25T06:36:02.241634Z","steps":["trace[1210668906] 'read index received' (duration: 139.378596ms)","trace[1210668906] 'applied index is now lower than readState.Index' (duration: 901.513µs)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:36:02.241914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.545562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2569"} {"level":"info","ts":"2026-07-25T06:36:02.242001Z","caller":"traceutil/trace.go:171","msg":"trace[1123294025] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1417; }","duration":"140.676118ms","start":"2026-07-25T06:36:02.101308Z","end":"2026-07-25T06:36:02.241985Z","steps":["trace[1123294025] 'agreement among raft nodes before linearized reading' (duration: 140.447997ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:03.198846Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592197943351274961,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-25T06:36:03.491719Z","caller":"traceutil/trace.go:171","msg":"trace[405795118] linearizableReadLoop","detail":"{readStateIndex:1484; appliedIndex:1483; }","duration":"792.962226ms","start":"2026-07-25T06:36:02.698733Z","end":"2026-07-25T06:36:03.491696Z","steps":["trace[405795118] 'read index received' (duration: 792.671373ms)","trace[405795118] 'applied index is now lower than readState.Index' (duration: 289.903µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:36:03.491806Z","caller":"traceutil/trace.go:171","msg":"trace[882736038] transaction","detail":"{read_only:false; response_revision:1419; number_of_response:1; }","duration":"841.069857ms","start":"2026-07-25T06:36:02.650687Z","end":"2026-07-25T06:36:03.491757Z","steps":["trace[882736038] 'process raft request' (duration: 840.783674ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:03.4919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.150045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T06:36:03.491937Z","caller":"traceutil/trace.go:171","msg":"trace[145799041] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1419; }","duration":"793.270191ms","start":"2026-07-25T06:36:02.698656Z","end":"2026-07-25T06:36:03.491926Z","steps":["trace[145799041] 'agreement among raft nodes before linearized reading' (duration: 793.161216ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:03.491977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:02.698625Z","time spent":"793.340734ms","remote":"127.0.0.1:57822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-07-25T06:36:03.492018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:02.650656Z","time spent":"841.251865ms","remote":"127.0.0.1:57756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":706,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:36:03.492028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.378266ms","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:7"} {"level":"info","ts":"2026-07-25T06:36:03.492142Z","caller":"traceutil/trace.go:171","msg":"trace[658379991] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1419; }","duration":"223.574575ms","start":"2026-07-25T06:36:03.268542Z","end":"2026-07-25T06:36:03.492117Z","steps":["trace[658379991] 'agreement among raft nodes before linearized reading' (duration: 223.331764ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:36:03.923369Z","caller":"traceutil/trace.go:171","msg":"trace[1511000811] linearizableReadLoop","detail":"{readStateIndex:1485; appliedIndex:1484; }","duration":"384.74185ms","start":"2026-07-25T06:36:03.538547Z","end":"2026-07-25T06:36:03.923289Z","steps":["trace[1511000811] 'read index received' (duration: 379.628206ms)","trace[1511000811] 'applied index is now lower than readState.Index' (duration: 5.112564ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:36:03.923375Z","caller":"traceutil/trace.go:171","msg":"trace[1564066721] transaction","detail":"{read_only:false; response_revision:1420; number_of_response:1; }","duration":"422.918746ms","start":"2026-07-25T06:36:03.500424Z","end":"2026-07-25T06:36:03.923343Z","steps":["trace[1564066721] 'process raft request' (duration: 417.736219ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:03.923489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.936498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:36:03.923517Z","caller":"traceutil/trace.go:171","msg":"trace[2131373969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1420; }","duration":"385.020172ms","start":"2026-07-25T06:36:03.538489Z","end":"2026-07-25T06:36:03.923509Z","steps":["trace[2131373969] 'agreement among raft nodes before linearized reading' (duration: 384.959929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:03.923573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:03.53847Z","time spent":"385.091766ms","remote":"127.0.0.1:57672","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-07-25T06:36:03.92384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:03.500404Z","time spent":"423.040832ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:36:03.952686Z","caller":"traceutil/trace.go:171","msg":"trace[1844026351] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"350.755521ms","start":"2026-07-25T06:36:03.6019Z","end":"2026-07-25T06:36:03.952656Z","steps":["trace[1844026351] 'process raft request' (duration: 350.604034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:03.952907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.268162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-25T06:36:03.952996Z","caller":"traceutil/trace.go:171","msg":"trace[1551812508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1421; }","duration":"147.423229ms","start":"2026-07-25T06:36:03.805555Z","end":"2026-07-25T06:36:03.952978Z","steps":["trace[1551812508] 'agreement among raft nodes before linearized reading' (duration: 147.119085ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:03.952793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.243733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-25T06:36:03.953139Z","caller":"traceutil/trace.go:171","msg":"trace[881560896] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1421; }","duration":"159.591389ms","start":"2026-07-25T06:36:03.793532Z","end":"2026-07-25T06:36:03.953123Z","steps":["trace[881560896] 'agreement among raft nodes before linearized reading' (duration: 159.145528ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:03.953271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:03.601865Z","time spent":"351.14637ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:36:04.467828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.729525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-25T06:36:04.467916Z","caller":"traceutil/trace.go:171","msg":"trace[1025309719] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1424; }","duration":"222.880062ms","start":"2026-07-25T06:36:04.245017Z","end":"2026-07-25T06:36:04.467897Z","steps":["trace[1025309719] 'range keys from in-memory index tree' (duration: 222.552227ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:04.887716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.448138ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-25T06:36:04.935568Z","caller":"traceutil/trace.go:171","msg":"trace[1775953257] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"464.376181ms","start":"2026-07-25T06:36:04.47117Z","end":"2026-07-25T06:36:04.935546Z","steps":["trace[1775953257] 'process raft request' (duration: 464.203813ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:04.935696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:04.471144Z","time spent":"464.482856ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:36:15.104306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.857886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:912"} {"level":"info","ts":"2026-07-25T06:36:15.104388Z","caller":"traceutil/trace.go:171","msg":"trace[1083615868] range","detail":"{range_begin:/registry/clusterroles/system:controller:horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:1463; }","duration":"106.993751ms","start":"2026-07-25T06:36:14.997377Z","end":"2026-07-25T06:36:15.104371Z","steps":["trace[1083615868] 'range keys from in-memory index tree' (duration: 106.762996ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:36:26.296449Z","caller":"traceutil/trace.go:171","msg":"trace[1916139420] linearizableReadLoop","detail":"{readStateIndex:1567; appliedIndex:1566; }","duration":"155.678851ms","start":"2026-07-25T06:36:26.140745Z","end":"2026-07-25T06:36:26.296424Z","steps":["trace[1916139420] 'read index received' (duration: 155.425965ms)","trace[1916139420] 'applied index is now lower than readState.Index' (duration: 252.026µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:36:26.296568Z","caller":"traceutil/trace.go:171","msg":"trace[1140127214] transaction","detail":"{read_only:false; response_revision:1497; number_of_response:1; }","duration":"160.638963ms","start":"2026-07-25T06:36:26.135872Z","end":"2026-07-25T06:36:26.296511Z","steps":["trace[1140127214] 'process raft request' (duration: 160.36191ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:26.296646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.877692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-node-lease/kube-root-ca.crt\" ","response":"range_response_count:1 size:1754"} {"level":"info","ts":"2026-07-25T06:36:26.296693Z","caller":"traceutil/trace.go:171","msg":"trace[404924329] range","detail":"{range_begin:/registry/configmaps/kube-node-lease/kube-root-ca.crt; range_end:; response_count:1; response_revision:1497; }","duration":"155.973582ms","start":"2026-07-25T06:36:26.140705Z","end":"2026-07-25T06:36:26.296679Z","steps":["trace[404924329] 'agreement among raft nodes before linearized reading' (duration: 155.866293ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:26.296857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.527685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/\" range_end:\"/registry/roles/kube-public0\" limit:500 ","response":"range_response_count:2 size:1073"} {"level":"info","ts":"2026-07-25T06:36:26.296973Z","caller":"traceutil/trace.go:171","msg":"trace[700694601] range","detail":"{range_begin:/registry/roles/kube-public/; range_end:/registry/roles/kube-public0; response_count:2; response_revision:1497; }","duration":"136.657083ms","start":"2026-07-25T06:36:26.160297Z","end":"2026-07-25T06:36:26.296954Z","steps":["trace[700694601] 'agreement among raft nodes before linearized reading' (duration: 136.471901ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:26.297242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.970732ms","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-07-25T06:36:26.297336Z","caller":"traceutil/trace.go:171","msg":"trace[646374681] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1497; }","duration":"102.105449ms","start":"2026-07-25T06:36:26.195205Z","end":"2026-07-25T06:36:26.29731Z","steps":["trace[646374681] 'agreement among raft nodes before linearized reading' (duration: 101.853604ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:36:26.505345Z","caller":"traceutil/trace.go:171","msg":"trace[222967442] transaction","detail":"{read_only:false; response_revision:1499; number_of_response:1; }","duration":"203.217104ms","start":"2026-07-25T06:36:26.302101Z","end":"2026-07-25T06:36:26.505318Z","steps":["trace[222967442] 'process raft request' (duration: 203.017143ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:36:26.505662Z","caller":"traceutil/trace.go:171","msg":"trace[1099409015] linearizableReadLoop","detail":"{readStateIndex:1571; appliedIndex:1567; }","duration":"200.4513ms","start":"2026-07-25T06:36:26.305186Z","end":"2026-07-25T06:36:26.505637Z","steps":["trace[1099409015] 'read index received' (duration: 35.027878ms)","trace[1099409015] 'applied index is now lower than readState.Index' (duration: 165.422192ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:36:26.505706Z","caller":"traceutil/trace.go:171","msg":"trace[334798637] transaction","detail":"{read_only:false; response_revision:1501; number_of_response:1; }","duration":"202.233599ms","start":"2026-07-25T06:36:26.303458Z","end":"2026-07-25T06:36:26.505692Z","steps":["trace[334798637] 'process raft request' (duration: 202.062126ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:36:26.5057Z","caller":"traceutil/trace.go:171","msg":"trace[482866476] transaction","detail":"{read_only:false; response_revision:1500; number_of_response:1; }","duration":"203.490358ms","start":"2026-07-25T06:36:26.302161Z","end":"2026-07-25T06:36:26.505651Z","steps":["trace[482866476] 'process raft request' (duration: 203.116294ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:26.505854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.399966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-public/cluster-info\" ","response":"range_response_count:1 size:2178"} {"level":"warn","ts":"2026-07-25T06:36:26.505846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.626114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-node-lease/\" range_end:\"/registry/events/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:36:26.505892Z","caller":"traceutil/trace.go:171","msg":"trace[8428600] range","detail":"{range_begin:/registry/configmaps/kube-public/cluster-info; range_end:; response_count:1; response_revision:1501; }","duration":"133.506146ms","start":"2026-07-25T06:36:26.372376Z","end":"2026-07-25T06:36:26.505882Z","steps":["trace[8428600] 'agreement among raft nodes before linearized reading' (duration: 133.411695ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:26.505918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.07171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-public/\" range_end:\"/registry/secrets/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:36:26.505933Z","caller":"traceutil/trace.go:171","msg":"trace[1219002737] range","detail":"{range_begin:/registry/events/kube-node-lease/; range_end:/registry/events/kube-node-lease0; response_count:0; response_revision:1501; }","duration":"200.750621ms","start":"2026-07-25T06:36:26.30516Z","end":"2026-07-25T06:36:26.505911Z","steps":["trace[1219002737] 'agreement among raft nodes before linearized reading' (duration: 200.605515ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:36:26.505953Z","caller":"traceutil/trace.go:171","msg":"trace[226171394] range","detail":"{range_begin:/registry/secrets/kube-public/; range_end:/registry/secrets/kube-public0; response_count:0; response_revision:1501; }","duration":"123.125065ms","start":"2026-07-25T06:36:26.382815Z","end":"2026-07-25T06:36:26.50594Z","steps":["trace[226171394] 'agreement among raft nodes before linearized reading' (duration: 123.07751ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:26.505854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.621789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-node-lease/\" range_end:\"/registry/services/specs/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:36:26.506074Z","caller":"traceutil/trace.go:171","msg":"trace[1780220728] range","detail":"{range_begin:/registry/services/specs/kube-node-lease/; range_end:/registry/services/specs/kube-node-lease0; response_count:0; response_revision:1501; }","duration":"110.859037ms","start":"2026-07-25T06:36:26.395181Z","end":"2026-07-25T06:36:26.50604Z","steps":["trace[1780220728] 'agreement among raft nodes before linearized reading' (duration: 110.61768ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:36:28.531074Z","caller":"traceutil/trace.go:171","msg":"trace[935078732] linearizableReadLoop","detail":"{readStateIndex:1574; appliedIndex:1573; }","duration":"227.819481ms","start":"2026-07-25T06:36:28.303235Z","end":"2026-07-25T06:36:28.531054Z","steps":["trace[935078732] 'read index received' (duration: 227.640158ms)","trace[935078732] 'applied index is now lower than readState.Index' (duration: 178.443µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:36:28.531168Z","caller":"traceutil/trace.go:171","msg":"trace[75441902] transaction","detail":"{read_only:false; response_revision:1504; number_of_response:1; }","duration":"229.495003ms","start":"2026-07-25T06:36:28.301647Z","end":"2026-07-25T06:36:28.531142Z","steps":["trace[75441902] 'process raft request' (duration: 229.282993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:28.531211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.953537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/local-path-storage/\" range_end:\"/registry/roles/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:36:28.531246Z","caller":"traceutil/trace.go:171","msg":"trace[186968796] range","detail":"{range_begin:/registry/roles/local-path-storage/; range_end:/registry/roles/local-path-storage0; response_count:0; response_revision:1504; }","duration":"228.016632ms","start":"2026-07-25T06:36:28.303218Z","end":"2026-07-25T06:36:28.531235Z","steps":["trace[186968796] 'agreement among raft nodes before linearized reading' (duration: 227.944819ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:28.531354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.808612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/local-path-storage/local-path-config\" ","response":"range_response_count:1 size:1464"} {"level":"info","ts":"2026-07-25T06:36:28.531407Z","caller":"traceutil/trace.go:171","msg":"trace[1689710602] range","detail":"{range_begin:/registry/configmaps/local-path-storage/local-path-config; range_end:; response_count:1; response_revision:1504; }","duration":"190.891374ms","start":"2026-07-25T06:36:28.340503Z","end":"2026-07-25T06:36:28.531394Z","steps":["trace[1689710602] 'agreement among raft nodes before linearized reading' (duration: 190.757796ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:28.531647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.3758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4709"} {"level":"info","ts":"2026-07-25T06:36:28.531684Z","caller":"traceutil/trace.go:171","msg":"trace[1523959049] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:1504; }","duration":"142.436694ms","start":"2026-07-25T06:36:28.389239Z","end":"2026-07-25T06:36:28.531676Z","steps":["trace[1523959049] 'agreement among raft nodes before linearized reading' (duration: 142.341853ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:28.53179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.477206ms","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-07-25T06:36:28.531833Z","caller":"traceutil/trace.go:171","msg":"trace[71180888] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1504; }","duration":"187.551929ms","start":"2026-07-25T06:36:28.344271Z","end":"2026-07-25T06:36:28.531823Z","steps":["trace[71180888] 'agreement among raft nodes before linearized reading' (duration: 187.451169ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:28.531887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.521961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" limit:500 ","response":"range_response_count:1 size:12755"} {"level":"info","ts":"2026-07-25T06:36:28.532065Z","caller":"traceutil/trace.go:171","msg":"trace[209313900] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:1504; }","duration":"171.780687ms","start":"2026-07-25T06:36:28.360258Z","end":"2026-07-25T06:36:28.532039Z","steps":["trace[209313900] 'agreement among raft nodes before linearized reading' (duration: 171.469576ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:29.134224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.908694ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:36:29.134682Z","caller":"traceutil/trace.go:171","msg":"trace[1445639342] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1504; }","duration":"296.38339ms","start":"2026-07-25T06:36:28.838273Z","end":"2026-07-25T06:36:29.134657Z","steps":["trace[1445639342] 'range keys from in-memory index tree' (duration: 295.888925ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:29.134669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.735935ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:36:29.135476Z","caller":"traceutil/trace.go:171","msg":"trace[1087136879] transaction","detail":"{read_only:false; response_revision:1505; number_of_response:1; }","duration":"593.216389ms","start":"2026-07-25T06:36:28.542237Z","end":"2026-07-25T06:36:29.135453Z","steps":["trace[1087136879] 'process raft request' (duration: 491.617884ms)","trace[1087136879] 'compare' (duration: 100.432154ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:36:29.135579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:28.54222Z","time spent":"593.294922ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:36:29.157809Z","caller":"traceutil/trace.go:171","msg":"trace[570676583] transaction","detail":"{read_only:false; response_revision:1507; number_of_response:1; }","duration":"613.975723ms","start":"2026-07-25T06:36:28.543805Z","end":"2026-07-25T06:36:29.157781Z","steps":["trace[570676583] 'process raft request' (duration: 613.877962ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:36:29.157877Z","caller":"traceutil/trace.go:171","msg":"trace[367106818] transaction","detail":"{read_only:false; response_revision:1506; number_of_response:1; }","duration":"614.138218ms","start":"2026-07-25T06:36:28.543695Z","end":"2026-07-25T06:36:29.157833Z","steps":["trace[367106818] 'process raft request' (duration: 613.848235ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:29.157979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:28.543796Z","time spent":"614.092191ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:36:29.158004Z","caller":"traceutil/trace.go:171","msg":"trace[89705424] linearizableReadLoop","detail":"{readStateIndex:1578; appliedIndex:1574; }","duration":"610.198009ms","start":"2026-07-25T06:36:28.54779Z","end":"2026-07-25T06:36:29.157988Z","steps":["trace[89705424] 'read index received' (duration: 486.137002ms)","trace[89705424] 'applied index is now lower than readState.Index' (duration: 124.059887ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:36:29.158101Z","caller":"traceutil/trace.go:171","msg":"trace[650563591] transaction","detail":"{read_only:false; response_revision:1508; number_of_response:1; }","duration":"614.247088ms","start":"2026-07-25T06:36:28.543844Z","end":"2026-07-25T06:36:29.158091Z","steps":["trace[650563591] 'process raft request' (duration: 613.89793ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:29.1582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:28.543839Z","time spent":"614.294713ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:36:29.158352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.559905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:36:29.158379Z","caller":"traceutil/trace.go:171","msg":"trace[2083958391] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1508; }","duration":"610.607681ms","start":"2026-07-25T06:36:28.547763Z","end":"2026-07-25T06:36:29.15837Z","steps":["trace[2083958391] 'agreement among raft nodes before linearized reading' (duration: 610.538597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:29.158405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:28.547754Z","time spent":"610.645528ms","remote":"127.0.0.1:57672","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-07-25T06:36:29.158401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:28.543669Z","time spent":"614.616802ms","remote":"127.0.0.1:57934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:36:29.158844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.743801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/local-path-storage/local-path-config\" ","response":"range_response_count:1 size:1464"} {"level":"info","ts":"2026-07-25T06:36:29.158934Z","caller":"traceutil/trace.go:171","msg":"trace[924148236] range","detail":"{range_begin:/registry/configmaps/local-path-storage/local-path-config; range_end:; response_count:1; response_revision:1508; }","duration":"515.86543ms","start":"2026-07-25T06:36:28.643038Z","end":"2026-07-25T06:36:29.158904Z","steps":["trace[924148236] 'agreement among raft nodes before linearized reading' (duration: 515.675407ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:29.158969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.448744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/\" range_end:\"/registry/serviceaccounts/local-path-storage0\" limit:500 ","response":"range_response_count:2 size:1083"} {"level":"warn","ts":"2026-07-25T06:36:29.158986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:28.643019Z","time spent":"515.954401ms","remote":"127.0.0.1:57780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1487,"request content":"key:\"/registry/configmaps/local-path-storage/local-path-config\" "} {"level":"info","ts":"2026-07-25T06:36:29.159018Z","caller":"traceutil/trace.go:171","msg":"trace[1791438796] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/; range_end:/registry/serviceaccounts/local-path-storage0; response_count:2; response_revision:1508; }","duration":"500.514438ms","start":"2026-07-25T06:36:28.658488Z","end":"2026-07-25T06:36:29.159002Z","steps":["trace[1791438796] 'agreement among raft nodes before linearized reading' (duration: 500.258841ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:29.159055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:28.658482Z","time spent":"500.562693ms","remote":"127.0.0.1:57868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":2,"response size":1106,"request content":"key:\"/registry/serviceaccounts/local-path-storage/\" range_end:\"/registry/serviceaccounts/local-path-storage0\" limit:500 "} {"level":"warn","ts":"2026-07-25T06:36:29.159128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.477456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/local-path-storage/\" range_end:\"/registry/services/specs/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T06:36:29.159221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.110185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4709"} {"level":"info","ts":"2026-07-25T06:36:29.159251Z","caller":"traceutil/trace.go:171","msg":"trace[2044318483] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:1508; }","duration":"505.15098ms","start":"2026-07-25T06:36:28.654091Z","end":"2026-07-25T06:36:29.159241Z","steps":["trace[2044318483] 'agreement among raft nodes before linearized reading' (duration: 505.063598ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:29.159278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:28.654084Z","time spent":"505.188097ms","remote":"127.0.0.1:58136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":4732,"request content":"key:\"/registry/deployments/kube-system/cilium-operator\" "} {"level":"info","ts":"2026-07-25T06:36:29.159425Z","caller":"traceutil/trace.go:171","msg":"trace[1925735321] range","detail":"{range_begin:/registry/services/specs/local-path-storage/; range_end:/registry/services/specs/local-path-storage0; response_count:0; response_revision:1508; }","duration":"485.627382ms","start":"2026-07-25T06:36:28.673601Z","end":"2026-07-25T06:36:29.159228Z","steps":["trace[1925735321] 'agreement among raft nodes before linearized reading' (duration: 485.481486ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:36:29.16058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:36:28.673565Z","time spent":"486.385391ms","remote":"127.0.0.1:57858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs/local-path-storage/\" range_end:\"/registry/services/specs/local-path-storage0\" limit:500 "} {"level":"info","ts":"2026-07-25T06:36:30.656481Z","caller":"traceutil/trace.go:171","msg":"trace[1914656908] transaction","detail":"{read_only:false; response_revision:1511; number_of_response:1; }","duration":"120.165037ms","start":"2026-07-25T06:36:30.53629Z","end":"2026-07-25T06:36:30.656455Z","steps":["trace[1914656908] 'process raft request' (duration: 119.755854ms)"],"step_count":1}