{"level":"warn","ts":"2026-07-02T00:24:02.572027Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T00:24:02.572114Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.77:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.77:2380","--initial-cluster=instance=https://199.204.45.77:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.77:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.77:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-02T00:24:02.572278Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T00:24:02.572291Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.77:2380"]} {"level":"info","ts":"2026-07-02T00:24:02.572356Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-02T00:24:02.57304Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"]} {"level":"info","ts":"2026-07-02T00:24:02.574145Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.77:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-02T00:24:02.57641Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.97247ms"} {"level":"info","ts":"2026-07-02T00:24:02.581814Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9133559b3198d4ec","cluster-id":"60f1aee33b0786f5"} {"level":"info","ts":"2026-07-02T00:24:02.581899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=()"} {"level":"info","ts":"2026-07-02T00:24:02.581919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 0"} {"level":"info","ts":"2026-07-02T00:24:02.581932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9133559b3198d4ec [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-02T00:24:02.581943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 1"} {"level":"info","ts":"2026-07-02T00:24:02.581974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"} {"level":"warn","ts":"2026-07-02T00:24:02.592291Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-02T00:24:02.59402Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-02T00:24:02.595307Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-02T00:24:02.59757Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9133559b3198d4ec","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-02T00:24:02.597782Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9133559b3198d4ec","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-02T00:24:02.59808Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-02T00:24:02.598162Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-02T00:24:02.598211Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-02T00:24:02.5985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"} {"level":"info","ts":"2026-07-02T00:24:02.598572Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","added-peer-id":"9133559b3198d4ec","added-peer-peer-urls":["https://199.204.45.77:2380"]} {"level":"info","ts":"2026-07-02T00:24:02.603151Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-02T00:24:02.603312Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.77:2380"} {"level":"info","ts":"2026-07-02T00:24:02.603403Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9133559b3198d4ec","initial-advertise-peer-urls":["https://199.204.45.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-02T00:24:02.603441Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-02T00:24:02.603345Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.77:2380"} {"level":"info","ts":"2026-07-02T00:24:03.38293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec is starting a new election at term 1"} {"level":"info","ts":"2026-07-02T00:24:03.382987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became pre-candidate at term 1"} {"level":"info","ts":"2026-07-02T00:24:03.383003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgPreVoteResp from 9133559b3198d4ec at term 1"} {"level":"info","ts":"2026-07-02T00:24:03.383016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became candidate at term 2"} {"level":"info","ts":"2026-07-02T00:24:03.383021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgVoteResp from 9133559b3198d4ec at term 2"} {"level":"info","ts":"2026-07-02T00:24:03.383029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became leader at term 2"} {"level":"info","ts":"2026-07-02T00:24:03.383036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9133559b3198d4ec elected leader 9133559b3198d4ec at term 2"} {"level":"info","ts":"2026-07-02T00:24:03.393143Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9133559b3198d4ec","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.77:2379]}","request-path":"/0/members/9133559b3198d4ec/attributes","cluster-id":"60f1aee33b0786f5","publish-timeout":"7s"} {"level":"info","ts":"2026-07-02T00:24:03.393399Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T00:24:03.393418Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T00:24:03.393921Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:24:03.396126Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:24:03.396349Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:24:03.396467Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:24:03.39661Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.77:2379"} {"level":"info","ts":"2026-07-02T00:24:03.397583Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-02T00:24:03.39766Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-02T00:24:03.39851Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-02T00:24:18.510876Z","caller":"traceutil/trace.go:171","msg":"trace[1286973430] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"168.72178ms","start":"2026-07-02T00:24:18.342135Z","end":"2026-07-02T00:24:18.510857Z","steps":["trace[1286973430] 'process raft request' (duration: 168.616378ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:19.278002Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15342812991239428492,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-02T00:24:19.390732Z","caller":"traceutil/trace.go:171","msg":"trace[1307277137] linearizableReadLoop","detail":"{readStateIndex:419; appliedIndex:418; }","duration":"613.384404ms","start":"2026-07-02T00:24:18.777318Z","end":"2026-07-02T00:24:19.390702Z","steps":["trace[1307277137] 'read index received' (duration: 613.184699ms)","trace[1307277137] 'applied index is now lower than readState.Index' (duration: 198.755µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:24:19.39078Z","caller":"traceutil/trace.go:171","msg":"trace[1828527364] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"873.516185ms","start":"2026-07-02T00:24:18.51723Z","end":"2026-07-02T00:24:19.390746Z","steps":["trace[1828527364] 'process raft request' (duration: 873.338361ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:19.391073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.565237ms","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-07-02T00:24:19.39106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.842322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-02T00:24:19.39114Z","caller":"traceutil/trace.go:171","msg":"trace[836934323] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:405; }","duration":"613.865103ms","start":"2026-07-02T00:24:18.777262Z","end":"2026-07-02T00:24:19.391127Z","steps":["trace[836934323] 'agreement among raft nodes before linearized reading' (duration: 613.573077ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:19.391165Z","caller":"traceutil/trace.go:171","msg":"trace[282694199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:405; }","duration":"609.009724ms","start":"2026-07-02T00:24:18.782136Z","end":"2026-07-02T00:24:19.391146Z","steps":["trace[282694199] 'agreement among raft nodes before linearized reading' (duration: 608.823201ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:19.391185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:18.777239Z","time spent":"613.936985ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-02T00:24:19.391237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.185024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-02T00:24:19.391274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.455979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-02T00:24:19.391304Z","caller":"traceutil/trace.go:171","msg":"trace[443736602] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:405; }","duration":"199.273596ms","start":"2026-07-02T00:24:19.192005Z","end":"2026-07-02T00:24:19.391278Z","steps":["trace[443736602] 'agreement among raft nodes before linearized reading' (duration: 199.184484ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:19.391213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:18.782115Z","time spent":"609.081836ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-02T00:24:19.391434Z","caller":"traceutil/trace.go:171","msg":"trace[1084172275] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:405; }","duration":"575.509459ms","start":"2026-07-02T00:24:18.815781Z","end":"2026-07-02T00:24:19.391291Z","steps":["trace[1084172275] 'agreement among raft nodes before linearized reading' (duration: 575.469548ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:19.391065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.103376ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:24:19.391516Z","caller":"traceutil/trace.go:171","msg":"trace[59236359] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:405; }","duration":"412.550965ms","start":"2026-07-02T00:24:18.978941Z","end":"2026-07-02T00:24:19.391492Z","steps":["trace[59236359] 'agreement among raft nodes before linearized reading' (duration: 412.050025ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:19.391734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:18.815766Z","time spent":"575.697363ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T00:24:19.393388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:18.517213Z","time spent":"873.622178ms","remote":"127.0.0.1:41120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6946,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:24:19.737649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.704751ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:24:19.737877Z","caller":"traceutil/trace.go:171","msg":"trace[607077333] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"341.706188ms","start":"2026-07-02T00:24:19.396154Z","end":"2026-07-02T00:24:19.73786Z","steps":["trace[607077333] 'process raft request' (duration: 341.645226ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:19.737908Z","caller":"traceutil/trace.go:171","msg":"trace[447191070] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"341.848101ms","start":"2026-07-02T00:24:19.396017Z","end":"2026-07-02T00:24:19.737865Z","steps":["trace[447191070] 'process raft request' (duration: 42.727522ms)","trace[447191070] 'compare' (duration: 298.395384ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:24:19.737956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:19.396137Z","time spent":"341.77435ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:24:19.738068Z","caller":"traceutil/trace.go:171","msg":"trace[732599522] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"341.905452ms","start":"2026-07-02T00:24:19.396153Z","end":"2026-07-02T00:24:19.738059Z","steps":["trace[732599522] 'process raft request' (duration: 341.588675ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:19.738059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:19.395992Z","time spent":"341.987554ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:24:19.738121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:19.396144Z","time spent":"341.952344ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:24:19.738207Z","caller":"traceutil/trace.go:171","msg":"trace[39667255] linearizableReadLoop","detail":"{readStateIndex:422; appliedIndex:419; }","duration":"341.975232ms","start":"2026-07-02T00:24:19.396206Z","end":"2026-07-02T00:24:19.738181Z","steps":["trace[39667255] 'read index received' (duration: 42.495336ms)","trace[39667255] 'applied index is now lower than readState.Index' (duration: 299.478776ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:24:19.738465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.227342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:24:19.738512Z","caller":"traceutil/trace.go:171","msg":"trace[2141412730] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:409; }","duration":"170.315393ms","start":"2026-07-02T00:24:19.568185Z","end":"2026-07-02T00:24:19.7385Z","steps":["trace[2141412730] 'agreement among raft nodes before linearized reading' (duration: 170.243932ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:19.738647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.444572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5326"} {"level":"info","ts":"2026-07-02T00:24:19.738693Z","caller":"traceutil/trace.go:171","msg":"trace[1514276777] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:409; }","duration":"342.521354ms","start":"2026-07-02T00:24:19.39616Z","end":"2026-07-02T00:24:19.738682Z","steps":["trace[1514276777] 'agreement among raft nodes before linearized reading' (duration: 342.443332ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:19.738724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:19.396144Z","time spent":"342.572966ms","remote":"127.0.0.1:41120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5349,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"info","ts":"2026-07-02T00:24:19.738678Z","caller":"traceutil/trace.go:171","msg":"trace[810977273] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"341.257298ms","start":"2026-07-02T00:24:19.397391Z","end":"2026-07-02T00:24:19.738648Z","steps":["trace[810977273] 'process raft request' (duration: 340.437712ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:19.739071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:19.397383Z","time spent":"341.483984ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:24:45.86937Z","caller":"traceutil/trace.go:171","msg":"trace[798179805] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"542.09267ms","start":"2026-07-02T00:24:45.327234Z","end":"2026-07-02T00:24:45.869327Z","steps":["trace[798179805] 'process raft request' (duration: 541.840465ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:45.869608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:45.327199Z","time spent":"542.285893ms","remote":"127.0.0.1:41120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:24:46.085474Z","caller":"traceutil/trace.go:171","msg":"trace[1144707278] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"369.7878ms","start":"2026-07-02T00:24:45.715626Z","end":"2026-07-02T00:24:46.085414Z","steps":["trace[1144707278] 'process raft request' (duration: 368.73ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:46.085558Z","caller":"traceutil/trace.go:171","msg":"trace[639175548] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:648; }","duration":"201.714673ms","start":"2026-07-02T00:24:45.883812Z","end":"2026-07-02T00:24:46.085527Z","steps":["trace[639175548] 'read index received' (duration: 200.329646ms)","trace[639175548] 'applied index is now lower than readState.Index' (duration: 1.383127ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:24:46.085679Z","caller":"traceutil/trace.go:171","msg":"trace[1165937065] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"239.301969ms","start":"2026-07-02T00:24:45.846365Z","end":"2026-07-02T00:24:46.085667Z","steps":["trace[1165937065] 'process raft request' (duration: 238.976192ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:46.08574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:45.715573Z","time spent":"370.013026ms","remote":"127.0.0.1:41024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:24:46.086033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.213645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-02T00:24:46.08608Z","caller":"traceutil/trace.go:171","msg":"trace[318843437] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:627; }","duration":"202.271796ms","start":"2026-07-02T00:24:45.883797Z","end":"2026-07-02T00:24:46.086069Z","steps":["trace[318843437] 'agreement among raft nodes before linearized reading' (duration: 202.121583ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:46.087358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.687997ms","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-07-02T00:24:46.087447Z","caller":"traceutil/trace.go:171","msg":"trace[1205773149] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"194.823919ms","start":"2026-07-02T00:24:45.892606Z","end":"2026-07-02T00:24:46.08743Z","steps":["trace[1205773149] 'agreement among raft nodes before linearized reading' (duration: 194.606475ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:46.088094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.185531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-02T00:24:46.088142Z","caller":"traceutil/trace.go:171","msg":"trace[361086297] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"186.274671ms","start":"2026-07-02T00:24:45.901853Z","end":"2026-07-02T00:24:46.088128Z","steps":["trace[361086297] 'agreement among raft nodes before linearized reading' (duration: 185.888654ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:46.08857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.011045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-02T00:24:46.088726Z","caller":"traceutil/trace.go:171","msg":"trace[966648867] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:627; }","duration":"189.198429ms","start":"2026-07-02T00:24:45.899476Z","end":"2026-07-02T00:24:46.088674Z","steps":["trace[966648867] 'agreement among raft nodes before linearized reading' (duration: 188.79996ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:46.707005Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15342812991239428982,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T00:24:47.063078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.991202ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:24:47.063187Z","caller":"traceutil/trace.go:171","msg":"trace[1921908589] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"966.309094ms","start":"2026-07-02T00:24:46.096859Z","end":"2026-07-02T00:24:47.063168Z","steps":["trace[1921908589] 'process raft request' (duration: 655.147709ms)","trace[1921908589] 'compare' (duration: 310.854709ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:24:47.063246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:46.096839Z","time spent":"966.379085ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:24:47.068022Z","caller":"traceutil/trace.go:171","msg":"trace[13583508] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"970.313223ms","start":"2026-07-02T00:24:46.097685Z","end":"2026-07-02T00:24:47.067998Z","steps":["trace[13583508] 'process raft request' (duration: 970.15744ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:47.068288Z","caller":"traceutil/trace.go:171","msg":"trace[319254530] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"967.456307ms","start":"2026-07-02T00:24:46.100815Z","end":"2026-07-02T00:24:47.068272Z","steps":["trace[319254530] 'process raft request' (duration: 967.145081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:47.068353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:46.100799Z","time spent":"967.522798ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:24:47.068221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:46.097655Z","time spent":"970.440635ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:24:47.068796Z","caller":"traceutil/trace.go:171","msg":"trace[1326396950] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:650; }","duration":"862.304871ms","start":"2026-07-02T00:24:46.206478Z","end":"2026-07-02T00:24:47.068783Z","steps":["trace[1326396950] 'read index received' (duration: 545.486555ms)","trace[1326396950] 'applied index is now lower than readState.Index' (duration: 316.816986ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:24:47.068864Z","caller":"traceutil/trace.go:171","msg":"trace[1338125727] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"962.870417ms","start":"2026-07-02T00:24:46.105985Z","end":"2026-07-02T00:24:47.068856Z","steps":["trace[1338125727] 'process raft request' (duration: 962.228704ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:47.068918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:46.105977Z","time spent":"962.906328ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:24:47.069222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.678457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.77\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-02T00:24:47.069337Z","caller":"traceutil/trace.go:171","msg":"trace[1518598948] range","detail":"{range_begin:/registry/masterleases/199.204.45.77; range_end:; response_count:1; response_revision:632; }","duration":"862.892482ms","start":"2026-07-02T00:24:46.206415Z","end":"2026-07-02T00:24:47.069308Z","steps":["trace[1518598948] 'agreement among raft nodes before linearized reading' (duration: 862.584866ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:47.06939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:46.206392Z","time spent":"862.987824ms","remote":"127.0.0.1:40974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.77\" "} {"level":"info","ts":"2026-07-02T00:24:47.06951Z","caller":"traceutil/trace.go:171","msg":"trace[619542687] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"922.754902ms","start":"2026-07-02T00:24:46.146744Z","end":"2026-07-02T00:24:47.069499Z","steps":["trace[619542687] 'process raft request' (duration: 921.986708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:47.069572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:46.146728Z","time spent":"922.815113ms","remote":"127.0.0.1:41478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T00:24:48.625312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.046942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:24:48.625477Z","caller":"traceutil/trace.go:171","msg":"trace[371930525] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:669; }","duration":"106.248927ms","start":"2026-07-02T00:24:48.519204Z","end":"2026-07-02T00:24:48.625453Z","steps":["trace[371930525] 'range keys from in-memory index tree' (duration: 105.980491ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:34.779475Z","caller":"traceutil/trace.go:171","msg":"trace[1724281078] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"225.120702ms","start":"2026-07-02T00:25:34.554332Z","end":"2026-07-02T00:25:34.779452Z","steps":["trace[1724281078] 'process raft request' (duration: 224.984319ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:59.661044Z","caller":"traceutil/trace.go:171","msg":"trace[1901057330] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"173.810596ms","start":"2026-07-02T00:25:59.487207Z","end":"2026-07-02T00:25:59.661018Z","steps":["trace[1901057330] 'process raft request' (duration: 173.647033ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:59.861338Z","caller":"traceutil/trace.go:171","msg":"trace[1924279009] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"373.539333ms","start":"2026-07-02T00:25:59.487774Z","end":"2026-07-02T00:25:59.861313Z","steps":["trace[1924279009] 'process raft request' (duration: 350.248522ms)","trace[1924279009] 'compare' (duration: 23.093868ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:25:59.861488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:59.487753Z","time spent":"373.660696ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:25:59.86158Z","caller":"traceutil/trace.go:171","msg":"trace[2119476117] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"373.30497ms","start":"2026-07-02T00:25:59.488255Z","end":"2026-07-02T00:25:59.86156Z","steps":["trace[2119476117] 'process raft request' (duration: 373.011084ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:59.861997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:59.488248Z","time spent":"373.653206ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:25:59.862394Z","caller":"traceutil/trace.go:171","msg":"trace[611476130] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1123; }","duration":"287.439222ms","start":"2026-07-02T00:25:59.574904Z","end":"2026-07-02T00:25:59.862343Z","steps":["trace[611476130] 'read index received' (duration: 85.925028ms)","trace[611476130] 'applied index is now lower than readState.Index' (duration: 201.503364ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:25:59.862527Z","caller":"traceutil/trace.go:171","msg":"trace[37145281] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"373.458253ms","start":"2026-07-02T00:25:59.489039Z","end":"2026-07-02T00:25:59.862498Z","steps":["trace[37145281] 'process raft request' (duration: 372.464944ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:59.862985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:59.489033Z","time spent":"373.903092ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:25:59.862636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.84577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T00:25:59.86312Z","caller":"traceutil/trace.go:171","msg":"trace[1691605287] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1086; }","duration":"288.395041ms","start":"2026-07-02T00:25:59.574703Z","end":"2026-07-02T00:25:59.863098Z","steps":["trace[1691605287] 'agreement among raft nodes before linearized reading' (duration: 287.797179ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:01.067689Z","caller":"traceutil/trace.go:171","msg":"trace[1510392256] linearizableReadLoop","detail":"{readStateIndex:1128; appliedIndex:1127; }","duration":"122.403617ms","start":"2026-07-02T00:26:00.945258Z","end":"2026-07-02T00:26:01.067661Z","steps":["trace[1510392256] 'read index received' (duration: 122.164673ms)","trace[1510392256] 'applied index is now lower than readState.Index' (duration: 237.914µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:26:01.067763Z","caller":"traceutil/trace.go:171","msg":"trace[901239999] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"129.296821ms","start":"2026-07-02T00:26:00.938437Z","end":"2026-07-02T00:26:01.067733Z","steps":["trace[901239999] 'process raft request' (duration: 129.059167ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:01.068048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.765514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-02T00:26:01.068335Z","caller":"traceutil/trace.go:171","msg":"trace[1818744113] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1087; }","duration":"123.059769ms","start":"2026-07-02T00:26:00.945181Z","end":"2026-07-02T00:26:01.06824Z","steps":["trace[1818744113] 'agreement among raft nodes before linearized reading' (duration: 122.635131ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:16.525984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.023003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T00:26:16.526037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.743892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.77\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-02T00:26:16.526088Z","caller":"traceutil/trace.go:171","msg":"trace[1695508017] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1190; }","duration":"428.204237ms","start":"2026-07-02T00:26:16.097863Z","end":"2026-07-02T00:26:16.526067Z","steps":["trace[1695508017] 'count revisions from in-memory index tree' (duration: 427.926921ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:16.526116Z","caller":"traceutil/trace.go:171","msg":"trace[1362802081] range","detail":"{range_begin:/registry/masterleases/199.204.45.77; range_end:; response_count:1; response_revision:1190; }","duration":"314.864425ms","start":"2026-07-02T00:26:16.211231Z","end":"2026-07-02T00:26:16.526096Z","steps":["trace[1362802081] 'range keys from in-memory index tree' (duration: 314.558099ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:16.526146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:16.097844Z","time spent":"428.289058ms","remote":"127.0.0.1:56686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-02T00:26:16.526163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:16.211217Z","time spent":"314.936966ms","remote":"127.0.0.1:40974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.77\" "} {"level":"info","ts":"2026-07-02T00:26:34.436339Z","caller":"traceutil/trace.go:171","msg":"trace[1808600333] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1323; }","duration":"432.03008ms","start":"2026-07-02T00:26:34.004284Z","end":"2026-07-02T00:26:34.436314Z","steps":["trace[1808600333] 'read index received' (duration: 431.848316ms)","trace[1808600333] 'applied index is now lower than readState.Index' (duration: 180.534µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:26:34.436435Z","caller":"traceutil/trace.go:171","msg":"trace[717804909] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"603.847439ms","start":"2026-07-02T00:26:33.832556Z","end":"2026-07-02T00:26:34.436403Z","steps":["trace[717804909] 'process raft request' (duration: 603.581453ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:34.43653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.230764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:26:34.436569Z","caller":"traceutil/trace.go:171","msg":"trace[1072641601] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1274; }","duration":"432.325236ms","start":"2026-07-02T00:26:34.004232Z","end":"2026-07-02T00:26:34.436557Z","steps":["trace[1072641601] 'agreement among raft nodes before linearized reading' (duration: 432.240585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:34.43663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:34.004214Z","time spent":"432.407888ms","remote":"127.0.0.1:40946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T00:26:34.436632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:33.83252Z","time spent":"604.004641ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:26:34.436812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.514491ms","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-07-02T00:26:34.436845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.499395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-02T00:26:34.436903Z","caller":"traceutil/trace.go:171","msg":"trace[681003743] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1274; }","duration":"407.573996ms","start":"2026-07-02T00:26:34.029311Z","end":"2026-07-02T00:26:34.436885Z","steps":["trace[681003743] 'agreement among raft nodes before linearized reading' (duration: 407.321681ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:34.43691Z","caller":"traceutil/trace.go:171","msg":"trace[773331376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1274; }","duration":"414.648722ms","start":"2026-07-02T00:26:34.022221Z","end":"2026-07-02T00:26:34.43687Z","steps":["trace[773331376] 'agreement among raft nodes before linearized reading' (duration: 414.401568ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:34.436937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:34.029299Z","time spent":"407.630926ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-02T00:26:34.436962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:34.022199Z","time spent":"414.750435ms","remote":"127.0.0.1:41204","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-07-02T00:26:34.437261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.00537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-02T00:26:34.437352Z","caller":"traceutil/trace.go:171","msg":"trace[1687212387] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1274; }","duration":"414.142433ms","start":"2026-07-02T00:26:34.02319Z","end":"2026-07-02T00:26:34.437332Z","steps":["trace[1687212387] 'agreement among raft nodes before linearized reading' (duration: 413.534612ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:34.437417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:34.02317Z","time spent":"414.238075ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-02T00:26:35.505052Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15342812991239430383,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T00:26:35.864774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.1806114s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:26:35.864868Z","caller":"traceutil/trace.go:171","msg":"trace[1563810292] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1274; }","duration":"1.180727692s","start":"2026-07-02T00:26:34.684127Z","end":"2026-07-02T00:26:35.864855Z","steps":["trace[1563810292] 'range keys from in-memory index tree' (duration: 1.180574879s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:35.865738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.507024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:26:35.865839Z","caller":"traceutil/trace.go:171","msg":"trace[1386376291] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"1.424550276s","start":"2026-07-02T00:26:34.441269Z","end":"2026-07-02T00:26:35.86582Z","steps":["trace[1386376291] 'process raft request' (duration: 497.872159ms)","trace[1386376291] 'compare' (duration: 925.844991ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:26:35.86591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:34.44118Z","time spent":"1.42469702s","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:26:35.917882Z","caller":"traceutil/trace.go:171","msg":"trace[2087707157] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"1.475379634s","start":"2026-07-02T00:26:34.442473Z","end":"2026-07-02T00:26:35.917853Z","steps":["trace[2087707157] 'process raft request' (duration: 1.475332503s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:35.918281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:34.442458Z","time spent":"1.47569596s","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:26:35.917906Z","caller":"traceutil/trace.go:171","msg":"trace[1091192453] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"1.47615755s","start":"2026-07-02T00:26:34.441721Z","end":"2026-07-02T00:26:35.917878Z","steps":["trace[1091192453] 'process raft request' (duration: 1.475949666s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:35.9186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:34.441692Z","time spent":"1.47676143s","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:26:36.145312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.707898ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:26:36.145585Z","caller":"traceutil/trace.go:171","msg":"trace[799410496] linearizableReadLoop","detail":"{readStateIndex:1328; appliedIndex:1325; }","duration":"1.140721954s","start":"2026-07-02T00:26:35.004846Z","end":"2026-07-02T00:26:36.145568Z","steps":["trace[799410496] 'read index received' (duration: 912.832809ms)","trace[799410496] 'applied index is now lower than readState.Index' (duration: 227.885855ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:26:36.145642Z","caller":"traceutil/trace.go:171","msg":"trace[1172228939] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"942.117958ms","start":"2026-07-02T00:26:35.203476Z","end":"2026-07-02T00:26:36.145594Z","steps":["trace[1172228939] 'process raft request' (duration: 810.020622ms)","trace[1172228939] 'compare' (duration: 131.456774ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:26:36.145735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.140888187s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:26:36.145777Z","caller":"traceutil/trace.go:171","msg":"trace[1949547506] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1278; }","duration":"1.140965198s","start":"2026-07-02T00:26:35.004798Z","end":"2026-07-02T00:26:36.145763Z","steps":["trace[1949547506] 'agreement among raft nodes before linearized reading' (duration: 1.140885046s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:36.145798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:35.20345Z","time spent":"942.25834ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:26:36.14581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:35.004757Z","time spent":"1.141045351s","remote":"127.0.0.1:40946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T00:26:36.14626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"816.461997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-02T00:26:36.146293Z","caller":"traceutil/trace.go:171","msg":"trace[68949213] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1278; }","duration":"816.527339ms","start":"2026-07-02T00:26:35.329757Z","end":"2026-07-02T00:26:36.146284Z","steps":["trace[68949213] 'agreement among raft nodes before linearized reading' (duration: 816.410046ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:36.146342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:35.329727Z","time spent":"816.595369ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-02T00:26:36.328871Z","caller":"traceutil/trace.go:171","msg":"trace[1835707024] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"103.293906ms","start":"2026-07-02T00:26:36.225547Z","end":"2026-07-02T00:26:36.32884Z","steps":["trace[1835707024] 'process raft request' (duration: 90.165031ms)","trace[1835707024] 'compare' (duration: 12.981442ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:26:38.422034Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15342812991239430403,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-02T00:26:38.474389Z","caller":"traceutil/trace.go:171","msg":"trace[2145340289] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"599.941132ms","start":"2026-07-02T00:26:37.87443Z","end":"2026-07-02T00:26:38.474371Z","steps":["trace[2145340289] 'process raft request' (duration: 599.814689ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:38.4745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:37.874413Z","time spent":"600.030334ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:26:38.501516Z","caller":"traceutil/trace.go:171","msg":"trace[1117073458] linearizableReadLoop","detail":"{readStateIndex:1334; appliedIndex:1332; }","duration":"579.513835ms","start":"2026-07-02T00:26:37.921978Z","end":"2026-07-02T00:26:38.501492Z","steps":["trace[1117073458] 'read index received' (duration: 552.321446ms)","trace[1117073458] 'applied index is now lower than readState.Index' (duration: 27.191619ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:26:38.501548Z","caller":"traceutil/trace.go:171","msg":"trace[2140049689] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"350.784393ms","start":"2026-07-02T00:26:38.150738Z","end":"2026-07-02T00:26:38.501523Z","steps":["trace[2140049689] 'process raft request' (duration: 350.6225ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:38.501679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.439413ms","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-07-02T00:26:38.501703Z","caller":"traceutil/trace.go:171","msg":"trace[961471760] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1283; }","duration":"338.501575ms","start":"2026-07-02T00:26:38.163194Z","end":"2026-07-02T00:26:38.501695Z","steps":["trace[961471760] 'agreement among raft nodes before linearized reading' (duration: 338.438574ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:38.501693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.932095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T00:26:38.501721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:38.163179Z","time spent":"338.536755ms","remote":"127.0.0.1:33704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"info","ts":"2026-07-02T00:26:38.501744Z","caller":"traceutil/trace.go:171","msg":"trace[966229380] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1283; }","duration":"214.031557ms","start":"2026-07-02T00:26:38.287699Z","end":"2026-07-02T00:26:38.50173Z","steps":["trace[966229380] 'agreement among raft nodes before linearized reading' (duration: 213.943536ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:38.501751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.203819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-02T00:26:38.501787Z","caller":"traceutil/trace.go:171","msg":"trace[589694630] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1283; }","duration":"578.286521ms","start":"2026-07-02T00:26:37.92349Z","end":"2026-07-02T00:26:38.501777Z","steps":["trace[589694630] 'agreement among raft nodes before linearized reading' (duration: 578.128788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:38.501821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:37.923474Z","time spent":"578.339302ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-02T00:26:38.501827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.462155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-02T00:26:38.501913Z","caller":"traceutil/trace.go:171","msg":"trace[1232023404] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1283; }","duration":"301.580416ms","start":"2026-07-02T00:26:38.200311Z","end":"2026-07-02T00:26:38.501892Z","steps":["trace[1232023404] 'agreement among raft nodes before linearized reading' (duration: 301.352992ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:38.501962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.937482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T00:26:38.501967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:38.200297Z","time spent":"301.656639ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-02T00:26:38.501982Z","caller":"traceutil/trace.go:171","msg":"trace[1160850871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1283; }","duration":"496.995213ms","start":"2026-07-02T00:26:38.004981Z","end":"2026-07-02T00:26:38.501976Z","steps":["trace[1160850871] 'agreement among raft nodes before linearized reading' (duration: 496.964342ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:38.501984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.38568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"warn","ts":"2026-07-02T00:26:38.502001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:38.004958Z","time spent":"497.040023ms","remote":"127.0.0.1:40946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T00:26:38.502013Z","caller":"traceutil/trace.go:171","msg":"trace[171655423] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1283; }","duration":"496.439761ms","start":"2026-07-02T00:26:38.005564Z","end":"2026-07-02T00:26:38.502004Z","steps":["trace[171655423] 'agreement among raft nodes before linearized reading' (duration: 496.35032ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:38.502039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:38.005553Z","time spent":"496.479902ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-02T00:26:38.502136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.163478ms","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-07-02T00:26:38.502154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:38.150712Z","time spent":"350.880585ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:26:38.502175Z","caller":"traceutil/trace.go:171","msg":"trace[436157403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1283; }","duration":"580.250218ms","start":"2026-07-02T00:26:37.921913Z","end":"2026-07-02T00:26:38.502163Z","steps":["trace[436157403] 'agreement among raft nodes before linearized reading' (duration: 580.117186ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:38.502201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:37.921887Z","time spent":"580.30796ms","remote":"127.0.0.1:41204","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-07-02T00:26:39.007005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.614228ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:26:39.007173Z","caller":"traceutil/trace.go:171","msg":"trace[46583537] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"501.621952ms","start":"2026-07-02T00:26:38.505522Z","end":"2026-07-02T00:26:39.007144Z","steps":["trace[46583537] 'process raft request' (duration: 78.79352ms)","trace[46583537] 'compare' (duration: 422.515706ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:26:39.007188Z","caller":"traceutil/trace.go:171","msg":"trace[1596067940] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"500.248966ms","start":"2026-07-02T00:26:38.506924Z","end":"2026-07-02T00:26:39.007173Z","steps":["trace[1596067940] 'process raft request' (duration: 500.172714ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:39.007256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:38.506896Z","time spent":"500.328477ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:26:39.007267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:38.505501Z","time spent":"501.723354ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:26:39.007476Z","caller":"traceutil/trace.go:171","msg":"trace[1944232356] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"500.385628ms","start":"2026-07-02T00:26:38.507078Z","end":"2026-07-02T00:26:39.007463Z","steps":["trace[1944232356] 'process raft request' (duration: 500.066042ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:39.007555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:38.50706Z","time spent":"500.455009ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:26:39.007581Z","caller":"traceutil/trace.go:171","msg":"trace[314184306] linearizableReadLoop","detail":"{readStateIndex:1338; appliedIndex:1334; }","duration":"434.660681ms","start":"2026-07-02T00:26:38.57291Z","end":"2026-07-02T00:26:39.007571Z","steps":["trace[314184306] 'read index received' (duration: 11.405111ms)","trace[314184306] 'applied index is now lower than readState.Index' (duration: 423.25481ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:26:39.007641Z","caller":"traceutil/trace.go:171","msg":"trace[675971720] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"500.49851ms","start":"2026-07-02T00:26:38.507133Z","end":"2026-07-02T00:26:39.007632Z","steps":["trace[675971720] 'process raft request' (duration: 500.246056ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:39.00769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:38.507109Z","time spent":"500.557001ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:26:39.007731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.815874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-02T00:26:39.007765Z","caller":"traceutil/trace.go:171","msg":"trace[567123744] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1287; }","duration":"434.892566ms","start":"2026-07-02T00:26:38.572863Z","end":"2026-07-02T00:26:39.007756Z","steps":["trace[567123744] 'agreement among raft nodes before linearized reading' (duration: 434.745723ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:39.007798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:38.572843Z","time spent":"434.948598ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-02T00:26:39.19067Z","caller":"traceutil/trace.go:171","msg":"trace[2084248615] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"178.958486ms","start":"2026-07-02T00:26:39.011686Z","end":"2026-07-02T00:26:39.190644Z","steps":["trace[2084248615] 'process raft request' (duration: 178.781402ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:39.216112Z","caller":"traceutil/trace.go:171","msg":"trace[936562071] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"199.187749ms","start":"2026-07-02T00:26:39.016896Z","end":"2026-07-02T00:26:39.216084Z","steps":["trace[936562071] 'process raft request' (duration: 199.068376ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:39.880303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.781649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T00:26:39.880387Z","caller":"traceutil/trace.go:171","msg":"trace[219753088] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1289; }","duration":"183.896871ms","start":"2026-07-02T00:26:39.69647Z","end":"2026-07-02T00:26:39.880367Z","steps":["trace[219753088] 'count revisions from in-memory index tree' (duration: 183.702088ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:44.410943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.471335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:26:44.411203Z","caller":"traceutil/trace.go:171","msg":"trace[1334148202] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1336; }","duration":"405.787801ms","start":"2026-07-02T00:26:44.005395Z","end":"2026-07-02T00:26:44.411183Z","steps":["trace[1334148202] 'range keys from in-memory index tree' (duration: 405.389574ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:44.411345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:44.005373Z","time spent":"405.957444ms","remote":"127.0.0.1:40946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T00:26:44.411204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.437628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-07-02T00:26:44.411686Z","caller":"traceutil/trace.go:171","msg":"trace[1841754983] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1336; }","duration":"399.971868ms","start":"2026-07-02T00:26:44.011699Z","end":"2026-07-02T00:26:44.411671Z","steps":["trace[1841754983] 'range keys from in-memory index tree' (duration: 399.244675ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:44.411832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:44.011672Z","time spent":"400.139982ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-02T00:26:44.737634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.975375ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:26:44.737871Z","caller":"traceutil/trace.go:171","msg":"trace[1788292987] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"220.090854ms","start":"2026-07-02T00:26:44.517756Z","end":"2026-07-02T00:26:44.737847Z","steps":["trace[1788292987] 'process raft request' (duration: 220.007032ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:44.737909Z","caller":"traceutil/trace.go:171","msg":"trace[993778822] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"232.737539ms","start":"2026-07-02T00:26:44.505144Z","end":"2026-07-02T00:26:44.737882Z","steps":["trace[993778822] 'process raft request' (duration: 19.405547ms)","trace[993778822] 'compare' (duration: 212.834243ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:26:45.598842Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15342812991239430500,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T00:26:46.099593Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15342812991239430500,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T00:26:46.600777Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15342812991239430500,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T00:26:46.983508Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.944115668s","expected-duration":"1s"} {"level":"info","ts":"2026-07-02T00:26:46.983905Z","caller":"traceutil/trace.go:171","msg":"trace[1755457384] linearizableReadLoop","detail":"{readStateIndex:1392; appliedIndex:1391; }","duration":"1.885638602s","start":"2026-07-02T00:26:45.098245Z","end":"2026-07-02T00:26:46.983884Z","steps":["trace[1755457384] 'read index received' (duration: 1.885520329s)","trace[1755457384] 'applied index is now lower than readState.Index' (duration: 117.333µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:26:46.983951Z","caller":"traceutil/trace.go:171","msg":"trace[815771993] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"1.944610247s","start":"2026-07-02T00:26:45.039318Z","end":"2026-07-02T00:26:46.983928Z","steps":["trace[815771993] 'process raft request' (duration: 1.944442944s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:46.984172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.885894076s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-02T00:26:46.984209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:45.039308Z","time spent":"1.94477958s","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:26:46.984257Z","caller":"traceutil/trace.go:171","msg":"trace[213185106] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1340; }","duration":"1.886005279s","start":"2026-07-02T00:26:45.09823Z","end":"2026-07-02T00:26:46.984236Z","steps":["trace[213185106] 'agreement among raft nodes before linearized reading' (duration: 1.885736934s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:46.984311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:45.098224Z","time spent":"1.88607856s","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-02T00:26:46.989364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.888701271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-02T00:26:46.98942Z","caller":"traceutil/trace.go:171","msg":"trace[121687643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1341; }","duration":"1.888809463s","start":"2026-07-02T00:26:45.100597Z","end":"2026-07-02T00:26:46.989407Z","steps":["trace[121687643] 'agreement among raft nodes before linearized reading' (duration: 1.88864169s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:46.989456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:45.100572Z","time spent":"1.888874975s","remote":"127.0.0.1:41204","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-07-02T00:26:46.989479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.230696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.77\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-02T00:26:46.98949Z","caller":"traceutil/trace.go:171","msg":"trace[1812802047] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"246.830163ms","start":"2026-07-02T00:26:46.742617Z","end":"2026-07-02T00:26:46.989447Z","steps":["trace[1812802047] 'process raft request' (duration: 246.501827ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:46.989565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.929089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:26:46.98956Z","caller":"traceutil/trace.go:171","msg":"trace[272505199] range","detail":"{range_begin:/registry/masterleases/199.204.45.77; range_end:; response_count:1; response_revision:1341; }","duration":"777.348537ms","start":"2026-07-02T00:26:46.212188Z","end":"2026-07-02T00:26:46.989537Z","steps":["trace[272505199] 'agreement among raft nodes before linearized reading' (duration: 777.068352ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:46.989597Z","caller":"traceutil/trace.go:171","msg":"trace[1079346032] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1341; }","duration":"983.995321ms","start":"2026-07-02T00:26:46.00559Z","end":"2026-07-02T00:26:46.989585Z","steps":["trace[1079346032] 'agreement among raft nodes before linearized reading' (duration: 983.955001ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:46.989623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:46.00557Z","time spent":"984.047902ms","remote":"127.0.0.1:40946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T00:26:46.989618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.907395ms","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-07-02T00:26:46.989673Z","caller":"traceutil/trace.go:171","msg":"trace[882558946] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1341; }","duration":"248.000956ms","start":"2026-07-02T00:26:46.74166Z","end":"2026-07-02T00:26:46.989661Z","steps":["trace[882558946] 'agreement among raft nodes before linearized reading' (duration: 247.846753ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:46.989755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.816952ms","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-07-02T00:26:46.989809Z","caller":"traceutil/trace.go:171","msg":"trace[643353736] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1341; }","duration":"264.899294ms","start":"2026-07-02T00:26:46.724893Z","end":"2026-07-02T00:26:46.989793Z","steps":["trace[643353736] 'agreement among raft nodes before linearized reading' (duration: 264.764732ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:46.989902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.889243851s","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-07-02T00:26:46.989631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:46.212167Z","time spent":"777.45351ms","remote":"127.0.0.1:40974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.77\" "} {"level":"warn","ts":"2026-07-02T00:26:46.989927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.842016384s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:26:46.990001Z","caller":"traceutil/trace.go:171","msg":"trace[2000362454] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1341; }","duration":"1.842132088s","start":"2026-07-02T00:26:45.147838Z","end":"2026-07-02T00:26:46.98997Z","steps":["trace[2000362454] 'agreement among raft nodes before linearized reading' (duration: 1.841981454s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:46.990053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.500614745s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-07-02T00:26:46.990056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:45.147827Z","time spent":"1.842215049s","remote":"127.0.0.1:41354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"info","ts":"2026-07-02T00:26:46.990088Z","caller":"traceutil/trace.go:171","msg":"trace[1678635907] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1341; }","duration":"1.500678416s","start":"2026-07-02T00:26:45.489401Z","end":"2026-07-02T00:26:46.99008Z","steps":["trace[1678635907] 'agreement among raft nodes before linearized reading' (duration: 1.500382009s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:46.990121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:45.489386Z","time spent":"1.500728157s","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-07-02T00:26:46.98994Z","caller":"traceutil/trace.go:171","msg":"trace[153135797] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1341; }","duration":"1.889291323s","start":"2026-07-02T00:26:45.100639Z","end":"2026-07-02T00:26:46.98993Z","steps":["trace[153135797] 'agreement among raft nodes before linearized reading' (duration: 1.88920228s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:46.990302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:45.100633Z","time spent":"1.889660051s","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-02T00:26:46.990424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.780833017s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-02T00:26:46.990467Z","caller":"traceutil/trace.go:171","msg":"trace[1374183198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1341; }","duration":"1.780894278s","start":"2026-07-02T00:26:45.209561Z","end":"2026-07-02T00:26:46.990455Z","steps":["trace[1374183198] 'agreement among raft nodes before linearized reading' (duration: 1.780710384s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:46.990564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:45.20955Z","time spent":"1.78095311s","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-02T00:26:57.208696Z","caller":"traceutil/trace.go:171","msg":"trace[640976227] transaction","detail":"{read_only:false; response_revision:1390; number_of_response:1; }","duration":"127.804516ms","start":"2026-07-02T00:26:57.08087Z","end":"2026-07-02T00:26:57.208674Z","steps":["trace[640976227] 'process raft request' (duration: 127.672474ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:57.209125Z","caller":"traceutil/trace.go:171","msg":"trace[2099928203] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"128.073661ms","start":"2026-07-02T00:26:57.080982Z","end":"2026-07-02T00:26:57.209055Z","steps":["trace[2099928203] 'process raft request' (duration: 127.656494ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:57.209717Z","caller":"traceutil/trace.go:171","msg":"trace[1439359867] transaction","detail":"{read_only:false; response_revision:1392; number_of_response:1; }","duration":"128.642613ms","start":"2026-07-02T00:26:57.081056Z","end":"2026-07-02T00:26:57.209699Z","steps":["trace[1439359867] 'process raft request' (duration: 127.873188ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:57.209862Z","caller":"traceutil/trace.go:171","msg":"trace[706923870] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"128.611933ms","start":"2026-07-02T00:26:57.081226Z","end":"2026-07-02T00:26:57.209838Z","steps":["trace[706923870] 'process raft request' (duration: 128.564272ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:57.209859Z","caller":"traceutil/trace.go:171","msg":"trace[920609760] transaction","detail":"{read_only:false; response_revision:1393; number_of_response:1; }","duration":"128.721945ms","start":"2026-07-02T00:26:57.08111Z","end":"2026-07-02T00:26:57.209832Z","steps":["trace[920609760] 'process raft request' (duration: 128.514231ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:57.210013Z","caller":"traceutil/trace.go:171","msg":"trace[1057572888] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"128.761476ms","start":"2026-07-02T00:26:57.081234Z","end":"2026-07-02T00:26:57.209995Z","steps":["trace[1057572888] 'process raft request' (duration: 128.514261ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:59.503685Z","caller":"traceutil/trace.go:171","msg":"trace[1290257563] transaction","detail":"{read_only:false; response_revision:1401; number_of_response:1; }","duration":"223.35166ms","start":"2026-07-02T00:26:59.280308Z","end":"2026-07-02T00:26:59.50366Z","steps":["trace[1290257563] 'process raft request' (duration: 223.181207ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:59.503929Z","caller":"traceutil/trace.go:171","msg":"trace[2085836046] transaction","detail":"{read_only:false; response_revision:1400; number_of_response:1; }","duration":"223.614005ms","start":"2026-07-02T00:26:59.280303Z","end":"2026-07-02T00:26:59.503917Z","steps":["trace[2085836046] 'process raft request' (duration: 222.962833ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:59.503895Z","caller":"traceutil/trace.go:171","msg":"trace[1582926756] transaction","detail":"{read_only:false; response_revision:1402; number_of_response:1; }","duration":"222.490964ms","start":"2026-07-02T00:26:59.281343Z","end":"2026-07-02T00:26:59.503834Z","steps":["trace[1582926756] 'process raft request' (duration: 222.196019ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:59.50407Z","caller":"traceutil/trace.go:171","msg":"trace[957396109] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"221.906772ms","start":"2026-07-02T00:26:59.282134Z","end":"2026-07-02T00:26:59.504041Z","steps":["trace[957396109] 'process raft request' (duration: 221.437114ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:21.501941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.941786ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:27:21.502216Z","caller":"traceutil/trace.go:171","msg":"trace[2105002449] transaction","detail":"{read_only:false; response_revision:1500; number_of_response:1; }","duration":"227.909517ms","start":"2026-07-02T00:27:21.274281Z","end":"2026-07-02T00:27:21.502191Z","steps":["trace[2105002449] 'process raft request' (duration: 37.625155ms)","trace[2105002449] 'compare' (duration: 189.825903ms)"],"step_count":2}