{"level":"warn","ts":"2026-04-13T15:18:36.552021Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T15:18:36.55213Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.141: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.141:2380","--initial-cluster=instance=https://199.204.45.141:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.141:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.141:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-13T15:18:36.55221Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T15:18:36.552226Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-13T15:18:36.552247Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-13T15:18:36.553035Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"]} {"level":"info","ts":"2026-04-13T15:18:36.553131Z","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":16,"max-cpu-available":16,"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.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.141:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-13T15:18:36.558062Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.679066ms"} {"level":"info","ts":"2026-04-13T15:18:36.564861Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9ef3b4f68930dc2","cluster-id":"b19a5957e6e65747"} {"level":"info","ts":"2026-04-13T15:18:36.565036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T15:18:36.565078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 0"} {"level":"info","ts":"2026-04-13T15:18:36.565089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9ef3b4f68930dc2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T15:18:36.5651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 1"} {"level":"info","ts":"2026-04-13T15:18:36.565137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"warn","ts":"2026-04-13T15:18:36.584772Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T15:18:36.586262Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T15:18:36.587151Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-13T15:18:36.589861Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9ef3b4f68930dc2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T15:18:36.590109Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-13T15:18:36.590253Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-13T15:18:36.59012Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9ef3b4f68930dc2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T15:18:36.590272Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-13T15:18:36.591065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"info","ts":"2026-04-13T15:18:36.5922Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","added-peer-id":"9ef3b4f68930dc2","added-peer-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-13T15:18:36.594806Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-13T15:18:36.594999Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-13T15:18:36.595086Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-13T15:18:36.595144Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9ef3b4f68930dc2","initial-advertise-peer-urls":["https://199.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T15:18:36.595186Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T15:18:37.166768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T15:18:37.166838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T15:18:37.166872Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgPreVoteResp from 9ef3b4f68930dc2 at term 1"} {"level":"info","ts":"2026-04-13T15:18:37.166888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became candidate at term 2"} {"level":"info","ts":"2026-04-13T15:18:37.1669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgVoteResp from 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-13T15:18:37.166911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became leader at term 2"} {"level":"info","ts":"2026-04-13T15:18:37.166925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9ef3b4f68930dc2 elected leader 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-13T15:18:37.18172Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T15:18:37.184931Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T15:18:37.184926Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9ef3b4f68930dc2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.141:2379]}","request-path":"/0/members/9ef3b4f68930dc2/attributes","cluster-id":"b19a5957e6e65747","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T15:18:37.185024Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T15:18:37.185398Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T15:18:37.185451Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T15:18:37.185687Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T15:18:37.18599Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T15:18:37.186077Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T15:18:37.188548Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T15:18:37.188896Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.141:2379"} {"level":"info","ts":"2026-04-13T15:18:38.67959Z","caller":"traceutil/trace.go:171","msg":"trace[894123307] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"108.901931ms","start":"2026-04-13T15:18:38.570646Z","end":"2026-04-13T15:18:38.679548Z","steps":["trace[894123307] 'process raft request' (duration: 28.303453ms)","trace[894123307] 'compare' (duration: 80.345655ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:18:38.680141Z","caller":"traceutil/trace.go:171","msg":"trace[944162431] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"108.565138ms","start":"2026-04-13T15:18:38.571492Z","end":"2026-04-13T15:18:38.680057Z","steps":["trace[944162431] 'process raft request' (duration: 107.971951ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:38.68023Z","caller":"traceutil/trace.go:171","msg":"trace[1148881524] linearizableReadLoop","detail":"{readStateIndex:21; appliedIndex:17; }","duration":"101.374052ms","start":"2026-04-13T15:18:38.578827Z","end":"2026-04-13T15:18:38.680201Z","steps":["trace[1148881524] 'read index received' (duration: 20.131627ms)","trace[1148881524] 'applied index is now lower than readState.Index' (duration: 81.239935ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:18:38.680268Z","caller":"traceutil/trace.go:171","msg":"trace[1846250879] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"108.753299ms","start":"2026-04-13T15:18:38.571498Z","end":"2026-04-13T15:18:38.680251Z","steps":["trace[1846250879] 'process raft request' (duration: 108.00488ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:38.680267Z","caller":"traceutil/trace.go:171","msg":"trace[1863828001] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"108.450435ms","start":"2026-04-13T15:18:38.571763Z","end":"2026-04-13T15:18:38.680213Z","steps":["trace[1863828001] 'process raft request' (duration: 107.764988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:38.680958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.067586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-13T15:18:38.681283Z","caller":"traceutil/trace.go:171","msg":"trace[1783597083] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"111.968467ms","start":"2026-04-13T15:18:38.569293Z","end":"2026-04-13T15:18:38.681261Z","steps":["trace[1783597083] 'agreement among raft nodes before linearized reading' (duration: 111.038577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:38.681715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.289071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T15:18:38.68184Z","caller":"traceutil/trace.go:171","msg":"trace[1274936932] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:21; }","duration":"108.645979ms","start":"2026-04-13T15:18:38.573165Z","end":"2026-04-13T15:18:38.681811Z","steps":["trace[1274936932] 'agreement among raft nodes before linearized reading' (duration: 107.164521ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:53.320328Z","caller":"traceutil/trace.go:171","msg":"trace[458761448] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"484.462779ms","start":"2026-04-13T15:18:52.83584Z","end":"2026-04-13T15:18:53.320303Z","steps":["trace[458761448] 'process raft request' (duration: 484.335806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:53.320829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:18:52.835823Z","time spent":"484.582173ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:18:54.455633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.388856ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:18:54.45574Z","caller":"traceutil/trace.go:171","msg":"trace[956977122] linearizableReadLoop","detail":"{readStateIndex:424; appliedIndex:423; }","duration":"741.667622ms","start":"2026-04-13T15:18:53.714056Z","end":"2026-04-13T15:18:54.455723Z","steps":["trace[956977122] 'read index received' (duration: 127.763623ms)","trace[956977122] 'applied index is now lower than readState.Index' (duration: 613.902629ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:18:54.455828Z","caller":"traceutil/trace.go:171","msg":"trace[1882898737] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"1.079891169s","start":"2026-04-13T15:18:53.375915Z","end":"2026-04-13T15:18:54.455806Z","steps":["trace[1882898737] 'process raft request' (duration: 465.995ms)","trace[1882898737] 'compare' (duration: 612.997697ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:18:54.455915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.312585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T15:18:54.455956Z","caller":"traceutil/trace.go:171","msg":"trace[877187778] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:412; }","duration":"496.407877ms","start":"2026-04-13T15:18:53.959539Z","end":"2026-04-13T15:18:54.455947Z","steps":["trace[877187778] 'agreement among raft nodes before linearized reading' (duration: 496.346365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:54.45599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:18:53.959511Z","time spent":"496.471339ms","remote":"127.0.0.1:51348","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-04-13T15:18:54.456083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:18:53.375891Z","time spent":"1.080023952s","remote":"127.0.0.1:51348","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-04-13T15:18:54.455855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.800246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-13T15:18:54.456229Z","caller":"traceutil/trace.go:171","msg":"trace[1117031597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:412; }","duration":"742.220827ms","start":"2026-04-13T15:18:53.713999Z","end":"2026-04-13T15:18:54.45622Z","steps":["trace[1117031597] 'agreement among raft nodes before linearized reading' (duration: 741.812286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:54.456266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:18:53.713979Z","time spent":"742.277007ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T15:18:54.456292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.304222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4373"} {"level":"info","ts":"2026-04-13T15:18:54.456473Z","caller":"traceutil/trace.go:171","msg":"trace[1220349181] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:412; }","duration":"191.577759ms","start":"2026-04-13T15:18:54.264865Z","end":"2026-04-13T15:18:54.456443Z","steps":["trace[1220349181] 'agreement among raft nodes before linearized reading' (duration: 191.089176ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:55.312426Z","caller":"traceutil/trace.go:171","msg":"trace[959167205] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"851.295459ms","start":"2026-04-13T15:18:54.461053Z","end":"2026-04-13T15:18:55.312348Z","steps":["trace[959167205] 'process raft request' (duration: 851.056033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:55.312667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:18:54.461031Z","time spent":"851.538326ms","remote":"127.0.0.1:51348","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-04-13T15:18:55.323185Z","caller":"traceutil/trace.go:171","msg":"trace[1171874455] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:424; }","duration":"435.936425ms","start":"2026-04-13T15:18:54.887212Z","end":"2026-04-13T15:18:55.323149Z","steps":["trace[1171874455] 'read index received' (duration: 425.017161ms)","trace[1171874455] 'applied index is now lower than readState.Index' (duration: 10.918134ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:18:55.323301Z","caller":"traceutil/trace.go:171","msg":"trace[331343997] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"862.014528ms","start":"2026-04-13T15:18:54.461268Z","end":"2026-04-13T15:18:55.323283Z","steps":["trace[331343997] 'process raft request' (duration: 861.651189ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:55.323314Z","caller":"traceutil/trace.go:171","msg":"trace[516712680] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"856.142745ms","start":"2026-04-13T15:18:54.46714Z","end":"2026-04-13T15:18:55.323283Z","steps":["trace[516712680] 'process raft request' (duration: 855.94582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:55.323474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:18:54.461246Z","time spent":"862.112291ms","remote":"127.0.0.1:51348","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-04-13T15:18:55.323476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:18:54.467122Z","time spent":"856.248628ms","remote":"127.0.0.1:51278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4365,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:18:55.323566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.313554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:18:55.323703Z","caller":"traceutil/trace.go:171","msg":"trace[1235120280] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:415; }","duration":"436.514839ms","start":"2026-04-13T15:18:54.887153Z","end":"2026-04-13T15:18:55.323668Z","steps":["trace[1235120280] 'agreement among raft nodes before linearized reading' (duration: 436.17791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:55.323756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:18:54.887128Z","time spent":"436.618352ms","remote":"127.0.0.1:51114","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-04-13T15:18:57.03101Z","caller":"traceutil/trace.go:171","msg":"trace[2003551451] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"103.123813ms","start":"2026-04-13T15:18:56.927855Z","end":"2026-04-13T15:18:57.030979Z","steps":["trace[2003551451] 'process raft request' (duration: 91.692391ms)","trace[2003551451] 'compare' (duration: 11.300979ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:18:57.368795Z","caller":"traceutil/trace.go:171","msg":"trace[111880337] transaction","detail":"{read_only:false; number_of_response:1; response_revision:433; }","duration":"154.048847ms","start":"2026-04-13T15:18:57.214728Z","end":"2026-04-13T15:18:57.368777Z","steps":["trace[111880337] 'process raft request' (duration: 154.014956ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:57.368822Z","caller":"traceutil/trace.go:171","msg":"trace[967092001] transaction","detail":"{read_only:false; number_of_response:1; response_revision:432; }","duration":"160.738602ms","start":"2026-04-13T15:18:57.208053Z","end":"2026-04-13T15:18:57.368792Z","steps":["trace[967092001] 'process raft request' (duration: 147.194025ms)","trace[967092001] 'compare' (duration: 13.366113ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:18:57.368888Z","caller":"traceutil/trace.go:171","msg":"trace[583716532] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"157.982241ms","start":"2026-04-13T15:18:57.21089Z","end":"2026-04-13T15:18:57.368872Z","steps":["trace[583716532] 'process raft request' (duration: 157.797896ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:57.36918Z","caller":"traceutil/trace.go:171","msg":"trace[827685885] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"116.31955ms","start":"2026-04-13T15:18:57.252852Z","end":"2026-04-13T15:18:57.369172Z","steps":["trace[827685885] 'process raft request' (duration: 115.993472ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:57.369165Z","caller":"traceutil/trace.go:171","msg":"trace[708672824] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"112.974882ms","start":"2026-04-13T15:18:57.25616Z","end":"2026-04-13T15:18:57.369135Z","steps":["trace[708672824] 'process raft request' (duration: 112.827539ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:59.578363Z","caller":"traceutil/trace.go:171","msg":"trace[757356151] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"146.979731ms","start":"2026-04-13T15:18:59.431362Z","end":"2026-04-13T15:18:59.578342Z","steps":["trace[757356151] 'process raft request' (duration: 104.930986ms)","trace[757356151] 'compare' (duration: 41.88503ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:19:10.993966Z","caller":"traceutil/trace.go:171","msg":"trace[1226740689] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"208.512954ms","start":"2026-04-13T15:19:10.785423Z","end":"2026-04-13T15:19:10.993936Z","steps":["trace[1226740689] 'process raft request' (duration: 208.262235ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:11.006808Z","caller":"traceutil/trace.go:171","msg":"trace[1773700288] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"214.643107ms","start":"2026-04-13T15:19:10.792144Z","end":"2026-04-13T15:19:11.006788Z","steps":["trace[1773700288] 'process raft request' (duration: 214.447599ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:11.006887Z","caller":"traceutil/trace.go:171","msg":"trace[1089372459] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"214.347957ms","start":"2026-04-13T15:19:10.792504Z","end":"2026-04-13T15:19:11.006852Z","steps":["trace[1089372459] 'process raft request' (duration: 214.186431ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:11.006959Z","caller":"traceutil/trace.go:171","msg":"trace[1473700728] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"189.761257ms","start":"2026-04-13T15:19:10.817142Z","end":"2026-04-13T15:19:11.006903Z","steps":["trace[1473700728] 'process raft request' (duration: 189.57841ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:11.006984Z","caller":"traceutil/trace.go:171","msg":"trace[351665734] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"187.091925ms","start":"2026-04-13T15:19:10.819866Z","end":"2026-04-13T15:19:11.006958Z","steps":["trace[351665734] 'process raft request' (duration: 186.963561ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:11.00704Z","caller":"traceutil/trace.go:171","msg":"trace[2117052862] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"187.783619ms","start":"2026-04-13T15:19:10.819181Z","end":"2026-04-13T15:19:11.006965Z","steps":["trace[2117052862] 'process raft request' (duration: 187.623373ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:11.007083Z","caller":"traceutil/trace.go:171","msg":"trace[284323964] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"186.542167ms","start":"2026-04-13T15:19:10.820484Z","end":"2026-04-13T15:19:11.007026Z","steps":["trace[284323964] 'process raft request' (duration: 186.372691ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:11.007102Z","caller":"traceutil/trace.go:171","msg":"trace[1908927338] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"185.641266ms","start":"2026-04-13T15:19:10.821416Z","end":"2026-04-13T15:19:11.007058Z","steps":["trace[1908927338] 'process raft request' (duration: 185.47139ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:11.007134Z","caller":"traceutil/trace.go:171","msg":"trace[1110011441] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"176.193183ms","start":"2026-04-13T15:19:10.830898Z","end":"2026-04-13T15:19:11.007092Z","steps":["trace[1110011441] 'process raft request' (duration: 176.066519ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:11.007201Z","caller":"traceutil/trace.go:171","msg":"trace[1133857660] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"144.332195ms","start":"2026-04-13T15:19:10.862846Z","end":"2026-04-13T15:19:11.007178Z","steps":["trace[1133857660] 'process raft request' (duration: 144.208501ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:11.007187Z","caller":"traceutil/trace.go:171","msg":"trace[1264285640] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"168.585223ms","start":"2026-04-13T15:19:10.838541Z","end":"2026-04-13T15:19:11.007126Z","steps":["trace[1264285640] 'process raft request' (duration: 168.465359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:17.811395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.589059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-13T15:19:17.811461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.508836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-13T15:19:17.811501Z","caller":"traceutil/trace.go:171","msg":"trace[179513028] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:622; }","duration":"289.747855ms","start":"2026-04-13T15:19:17.521731Z","end":"2026-04-13T15:19:17.811479Z","steps":["trace[179513028] 'range keys from in-memory index tree' (duration: 289.260905ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:17.811522Z","caller":"traceutil/trace.go:171","msg":"trace[1317888208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"289.589089ms","start":"2026-04-13T15:19:17.521915Z","end":"2026-04-13T15:19:17.811504Z","steps":["trace[1317888208] 'range keys from in-memory index tree' (duration: 289.389642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:17.811635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.218805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:19:17.811661Z","caller":"traceutil/trace.go:171","msg":"trace[1559620768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"218.272737ms","start":"2026-04-13T15:19:17.593382Z","end":"2026-04-13T15:19:17.811655Z","steps":["trace[1559620768] 'range keys from in-memory index tree' (duration: 218.167513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:17.81169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.560427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T15:19:17.811773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.89851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-13T15:19:17.811837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.544446ms","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:5"} {"level":"info","ts":"2026-04-13T15:19:17.811856Z","caller":"traceutil/trace.go:171","msg":"trace[1572363549] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:622; }","duration":"289.999735ms","start":"2026-04-13T15:19:17.521835Z","end":"2026-04-13T15:19:17.811835Z","steps":["trace[1572363549] 'range keys from in-memory index tree' (duration: 289.763996ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:17.811867Z","caller":"traceutil/trace.go:171","msg":"trace[1997179283] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:622; }","duration":"435.591138ms","start":"2026-04-13T15:19:17.376267Z","end":"2026-04-13T15:19:17.811858Z","steps":["trace[1997179283] 'count revisions from in-memory index tree' (duration: 435.455303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:17.811914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:17.37624Z","time spent":"435.662901ms","remote":"127.0.0.1:36502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-13T15:19:17.811793Z","caller":"traceutil/trace.go:171","msg":"trace[5153522] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:622; }","duration":"435.722893ms","start":"2026-04-13T15:19:17.376048Z","end":"2026-04-13T15:19:17.811771Z","steps":["trace[5153522] 'range keys from in-memory index tree' (duration: 435.200963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:17.812023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:17.376016Z","time spent":"435.977603ms","remote":"127.0.0.1:36502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-13T15:19:18.251665Z","caller":"traceutil/trace.go:171","msg":"trace[1630549826] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"455.633964ms","start":"2026-04-13T15:19:17.79601Z","end":"2026-04-13T15:19:18.251644Z","steps":["trace[1630549826] 'process raft request' (duration: 455.088322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:18.251809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:17.795965Z","time spent":"455.766149ms","remote":"127.0.0.1:51194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:19:20.407328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.614622251s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:19:20.408121Z","caller":"traceutil/trace.go:171","msg":"trace[1300002129] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"2.592125429s","start":"2026-04-13T15:19:17.815915Z","end":"2026-04-13T15:19:20.408041Z","steps":["trace[1300002129] 'process raft request' (duration: 976.653874ms)","trace[1300002129] 'compare' (duration: 1.614186575s)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:19:20.40833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:17.815898Z","time spent":"2.592312098s","remote":"127.0.0.1:51348","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-04-13T15:19:20.408439Z","caller":"traceutil/trace.go:171","msg":"trace[47039121] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"2.592157162s","start":"2026-04-13T15:19:17.816259Z","end":"2026-04-13T15:19:20.408416Z","steps":["trace[47039121] 'process raft request' (duration: 2.591192283s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:20.40854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:17.816227Z","time spent":"2.592270556s","remote":"127.0.0.1:51348","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-04-13T15:19:20.40866Z","caller":"traceutil/trace.go:171","msg":"trace[600141015] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"2.094826235s","start":"2026-04-13T15:19:18.313803Z","end":"2026-04-13T15:19:20.40863Z","steps":["trace[600141015] 'process raft request' (duration: 2.094747032s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:20.408774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:18.313778Z","time spent":"2.094945399s","remote":"127.0.0.1:51336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T15:19:20.408751Z","caller":"traceutil/trace.go:171","msg":"trace[1623636803] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"2.592019977s","start":"2026-04-13T15:19:17.816648Z","end":"2026-04-13T15:19:20.408668Z","steps":["trace[1623636803] 'process raft request' (duration: 2.591714425s)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:20.40865Z","caller":"traceutil/trace.go:171","msg":"trace[1586313200] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:643; }","duration":"2.167858506s","start":"2026-04-13T15:19:18.240768Z","end":"2026-04-13T15:19:20.408627Z","steps":["trace[1586313200] 'read index received' (duration: 10.274452ms)","trace[1586313200] 'applied index is now lower than readState.Index' (duration: 2.157582144s)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:19:20.408912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.168133017s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5gxk9\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-04-13T15:19:20.408943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:17.816607Z","time spent":"2.592235995s","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:19:20.408983Z","caller":"traceutil/trace.go:171","msg":"trace[336867200] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5gxk9; range_end:; response_count:1; response_revision:627; }","duration":"2.168254641s","start":"2026-04-13T15:19:18.240713Z","end":"2026-04-13T15:19:20.408967Z","steps":["trace[336867200] 'agreement among raft nodes before linearized reading' (duration: 2.167999451s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:20.409033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:18.240693Z","time spent":"2.168327774s","remote":"127.0.0.1:51292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-5gxk9\" "} {"level":"info","ts":"2026-04-13T15:19:20.446841Z","caller":"traceutil/trace.go:171","msg":"trace[978436196] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"575.79412ms","start":"2026-04-13T15:19:19.871016Z","end":"2026-04-13T15:19:20.44681Z","steps":["trace[978436196] 'process raft request' (duration: 575.652895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:20.447005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.851507942s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T15:19:20.447066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:19.870994Z","time spent":"575.984398ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:19:20.447096Z","caller":"traceutil/trace.go:171","msg":"trace[1199739654] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"1.851671848s","start":"2026-04-13T15:19:18.595402Z","end":"2026-04-13T15:19:20.447074Z","steps":["trace[1199739654] 'agreement among raft nodes before linearized reading' (duration: 1.851494261s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:20.447075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.860936752s","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-04-13T15:19:20.447165Z","caller":"traceutil/trace.go:171","msg":"trace[778604124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:628; }","duration":"1.861053436s","start":"2026-04-13T15:19:18.586096Z","end":"2026-04-13T15:19:20.44715Z","steps":["trace[778604124] 'agreement among raft nodes before linearized reading' (duration: 1.860849238s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:20.447223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:18.586065Z","time spent":"1.86115035s","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T15:19:20.447163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:18.595374Z","time spent":"1.851778532s","remote":"127.0.0.1:51114","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-04-13T15:19:20.447476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.821499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-13T15:19:20.447602Z","caller":"traceutil/trace.go:171","msg":"trace[903903141] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:628; }","duration":"159.001295ms","start":"2026-04-13T15:19:20.288578Z","end":"2026-04-13T15:19:20.447579Z","steps":["trace[903903141] 'agreement among raft nodes before linearized reading' (duration: 158.299827ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:20.536882Z","caller":"traceutil/trace.go:171","msg":"trace[1193847161] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"111.600458ms","start":"2026-04-13T15:19:20.425257Z","end":"2026-04-13T15:19:20.536857Z","steps":["trace[1193847161] 'process raft request' (duration: 110.505376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:20.536968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.034196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-13T15:19:20.537191Z","caller":"traceutil/trace.go:171","msg":"trace[973163920] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:629; }","duration":"123.311177ms","start":"2026-04-13T15:19:20.413856Z","end":"2026-04-13T15:19:20.537167Z","steps":["trace[973163920] 'agreement among raft nodes before linearized reading' (duration: 123.000034ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:36.301724Z","caller":"traceutil/trace.go:171","msg":"trace[300738910] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"285.044814ms","start":"2026-04-13T15:19:36.016648Z","end":"2026-04-13T15:19:36.301693Z","steps":["trace[300738910] 'process raft request' (duration: 284.824534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:36.941708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.490961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T15:19:36.941805Z","caller":"traceutil/trace.go:171","msg":"trace[1012888083] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:789; }","duration":"396.650489ms","start":"2026-04-13T15:19:36.545135Z","end":"2026-04-13T15:19:36.941785Z","steps":["trace[1012888083] 'range keys from in-memory index tree' (duration: 396.316754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:36.94185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:36.545115Z","time spent":"396.725272ms","remote":"127.0.0.1:51348","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-04-13T15:19:36.94187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.000441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-s69w2\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-04-13T15:19:36.942006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.48425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-13T15:19:36.942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.679755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-13T15:19:36.942054Z","caller":"traceutil/trace.go:171","msg":"trace[1583240120] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:789; }","duration":"394.598845ms","start":"2026-04-13T15:19:36.54744Z","end":"2026-04-13T15:19:36.942039Z","steps":["trace[1583240120] 'range keys from in-memory index tree' (duration: 394.29095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:36.942105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:36.547406Z","time spent":"394.687759ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-13T15:19:36.942045Z","caller":"traceutil/trace.go:171","msg":"trace[1887204794] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-s69w2; range_end:; response_count:1; response_revision:789; }","duration":"580.160007ms","start":"2026-04-13T15:19:36.361794Z","end":"2026-04-13T15:19:36.941954Z","steps":["trace[1887204794] 'range keys from in-memory index tree' (duration: 579.802291ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:36.942074Z","caller":"traceutil/trace.go:171","msg":"trace[1422997140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:789; }","duration":"395.8017ms","start":"2026-04-13T15:19:36.546253Z","end":"2026-04-13T15:19:36.942055Z","steps":["trace[1422997140] 'range keys from in-memory index tree' (duration: 395.492326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:36.942174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:36.361768Z","time spent":"580.387538ms","remote":"127.0.0.1:51292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-s69w2\" "} {"level":"warn","ts":"2026-04-13T15:19:36.94187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.593613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-13T15:19:36.942204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:36.54623Z","time spent":"395.960038ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T15:19:36.942298Z","caller":"traceutil/trace.go:171","msg":"trace[146854601] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:789; }","duration":"308.042913ms","start":"2026-04-13T15:19:36.634206Z","end":"2026-04-13T15:19:36.942249Z","steps":["trace[146854601] 'range keys from in-memory index tree' (duration: 307.392213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:36.94241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:36.634176Z","time spent":"308.198101ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-13T15:20:09.741901Z","caller":"traceutil/trace.go:171","msg":"trace[1166910884] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"110.432779ms","start":"2026-04-13T15:20:09.631443Z","end":"2026-04-13T15:20:09.741876Z","steps":["trace[1166910884] 'process raft request' (duration: 110.26882ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:20:25.445651Z","caller":"traceutil/trace.go:171","msg":"trace[1183454398] linearizableReadLoop","detail":"{readStateIndex:1086; appliedIndex:1085; }","duration":"225.143982ms","start":"2026-04-13T15:20:25.220487Z","end":"2026-04-13T15:20:25.445631Z","steps":["trace[1183454398] 'read index received' (duration: 224.993023ms)","trace[1183454398] 'applied index is now lower than readState.Index' (duration: 150.369µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:20:25.445745Z","caller":"traceutil/trace.go:171","msg":"trace[1689445909] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"230.899527ms","start":"2026-04-13T15:20:25.214829Z","end":"2026-04-13T15:20:25.445729Z","steps":["trace[1689445909] 'process raft request' (duration: 230.667133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:20:25.445845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.340403ms","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-04-13T15:20:25.445905Z","caller":"traceutil/trace.go:171","msg":"trace[551011595] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1048; }","duration":"225.413707ms","start":"2026-04-13T15:20:25.220466Z","end":"2026-04-13T15:20:25.44588Z","steps":["trace[551011595] 'agreement among raft nodes before linearized reading' (duration: 225.271759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:20:25.445937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.529145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-13T15:20:25.445977Z","caller":"traceutil/trace.go:171","msg":"trace[661358552] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1048; }","duration":"224.579898ms","start":"2026-04-13T15:20:25.221387Z","end":"2026-04-13T15:20:25.445967Z","steps":["trace[661358552] 'agreement among raft nodes before linearized reading' (duration: 224.486623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:20:25.445987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.875226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-13T15:20:25.446084Z","caller":"traceutil/trace.go:171","msg":"trace[2075707500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1048; }","duration":"224.987621ms","start":"2026-04-13T15:20:25.221067Z","end":"2026-04-13T15:20:25.446054Z","steps":["trace[2075707500] 'agreement among raft nodes before linearized reading' (duration: 224.749298ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:20:30.739923Z","caller":"traceutil/trace.go:171","msg":"trace[1562318979] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"138.813844ms","start":"2026-04-13T15:20:30.601088Z","end":"2026-04-13T15:20:30.739902Z","steps":["trace[1562318979] 'process raft request' (duration: 138.698627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:20:31.168808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.360053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:20:31.168892Z","caller":"traceutil/trace.go:171","msg":"trace[825364555] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1066; }","duration":"328.512793ms","start":"2026-04-13T15:20:30.840361Z","end":"2026-04-13T15:20:31.168874Z","steps":["trace[825364555] 'count revisions from in-memory index tree' (duration: 328.231445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:20:31.168934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:20:30.840337Z","time spent":"328.589248ms","remote":"127.0.0.1:51376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-13T15:20:31.169028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.338608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:20:31.16914Z","caller":"traceutil/trace.go:171","msg":"trace[1617446602] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1066; }","duration":"235.51648ms","start":"2026-04-13T15:20:30.933601Z","end":"2026-04-13T15:20:31.169117Z","steps":["trace[1617446602] 'count revisions from in-memory index tree' (duration: 235.109322ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:21:00.337809Z","caller":"traceutil/trace.go:171","msg":"trace[252966935] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"382.706622ms","start":"2026-04-13T15:20:59.955062Z","end":"2026-04-13T15:21:00.337768Z","steps":["trace[252966935] 'process raft request' (duration: 382.496596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:21:00.338013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:20:59.95504Z","time spent":"382.885144ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:21:01.348291Z","caller":"traceutil/trace.go:171","msg":"trace[1718456950] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"343.293786ms","start":"2026-04-13T15:21:01.004974Z","end":"2026-04-13T15:21:01.348268Z","steps":["trace[1718456950] 'process raft request' (duration: 343.159547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:21:01.348433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:21:01.004948Z","time spent":"343.419025ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:21:01.966428Z","caller":"traceutil/trace.go:171","msg":"trace[54911400] linearizableReadLoop","detail":"{readStateIndex:1212; appliedIndex:1211; }","duration":"270.571006ms","start":"2026-04-13T15:21:01.695832Z","end":"2026-04-13T15:21:01.966403Z","steps":["trace[54911400] 'read index received' (duration: 270.355512ms)","trace[54911400] 'applied index is now lower than readState.Index' (duration: 214.504µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:21:01.966544Z","caller":"traceutil/trace.go:171","msg":"trace[1246432919] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"295.133205ms","start":"2026-04-13T15:21:01.671378Z","end":"2026-04-13T15:21:01.966511Z","steps":["trace[1246432919] 'process raft request' (duration: 294.875617ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:21:01.966731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.876637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-13T15:21:01.966779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.76368ms","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-04-13T15:21:01.966807Z","caller":"traceutil/trace.go:171","msg":"trace[1140177057] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1166; }","duration":"271.005866ms","start":"2026-04-13T15:21:01.695783Z","end":"2026-04-13T15:21:01.966789Z","steps":["trace[1140177057] 'agreement among raft nodes before linearized reading' (duration: 270.766769ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:21:01.966821Z","caller":"traceutil/trace.go:171","msg":"trace[1587392787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1166; }","duration":"257.849776ms","start":"2026-04-13T15:21:01.708961Z","end":"2026-04-13T15:21:01.966811Z","steps":["trace[1587392787] 'agreement among raft nodes before linearized reading' (duration: 257.721097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:21:01.966804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.505951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-13T15:21:01.967028Z","caller":"traceutil/trace.go:171","msg":"trace[1970419527] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1166; }","duration":"264.824353ms","start":"2026-04-13T15:21:01.702186Z","end":"2026-04-13T15:21:01.96701Z","steps":["trace[1970419527] 'agreement among raft nodes before linearized reading' (duration: 264.388543ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:21:02.213202Z","caller":"traceutil/trace.go:171","msg":"trace[1173673799] linearizableReadLoop","detail":"{readStateIndex:1215; appliedIndex:1212; }","duration":"182.204085ms","start":"2026-04-13T15:21:02.030967Z","end":"2026-04-13T15:21:02.213171Z","steps":["trace[1173673799] 'read index received' (duration: 142.220802ms)","trace[1173673799] 'applied index is now lower than readState.Index' (duration: 39.981513ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:21:02.213367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.364166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:21:02.213353Z","caller":"traceutil/trace.go:171","msg":"trace[708907622] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"242.11025ms","start":"2026-04-13T15:21:01.971204Z","end":"2026-04-13T15:21:02.213315Z","steps":["trace[708907622] 'process raft request' (duration: 241.830551ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:21:02.213424Z","caller":"traceutil/trace.go:171","msg":"trace[977721821] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1169; }","duration":"182.489434ms","start":"2026-04-13T15:21:02.030916Z","end":"2026-04-13T15:21:02.213406Z","steps":["trace[977721821] 'agreement among raft nodes before linearized reading' (duration: 182.377597ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:21:02.213478Z","caller":"traceutil/trace.go:171","msg":"trace[2129608335] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"241.991232ms","start":"2026-04-13T15:21:01.971465Z","end":"2026-04-13T15:21:02.213456Z","steps":["trace[2129608335] 'process raft request' (duration: 241.648118ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:21:02.213549Z","caller":"traceutil/trace.go:171","msg":"trace[136152994] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"242.304063ms","start":"2026-04-13T15:21:01.971203Z","end":"2026-04-13T15:21:02.213507Z","steps":["trace[136152994] 'process raft request' (duration: 201.964576ms)","trace[136152994] 'compare' (duration: 39.727715ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:24:41.198239Z","caller":"traceutil/trace.go:171","msg":"trace[2007383370] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"103.542453ms","start":"2026-04-13T15:24:41.094654Z","end":"2026-04-13T15:24:41.198196Z","steps":["trace[2007383370] 'process raft request' (duration: 103.326468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:32.59227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.384002ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:25:32.592369Z","caller":"traceutil/trace.go:171","msg":"trace[1796970208] linearizableReadLoop","detail":"{readStateIndex:2162; appliedIndex:2161; }","duration":"292.216765ms","start":"2026-04-13T15:25:32.30014Z","end":"2026-04-13T15:25:32.592357Z","steps":["trace[1796970208] 'read index received' (duration: 1.643718ms)","trace[1796970208] 'applied index is now lower than readState.Index' (duration: 290.571977ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:25:32.592431Z","caller":"traceutil/trace.go:171","msg":"trace[1378695943] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"294.423826ms","start":"2026-04-13T15:25:32.298001Z","end":"2026-04-13T15:25:32.592425Z","steps":["trace[1378695943] 'compare' (duration: 290.26732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:32.592563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.59976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:25:32.592584Z","caller":"traceutil/trace.go:171","msg":"trace[821442365] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:2062; }","duration":"233.62044ms","start":"2026-04-13T15:25:32.358956Z","end":"2026-04-13T15:25:32.592576Z","steps":["trace[821442365] 'agreement among raft nodes before linearized reading' (duration: 233.569699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:32.592635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.531601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:25:32.592745Z","caller":"traceutil/trace.go:171","msg":"trace[395739489] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:0; response_revision:2062; }","duration":"288.679855ms","start":"2026-04-13T15:25:32.304049Z","end":"2026-04-13T15:25:32.592728Z","steps":["trace[395739489] 'agreement among raft nodes before linearized reading' (duration: 288.450899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:32.592845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.670655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:25:32.592929Z","caller":"traceutil/trace.go:171","msg":"trace[1365023563] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:0; response_revision:2062; }","duration":"292.791168ms","start":"2026-04-13T15:25:32.300117Z","end":"2026-04-13T15:25:32.592908Z","steps":["trace[1365023563] 'agreement among raft nodes before linearized reading' (duration: 292.396239ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:38.174472Z","caller":"traceutil/trace.go:171","msg":"trace[1327129643] transaction","detail":"{read_only:false; response_revision:2491; number_of_response:1; }","duration":"110.586049ms","start":"2026-04-13T15:25:38.063851Z","end":"2026-04-13T15:25:38.174437Z","steps":["trace[1327129643] 'process raft request' (duration: 110.391094ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:39.984284Z","caller":"traceutil/trace.go:171","msg":"trace[1246998357] transaction","detail":"{read_only:false; response_revision:2496; number_of_response:1; }","duration":"1.049880963s","start":"2026-04-13T15:25:38.934374Z","end":"2026-04-13T15:25:39.984255Z","steps":["trace[1246998357] 'process raft request' (duration: 1.049701018s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:39.98445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:38.934349Z","time spent":"1.050019375s","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:25:40.03261Z","caller":"traceutil/trace.go:171","msg":"trace[834724717] linearizableReadLoop","detail":"{readStateIndex:2600; appliedIndex:2598; }","duration":"506.575414ms","start":"2026-04-13T15:25:39.526011Z","end":"2026-04-13T15:25:40.032587Z","steps":["trace[834724717] 'read index received' (duration: 458.195044ms)","trace[834724717] 'applied index is now lower than readState.Index' (duration: 48.3793ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:25:40.032728Z","caller":"traceutil/trace.go:171","msg":"trace[1690814948] transaction","detail":"{read_only:false; response_revision:2497; number_of_response:1; }","duration":"512.850788ms","start":"2026-04-13T15:25:39.519867Z","end":"2026-04-13T15:25:40.032718Z","steps":["trace[1690814948] 'process raft request' (duration: 512.116392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:40.032837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:39.519841Z","time spent":"512.91431ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:25:40.032948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.722132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:25:40.033013Z","caller":"traceutil/trace.go:171","msg":"trace[1185655731] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2497; }","duration":"436.825724ms","start":"2026-04-13T15:25:39.596168Z","end":"2026-04-13T15:25:40.032994Z","steps":["trace[1185655731] 'agreement among raft nodes before linearized reading' (duration: 436.68678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:40.033048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:39.596147Z","time spent":"436.893276ms","remote":"127.0.0.1:51114","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-04-13T15:25:40.033335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.26635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-13T15:25:40.033309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.427109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-13T15:25:40.033401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.909709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-13T15:25:40.033418Z","caller":"traceutil/trace.go:171","msg":"trace[637127321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2497; }","duration":"227.595233ms","start":"2026-04-13T15:25:39.805801Z","end":"2026-04-13T15:25:40.033396Z","steps":["trace[637127321] 'agreement among raft nodes before linearized reading' (duration: 227.303956ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:40.033444Z","caller":"traceutil/trace.go:171","msg":"trace[100591185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2497; }","duration":"342.984651ms","start":"2026-04-13T15:25:39.690446Z","end":"2026-04-13T15:25:40.033431Z","steps":["trace[100591185] 'agreement among raft nodes before linearized reading' (duration: 342.848787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:40.033476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:39.69043Z","time spent":"343.039302ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T15:25:40.033371Z","caller":"traceutil/trace.go:171","msg":"trace[502070697] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2497; }","duration":"266.340092ms","start":"2026-04-13T15:25:39.767019Z","end":"2026-04-13T15:25:40.033359Z","steps":["trace[502070697] 'agreement among raft nodes before linearized reading' (duration: 266.210509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:40.03357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.802528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:25:40.034007Z","caller":"traceutil/trace.go:171","msg":"trace[1132196107] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:2497; }","duration":"313.266059ms","start":"2026-04-13T15:25:39.720726Z","end":"2026-04-13T15:25:40.033992Z","steps":["trace[1132196107] 'agreement among raft nodes before linearized reading' (duration: 312.815729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:40.034059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:39.720709Z","time spent":"313.33495ms","remote":"127.0.0.1:36338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-13T15:25:40.033658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.831473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-13T15:25:40.034187Z","caller":"traceutil/trace.go:171","msg":"trace[1522471530] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2497; }","duration":"508.396627ms","start":"2026-04-13T15:25:39.525773Z","end":"2026-04-13T15:25:40.03417Z","steps":["trace[1522471530] 'agreement among raft nodes before linearized reading' (duration: 507.827534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:40.034246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:39.525756Z","time spent":"508.469928ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T15:25:44.853932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.103865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T15:25:44.854039Z","caller":"traceutil/trace.go:171","msg":"trace[2134975964] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2535; }","duration":"164.228828ms","start":"2026-04-13T15:25:44.689783Z","end":"2026-04-13T15:25:44.854012Z","steps":["trace[2134975964] 'count revisions from in-memory index tree' (duration: 163.965062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:50.91457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.975658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-13T15:25:50.914714Z","caller":"traceutil/trace.go:171","msg":"trace[725515841] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:2681; }","duration":"602.180672ms","start":"2026-04-13T15:25:50.312507Z","end":"2026-04-13T15:25:50.914687Z","steps":["trace[725515841] 'range keys from in-memory index tree' (duration: 601.705523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:50.914762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:50.312476Z","time spent":"602.274595ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.141\" "} {"level":"info","ts":"2026-04-13T15:25:51.05406Z","caller":"traceutil/trace.go:171","msg":"trace[1432664166] linearizableReadLoop","detail":"{readStateIndex:2788; appliedIndex:2787; }","duration":"480.808017ms","start":"2026-04-13T15:25:50.573226Z","end":"2026-04-13T15:25:51.054034Z","steps":["trace[1432664166] 'read index received' (duration: 480.780045ms)","trace[1432664166] 'applied index is now lower than readState.Index' (duration: 26.802µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:25:51.054178Z","caller":"traceutil/trace.go:171","msg":"trace[1318181966] transaction","detail":"{read_only:false; response_revision:2682; number_of_response:1; }","duration":"567.788682ms","start":"2026-04-13T15:25:50.48638Z","end":"2026-04-13T15:25:51.054169Z","steps":["trace[1318181966] 'process raft request' (duration: 567.473694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:51.054277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:50.486355Z","time spent":"567.843082ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:25:51.054401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.150335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:25:51.054497Z","caller":"traceutil/trace.go:171","msg":"trace[1406506387] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2682; }","duration":"481.283377ms","start":"2026-04-13T15:25:50.57319Z","end":"2026-04-13T15:25:51.054474Z","steps":["trace[1406506387] 'agreement among raft nodes before linearized reading' (duration: 481.125904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:51.054556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:50.573173Z","time spent":"481.371298ms","remote":"127.0.0.1:51412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-04-13T15:25:51.055545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.96454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-patch-vrpl7\" ","response":"range_response_count:1 size:4179"} {"level":"info","ts":"2026-04-13T15:25:51.055604Z","caller":"traceutil/trace.go:171","msg":"trace[1342429007] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-patch-vrpl7; range_end:; response_count:1; response_revision:2682; }","duration":"430.049891ms","start":"2026-04-13T15:25:50.625537Z","end":"2026-04-13T15:25:51.055587Z","steps":["trace[1342429007] 'agreement among raft nodes before linearized reading' (duration: 429.855587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:51.055641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:50.625515Z","time spent":"430.117723ms","remote":"127.0.0.1:51292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":4202,"request content":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-patch-vrpl7\" "} {"level":"info","ts":"2026-04-13T15:26:08.294782Z","caller":"traceutil/trace.go:171","msg":"trace[1455779484] linearizableReadLoop","detail":"{readStateIndex:2885; appliedIndex:2883; }","duration":"104.220406ms","start":"2026-04-13T15:26:08.190536Z","end":"2026-04-13T15:26:08.294756Z","steps":["trace[1455779484] 'read index received' (duration: 12.675108ms)","trace[1455779484] 'applied index is now lower than readState.Index' (duration: 91.544168ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:26:08.294913Z","caller":"traceutil/trace.go:171","msg":"trace[123640822] transaction","detail":"{read_only:false; response_revision:2774; number_of_response:1; }","duration":"105.273568ms","start":"2026-04-13T15:26:08.189593Z","end":"2026-04-13T15:26:08.294866Z","steps":["trace[123640822] 'process raft request' (duration: 104.984842ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:08.295556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.991111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-13T15:26:08.295625Z","caller":"traceutil/trace.go:171","msg":"trace[1225348809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2774; }","duration":"105.096393ms","start":"2026-04-13T15:26:08.190509Z","end":"2026-04-13T15:26:08.295606Z","steps":["trace[1225348809] 'agreement among raft nodes before linearized reading' (duration: 104.394719ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:12.398694Z","caller":"traceutil/trace.go:171","msg":"trace[683472355] linearizableReadLoop","detail":"{readStateIndex:2903; appliedIndex:2902; }","duration":"244.720201ms","start":"2026-04-13T15:26:12.153943Z","end":"2026-04-13T15:26:12.398663Z","steps":["trace[683472355] 'read index received' (duration: 244.562478ms)","trace[683472355] 'applied index is now lower than readState.Index' (duration: 156.423µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:26:12.398744Z","caller":"traceutil/trace.go:171","msg":"trace[2101237865] transaction","detail":"{read_only:false; response_revision:2791; number_of_response:1; }","duration":"249.884417ms","start":"2026-04-13T15:26:12.14883Z","end":"2026-04-13T15:26:12.398714Z","steps":["trace[2101237865] 'process raft request' (duration: 249.642592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:12.399177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.211171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-13T15:26:12.399243Z","caller":"traceutil/trace.go:171","msg":"trace[1189864705] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2791; }","duration":"245.323384ms","start":"2026-04-13T15:26:12.153899Z","end":"2026-04-13T15:26:12.399222Z","steps":["trace[1189864705] 'agreement among raft nodes before linearized reading' (duration: 244.932186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:12.899658Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991528072938466723,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T15:26:13.349107Z","caller":"traceutil/trace.go:171","msg":"trace[1425487447] transaction","detail":"{read_only:false; response_revision:2792; number_of_response:1; }","duration":"1.091703039s","start":"2026-04-13T15:26:12.25738Z","end":"2026-04-13T15:26:13.349083Z","steps":["trace[1425487447] 'process raft request' (duration: 1.091566037s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:13.349241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:12.257359Z","time spent":"1.091818062s","remote":"127.0.0.1:51278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7772,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:26:13.521579Z","caller":"traceutil/trace.go:171","msg":"trace[1884600725] linearizableReadLoop","detail":"{readStateIndex:2905; appliedIndex:2903; }","duration":"1.122768203s","start":"2026-04-13T15:26:12.398787Z","end":"2026-04-13T15:26:13.521556Z","steps":["trace[1884600725] 'read index received' (duration: 950.237523ms)","trace[1884600725] 'applied index is now lower than readState.Index' (duration: 172.52973ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:26:13.521791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.169881714s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-13T15:26:13.521814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.188741079s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-13T15:26:13.521829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.21233383s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-13T15:26:13.521886Z","caller":"traceutil/trace.go:171","msg":"trace[1883939474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2793; }","duration":"1.170016827s","start":"2026-04-13T15:26:12.351848Z","end":"2026-04-13T15:26:13.521865Z","steps":["trace[1883939474] 'agreement among raft nodes before linearized reading' (duration: 1.169750611s)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:13.521901Z","caller":"traceutil/trace.go:171","msg":"trace[330702011] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2793; }","duration":"1.188880072s","start":"2026-04-13T15:26:12.332997Z","end":"2026-04-13T15:26:13.521877Z","steps":["trace[330702011] 'agreement among raft nodes before linearized reading' (duration: 1.188632527s)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:13.521909Z","caller":"traceutil/trace.go:171","msg":"trace[183407500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2793; }","duration":"1.212447492s","start":"2026-04-13T15:26:12.309443Z","end":"2026-04-13T15:26:13.52189Z","steps":["trace[183407500] 'agreement among raft nodes before linearized reading' (duration: 1.212246508s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:13.521935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:12.351836Z","time spent":"1.170090328s","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T15:26:13.521942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:12.332966Z","time spent":"1.188967044s","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T15:26:13.521958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:12.30943Z","time spent":"1.212514223s","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-13T15:26:13.521933Z","caller":"traceutil/trace.go:171","msg":"trace[1301857903] transaction","detail":"{read_only:false; response_revision:2793; number_of_response:1; }","duration":"1.11822574s","start":"2026-04-13T15:26:12.403661Z","end":"2026-04-13T15:26:13.521887Z","steps":["trace[1301857903] 'process raft request' (duration: 1.117747501s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:13.521827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.296957236s","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-04-13T15:26:13.522072Z","caller":"traceutil/trace.go:171","msg":"trace[216982403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2793; }","duration":"1.297240361s","start":"2026-04-13T15:26:12.224801Z","end":"2026-04-13T15:26:13.522041Z","steps":["trace[216982403] 'agreement among raft nodes before linearized reading' (duration: 1.296888714s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:13.522103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:12.40364Z","time spent":"1.118369963s","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:26:13.522156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:12.224779Z","time spent":"1.297346784s","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T15:26:13.819731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.903928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:26:13.819834Z","caller":"traceutil/trace.go:171","msg":"trace[1405801158] transaction","detail":"{read_only:false; response_revision:2795; number_of_response:1; }","duration":"293.534717ms","start":"2026-04-13T15:26:13.526287Z","end":"2026-04-13T15:26:13.819821Z","steps":["trace[1405801158] 'process raft request' (duration: 91.485916ms)","trace[1405801158] 'compare' (duration: 201.829677ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:26:13.820011Z","caller":"traceutil/trace.go:171","msg":"trace[1605220189] transaction","detail":"{read_only:false; response_revision:2796; number_of_response:1; }","duration":"293.570368ms","start":"2026-04-13T15:26:13.526434Z","end":"2026-04-13T15:26:13.820004Z","steps":["trace[1605220189] 'process raft request' (duration: 293.358304ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:13.820134Z","caller":"traceutil/trace.go:171","msg":"trace[1759839848] linearizableReadLoop","detail":"{readStateIndex:2909; appliedIndex:2906; }","duration":"225.614561ms","start":"2026-04-13T15:26:13.594491Z","end":"2026-04-13T15:26:13.820106Z","steps":["trace[1759839848] 'read index received' (duration: 23.242973ms)","trace[1759839848] 'applied index is now lower than readState.Index' (duration: 202.369728ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:26:13.820162Z","caller":"traceutil/trace.go:171","msg":"trace[1206642389] transaction","detail":"{read_only:false; response_revision:2797; number_of_response:1; }","duration":"293.583788ms","start":"2026-04-13T15:26:13.526557Z","end":"2026-04-13T15:26:13.820141Z","steps":["trace[1206642389] 'process raft request' (duration: 293.422025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:13.820219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.732153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:26:13.820254Z","caller":"traceutil/trace.go:171","msg":"trace[1287301857] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2797; }","duration":"225.799795ms","start":"2026-04-13T15:26:13.594444Z","end":"2026-04-13T15:26:13.820244Z","steps":["trace[1287301857] 'agreement among raft nodes before linearized reading' (duration: 225.738894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:15.248435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.492351ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:26:15.248566Z","caller":"traceutil/trace.go:171","msg":"trace[511234070] transaction","detail":"{read_only:false; response_revision:2800; number_of_response:1; }","duration":"548.14755ms","start":"2026-04-13T15:26:14.700397Z","end":"2026-04-13T15:26:15.248544Z","steps":["trace[511234070] 'process raft request' (duration: 64.420964ms)","trace[511234070] 'compare' (duration: 482.703006ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:26:15.248636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:14.700375Z","time spent":"548.224762ms","remote":"127.0.0.1:51364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1597,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:26:15.271983Z","caller":"traceutil/trace.go:171","msg":"trace[1396105998] transaction","detail":"{read_only:false; response_revision:2802; number_of_response:1; }","duration":"571.333404ms","start":"2026-04-13T15:26:14.700609Z","end":"2026-04-13T15:26:15.271942Z","steps":["trace[1396105998] 'process raft request' (duration: 571.078048ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:15.272086Z","caller":"traceutil/trace.go:171","msg":"trace[168328571] transaction","detail":"{read_only:false; response_revision:2804; number_of_response:1; }","duration":"570.270392ms","start":"2026-04-13T15:26:14.701734Z","end":"2026-04-13T15:26:15.272004Z","steps":["trace[168328571] 'process raft request' (duration: 570.17563ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:15.272138Z","caller":"traceutil/trace.go:171","msg":"trace[120458917] transaction","detail":"{read_only:false; response_revision:2801; number_of_response:1; }","duration":"571.501257ms","start":"2026-04-13T15:26:14.700601Z","end":"2026-04-13T15:26:15.272102Z","steps":["trace[120458917] 'process raft request' (duration: 570.836883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:15.272179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:14.70058Z","time spent":"571.487326ms","remote":"127.0.0.1:51264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1043,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:26:15.272156Z","caller":"traceutil/trace.go:171","msg":"trace[1701477816] transaction","detail":"{read_only:false; response_revision:2803; number_of_response:1; }","duration":"570.430955ms","start":"2026-04-13T15:26:14.701593Z","end":"2026-04-13T15:26:15.272024Z","steps":["trace[1701477816] 'process raft request' (duration: 570.23134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:15.272307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:14.700569Z","time spent":"571.669021ms","remote":"127.0.0.1:51264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1047,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:26:15.272377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:14.701717Z","time spent":"570.498887ms","remote":"127.0.0.1:51364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1577,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:26:15.272521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:14.701572Z","time spent":"570.736682ms","remote":"127.0.0.1:51594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4786,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:26:15.878678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.804395ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:26:15.878952Z","caller":"traceutil/trace.go:171","msg":"trace[112160068] linearizableReadLoop","detail":"{readStateIndex:2919; appliedIndex:2918; }","duration":"283.483262ms","start":"2026-04-13T15:26:15.595438Z","end":"2026-04-13T15:26:15.878921Z","steps":["trace[112160068] 'read index received' (duration: 83.304689ms)","trace[112160068] 'applied index is now lower than readState.Index' (duration: 200.172583ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:26:15.878963Z","caller":"traceutil/trace.go:171","msg":"trace[143134486] transaction","detail":"{read_only:false; response_revision:2807; number_of_response:1; }","duration":"306.749217ms","start":"2026-04-13T15:26:15.572165Z","end":"2026-04-13T15:26:15.878914Z","steps":["trace[143134486] 'process raft request' (duration: 106.576774ms)","trace[143134486] 'compare' (duration: 199.646102ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:26:15.879153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:15.572144Z","time spent":"306.900339ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:26:16.180947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.138382ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-13T15:26:16.181056Z","caller":"traceutil/trace.go:171","msg":"trace[425026266] linearizableReadLoop","detail":"{readStateIndex:2920; appliedIndex:2919; }","duration":"302.016929ms","start":"2026-04-13T15:26:15.879021Z","end":"2026-04-13T15:26:16.181038Z","steps":["trace[425026266] 'read index received' (duration: 63.761µs)","trace[425026266] 'applied index is now lower than readState.Index' (duration: 301.951568ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:26:16.181214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.017711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-13T15:26:16.181189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.725737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:26:16.181251Z","caller":"traceutil/trace.go:171","msg":"trace[357026838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2807; }","duration":"356.101112ms","start":"2026-04-13T15:26:15.825139Z","end":"2026-04-13T15:26:16.18124Z","steps":["trace[357026838] 'agreement among raft nodes before linearized reading' (duration: 355.946839ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:16.18129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:15.825117Z","time spent":"356.161374ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T15:26:16.181296Z","caller":"traceutil/trace.go:171","msg":"trace[2006087208] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2807; }","duration":"585.8778ms","start":"2026-04-13T15:26:15.595387Z","end":"2026-04-13T15:26:16.181264Z","steps":["trace[2006087208] 'agreement among raft nodes before linearized reading' (duration: 283.641816ms)","trace[2006087208] 'range keys from in-memory index tree' (duration: 302.062891ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:26:16.181357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:15.595367Z","time spent":"585.977372ms","remote":"127.0.0.1:51114","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-04-13T15:26:16.181387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.805677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-13T15:26:16.181454Z","caller":"traceutil/trace.go:171","msg":"trace[453774196] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2807; }","duration":"356.222205ms","start":"2026-04-13T15:26:15.825216Z","end":"2026-04-13T15:26:16.181439Z","steps":["trace[453774196] 'agreement among raft nodes before linearized reading' (duration: 355.95255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:16.18149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:15.825183Z","time spent":"356.298996ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T15:26:16.181541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.899958ms","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-04-13T15:26:16.181652Z","caller":"traceutil/trace.go:171","msg":"trace[1889433078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2807; }","duration":"356.164804ms","start":"2026-04-13T15:26:15.825468Z","end":"2026-04-13T15:26:16.181632Z","steps":["trace[1889433078] 'agreement among raft nodes before linearized reading' (duration: 355.703575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:16.181723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:15.825459Z","time spent":"356.252406ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-13T15:26:16.372912Z","caller":"traceutil/trace.go:171","msg":"trace[1382643576] transaction","detail":"{read_only:false; response_revision:2808; number_of_response:1; }","duration":"187.73752ms","start":"2026-04-13T15:26:16.18515Z","end":"2026-04-13T15:26:16.372888Z","steps":["trace[1382643576] 'process raft request' (duration: 187.577485ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:16.467183Z","caller":"traceutil/trace.go:171","msg":"trace[1840785625] transaction","detail":"{read_only:false; response_revision:2809; number_of_response:1; }","duration":"281.544873ms","start":"2026-04-13T15:26:16.185614Z","end":"2026-04-13T15:26:16.467159Z","steps":["trace[1840785625] 'process raft request' (duration: 281.325838ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:16.467397Z","caller":"traceutil/trace.go:171","msg":"trace[606831650] transaction","detail":"{read_only:false; response_revision:2810; number_of_response:1; }","duration":"281.570573ms","start":"2026-04-13T15:26:16.185794Z","end":"2026-04-13T15:26:16.467364Z","steps":["trace[606831650] 'process raft request' (duration: 281.322678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:18.802733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.84438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-13T15:26:18.802812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.224114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-13T15:26:18.802876Z","caller":"traceutil/trace.go:171","msg":"trace[84495873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2814; }","duration":"424.342547ms","start":"2026-04-13T15:26:18.378517Z","end":"2026-04-13T15:26:18.80286Z","steps":["trace[84495873] 'range keys from in-memory index tree' (duration: 423.888546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:18.802917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:18.378493Z","time spent":"424.414828ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T15:26:18.803296Z","caller":"traceutil/trace.go:171","msg":"trace[538608610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2814; }","duration":"332.013533ms","start":"2026-04-13T15:26:18.470829Z","end":"2026-04-13T15:26:18.802843Z","steps":["trace[538608610] 'range keys from in-memory index tree' (duration: 331.620615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:18.803433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:18.470812Z","time spent":"332.530954ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T15:26:18.803675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.004182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-13T15:26:18.803742Z","caller":"traceutil/trace.go:171","msg":"trace[707971534] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2814; }","duration":"332.115715ms","start":"2026-04-13T15:26:18.471617Z","end":"2026-04-13T15:26:18.803733Z","steps":["trace[707971534] 'range keys from in-memory index tree' (duration: 330.860569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:18.803764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:18.471605Z","time spent":"332.152995ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-13T15:26:18.827364Z","caller":"traceutil/trace.go:171","msg":"trace[1061679223] transaction","detail":"{read_only:false; response_revision:2815; number_of_response:1; }","duration":"323.542ms","start":"2026-04-13T15:26:18.503803Z","end":"2026-04-13T15:26:18.827345Z","steps":["trace[1061679223] 'process raft request' (duration: 323.415337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:18.827483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:18.503766Z","time spent":"323.652212ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:26:19.061737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.572279ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:26:19.061994Z","caller":"traceutil/trace.go:171","msg":"trace[1881940460] transaction","detail":"{read_only:false; response_revision:2819; number_of_response:1; }","duration":"196.251682ms","start":"2026-04-13T15:26:18.865716Z","end":"2026-04-13T15:26:19.061967Z","steps":["trace[1881940460] 'process raft request' (duration: 52.338387ms)","trace[1881940460] 'compare' (duration: 143.427616ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:26:21.316036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.135154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:26:21.316163Z","caller":"traceutil/trace.go:171","msg":"trace[1805262258] linearizableReadLoop","detail":"{readStateIndex:2940; appliedIndex:2939; }","duration":"451.183553ms","start":"2026-04-13T15:26:20.86496Z","end":"2026-04-13T15:26:21.316143Z","steps":["trace[1805262258] 'read index received' (duration: 245.851555ms)","trace[1805262258] 'applied index is now lower than readState.Index' (duration: 205.330538ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:26:21.31624Z","caller":"traceutil/trace.go:171","msg":"trace[1572621142] transaction","detail":"{read_only:false; response_revision:2826; number_of_response:1; }","duration":"484.184386ms","start":"2026-04-13T15:26:20.832016Z","end":"2026-04-13T15:26:21.316201Z","steps":["trace[1572621142] 'process raft request' (duration: 278.782107ms)","trace[1572621142] 'compare' (duration: 204.866768ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:26:21.316377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.418187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-13T15:26:21.316385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.732417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:26:21.316417Z","caller":"traceutil/trace.go:171","msg":"trace[922516083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2826; }","duration":"451.482779ms","start":"2026-04-13T15:26:20.864925Z","end":"2026-04-13T15:26:21.316407Z","steps":["trace[922516083] 'agreement among raft nodes before linearized reading' (duration: 451.316196ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:21.316434Z","caller":"traceutil/trace.go:171","msg":"trace[121703018] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:2826; }","duration":"156.833419ms","start":"2026-04-13T15:26:21.159588Z","end":"2026-04-13T15:26:21.316421Z","steps":["trace[121703018] 'agreement among raft nodes before linearized reading' (duration: 156.736978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:21.316418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:20.831988Z","time spent":"484.3394ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:26:21.316433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.419327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-13T15:26:21.316487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.085891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-13T15:26:21.316521Z","caller":"traceutil/trace.go:171","msg":"trace[1885191886] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2826; }","duration":"451.514099ms","start":"2026-04-13T15:26:20.864991Z","end":"2026-04-13T15:26:21.316505Z","steps":["trace[1885191886] 'agreement among raft nodes before linearized reading' (duration: 451.313565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:21.316562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:20.864938Z","time spent":"451.615172ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-13T15:26:21.316566Z","caller":"traceutil/trace.go:171","msg":"trace[1361094057] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2826; }","duration":"451.182003ms","start":"2026-04-13T15:26:20.865361Z","end":"2026-04-13T15:26:21.316543Z","steps":["trace[1361094057] 'agreement among raft nodes before linearized reading' (duration: 450.994489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:21.316454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:20.86491Z","time spent":"451.53612ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T15:26:21.316595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:20.865351Z","time spent":"451.238194ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T15:26:21.947788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.907412ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:26:21.948344Z","caller":"traceutil/trace.go:171","msg":"trace[117243925] transaction","detail":"{read_only:false; response_revision:2828; number_of_response:1; }","duration":"627.324145ms","start":"2026-04-13T15:26:21.32099Z","end":"2026-04-13T15:26:21.948314Z","steps":["trace[117243925] 'process raft request' (duration: 389.80075ms)","trace[117243925] 'compare' (duration: 236.32681ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:26:21.948381Z","caller":"traceutil/trace.go:171","msg":"trace[577300751] linearizableReadLoop","detail":"{readStateIndex:2943; appliedIndex:2941; }","duration":"353.390358ms","start":"2026-04-13T15:26:21.594967Z","end":"2026-04-13T15:26:21.948357Z","steps":["trace[577300751] 'read index received' (duration: 115.828202ms)","trace[577300751] 'applied index is now lower than readState.Index' (duration: 237.557576ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:26:21.948454Z","caller":"traceutil/trace.go:171","msg":"trace[1964018593] transaction","detail":"{read_only:false; response_revision:2829; number_of_response:1; }","duration":"626.998339ms","start":"2026-04-13T15:26:21.321414Z","end":"2026-04-13T15:26:21.948412Z","steps":["trace[1964018593] 'process raft request' (duration: 626.850686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:21.948566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.599042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:26:21.948617Z","caller":"traceutil/trace.go:171","msg":"trace[890633494] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2829; }","duration":"353.690884ms","start":"2026-04-13T15:26:21.594913Z","end":"2026-04-13T15:26:21.948604Z","steps":["trace[890633494] 'agreement among raft nodes before linearized reading' (duration: 353.604912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:21.948627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:21.321378Z","time spent":"627.216603ms","remote":"127.0.0.1:51348","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-04-13T15:26:21.948657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:21.594891Z","time spent":"353.759005ms","remote":"127.0.0.1:51114","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-04-13T15:26:21.948487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:21.320966Z","time spent":"627.444947ms","remote":"127.0.0.1:51348","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-04-13T15:26:21.94936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.301139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-13T15:26:21.949479Z","caller":"traceutil/trace.go:171","msg":"trace[1791080628] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2829; }","duration":"309.456742ms","start":"2026-04-13T15:26:21.640005Z","end":"2026-04-13T15:26:21.949461Z","steps":["trace[1791080628] 'agreement among raft nodes before linearized reading' (duration: 308.733438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:21.949676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:26:21.639986Z","time spent":"309.602735ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-13T15:26:23.526236Z","caller":"traceutil/trace.go:171","msg":"trace[849140621] transaction","detail":"{read_only:false; response_revision:2860; number_of_response:1; }","duration":"102.540982ms","start":"2026-04-13T15:26:23.423666Z","end":"2026-04-13T15:26:23.526207Z","steps":["trace[849140621] 'process raft request' (duration: 77.127983ms)","trace[849140621] 'compare' (duration: 25.281796ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:26:23.676598Z","caller":"traceutil/trace.go:171","msg":"trace[548426991] linearizableReadLoop","detail":"{readStateIndex:2975; appliedIndex:2974; }","duration":"165.218969ms","start":"2026-04-13T15:26:23.511338Z","end":"2026-04-13T15:26:23.676557Z","steps":["trace[548426991] 'read index received' (duration: 163.846261ms)","trace[548426991] 'applied index is now lower than readState.Index' (duration: 1.371518ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:26:23.676704Z","caller":"traceutil/trace.go:171","msg":"trace[1197637850] transaction","detail":"{read_only:false; response_revision:2861; number_of_response:1; }","duration":"177.077222ms","start":"2026-04-13T15:26:23.499602Z","end":"2026-04-13T15:26:23.676679Z","steps":["trace[1197637850] 'process raft request' (duration: 175.600711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:26:23.676764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.399073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:26:23.676812Z","caller":"traceutil/trace.go:171","msg":"trace[12496912] range","detail":"{range_begin:/registry/leases/ingress-nginx/ingress-nginx-leader; range_end:; response_count:0; response_revision:2861; }","duration":"165.489265ms","start":"2026-04-13T15:26:23.511309Z","end":"2026-04-13T15:26:23.676798Z","steps":["trace[12496912] 'agreement among raft nodes before linearized reading' (duration: 165.394243ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:23.677334Z","caller":"traceutil/trace.go:171","msg":"trace[2020903343] transaction","detail":"{read_only:false; number_of_response:1; response_revision:2862; }","duration":"149.403957ms","start":"2026-04-13T15:26:23.5279Z","end":"2026-04-13T15:26:23.677304Z","steps":["trace[2020903343] 'process raft request' (duration: 149.201703ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:23.677362Z","caller":"traceutil/trace.go:171","msg":"trace[1170873216] transaction","detail":"{read_only:false; response_revision:2863; number_of_response:1; }","duration":"117.095668ms","start":"2026-04-13T15:26:23.560207Z","end":"2026-04-13T15:26:23.677303Z","steps":["trace[1170873216] 'process raft request' (duration: 117.024097ms)"],"step_count":1}