{"level":"warn","ts":"2026-04-10T04:53:22.706942Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T04:53:22.707034Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.200:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.200:2380","--initial-cluster=instance=https://162.253.55.200:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.200:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.200: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-04-10T04:53:22.707098Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T04:53:22.707111Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.200:2380"]} {"level":"info","ts":"2026-04-10T04:53:22.707127Z","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-04-10T04:53:22.707786Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"]} {"level":"info","ts":"2026-04-10T04:53:22.707975Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.200:2380"],"listen-peer-urls":["https://162.253.55.200:2380"],"advertise-client-urls":["https://162.253.55.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.200: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-04-10T04:53:22.712503Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.217882ms"} {"level":"info","ts":"2026-04-10T04:53:22.72159Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e10bb51ed7578852","cluster-id":"aa14459abd2161c3"} {"level":"info","ts":"2026-04-10T04:53:22.721756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=()"} {"level":"info","ts":"2026-04-10T04:53:22.721796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became follower at term 0"} {"level":"info","ts":"2026-04-10T04:53:22.721875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e10bb51ed7578852 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-10T04:53:22.72189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became follower at term 1"} {"level":"info","ts":"2026-04-10T04:53:22.721975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=(16216254027344087122)"} {"level":"warn","ts":"2026-04-10T04:53:22.728815Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-10T04:53:22.730362Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-10T04:53:22.731744Z","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-04-10T04:53:22.734898Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e10bb51ed7578852","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-10T04:53:22.741457Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e10bb51ed7578852","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-10T04:53:22.741646Z","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-04-10T04:53:22.742531Z","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-04-10T04:53:22.742555Z","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-04-10T04:53:22.743458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=(16216254027344087122)"} {"level":"info","ts":"2026-04-10T04:53:22.743783Z","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-04-10T04:53:22.744014Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aa14459abd2161c3","local-member-id":"e10bb51ed7578852","added-peer-id":"e10bb51ed7578852","added-peer-peer-urls":["https://162.253.55.200:2380"]} {"level":"info","ts":"2026-04-10T04:53:22.744033Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.200:2380"} {"level":"info","ts":"2026-04-10T04:53:22.744101Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.200:2380"} {"level":"info","ts":"2026-04-10T04:53:22.744267Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e10bb51ed7578852","initial-advertise-peer-urls":["https://162.253.55.200:2380"],"listen-peer-urls":["https://162.253.55.200:2380"],"advertise-client-urls":["https://162.253.55.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-10T04:53:22.744322Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-10T04:53:23.722827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 is starting a new election at term 1"} {"level":"info","ts":"2026-04-10T04:53:23.722888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-10T04:53:23.722925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 received MsgPreVoteResp from e10bb51ed7578852 at term 1"} {"level":"info","ts":"2026-04-10T04:53:23.722953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became candidate at term 2"} {"level":"info","ts":"2026-04-10T04:53:23.72297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 received MsgVoteResp from e10bb51ed7578852 at term 2"} {"level":"info","ts":"2026-04-10T04:53:23.722986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became leader at term 2"} {"level":"info","ts":"2026-04-10T04:53:23.723005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e10bb51ed7578852 elected leader e10bb51ed7578852 at term 2"} {"level":"info","ts":"2026-04-10T04:53:23.724145Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e10bb51ed7578852","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.200:2379]}","request-path":"/0/members/e10bb51ed7578852/attributes","cluster-id":"aa14459abd2161c3","publish-timeout":"7s"} {"level":"info","ts":"2026-04-10T04:53:23.724286Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T04:53:23.724493Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T04:53:23.724441Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T04:53:23.724778Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-10T04:53:23.724807Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-10T04:53:23.727429Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-10T04:53:23.728599Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.200:2379"} {"level":"info","ts":"2026-04-10T04:53:23.733756Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aa14459abd2161c3","local-member-id":"e10bb51ed7578852","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T04:53:23.733897Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T04:53:23.733951Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T04:53:58.693223Z","caller":"traceutil/trace.go:171","msg":"trace[839819951] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"214.512962ms","start":"2026-04-10T04:53:58.478662Z","end":"2026-04-10T04:53:58.693175Z","steps":["trace[839819951] 'read index received' (duration: 207.542264ms)","trace[839819951] 'applied index is now lower than readState.Index' (duration: 6.969998ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:53:58.693265Z","caller":"traceutil/trace.go:171","msg":"trace[2143816737] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"223.096291ms","start":"2026-04-10T04:53:58.470142Z","end":"2026-04-10T04:53:58.693238Z","steps":["trace[2143816737] 'process raft request' (duration: 222.251821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:53:58.694126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.437516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mndbf\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-10T04:53:58.696261Z","caller":"traceutil/trace.go:171","msg":"trace[1322860140] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mndbf; range_end:; response_count:1; response_revision:572; }","duration":"217.597787ms","start":"2026-04-10T04:53:58.478652Z","end":"2026-04-10T04:53:58.696249Z","steps":["trace[1322860140] 'agreement among raft nodes before linearized reading' (duration: 215.321543ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:53:58.866478Z","caller":"traceutil/trace.go:171","msg":"trace[692998097] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"168.85382ms","start":"2026-04-10T04:53:58.697592Z","end":"2026-04-10T04:53:58.866446Z","steps":["trace[692998097] 'process raft request' (duration: 113.710869ms)","trace[692998097] 'compare' (duration: 54.998778ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:53:59.44095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.347725ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T04:53:59.441181Z","caller":"traceutil/trace.go:171","msg":"trace[1284786304] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"493.020233ms","start":"2026-04-10T04:53:58.948144Z","end":"2026-04-10T04:53:59.441164Z","steps":["trace[1284786304] 'process raft request' (duration: 492.974342ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:53:59.44116Z","caller":"traceutil/trace.go:171","msg":"trace[473588071] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"732.846078ms","start":"2026-04-10T04:53:58.708261Z","end":"2026-04-10T04:53:59.441107Z","steps":["trace[473588071] 'process raft request' (duration: 273.798007ms)","trace[473588071] 'compare' (duration: 458.197701ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:53:59.441258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:53:58.948115Z","time spent":"493.111015ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:53:59.441327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:53:58.70825Z","time spent":"732.988261ms","remote":"127.0.0.1:57822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:53:59.441311Z","caller":"traceutil/trace.go:171","msg":"trace[2065393904] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:598; }","duration":"639.776449ms","start":"2026-04-10T04:53:58.80148Z","end":"2026-04-10T04:53:59.441256Z","steps":["trace[2065393904] 'read index received' (duration: 9.832889ms)","trace[2065393904] 'applied index is now lower than readState.Index' (duration: 629.94147ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:53:59.441442Z","caller":"traceutil/trace.go:171","msg":"trace[1761678810] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"696.648493ms","start":"2026-04-10T04:53:58.744777Z","end":"2026-04-10T04:53:59.441426Z","steps":["trace[1761678810] 'process raft request' (duration: 696.277663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:53:59.441565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:53:58.744751Z","time spent":"696.740546ms","remote":"127.0.0.1:58128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T04:53:59.44181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.275032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-10T04:53:59.44196Z","caller":"traceutil/trace.go:171","msg":"trace[765773875] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:576; }","duration":"640.510528ms","start":"2026-04-10T04:53:58.80143Z","end":"2026-04-10T04:53:59.441941Z","steps":["trace[765773875] 'agreement among raft nodes before linearized reading' (duration: 640.030366ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:53:59.442098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:53:58.801405Z","time spent":"640.676301ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-10T04:53:59.637286Z","caller":"traceutil/trace.go:171","msg":"trace[1232541916] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"195.878224ms","start":"2026-04-10T04:53:59.441388Z","end":"2026-04-10T04:53:59.637266Z","steps":["trace[1232541916] 'read index received' (duration: 194.170453ms)","trace[1232541916] 'applied index is now lower than readState.Index' (duration: 1.707061ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:53:59.637345Z","caller":"traceutil/trace.go:171","msg":"trace[1905612018] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"426.011494ms","start":"2026-04-10T04:53:59.211307Z","end":"2026-04-10T04:53:59.637318Z","steps":["trace[1905612018] 'process raft request' (duration: 424.323824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:53:59.637432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.299265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:53:59.637464Z","caller":"traceutil/trace.go:171","msg":"trace[595400674] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:577; }","duration":"684.411447ms","start":"2026-04-10T04:53:58.953044Z","end":"2026-04-10T04:53:59.637456Z","steps":["trace[595400674] 'agreement among raft nodes before linearized reading' (duration: 684.314405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:53:59.637488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:53:58.952994Z","time spent":"684.488269ms","remote":"127.0.0.1:57596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T04:53:59.637479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:53:59.211279Z","time spent":"426.126577ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:53:59.637843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.740172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-10T04:53:59.637934Z","caller":"traceutil/trace.go:171","msg":"trace[1390363023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:577; }","duration":"389.198674ms","start":"2026-04-10T04:53:59.248689Z","end":"2026-04-10T04:53:59.637888Z","steps":["trace[1390363023] 'agreement among raft nodes before linearized reading' (duration: 388.63958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:53:59.637974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:53:59.248664Z","time spent":"389.299526ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-10T04:53:59.639699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.961431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:53:59.639778Z","caller":"traceutil/trace.go:171","msg":"trace[1811163910] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:578; }","duration":"183.069123ms","start":"2026-04-10T04:53:59.456688Z","end":"2026-04-10T04:53:59.639757Z","steps":["trace[1811163910] 'agreement among raft nodes before linearized reading' (duration: 182.93796ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:53:59.63983Z","caller":"traceutil/trace.go:171","msg":"trace[69561380] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"190.933073ms","start":"2026-04-10T04:53:59.448872Z","end":"2026-04-10T04:53:59.639806Z","steps":["trace[69561380] 'process raft request' (duration: 190.643916ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:54:50.065858Z","caller":"traceutil/trace.go:171","msg":"trace[846286104] linearizableReadLoop","detail":"{readStateIndex:991; appliedIndex:990; }","duration":"198.936554ms","start":"2026-04-10T04:54:49.866898Z","end":"2026-04-10T04:54:50.065835Z","steps":["trace[846286104] 'read index received' (duration: 198.682078ms)","trace[846286104] 'applied index is now lower than readState.Index' (duration: 253.666µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:54:50.066003Z","caller":"traceutil/trace.go:171","msg":"trace[1038895930] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"267.657841ms","start":"2026-04-10T04:54:49.798337Z","end":"2026-04-10T04:54:50.065995Z","steps":["trace[1038895930] 'process raft request' (duration: 267.347304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:54:50.066295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.312604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-10T04:54:50.066418Z","caller":"traceutil/trace.go:171","msg":"trace[234045130] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:953; }","duration":"189.454778ms","start":"2026-04-10T04:54:49.876919Z","end":"2026-04-10T04:54:50.066374Z","steps":["trace[234045130] 'agreement among raft nodes before linearized reading' (duration: 189.195092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:54:50.066434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.522889ms","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-04-10T04:54:50.066468Z","caller":"traceutil/trace.go:171","msg":"trace[50279568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:953; }","duration":"199.61062ms","start":"2026-04-10T04:54:49.866849Z","end":"2026-04-10T04:54:50.06646Z","steps":["trace[50279568] 'agreement among raft nodes before linearized reading' (duration: 199.463587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:54:50.066633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.247997ms","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-04-10T04:54:50.066674Z","caller":"traceutil/trace.go:171","msg":"trace[1585796293] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:953; }","duration":"137.328529ms","start":"2026-04-10T04:54:49.929335Z","end":"2026-04-10T04:54:50.066663Z","steps":["trace[1585796293] 'agreement among raft nodes before linearized reading' (duration: 137.233207ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:54:50.371183Z","caller":"traceutil/trace.go:171","msg":"trace[792514219] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"301.258535ms","start":"2026-04-10T04:54:50.06989Z","end":"2026-04-10T04:54:50.371148Z","steps":["trace[792514219] 'process raft request' (duration: 279.559985ms)","trace[792514219] 'compare' (duration: 21.549717ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:54:50.371336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:54:50.069867Z","time spent":"301.393159ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:54:50.509855Z","caller":"traceutil/trace.go:171","msg":"trace[585145294] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"439.66333ms","start":"2026-04-10T04:54:50.070151Z","end":"2026-04-10T04:54:50.509814Z","steps":["trace[585145294] 'process raft request' (duration: 438.38917ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:54:50.509852Z","caller":"traceutil/trace.go:171","msg":"trace[1992707133] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"439.480515ms","start":"2026-04-10T04:54:50.070342Z","end":"2026-04-10T04:54:50.509823Z","steps":["trace[1992707133] 'process raft request' (duration: 439.414123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:54:50.510067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:54:50.070136Z","time spent":"439.818873ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:54:50.510077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:54:50.070332Z","time spent":"439.640559ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:55:11.411032Z","caller":"traceutil/trace.go:171","msg":"trace[116332709] linearizableReadLoop","detail":"{readStateIndex:1065; appliedIndex:1064; }","duration":"191.156328ms","start":"2026-04-10T04:55:11.219841Z","end":"2026-04-10T04:55:11.410997Z","steps":["trace[116332709] 'read index received' (duration: 190.905592ms)","trace[116332709] 'applied index is now lower than readState.Index' (duration: 249.076µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:55:11.411109Z","caller":"traceutil/trace.go:171","msg":"trace[365385807] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"393.181526ms","start":"2026-04-10T04:55:11.017889Z","end":"2026-04-10T04:55:11.41107Z","steps":["trace[365385807] 'process raft request' (duration: 392.880349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:11.411377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.079368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-10T04:55:11.411385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.513256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-10T04:55:11.411413Z","caller":"traceutil/trace.go:171","msg":"trace[230335326] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1023; }","duration":"171.18165ms","start":"2026-04-10T04:55:11.240224Z","end":"2026-04-10T04:55:11.411405Z","steps":["trace[230335326] 'agreement among raft nodes before linearized reading' (duration: 171.011596ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:11.411452Z","caller":"traceutil/trace.go:171","msg":"trace[1757884023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1023; }","duration":"191.66024ms","start":"2026-04-10T04:55:11.219774Z","end":"2026-04-10T04:55:11.411435Z","steps":["trace[1757884023] 'agreement among raft nodes before linearized reading' (duration: 191.431765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:11.411584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:11.017848Z","time spent":"393.668418ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:55:12.1845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.785493ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T04:55:12.184745Z","caller":"traceutil/trace.go:171","msg":"trace[1115272073] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"769.720893ms","start":"2026-04-10T04:55:11.414986Z","end":"2026-04-10T04:55:12.184707Z","steps":["trace[1115272073] 'process raft request' (duration: 116.628782ms)","trace[1115272073] 'compare' (duration: 652.65214ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:55:12.184888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:11.414956Z","time spent":"769.854627ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:55:12.184916Z","caller":"traceutil/trace.go:171","msg":"trace[1100453406] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"769.637582ms","start":"2026-04-10T04:55:11.415248Z","end":"2026-04-10T04:55:12.184886Z","steps":["trace[1100453406] 'process raft request' (duration: 769.366964ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:12.184904Z","caller":"traceutil/trace.go:171","msg":"trace[1479545076] linearizableReadLoop","detail":"{readStateIndex:1067; appliedIndex:1065; }","duration":"613.505533ms","start":"2026-04-10T04:55:11.57137Z","end":"2026-04-10T04:55:12.184876Z","steps":["trace[1479545076] 'read index received' (duration: 368.512895ms)","trace[1479545076] 'applied index is now lower than readState.Index' (duration: 244.990527ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:55:12.185032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:11.415239Z","time spent":"769.732734ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:55:12.393031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.640297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T04:55:12.39305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.354501ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-10T04:55:12.393117Z","caller":"traceutil/trace.go:171","msg":"trace[1879689680] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1025; }","duration":"821.782851ms","start":"2026-04-10T04:55:11.57131Z","end":"2026-04-10T04:55:12.393093Z","steps":["trace[1879689680] 'agreement among raft nodes before linearized reading' (duration: 613.639976ms)","trace[1879689680] 'range keys from in-memory index tree' (duration: 208.019901ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:55:12.393165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:11.571285Z","time spent":"821.871512ms","remote":"127.0.0.1:57592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T04:55:12.393466Z","caller":"traceutil/trace.go:171","msg":"trace[989279462] linearizableReadLoop","detail":"{readStateIndex:1069; appliedIndex:1067; }","duration":"208.453672ms","start":"2026-04-10T04:55:12.184978Z","end":"2026-04-10T04:55:12.393432Z","steps":["trace[989279462] 'read index received' (duration: 182.523531ms)","trace[989279462] 'applied index is now lower than readState.Index' (duration: 25.928901ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:55:12.393499Z","caller":"traceutil/trace.go:171","msg":"trace[989296270] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"262.074557ms","start":"2026-04-10T04:55:12.13141Z","end":"2026-04-10T04:55:12.393484Z","steps":["trace[989296270] 'process raft request' (duration: 261.816881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:12.393599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.858048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T04:55:12.393634Z","caller":"traceutil/trace.go:171","msg":"trace[1557720042] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1026; }","duration":"635.94691ms","start":"2026-04-10T04:55:11.757678Z","end":"2026-04-10T04:55:12.393625Z","steps":["trace[1557720042] 'agreement among raft nodes before linearized reading' (duration: 635.850238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:12.393667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:11.757651Z","time spent":"636.006761ms","remote":"127.0.0.1:57718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":9,"response size":31,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-04-10T04:55:12.393675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.003799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:55:12.393825Z","caller":"traceutil/trace.go:171","msg":"trace[948395417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1026; }","duration":"443.191384ms","start":"2026-04-10T04:55:11.950574Z","end":"2026-04-10T04:55:12.393765Z","steps":["trace[948395417] 'agreement among raft nodes before linearized reading' (duration: 442.941928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:12.393887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:11.950555Z","time spent":"443.321087ms","remote":"127.0.0.1:57596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T04:55:12.394426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.620947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T04:55:12.394528Z","caller":"traceutil/trace.go:171","msg":"trace[705859578] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1026; }","duration":"735.77193ms","start":"2026-04-10T04:55:11.658728Z","end":"2026-04-10T04:55:12.3945Z","steps":["trace[705859578] 'agreement among raft nodes before linearized reading' (duration: 734.789117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:12.394583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:11.658717Z","time spent":"735.854583ms","remote":"127.0.0.1:41652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"info","ts":"2026-04-10T04:55:16.457347Z","caller":"traceutil/trace.go:171","msg":"trace[1461143975] linearizableReadLoop","detail":"{readStateIndex:1079; appliedIndex:1078; }","duration":"175.772799ms","start":"2026-04-10T04:55:16.281534Z","end":"2026-04-10T04:55:16.457307Z","steps":["trace[1461143975] 'read index received' (duration: 175.509163ms)","trace[1461143975] 'applied index is now lower than readState.Index' (duration: 262.376µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:55:16.457434Z","caller":"traceutil/trace.go:171","msg":"trace[1379928587] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"222.825197ms","start":"2026-04-10T04:55:16.234586Z","end":"2026-04-10T04:55:16.457411Z","steps":["trace[1379928587] 'process raft request' (duration: 222.469619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:16.457611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.054107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-10T04:55:16.457658Z","caller":"traceutil/trace.go:171","msg":"trace[236488589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1036; }","duration":"176.142078ms","start":"2026-04-10T04:55:16.281503Z","end":"2026-04-10T04:55:16.457645Z","steps":["trace[236488589] 'agreement among raft nodes before linearized reading' (duration: 175.967044ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:16.70459Z","caller":"traceutil/trace.go:171","msg":"trace[1900877638] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"257.434965ms","start":"2026-04-10T04:55:16.447121Z","end":"2026-04-10T04:55:16.704556Z","steps":["trace[1900877638] 'process raft request' (duration: 160.549215ms)","trace[1900877638] 'compare' (duration: 96.284106ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:55:16.704857Z","caller":"traceutil/trace.go:171","msg":"trace[470213689] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"242.241762ms","start":"2026-04-10T04:55:16.462576Z","end":"2026-04-10T04:55:16.704818Z","steps":["trace[470213689] 'process raft request' (duration: 241.924514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:27.310524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.557429ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T04:55:27.310647Z","caller":"traceutil/trace.go:171","msg":"trace[1133428791] linearizableReadLoop","detail":"{readStateIndex:1173; appliedIndex:1171; }","duration":"469.613467ms","start":"2026-04-10T04:55:26.841Z","end":"2026-04-10T04:55:27.310614Z","steps":["trace[1133428791] 'read index received' (duration: 3.696929ms)","trace[1133428791] 'applied index is now lower than readState.Index' (duration: 465.915468ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:55:27.310739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.74025ms","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-04-10T04:55:27.310758Z","caller":"traceutil/trace.go:171","msg":"trace[1000851007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1125; }","duration":"469.76749ms","start":"2026-04-10T04:55:26.840984Z","end":"2026-04-10T04:55:27.310751Z","steps":["trace[1000851007] 'agreement among raft nodes before linearized reading' (duration: 469.683128ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:27.310743Z","caller":"traceutil/trace.go:171","msg":"trace[1095226546] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"470.113168ms","start":"2026-04-10T04:55:26.840602Z","end":"2026-04-10T04:55:27.310716Z","steps":["trace[1095226546] 'process raft request' (duration: 227.301193ms)","trace[1095226546] 'compare' (duration: 242.456387ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:55:27.310783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:26.840978Z","time spent":"469.800481ms","remote":"127.0.0.1:57896","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-04-10T04:55:27.310898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:26.840567Z","time spent":"470.258152ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:55:27.481226Z","caller":"traceutil/trace.go:171","msg":"trace[138591967] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"166.018386ms","start":"2026-04-10T04:55:27.315187Z","end":"2026-04-10T04:55:27.481206Z","steps":["trace[138591967] 'process raft request' (duration: 97.613667ms)","trace[138591967] 'compare' (duration: 68.336858ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:55:29.256951Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9823086866253261764,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T04:55:29.757973Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9823086866253261764,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T04:55:29.808317Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.295686891s","expected-duration":"1s"} {"level":"info","ts":"2026-04-10T04:55:29.809213Z","caller":"traceutil/trace.go:171","msg":"trace[498851864] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"1.296635264s","start":"2026-04-10T04:55:28.512551Z","end":"2026-04-10T04:55:29.809187Z","steps":["trace[498851864] 'process raft request' (duration: 1.29645534s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:29.809405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:28.512534Z","time spent":"1.296744566s","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:55:29.823241Z","caller":"traceutil/trace.go:171","msg":"trace[154275765] linearizableReadLoop","detail":"{readStateIndex:1177; appliedIndex:1176; }","duration":"1.066540833s","start":"2026-04-10T04:55:28.756678Z","end":"2026-04-10T04:55:29.823219Z","steps":["trace[154275765] 'read index received' (duration: 1.052690381s)","trace[154275765] 'applied index is now lower than readState.Index' (duration: 13.849062ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:55:29.823463Z","caller":"traceutil/trace.go:171","msg":"trace[1060729725] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"1.079051073s","start":"2026-04-10T04:55:28.7444Z","end":"2026-04-10T04:55:29.823451Z","steps":["trace[1060729725] 'process raft request' (duration: 1.078658113s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:29.823589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:28.744376Z","time spent":"1.079139894s","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:55:29.823654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.233838ms","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-04-10T04:55:29.823706Z","caller":"traceutil/trace.go:171","msg":"trace[1198041831] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1129; }","duration":"973.317009ms","start":"2026-04-10T04:55:28.850378Z","end":"2026-04-10T04:55:29.823695Z","steps":["trace[1198041831] 'agreement among raft nodes before linearized reading' (duration: 973.161856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:29.823732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:28.850369Z","time spent":"973.35908ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-10T04:55:29.823762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.376225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:55:29.823814Z","caller":"traceutil/trace.go:171","msg":"trace[1668770122] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1129; }","duration":"404.460016ms","start":"2026-04-10T04:55:29.41934Z","end":"2026-04-10T04:55:29.8238Z","steps":["trace[1668770122] 'agreement among raft nodes before linearized reading' (duration: 404.376724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:29.82385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:29.419326Z","time spent":"404.515618ms","remote":"127.0.0.1:57708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-04-10T04:55:29.823863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.938774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-10T04:55:29.823913Z","caller":"traceutil/trace.go:171","msg":"trace[1608321513] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1129; }","duration":"508.025356ms","start":"2026-04-10T04:55:29.315874Z","end":"2026-04-10T04:55:29.823899Z","steps":["trace[1608321513] 'agreement among raft nodes before linearized reading' (duration: 507.874953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:29.823903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.067218199s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-10T04:55:29.823971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:29.315858Z","time spent":"508.078798ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-10T04:55:29.823987Z","caller":"traceutil/trace.go:171","msg":"trace[32522327] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1129; }","duration":"1.067333592s","start":"2026-04-10T04:55:28.756638Z","end":"2026-04-10T04:55:29.823972Z","steps":["trace[32522327] 'agreement among raft nodes before linearized reading' (duration: 1.067153048s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:29.824021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:28.756625Z","time spent":"1.067388893s","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-10T04:55:29.824299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.808364ms","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-04-10T04:55:29.824345Z","caller":"traceutil/trace.go:171","msg":"trace[1950982853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1129; }","duration":"338.879616ms","start":"2026-04-10T04:55:29.485453Z","end":"2026-04-10T04:55:29.824333Z","steps":["trace[1950982853] 'agreement among raft nodes before linearized reading' (duration: 338.136989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:29.824418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:29.485438Z","time spent":"338.969968ms","remote":"127.0.0.1:57896","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-04-10T04:55:30.451572Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9823086866253261768,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-10T04:55:30.687558Z","caller":"traceutil/trace.go:171","msg":"trace[2098686539] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"858.255154ms","start":"2026-04-10T04:55:29.828765Z","end":"2026-04-10T04:55:30.687021Z","steps":["trace[2098686539] 'process raft request' (duration: 858.10748ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:30.687682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:29.828744Z","time spent":"858.876429ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:55:30.687955Z","caller":"traceutil/trace.go:171","msg":"trace[1639282779] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"858.839409ms","start":"2026-04-10T04:55:29.829102Z","end":"2026-04-10T04:55:30.687941Z","steps":["trace[1639282779] 'process raft request' (duration: 858.564591ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:30.687951Z","caller":"traceutil/trace.go:171","msg":"trace[1100442507] linearizableReadLoop","detail":"{readStateIndex:1181; appliedIndex:1177; }","duration":"736.645192ms","start":"2026-04-10T04:55:29.951283Z","end":"2026-04-10T04:55:30.687928Z","steps":["trace[1100442507] 'read index received' (duration: 735.492104ms)","trace[1100442507] 'applied index is now lower than readState.Index' (duration: 1.152078ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:55:30.688017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:29.829089Z","time spent":"858.898391ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:55:30.688069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.764215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:55:30.688202Z","caller":"traceutil/trace.go:171","msg":"trace[1007882188] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"858.940531ms","start":"2026-04-10T04:55:29.829251Z","end":"2026-04-10T04:55:30.688191Z","steps":["trace[1007882188] 'process raft request' (duration: 858.526321ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:30.688106Z","caller":"traceutil/trace.go:171","msg":"trace[373642460] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1133; }","duration":"736.845656ms","start":"2026-04-10T04:55:29.951251Z","end":"2026-04-10T04:55:30.688096Z","steps":["trace[373642460] 'agreement among raft nodes before linearized reading' (duration: 736.750114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:30.688258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:29.829223Z","time spent":"859.010282ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:55:30.688259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:29.951234Z","time spent":"737.014851ms","remote":"127.0.0.1:57592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T04:55:30.688323Z","caller":"traceutil/trace.go:171","msg":"trace[457715886] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"858.92167ms","start":"2026-04-10T04:55:29.829394Z","end":"2026-04-10T04:55:30.688315Z","steps":["trace[457715886] 'process raft request' (duration: 858.46865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:30.68836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:29.829375Z","time spent":"858.965852ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:55:46.24321Z","caller":"traceutil/trace.go:171","msg":"trace[340695438] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"327.983635ms","start":"2026-04-10T04:55:45.915194Z","end":"2026-04-10T04:55:46.243177Z","steps":["trace[340695438] 'process raft request' (duration: 327.840831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:46.24347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:45.91518Z","time spent":"328.099268ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:55:46.845966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.41958ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T04:55:46.846262Z","caller":"traceutil/trace.go:171","msg":"trace[1214813642] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"929.146973ms","start":"2026-04-10T04:55:45.917092Z","end":"2026-04-10T04:55:46.846239Z","steps":["trace[1214813642] 'process raft request' (duration: 809.410885ms)","trace[1214813642] 'compare' (duration: 118.960699ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:55:46.846348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:45.917068Z","time spent":"929.235764ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:55:47.018425Z","caller":"traceutil/trace.go:171","msg":"trace[1896135757] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"168.71968ms","start":"2026-04-10T04:55:46.849677Z","end":"2026-04-10T04:55:47.018397Z","steps":["trace[1896135757] 'process raft request' (duration: 168.456604ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:47.018436Z","caller":"traceutil/trace.go:171","msg":"trace[372077641] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"167.42226ms","start":"2026-04-10T04:55:46.85099Z","end":"2026-04-10T04:55:47.018412Z","steps":["trace[372077641] 'process raft request' (duration: 167.380919ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:47.018495Z","caller":"traceutil/trace.go:171","msg":"trace[300910024] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"168.235109ms","start":"2026-04-10T04:55:46.850226Z","end":"2026-04-10T04:55:47.018461Z","steps":["trace[300910024] 'process raft request' (duration: 168.073825ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:47.018532Z","caller":"traceutil/trace.go:171","msg":"trace[1076669002] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"168.155867ms","start":"2026-04-10T04:55:46.850342Z","end":"2026-04-10T04:55:47.018498Z","steps":["trace[1076669002] 'process raft request' (duration: 168.000133ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:47.028573Z","caller":"traceutil/trace.go:171","msg":"trace[1960359873] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"127.433492ms","start":"2026-04-10T04:55:46.901127Z","end":"2026-04-10T04:55:47.02856Z","steps":["trace[1960359873] 'process raft request' (duration: 127.283009ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:48.738043Z","caller":"traceutil/trace.go:171","msg":"trace[1808138010] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"490.225532ms","start":"2026-04-10T04:55:48.247789Z","end":"2026-04-10T04:55:48.738015Z","steps":["trace[1808138010] 'process raft request' (duration: 490.021867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:48.73823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:48.247757Z","time spent":"490.385216ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:55:49.326859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.962227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T04:55:49.327005Z","caller":"traceutil/trace.go:171","msg":"trace[1457109378] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1266; }","duration":"476.500281ms","start":"2026-04-10T04:55:48.850486Z","end":"2026-04-10T04:55:49.326986Z","steps":["trace[1457109378] 'read index received' (duration: 131.323229ms)","trace[1457109378] 'applied index is now lower than readState.Index' (duration: 345.175682ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:55:49.327097Z","caller":"traceutil/trace.go:171","msg":"trace[1100630724] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"739.093799ms","start":"2026-04-10T04:55:48.587948Z","end":"2026-04-10T04:55:49.327042Z","steps":["trace[1100630724] 'process raft request' (duration: 393.828574ms)","trace[1100630724] 'compare' (duration: 344.810264ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:55:49.327141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.38745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T04:55:49.32719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.705057ms","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-04-10T04:55:49.327219Z","caller":"traceutil/trace.go:171","msg":"trace[94720897] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1215; }","duration":"476.771988ms","start":"2026-04-10T04:55:48.850438Z","end":"2026-04-10T04:55:49.32721Z","steps":["trace[94720897] 'agreement among raft nodes before linearized reading' (duration: 476.641635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:49.327238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:48.587919Z","time spent":"739.240921ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:55:49.327251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:48.850417Z","time spent":"476.825999ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-10T04:55:49.327298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.9147ms","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-04-10T04:55:49.327367Z","caller":"traceutil/trace.go:171","msg":"trace[56428831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1215; }","duration":"304.005242ms","start":"2026-04-10T04:55:49.023345Z","end":"2026-04-10T04:55:49.32735Z","steps":["trace[56428831] 'agreement among raft nodes before linearized reading' (duration: 303.790417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:49.327416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:49.023339Z","time spent":"304.063253ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-10T04:55:49.327421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.102424ms","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-04-10T04:55:49.327459Z","caller":"traceutil/trace.go:171","msg":"trace[605926061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1215; }","duration":"304.158965ms","start":"2026-04-10T04:55:49.023289Z","end":"2026-04-10T04:55:49.327448Z","steps":["trace[605926061] 'agreement among raft nodes before linearized reading' (duration: 304.045633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:49.327471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.866589ms","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-04-10T04:55:49.32749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:49.023282Z","time spent":"304.201536ms","remote":"127.0.0.1:57896","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-04-10T04:55:49.327502Z","caller":"traceutil/trace.go:171","msg":"trace[382526733] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1215; }","duration":"303.91875ms","start":"2026-04-10T04:55:49.023575Z","end":"2026-04-10T04:55:49.327494Z","steps":["trace[382526733] 'agreement among raft nodes before linearized reading' (duration: 303.820188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:49.327524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:49.023561Z","time spent":"303.957771ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-10T04:55:49.327584Z","caller":"traceutil/trace.go:171","msg":"trace[736599954] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1215; }","duration":"375.483142ms","start":"2026-04-10T04:55:48.951702Z","end":"2026-04-10T04:55:49.327185Z","steps":["trace[736599954] 'agreement among raft nodes before linearized reading' (duration: 375.39071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:49.32758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.496194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-10T04:55:49.327612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:48.951684Z","time spent":"375.922562ms","remote":"127.0.0.1:57592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T04:55:49.327652Z","caller":"traceutil/trace.go:171","msg":"trace[556606191] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1215; }","duration":"304.604376ms","start":"2026-04-10T04:55:49.02303Z","end":"2026-04-10T04:55:49.327635Z","steps":["trace[556606191] 'agreement among raft nodes before linearized reading' (duration: 304.391211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:49.327711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:49.023017Z","time spent":"304.685428ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-10T04:55:49.620384Z","caller":"traceutil/trace.go:171","msg":"trace[1805530331] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"288.52356ms","start":"2026-04-10T04:55:49.331828Z","end":"2026-04-10T04:55:49.620352Z","steps":["trace[1805530331] 'process raft request' (duration: 236.395676ms)","trace[1805530331] 'compare' (duration: 52.014672ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:55:49.690642Z","caller":"traceutil/trace.go:171","msg":"trace[1180471268] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"358.77822ms","start":"2026-04-10T04:55:49.331839Z","end":"2026-04-10T04:55:49.690617Z","steps":["trace[1180471268] 'process raft request' (duration: 358.585146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:49.690842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:49.331818Z","time spent":"358.915453ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:55:49.690878Z","caller":"traceutil/trace.go:171","msg":"trace[286620421] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"358.869292ms","start":"2026-04-10T04:55:49.331984Z","end":"2026-04-10T04:55:49.690853Z","steps":["trace[286620421] 'process raft request' (duration: 358.593075ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:49.690925Z","caller":"traceutil/trace.go:171","msg":"trace[253010696] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"358.78549ms","start":"2026-04-10T04:55:49.33212Z","end":"2026-04-10T04:55:49.690905Z","steps":["trace[253010696] 'process raft request' (duration: 358.751379ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:49.690987Z","caller":"traceutil/trace.go:171","msg":"trace[961980619] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"358.950954ms","start":"2026-04-10T04:55:49.332025Z","end":"2026-04-10T04:55:49.690976Z","steps":["trace[961980619] 'process raft request' (duration: 358.742999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:49.691041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:49.332109Z","time spent":"358.870812ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:55:49.691048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:49.331978Z","time spent":"359.040266ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:55:49.691293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:49.331963Z","time spent":"358.985575ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:55:50.992232Z","caller":"traceutil/trace.go:171","msg":"trace[769988076] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"249.613964ms","start":"2026-04-10T04:55:50.742597Z","end":"2026-04-10T04:55:50.992211Z","steps":["trace[769988076] 'process raft request' (duration: 248.969939ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:51.737012Z","caller":"traceutil/trace.go:171","msg":"trace[485602113] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"109.681369ms","start":"2026-04-10T04:55:51.627299Z","end":"2026-04-10T04:55:51.73698Z","steps":["trace[485602113] 'process raft request' (duration: 109.414743ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:51.857706Z","caller":"traceutil/trace.go:171","msg":"trace[1607616086] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"117.528277ms","start":"2026-04-10T04:55:51.740162Z","end":"2026-04-10T04:55:51.85769Z","steps":["trace[1607616086] 'process raft request' (duration: 117.410064ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:51.857861Z","caller":"traceutil/trace.go:171","msg":"trace[1496825347] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"117.416843ms","start":"2026-04-10T04:55:51.740439Z","end":"2026-04-10T04:55:51.857856Z","steps":["trace[1496825347] 'process raft request' (duration: 117.225319ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:51.85807Z","caller":"traceutil/trace.go:171","msg":"trace[1125758618] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"116.856411ms","start":"2026-04-10T04:55:51.741208Z","end":"2026-04-10T04:55:51.858065Z","steps":["trace[1125758618] 'process raft request' (duration: 116.614624ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:53.84954Z","caller":"traceutil/trace.go:171","msg":"trace[1957081003] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"105.111508ms","start":"2026-04-10T04:55:53.744389Z","end":"2026-04-10T04:55:53.849501Z","steps":["trace[1957081003] 'process raft request' (duration: 104.688428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:59.530344Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9823086866253262071,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T04:55:59.837281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.809076616s","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-04-10T04:55:59.837358Z","caller":"traceutil/trace.go:171","msg":"trace[622699812] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1276; }","duration":"1.809166298s","start":"2026-04-10T04:55:58.028174Z","end":"2026-04-10T04:55:59.837341Z","steps":["trace[622699812] 'count revisions from in-memory index tree' (duration: 1.808981504s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:59.837401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:58.028138Z","time spent":"1.80925206s","remote":"127.0.0.1:58086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":31,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-04-10T04:55:59.83743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.968400158s","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-04-10T04:55:59.837534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.95641083s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-10T04:55:59.837577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.886386076s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T04:55:59.837577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.949317359s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-10T04:55:59.837613Z","caller":"traceutil/trace.go:171","msg":"trace[1655027323] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1276; }","duration":"1.886475647s","start":"2026-04-10T04:55:57.951128Z","end":"2026-04-10T04:55:59.837604Z","steps":["trace[1655027323] 'range keys from in-memory index tree' (duration: 1.886324843s)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:55:59.837616Z","caller":"traceutil/trace.go:171","msg":"trace[380392398] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1276; }","duration":"1.956540693s","start":"2026-04-10T04:55:57.881058Z","end":"2026-04-10T04:55:59.837598Z","steps":["trace[380392398] 'range keys from in-memory index tree' (duration: 1.956204295s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:59.837638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:57.951122Z","time spent":"1.886510688s","remote":"127.0.0.1:57592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T04:55:59.837644Z","caller":"traceutil/trace.go:171","msg":"trace[193403839] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1276; }","duration":"1.949413672s","start":"2026-04-10T04:55:57.888215Z","end":"2026-04-10T04:55:59.837629Z","steps":["trace[193403839] 'range keys from in-memory index tree' (duration: 1.949186417s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:59.837662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:57.881046Z","time spent":"1.956606645s","remote":"127.0.0.1:57896","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-04-10T04:55:59.837696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:57.888198Z","time spent":"1.949486813s","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-10T04:55:59.837349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.948832668s","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-04-10T04:55:59.837838Z","caller":"traceutil/trace.go:171","msg":"trace[694744921] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1276; }","duration":"1.949349131s","start":"2026-04-10T04:55:57.888479Z","end":"2026-04-10T04:55:59.837828Z","steps":["trace[694744921] 'range keys from in-memory index tree' (duration: 1.948681104s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:59.83787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:57.888469Z","time spent":"1.949392411s","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-10T04:55:59.837877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.662394258s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-10T04:55:59.837918Z","caller":"traceutil/trace.go:171","msg":"trace[1920045901] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1276; }","duration":"1.66246945s","start":"2026-04-10T04:55:58.175435Z","end":"2026-04-10T04:55:59.837905Z","steps":["trace[1920045901] 'range keys from in-memory index tree' (duration: 1.662276374s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:59.837942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.9601611s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-10T04:55:59.837555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.948321716s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-10T04:55:59.837974Z","caller":"traceutil/trace.go:171","msg":"trace[174538239] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1276; }","duration":"1.960233532s","start":"2026-04-10T04:55:57.87773Z","end":"2026-04-10T04:55:59.837964Z","steps":["trace[174538239] 'range keys from in-memory index tree' (duration: 1.960044138s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:59.837983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:58.175417Z","time spent":"1.662537831s","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-10T04:55:59.837993Z","caller":"traceutil/trace.go:171","msg":"trace[145262102] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1276; }","duration":"1.948771456s","start":"2026-04-10T04:55:57.889201Z","end":"2026-04-10T04:55:59.837972Z","steps":["trace[145262102] 'range keys from in-memory index tree' (duration: 1.948216232s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:59.83801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:57.877708Z","time spent":"1.960296174s","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-10T04:55:59.837548Z","caller":"traceutil/trace.go:171","msg":"trace[527413944] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1276; }","duration":"1.968581023s","start":"2026-04-10T04:55:57.868948Z","end":"2026-04-10T04:55:59.837529Z","steps":["trace[527413944] 'range keys from in-memory index tree' (duration: 1.968192973s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:59.838038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:57.889193Z","time spent":"1.948831418s","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-10T04:55:59.838074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:57.868924Z","time spent":"1.969141256s","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-10T04:55:59.838371Z","caller":"traceutil/trace.go:171","msg":"trace[2095665692] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"822.524655ms","start":"2026-04-10T04:55:59.015822Z","end":"2026-04-10T04:55:59.838346Z","steps":["trace[2095665692] 'process raft request' (duration: 822.379532ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:55:59.838607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:59.015785Z","time spent":"822.692328ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:56:00.004134Z","caller":"traceutil/trace.go:171","msg":"trace[411374064] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"515.901459ms","start":"2026-04-10T04:55:59.488204Z","end":"2026-04-10T04:56:00.004105Z","steps":["trace[411374064] 'process raft request' (duration: 513.607365ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:56:00.004174Z","caller":"traceutil/trace.go:171","msg":"trace[672457150] linearizableReadLoop","detail":"{readStateIndex:1332; appliedIndex:1330; }","duration":"974.341606ms","start":"2026-04-10T04:55:59.029807Z","end":"2026-04-10T04:56:00.004148Z","steps":["trace[672457150] 'read index received' (duration: 808.123828ms)","trace[672457150] 'applied index is now lower than readState.Index' (duration: 166.130486ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:56:00.004406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.528502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:56:00.004478Z","caller":"traceutil/trace.go:171","msg":"trace[577229904] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1278; }","duration":"974.693496ms","start":"2026-04-10T04:55:59.029772Z","end":"2026-04-10T04:56:00.004465Z","steps":["trace[577229904] 'agreement among raft nodes before linearized reading' (duration: 974.525992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:56:00.004284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:59.48818Z","time spent":"516.022522ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:56:00.004564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:59.029759Z","time spent":"974.790328ms","remote":"127.0.0.1:57924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-04-10T04:56:00.00898Z","caller":"traceutil/trace.go:171","msg":"trace[613404745] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"164.879856ms","start":"2026-04-10T04:55:59.844085Z","end":"2026-04-10T04:56:00.008965Z","steps":["trace[613404745] 'process raft request' (duration: 164.798254ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:56:00.009231Z","caller":"traceutil/trace.go:171","msg":"trace[422265723] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"165.380508ms","start":"2026-04-10T04:55:59.843822Z","end":"2026-04-10T04:56:00.009202Z","steps":["trace[422265723] 'process raft request' (duration: 165.024989ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:56:00.009272Z","caller":"traceutil/trace.go:171","msg":"trace[553825110] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"165.397698ms","start":"2026-04-10T04:55:59.843815Z","end":"2026-04-10T04:56:00.009213Z","steps":["trace[553825110] 'process raft request' (duration: 164.956408ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:56:00.00924Z","caller":"traceutil/trace.go:171","msg":"trace[1138398707] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"165.06868ms","start":"2026-04-10T04:55:59.844149Z","end":"2026-04-10T04:56:00.009218Z","steps":["trace[1138398707] 'process raft request' (duration: 164.763773ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:56:00.009442Z","caller":"traceutil/trace.go:171","msg":"trace[1313903261] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"164.561157ms","start":"2026-04-10T04:55:59.844865Z","end":"2026-04-10T04:56:00.009426Z","steps":["trace[1313903261] 'process raft request' (duration: 164.302151ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:56:00.009516Z","caller":"traceutil/trace.go:171","msg":"trace[743141375] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"164.597308ms","start":"2026-04-10T04:55:59.844905Z","end":"2026-04-10T04:56:00.009503Z","steps":["trace[743141375] 'process raft request' (duration: 164.413154ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:56:00.009562Z","caller":"traceutil/trace.go:171","msg":"trace[1019490263] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"163.551194ms","start":"2026-04-10T04:55:59.845992Z","end":"2026-04-10T04:56:00.009543Z","steps":["trace[1019490263] 'process raft request' (duration: 163.4044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:56:00.009682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.684767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:56:00.00971Z","caller":"traceutil/trace.go:171","msg":"trace[371232819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1285; }","duration":"168.746439ms","start":"2026-04-10T04:55:59.840956Z","end":"2026-04-10T04:56:00.009703Z","steps":["trace[371232819] 'agreement among raft nodes before linearized reading' (duration: 168.661217ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:56:00.01198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.592303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-04-10T04:56:00.012052Z","caller":"traceutil/trace.go:171","msg":"trace[787305060] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1285; }","duration":"540.695286ms","start":"2026-04-10T04:55:59.47134Z","end":"2026-04-10T04:56:00.012035Z","steps":["trace[787305060] 'agreement among raft nodes before linearized reading' (duration: 538.208406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:56:00.012089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:55:59.471324Z","time spent":"540.756127ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}