{"level":"warn","ts":"2026-05-12T16:28:31.911377Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-12T16:28:31.911487Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.193:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.193:2380","--initial-cluster=instance=https://199.19.213.193:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.193:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.193: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-05-12T16:28:31.912892Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-12T16:28:31.912922Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.193:2380"]} {"level":"info","ts":"2026-05-12T16:28:31.913424Z","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-05-12T16:28:31.914172Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.193:2379"]} {"level":"info","ts":"2026-05-12T16:28:31.914429Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.193:2380"],"listen-peer-urls":["https://199.19.213.193:2380"],"advertise-client-urls":["https://199.19.213.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.193: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-05-12T16:28:31.920502Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.668675ms"} {"level":"info","ts":"2026-05-12T16:28:31.928653Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fc4b8086375a405d","cluster-id":"7155ef20751e16de"} {"level":"info","ts":"2026-05-12T16:28:31.928738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d switched to configuration voters=()"} {"level":"info","ts":"2026-05-12T16:28:31.928764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became follower at term 0"} {"level":"info","ts":"2026-05-12T16:28:31.928781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fc4b8086375a405d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-12T16:28:31.928841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became follower at term 1"} {"level":"info","ts":"2026-05-12T16:28:31.928943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d switched to configuration voters=(18179765634753773661)"} {"level":"warn","ts":"2026-05-12T16:28:31.940212Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-12T16:28:31.94344Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-12T16:28:31.944847Z","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-05-12T16:28:31.948803Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fc4b8086375a405d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-12T16:28:31.950509Z","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-05-12T16:28:31.950428Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fc4b8086375a405d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-12T16:28:31.950577Z","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-05-12T16:28:31.950623Z","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-05-12T16:28:31.953238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d switched to configuration voters=(18179765634753773661)"} {"level":"info","ts":"2026-05-12T16:28:31.958466Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7155ef20751e16de","local-member-id":"fc4b8086375a405d","added-peer-id":"fc4b8086375a405d","added-peer-peer-urls":["https://199.19.213.193:2380"]} {"level":"info","ts":"2026-05-12T16:28:31.95919Z","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-05-12T16:28:31.959349Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fc4b8086375a405d","initial-advertise-peer-urls":["https://199.19.213.193:2380"],"listen-peer-urls":["https://199.19.213.193:2380"],"advertise-client-urls":["https://199.19.213.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-12T16:28:31.959388Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-12T16:28:31.959487Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.193:2380"} {"level":"info","ts":"2026-05-12T16:28:31.959569Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.193:2380"} {"level":"info","ts":"2026-05-12T16:28:32.530267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d is starting a new election at term 1"} {"level":"info","ts":"2026-05-12T16:28:32.530333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-12T16:28:32.530368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d received MsgPreVoteResp from fc4b8086375a405d at term 1"} {"level":"info","ts":"2026-05-12T16:28:32.530383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became candidate at term 2"} {"level":"info","ts":"2026-05-12T16:28:32.530388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d received MsgVoteResp from fc4b8086375a405d at term 2"} {"level":"info","ts":"2026-05-12T16:28:32.530398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became leader at term 2"} {"level":"info","ts":"2026-05-12T16:28:32.530406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fc4b8086375a405d elected leader fc4b8086375a405d at term 2"} {"level":"info","ts":"2026-05-12T16:28:32.53848Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fc4b8086375a405d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.193:2379]}","request-path":"/0/members/fc4b8086375a405d/attributes","cluster-id":"7155ef20751e16de","publish-timeout":"7s"} {"level":"info","ts":"2026-05-12T16:28:32.538606Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T16:28:32.5388Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T16:28:32.538758Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T16:28:32.540951Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7155ef20751e16de","local-member-id":"fc4b8086375a405d","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T16:28:32.541156Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T16:28:32.541216Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T16:28:32.541532Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-12T16:28:32.541624Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-12T16:28:32.542364Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.193:2379"} {"level":"info","ts":"2026-05-12T16:28:32.543099Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-12T16:28:36.845045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.562683ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T16:28:36.84539Z","caller":"traceutil/trace.go:171","msg":"trace[1678729007] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"148.053662ms","start":"2026-05-12T16:28:36.69729Z","end":"2026-05-12T16:28:36.845344Z","steps":["trace[1678729007] 'process raft request' (duration: 147.94444ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:28:36.845434Z","caller":"traceutil/trace.go:171","msg":"trace[1858556786] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"171.468151ms","start":"2026-05-12T16:28:36.673929Z","end":"2026-05-12T16:28:36.845397Z","steps":["trace[1858556786] 'process raft request' (duration: 63.970155ms)","trace[1858556786] 'compare' (duration: 106.158607ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:28:40.722626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.904443ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-12T16:28:40.722771Z","caller":"traceutil/trace.go:171","msg":"trace[2036258523] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"152.80317ms","start":"2026-05-12T16:28:40.569925Z","end":"2026-05-12T16:28:40.722728Z","steps":["trace[2036258523] 'process raft request' (duration: 40.713349ms)","trace[2036258523] 'compare' (duration: 111.757378ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:28:48.030535Z","caller":"traceutil/trace.go:171","msg":"trace[307211064] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"131.562419ms","start":"2026-05-12T16:28:47.898951Z","end":"2026-05-12T16:28:48.030513Z","steps":["trace[307211064] 'process raft request' (duration: 131.417434ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:28:49.537327Z","caller":"traceutil/trace.go:171","msg":"trace[1297355911] linearizableReadLoop","detail":"{readStateIndex:426; appliedIndex:425; }","duration":"111.776403ms","start":"2026-05-12T16:28:49.425526Z","end":"2026-05-12T16:28:49.537303Z","steps":["trace[1297355911] 'read index received' (duration: 111.559756ms)","trace[1297355911] 'applied index is now lower than readState.Index' (duration: 215.407µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:28:49.537423Z","caller":"traceutil/trace.go:171","msg":"trace[1759710603] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"113.396089ms","start":"2026-05-12T16:28:49.423982Z","end":"2026-05-12T16:28:49.537378Z","steps":["trace[1759710603] 'process raft request' (duration: 113.173462ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:28:49.537701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.95738ms","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-05-12T16:28:49.537781Z","caller":"traceutil/trace.go:171","msg":"trace[2012997346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:414; }","duration":"112.302202ms","start":"2026-05-12T16:28:49.425458Z","end":"2026-05-12T16:28:49.53776Z","steps":["trace[2012997346] 'agreement among raft nodes before linearized reading' (duration: 111.95804ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:28:49.899135Z","caller":"traceutil/trace.go:171","msg":"trace[1962320568] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:438; }","duration":"212.276727ms","start":"2026-05-12T16:28:49.686842Z","end":"2026-05-12T16:28:49.899119Z","steps":["trace[1962320568] 'read index received' (duration: 4.067531ms)","trace[1962320568] 'applied index is now lower than readState.Index' (duration: 208.208396ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:28:49.899261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.399791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-05-12T16:28:49.899237Z","caller":"traceutil/trace.go:171","msg":"trace[1614053835] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"223.504015ms","start":"2026-05-12T16:28:49.675705Z","end":"2026-05-12T16:28:49.899209Z","steps":["trace[1614053835] 'process raft request' (duration: 161.42394ms)","trace[1614053835] 'compare' (duration: 61.897189ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:28:49.899281Z","caller":"traceutil/trace.go:171","msg":"trace[486790398] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:428; }","duration":"212.438593ms","start":"2026-05-12T16:28:49.686836Z","end":"2026-05-12T16:28:49.899275Z","steps":["trace[486790398] 'agreement among raft nodes before linearized reading' (duration: 212.377031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:28:49.899444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.875572ms","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-05-12T16:28:49.899558Z","caller":"traceutil/trace.go:171","msg":"trace[1275908775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:428; }","duration":"157.074448ms","start":"2026-05-12T16:28:49.742459Z","end":"2026-05-12T16:28:49.899533Z","steps":["trace[1275908775] 'agreement among raft nodes before linearized reading' (duration: 156.81671ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:28:50.252267Z","caller":"traceutil/trace.go:171","msg":"trace[452950313] linearizableReadLoop","detail":"{readStateIndex:456; appliedIndex:455; }","duration":"172.076149ms","start":"2026-05-12T16:28:50.080168Z","end":"2026-05-12T16:28:50.252244Z","steps":["trace[452950313] 'read index received' (duration: 102.519719ms)","trace[452950313] 'applied index is now lower than readState.Index' (duration: 69.55552ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:28:50.252374Z","caller":"traceutil/trace.go:171","msg":"trace[1334183203] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"195.779031ms","start":"2026-05-12T16:28:50.056547Z","end":"2026-05-12T16:28:50.252326Z","steps":["trace[1334183203] 'process raft request' (duration: 126.107346ms)","trace[1334183203] 'compare' (duration: 69.473798ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:28:50.252485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.289966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" ","response":"range_response_count:1 size:3819"} {"level":"info","ts":"2026-05-12T16:28:50.252541Z","caller":"traceutil/trace.go:171","msg":"trace[1535490948] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7c96b6546b; range_end:; response_count:1; response_revision:444; }","duration":"172.400361ms","start":"2026-05-12T16:28:50.080125Z","end":"2026-05-12T16:28:50.252525Z","steps":["trace[1535490948] 'agreement among raft nodes before linearized reading' (duration: 172.209594ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:28:50.257807Z","caller":"traceutil/trace.go:171","msg":"trace[1249574890] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"175.848079ms","start":"2026-05-12T16:28:50.08194Z","end":"2026-05-12T16:28:50.257788Z","steps":["trace[1249574890] 'process raft request' (duration: 175.680203ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:28:51.779557Z","caller":"traceutil/trace.go:171","msg":"trace[1000602859] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"234.923334ms","start":"2026-05-12T16:28:51.544612Z","end":"2026-05-12T16:28:51.779536Z","steps":["trace[1000602859] 'process raft request' (duration: 234.602793ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:28:51.779445Z","caller":"traceutil/trace.go:171","msg":"trace[290393821] linearizableReadLoop","detail":"{readStateIndex:461; appliedIndex:460; }","duration":"218.552709ms","start":"2026-05-12T16:28:51.560869Z","end":"2026-05-12T16:28:51.779422Z","steps":["trace[290393821] 'read index received' (duration: 218.380343ms)","trace[290393821] 'applied index is now lower than readState.Index' (duration: 169.706µs)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:28:51.779799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.90312ms","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-05-12T16:28:51.779891Z","caller":"traceutil/trace.go:171","msg":"trace[1381835331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:448; }","duration":"219.026505ms","start":"2026-05-12T16:28:51.560841Z","end":"2026-05-12T16:28:51.779868Z","steps":["trace[1381835331] 'agreement among raft nodes before linearized reading' (duration: 218.846269ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:28:56.008271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.157741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-12T16:28:56.00837Z","caller":"traceutil/trace.go:171","msg":"trace[837268044] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:457; }","duration":"215.311846ms","start":"2026-05-12T16:28:55.793035Z","end":"2026-05-12T16:28:56.008347Z","steps":["trace[837268044] 'range keys from in-memory index tree' (duration: 215.052738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:28:56.00877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.955515ms","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-05-12T16:28:56.008836Z","caller":"traceutil/trace.go:171","msg":"trace[1704400981] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:457; }","duration":"181.10519ms","start":"2026-05-12T16:28:55.827716Z","end":"2026-05-12T16:28:56.008822Z","steps":["trace[1704400981] 'range keys from in-memory index tree' (duration: 180.259622ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:28:56.372169Z","caller":"traceutil/trace.go:171","msg":"trace[406912928] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"359.070449ms","start":"2026-05-12T16:28:56.013066Z","end":"2026-05-12T16:28:56.372137Z","steps":["trace[406912928] 'process raft request' (duration: 358.878922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:28:56.372384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:28:56.013042Z","time spent":"359.231524ms","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T16:28:57.902213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.442441043s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T16:28:57.902319Z","caller":"traceutil/trace.go:171","msg":"trace[561858154] linearizableReadLoop","detail":"{readStateIndex:473; appliedIndex:471; }","duration":"1.736349955s","start":"2026-05-12T16:28:56.165958Z","end":"2026-05-12T16:28:57.902308Z","steps":["trace[561858154] 'read index received' (duration: 205.919926ms)","trace[561858154] 'applied index is now lower than readState.Index' (duration: 1.530429309s)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:28:57.902187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.403015439s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T16:28:57.90238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.736438888s","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-05-12T16:28:57.9024Z","caller":"traceutil/trace.go:171","msg":"trace[1217328090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:459; }","duration":"1.736510669s","start":"2026-05-12T16:28:56.165882Z","end":"2026-05-12T16:28:57.902392Z","steps":["trace[1217328090] 'agreement among raft nodes before linearized reading' (duration: 1.736469408s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:28:57.902422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:28:56.165851Z","time spent":"1.736565851s","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-12T16:28:57.902393Z","caller":"traceutil/trace.go:171","msg":"trace[833485184] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:458; }","duration":"1.403265527s","start":"2026-05-12T16:28:56.499103Z","end":"2026-05-12T16:28:57.902368Z","steps":["trace[833485184] 'range keys from in-memory index tree' (duration: 1.402993388s)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:28:57.902445Z","caller":"traceutil/trace.go:171","msg":"trace[1770031766] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"1.889244408s","start":"2026-05-12T16:28:56.013142Z","end":"2026-05-12T16:28:57.902386Z","steps":["trace[1770031766] 'process raft request' (duration: 446.564867ms)","trace[1770031766] 'compare' (duration: 1.44233099s)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:28:57.902646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:28:56.013101Z","time spent":"1.889441214s","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T16:28:57.939059Z","caller":"traceutil/trace.go:171","msg":"trace[1212275645] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"244.102308ms","start":"2026-05-12T16:28:57.694932Z","end":"2026-05-12T16:28:57.939034Z","steps":["trace[1212275645] 'process raft request' (duration: 243.947933ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:28:57.939085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.252378668s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-12T16:28:57.939128Z","caller":"traceutil/trace.go:171","msg":"trace[323188340] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:460; }","duration":"1.2524773s","start":"2026-05-12T16:28:56.686638Z","end":"2026-05-12T16:28:57.939115Z","steps":["trace[323188340] 'agreement among raft nodes before linearized reading' (duration: 1.252346216s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:28:57.939115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"847.796315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T16:28:57.93917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:28:56.686614Z","time spent":"1.252545273s","remote":"127.0.0.1:58638","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-05-12T16:28:57.939196Z","caller":"traceutil/trace.go:171","msg":"trace[1746004519] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:460; }","duration":"847.920618ms","start":"2026-05-12T16:28:57.091255Z","end":"2026-05-12T16:28:57.939176Z","steps":["trace[1746004519] 'agreement among raft nodes before linearized reading' (duration: 847.794134ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:28:57.939269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:28:57.091233Z","time spent":"848.025892ms","remote":"127.0.0.1:56094","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-05-12T16:29:05.107592Z","caller":"traceutil/trace.go:171","msg":"trace[925982519] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"285.35537ms","start":"2026-05-12T16:29:04.822214Z","end":"2026-05-12T16:29:05.107569Z","steps":["trace[925982519] 'process raft request' (duration: 285.167955ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:06.46544Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.355683803s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-12T16:29:07.09449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000715125s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-12T16:29:07.094572Z","caller":"traceutil/trace.go:171","msg":"trace[449765023] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000853019s","start":"2026-05-12T16:29:05.093701Z","end":"2026-05-12T16:29:07.094554Z","steps":["trace[449765023] 'agreement among raft nodes before linearized reading' (duration: 2.000752476s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.094627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:05.093685Z","time spent":"2.000924292s","remote":"127.0.0.1:56098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/12 16:29:07 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-12T16:29:07.11357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.202793ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:07.113706Z","caller":"traceutil/trace.go:171","msg":"trace[378987664] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:596; }","duration":"614.353707ms","start":"2026-05-12T16:29:06.499331Z","end":"2026-05-12T16:29:07.113685Z","steps":["trace[378987664] 'range keys from in-memory index tree' (duration: 614.187483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.113905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.132454ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-12T16:29:07.114632Z","caller":"traceutil/trace.go:171","msg":"trace[1472805046] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"2.284048652s","start":"2026-05-12T16:29:04.830534Z","end":"2026-05-12T16:29:07.114583Z","steps":["trace[1472805046] 'process raft request' (duration: 1.635200597s)","trace[1472805046] 'compare' (duration: 648.051242ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:29:07.114995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:04.830518Z","time spent":"2.284406932s","remote":"127.0.0.1:56128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T16:29:07.115149Z","caller":"traceutil/trace.go:171","msg":"trace[733510466] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"2.201995386s","start":"2026-05-12T16:29:04.913121Z","end":"2026-05-12T16:29:07.115116Z","steps":["trace[733510466] 'process raft request' (duration: 2.201131621s)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:07.11503Z","caller":"traceutil/trace.go:171","msg":"trace[753875237] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:614; }","duration":"2.021271057s","start":"2026-05-12T16:29:05.093748Z","end":"2026-05-12T16:29:07.115019Z","steps":["trace[753875237] 'read index received' (duration: 13.619706ms)","trace[753875237] 'applied index is now lower than readState.Index' (duration: 2.007650751s)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:29:07.115269Z","caller":"traceutil/trace.go:171","msg":"trace[973607206] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"699.708798ms","start":"2026-05-12T16:29:06.415552Z","end":"2026-05-12T16:29:07.115261Z","steps":["trace[973607206] 'process raft request' (duration: 699.688017ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:07.115058Z","caller":"traceutil/trace.go:171","msg":"trace[924885485] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"2.101884909s","start":"2026-05-12T16:29:05.013167Z","end":"2026-05-12T16:29:07.115052Z","steps":["trace[924885485] 'process raft request' (duration: 2.101814187s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.115327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:06.41552Z","time spent":"699.77935ms","remote":"127.0.0.1:56128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T16:29:07.115357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:04.913088Z","time spent":"2.20214646s","remote":"127.0.0.1:56128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T16:29:07.115364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:05.01314Z","time spent":"2.102169148s","remote":"127.0.0.1:56128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T16:29:07.115457Z","caller":"traceutil/trace.go:171","msg":"trace[187443683] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"1.900642843s","start":"2026-05-12T16:29:05.214809Z","end":"2026-05-12T16:29:07.115451Z","steps":["trace[187443683] 'process raft request' (duration: 1.90019856s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.115494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:05.214783Z","time spent":"1.900695124s","remote":"127.0.0.1:56128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T16:29:07.115525Z","caller":"traceutil/trace.go:171","msg":"trace[1459407433] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"1.498661525s","start":"2026-05-12T16:29:05.616846Z","end":"2026-05-12T16:29:07.115508Z","steps":["trace[1459407433] 'process raft request' (duration: 1.498347235s)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:07.115555Z","caller":"traceutil/trace.go:171","msg":"trace[1593874354] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"1.296745049s","start":"2026-05-12T16:29:05.818804Z","end":"2026-05-12T16:29:07.115549Z","steps":["trace[1593874354] 'process raft request' (duration: 1.296412389s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.11558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:05.818775Z","time spent":"1.296793061s","remote":"127.0.0.1:56128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T16:29:07.115606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:05.616819Z","time spent":"1.498750568s","remote":"127.0.0.1:56128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T16:29:07.115632Z","caller":"traceutil/trace.go:171","msg":"trace[2104488417] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"1.700393747s","start":"2026-05-12T16:29:05.415234Z","end":"2026-05-12T16:29:07.115628Z","steps":["trace[2104488417] 'process raft request' (duration: 1.699932902s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.11566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:05.415209Z","time spent":"1.700438587s","remote":"127.0.0.1:56128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T16:29:07.116221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.579484153s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.193\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-12T16:29:07.11625Z","caller":"traceutil/trace.go:171","msg":"trace[1327044917] range","detail":"{range_begin:/registry/masterleases/199.19.213.193; range_end:; response_count:1; response_revision:605; }","duration":"1.579559275s","start":"2026-05-12T16:29:05.536684Z","end":"2026-05-12T16:29:07.116243Z","steps":["trace[1327044917] 'agreement among raft nodes before linearized reading' (duration: 1.579471073s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.116272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:05.536665Z","time spent":"1.579601827s","remote":"127.0.0.1:56112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.193\" "} {"level":"warn","ts":"2026-05-12T16:29:07.116404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.648888ms","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-05-12T16:29:07.116432Z","caller":"traceutil/trace.go:171","msg":"trace[1611606849] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:605; }","duration":"672.70449ms","start":"2026-05-12T16:29:06.44372Z","end":"2026-05-12T16:29:07.116424Z","steps":["trace[1611606849] 'agreement among raft nodes before linearized reading' (duration: 672.603517ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.116477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:06.443703Z","time spent":"672.765891ms","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-12T16:29:07.116945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.82546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:8285"} {"level":"info","ts":"2026-05-12T16:29:07.117Z","caller":"traceutil/trace.go:171","msg":"trace[1313508842] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:605; }","duration":"103.884382ms","start":"2026-05-12T16:29:07.013103Z","end":"2026-05-12T16:29:07.116988Z","steps":["trace[1313508842] 'agreement among raft nodes before linearized reading' (duration: 103.744398ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.117297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.864076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-05-12T16:29:07.117351Z","caller":"traceutil/trace.go:171","msg":"trace[400651848] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:605; }","duration":"303.950448ms","start":"2026-05-12T16:29:06.813384Z","end":"2026-05-12T16:29:07.117335Z","steps":["trace[400651848] 'agreement among raft nodes before linearized reading' (duration: 303.828265ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.117442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:06.813364Z","time spent":"304.065052ms","remote":"127.0.0.1:56128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5609,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"warn","ts":"2026-05-12T16:29:07.11749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.104655087s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:07.117539Z","caller":"traceutil/trace.go:171","msg":"trace[1903570868] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:605; }","duration":"1.104726259s","start":"2026-05-12T16:29:06.012799Z","end":"2026-05-12T16:29:07.117525Z","steps":["trace[1903570868] 'agreement among raft nodes before linearized reading' (duration: 1.104654566s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.117585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:06.012787Z","time spent":"1.104790721s","remote":"127.0.0.1:56128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-05-12T16:29:07.117726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.802376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-12T16:29:07.117758Z","caller":"traceutil/trace.go:171","msg":"trace[1162380005] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"706.870318ms","start":"2026-05-12T16:29:06.410879Z","end":"2026-05-12T16:29:07.11775Z","steps":["trace[1162380005] 'agreement among raft nodes before linearized reading' (duration: 706.781866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.117787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:06.410849Z","time spent":"706.93167ms","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-12T16:29:07.117889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.915824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"warn","ts":"2026-05-12T16:29:07.117921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.357131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:07.117947Z","caller":"traceutil/trace.go:171","msg":"trace[1450641414] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:605; }","duration":"904.420483ms","start":"2026-05-12T16:29:06.213519Z","end":"2026-05-12T16:29:07.117939Z","steps":["trace[1450641414] 'agreement among raft nodes before linearized reading' (duration: 904.380471ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:07.117932Z","caller":"traceutil/trace.go:171","msg":"trace[56452868] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:605; }","duration":"505.009886ms","start":"2026-05-12T16:29:06.612912Z","end":"2026-05-12T16:29:07.117922Z","steps":["trace[56452868] 'agreement among raft nodes before linearized reading' (duration: 504.841671ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.11798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:06.213498Z","time spent":"904.475784ms","remote":"127.0.0.1:56128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-05-12T16:29:07.117992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:06.61289Z","time spent":"505.091829ms","remote":"127.0.0.1:56128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4106,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"warn","ts":"2026-05-12T16:29:07.11839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.142566675s","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-05-12T16:29:07.118497Z","caller":"traceutil/trace.go:171","msg":"trace[898560850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:605; }","duration":"1.142702939s","start":"2026-05-12T16:29:05.975766Z","end":"2026-05-12T16:29:07.118469Z","steps":["trace[898560850] 'agreement among raft nodes before linearized reading' (duration: 1.142297287s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.118584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:05.975755Z","time spent":"1.142809902s","remote":"127.0.0.1:58638","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-05-12T16:29:07.118664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.138888375s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-12T16:29:07.118731Z","caller":"traceutil/trace.go:171","msg":"trace[1202991407] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:605; }","duration":"1.138977328s","start":"2026-05-12T16:29:05.979735Z","end":"2026-05-12T16:29:07.118712Z","steps":["trace[1202991407] 'agreement among raft nodes before linearized reading' (duration: 1.138825244s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.118793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:05.979724Z","time spent":"1.13905632s","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-12T16:29:07.118768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.157691726s","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-05-12T16:29:07.11885Z","caller":"traceutil/trace.go:171","msg":"trace[1445243267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:605; }","duration":"1.15784137s","start":"2026-05-12T16:29:05.960995Z","end":"2026-05-12T16:29:07.118836Z","steps":["trace[1445243267] 'agreement among raft nodes before linearized reading' (duration: 1.157604074s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:07.118967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:05.960974Z","time spent":"1.157945773s","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-12T16:29:08.374637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.383524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-05-12T16:29:08.374727Z","caller":"traceutil/trace.go:171","msg":"trace[1980916957] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:637; }","duration":"347.513318ms","start":"2026-05-12T16:29:08.027194Z","end":"2026-05-12T16:29:08.374708Z","steps":["trace[1980916957] 'range keys from in-memory index tree' (duration: 347.262941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:08.375728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:08.02718Z","time spent":"348.537067ms","remote":"127.0.0.1:56128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":13252,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"info","ts":"2026-05-12T16:29:08.375281Z","caller":"traceutil/trace.go:171","msg":"trace[1271512564] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:657; }","duration":"161.507958ms","start":"2026-05-12T16:29:08.213756Z","end":"2026-05-12T16:29:08.375264Z","steps":["trace[1271512564] 'read index received' (duration: 126.76503ms)","trace[1271512564] 'applied index is now lower than readState.Index' (duration: 34.741968ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:29:08.375426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.672912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-05-12T16:29:08.376008Z","caller":"traceutil/trace.go:171","msg":"trace[10854061] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:639; }","duration":"162.290351ms","start":"2026-05-12T16:29:08.213703Z","end":"2026-05-12T16:29:08.375994Z","steps":["trace[10854061] 'agreement among raft nodes before linearized reading' (duration: 161.60489ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:08.375538Z","caller":"traceutil/trace.go:171","msg":"trace[1770725626] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"185.620568ms","start":"2026-05-12T16:29:08.189904Z","end":"2026-05-12T16:29:08.375525Z","steps":["trace[1770725626] 'process raft request' (duration: 150.347725ms)","trace[1770725626] 'compare' (duration: 34.210333ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:29:08.375633Z","caller":"traceutil/trace.go:171","msg":"trace[696843708] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"174.226407ms","start":"2026-05-12T16:29:08.201398Z","end":"2026-05-12T16:29:08.375625Z","steps":["trace[696843708] 'process raft request' (duration: 173.814205ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:12.046317Z","caller":"traceutil/trace.go:171","msg":"trace[645691117] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"122.172878ms","start":"2026-05-12T16:29:11.92412Z","end":"2026-05-12T16:29:12.046293Z","steps":["trace[645691117] 'process raft request' (duration: 121.369265ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.592979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.289428ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-12T16:29:12.593085Z","caller":"traceutil/trace.go:171","msg":"trace[905932270] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:684; }","duration":"460.425028ms","start":"2026-05-12T16:29:12.132632Z","end":"2026-05-12T16:29:12.593057Z","steps":["trace[905932270] 'read index received' (duration: 27.038138ms)","trace[905932270] 'applied index is now lower than readState.Index' (duration: 433.38593ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:29:12.5931Z","caller":"traceutil/trace.go:171","msg":"trace[1279534484] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"494.579028ms","start":"2026-05-12T16:29:12.098504Z","end":"2026-05-12T16:29:12.593083Z","steps":["trace[1279534484] 'process raft request' (duration: 61.126696ms)","trace[1279534484] 'compare' (duration: 433.138573ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:29:12.593155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.098474Z","time spent":"494.65915ms","remote":"127.0.0.1:58732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T16:29:12.593208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.568383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.593243Z","caller":"traceutil/trace.go:171","msg":"trace[1886468472] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:664; }","duration":"460.606384ms","start":"2026-05-12T16:29:12.132627Z","end":"2026-05-12T16:29:12.593233Z","steps":["trace[1886468472] 'agreement among raft nodes before linearized reading' (duration: 460.529082ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.593262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.568522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.593281Z","caller":"traceutil/trace.go:171","msg":"trace[826348189] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:664; }","duration":"460.602893ms","start":"2026-05-12T16:29:12.132672Z","end":"2026-05-12T16:29:12.593275Z","steps":["trace[826348189] 'agreement among raft nodes before linearized reading' (duration: 460.571392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.59331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.132667Z","time spent":"460.637724ms","remote":"127.0.0.1:44004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-12T16:29:12.593328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.771025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.593358Z","caller":"traceutil/trace.go:171","msg":"trace[2001970668] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:664; }","duration":"323.810396ms","start":"2026-05-12T16:29:12.26954Z","end":"2026-05-12T16:29:12.59335Z","steps":["trace[2001970668] 'agreement among raft nodes before linearized reading' (duration: 323.770195ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.593387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.269534Z","time spent":"323.846927ms","remote":"127.0.0.1:44064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-12T16:29:12.593467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.45426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.593494Z","caller":"traceutil/trace.go:171","msg":"trace[1178805521] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:664; }","duration":"367.496681ms","start":"2026-05-12T16:29:12.225989Z","end":"2026-05-12T16:29:12.593486Z","steps":["trace[1178805521] 'agreement among raft nodes before linearized reading' (duration: 367.45828ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.593519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.22598Z","time spent":"367.532543ms","remote":"127.0.0.1:44050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-05-12T16:29:12.593618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.040596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.593642Z","caller":"traceutil/trace.go:171","msg":"trace[1562619887] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:664; }","duration":"368.106798ms","start":"2026-05-12T16:29:12.22553Z","end":"2026-05-12T16:29:12.593637Z","steps":["trace[1562619887] 'agreement among raft nodes before linearized reading' (duration: 368.071867ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.593662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.225513Z","time spent":"368.142718ms","remote":"127.0.0.1:44050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-05-12T16:29:12.593749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.18669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.59377Z","caller":"traceutil/trace.go:171","msg":"trace[1972576885] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:664; }","duration":"368.242942ms","start":"2026-05-12T16:29:12.225522Z","end":"2026-05-12T16:29:12.593765Z","steps":["trace[1972576885] 'agreement among raft nodes before linearized reading' (duration: 368.211041ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.593778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.399095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T16:29:12.593811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.549084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.593816Z","caller":"traceutil/trace.go:171","msg":"trace[781126748] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:664; }","duration":"204.440606ms","start":"2026-05-12T16:29:12.389367Z","end":"2026-05-12T16:29:12.593808Z","steps":["trace[781126748] 'agreement among raft nodes before linearized reading' (duration: 204.385994ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.593848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.031788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.593867Z","caller":"traceutil/trace.go:171","msg":"trace[147339808] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:664; }","duration":"393.077728ms","start":"2026-05-12T16:29:12.200785Z","end":"2026-05-12T16:29:12.593863Z","steps":["trace[147339808] 'agreement among raft nodes before linearized reading' (duration: 393.051007ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.593882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.200774Z","time spent":"393.10419ms","remote":"127.0.0.1:44038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-12T16:29:12.593957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.131546ms","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":"warn","ts":"2026-05-12T16:29:12.593976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.206492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.593992Z","caller":"traceutil/trace.go:171","msg":"trace[207363983] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:664; }","duration":"393.242184ms","start":"2026-05-12T16:29:12.200745Z","end":"2026-05-12T16:29:12.593987Z","steps":["trace[207363983] 'agreement among raft nodes before linearized reading' (duration: 393.215853ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:12.59399Z","caller":"traceutil/trace.go:171","msg":"trace[1185193698] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:664; }","duration":"205.175047ms","start":"2026-05-12T16:29:12.388807Z","end":"2026-05-12T16:29:12.593982Z","steps":["trace[1185193698] 'agreement among raft nodes before linearized reading' (duration: 205.128175ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.594009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.200732Z","time spent":"393.272324ms","remote":"127.0.0.1:44038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-12T16:29:12.594091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.332025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.594118Z","caller":"traceutil/trace.go:171","msg":"trace[392286072] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:664; }","duration":"419.395697ms","start":"2026-05-12T16:29:12.174717Z","end":"2026-05-12T16:29:12.594113Z","steps":["trace[392286072] 'agreement among raft nodes before linearized reading' (duration: 419.357216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.594147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.174694Z","time spent":"419.447948ms","remote":"127.0.0.1:44032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-12T16:29:12.59415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.632202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.594176Z","caller":"traceutil/trace.go:171","msg":"trace[914126045] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:664; }","duration":"224.691384ms","start":"2026-05-12T16:29:12.369476Z","end":"2026-05-12T16:29:12.594168Z","steps":["trace[914126045] 'agreement among raft nodes before linearized reading' (duration: 224.658523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.594271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.583232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.594294Z","caller":"traceutil/trace.go:171","msg":"trace[1238400657] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:664; }","duration":"419.627883ms","start":"2026-05-12T16:29:12.17466Z","end":"2026-05-12T16:29:12.594288Z","steps":["trace[1238400657] 'agreement among raft nodes before linearized reading' (duration: 419.591362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.594311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.174649Z","time spent":"419.656964ms","remote":"127.0.0.1:44032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-12T16:29:12.594346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.080855ms","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-05-12T16:29:12.594379Z","caller":"traceutil/trace.go:171","msg":"trace[312388228] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:664; }","duration":"225.116916ms","start":"2026-05-12T16:29:12.369255Z","end":"2026-05-12T16:29:12.594372Z","steps":["trace[312388228] 'agreement among raft nodes before linearized reading' (duration: 225.067125ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.594394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.850292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.594409Z","caller":"traceutil/trace.go:171","msg":"trace[1870025852] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:664; }","duration":"449.893032ms","start":"2026-05-12T16:29:12.144512Z","end":"2026-05-12T16:29:12.594405Z","steps":["trace[1870025852] 'agreement among raft nodes before linearized reading' (duration: 449.867312ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.594433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.144496Z","time spent":"449.930884ms","remote":"127.0.0.1:44018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-12T16:29:12.594491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.353462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T16:29:12.59452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.995875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.594522Z","caller":"traceutil/trace.go:171","msg":"trace[271927844] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:664; }","duration":"225.403524ms","start":"2026-05-12T16:29:12.369111Z","end":"2026-05-12T16:29:12.594515Z","steps":["trace[271927844] 'agreement among raft nodes before linearized reading' (duration: 225.361063ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:12.594536Z","caller":"traceutil/trace.go:171","msg":"trace[765663196] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:664; }","duration":"450.043937ms","start":"2026-05-12T16:29:12.144487Z","end":"2026-05-12T16:29:12.594531Z","steps":["trace[765663196] 'agreement among raft nodes before linearized reading' (duration: 450.016206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.594552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.14446Z","time spent":"450.088468ms","remote":"127.0.0.1:44018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-12T16:29:12.594624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.186321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T16:29:12.59463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.096126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.594643Z","caller":"traceutil/trace.go:171","msg":"trace[1064272338] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:664; }","duration":"450.219482ms","start":"2026-05-12T16:29:12.144419Z","end":"2026-05-12T16:29:12.594638Z","steps":["trace[1064272338] 'agreement among raft nodes before linearized reading' (duration: 450.191301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.594658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.144407Z","time spent":"450.246722ms","remote":"127.0.0.1:44018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"info","ts":"2026-05-12T16:29:12.594654Z","caller":"traceutil/trace.go:171","msg":"trace[469684279] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:664; }","duration":"291.144878ms","start":"2026-05-12T16:29:12.303502Z","end":"2026-05-12T16:29:12.594647Z","steps":["trace[469684279] 'agreement among raft nodes before linearized reading' (duration: 291.108567ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.594734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.016542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.594756Z","caller":"traceutil/trace.go:171","msg":"trace[577693276] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:664; }","duration":"462.052534ms","start":"2026-05-12T16:29:12.132698Z","end":"2026-05-12T16:29:12.594751Z","steps":["trace[577693276] 'agreement among raft nodes before linearized reading' (duration: 462.020393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.594755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.931371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T16:29:12.594773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.132693Z","time spent":"462.074155ms","remote":"127.0.0.1:44004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-12T16:29:12.594779Z","caller":"traceutil/trace.go:171","msg":"trace[281970531] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:664; }","duration":"291.991113ms","start":"2026-05-12T16:29:12.302781Z","end":"2026-05-12T16:29:12.594772Z","steps":["trace[281970531] 'agreement among raft nodes before linearized reading' (duration: 291.955791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.593279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.132563Z","time spent":"460.708146ms","remote":"127.0.0.1:44004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-12T16:29:12.594916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.188519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T16:29:12.594117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.357672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.594961Z","caller":"traceutil/trace.go:171","msg":"trace[1763555277] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:664; }","duration":"292.22931ms","start":"2026-05-12T16:29:12.302719Z","end":"2026-05-12T16:29:12.594948Z","steps":["trace[1763555277] 'agreement among raft nodes before linearized reading' (duration: 292.177129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.595093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.310369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.595126Z","caller":"traceutil/trace.go:171","msg":"trace[141434185] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:664; }","duration":"325.35197ms","start":"2026-05-12T16:29:12.269766Z","end":"2026-05-12T16:29:12.595118Z","steps":["trace[141434185] 'agreement among raft nodes before linearized reading' (duration: 325.304739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.595152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.269762Z","time spent":"325.382461ms","remote":"127.0.0.1:44064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-12T16:29:12.593787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.225501Z","time spent":"368.280953ms","remote":"127.0.0.1:44050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"info","ts":"2026-05-12T16:29:12.593827Z","caller":"traceutil/trace.go:171","msg":"trace[1945668768] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:664; }","duration":"392.578215ms","start":"2026-05-12T16:29:12.201244Z","end":"2026-05-12T16:29:12.593823Z","steps":["trace[1945668768] 'agreement among raft nodes before linearized reading' (duration: 392.553494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.595432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:12.201238Z","time spent":"394.1813ms","remote":"127.0.0.1:44038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"info","ts":"2026-05-12T16:29:12.594969Z","caller":"traceutil/trace.go:171","msg":"trace[991862746] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:664; }","duration":"206.227547ms","start":"2026-05-12T16:29:12.388735Z","end":"2026-05-12T16:29:12.594962Z","steps":["trace[991862746] 'agreement among raft nodes before linearized reading' (duration: 205.341471ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.852715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.151234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.852779Z","caller":"traceutil/trace.go:171","msg":"trace[838861610] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:664; }","duration":"134.255867ms","start":"2026-05-12T16:29:12.718512Z","end":"2026-05-12T16:29:12.852768Z","steps":["trace[838861610] 'range keys from in-memory index tree' (duration: 134.040911ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.852945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.317989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.85297Z","caller":"traceutil/trace.go:171","msg":"trace[1302854298] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:664; }","duration":"134.35308ms","start":"2026-05-12T16:29:12.71861Z","end":"2026-05-12T16:29:12.852964Z","steps":["trace[1302854298] 'count revisions from in-memory index tree' (duration: 134.268498ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:12.853071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.461002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:12.853098Z","caller":"traceutil/trace.go:171","msg":"trace[614834865] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:664; }","duration":"134.498024ms","start":"2026-05-12T16:29:12.718594Z","end":"2026-05-12T16:29:12.853092Z","steps":["trace[614834865] 'range keys from in-memory index tree' (duration: 134.38672ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:13.107347Z","caller":"traceutil/trace.go:171","msg":"trace[966342460] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"123.761179ms","start":"2026-05-12T16:29:12.983562Z","end":"2026-05-12T16:29:13.107323Z","steps":["trace[966342460] 'process raft request' (duration: 122.379151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:14.127605Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4638037038732623540,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T16:29:14.628525Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4638037038732623540,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T16:29:15.128734Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4638037038732623540,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T16:29:15.629019Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4638037038732623540,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T16:29:16.092835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000764718s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-12T16:29:16.092928Z","caller":"traceutil/trace.go:171","msg":"trace[595233099] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000904382s","start":"2026-05-12T16:29:14.092004Z","end":"2026-05-12T16:29:16.092909Z","steps":["trace[595233099] 'agreement among raft nodes before linearized reading' (duration: 2.000791479s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:16.092974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:14.091985Z","time spent":"2.000978164s","remote":"127.0.0.1:56094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/12 16:29:16 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-12T16:29:16.129448Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4638037038732623540,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T16:29:16.629994Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4638037038732623540,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T16:29:17.130709Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4638037038732623540,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T16:29:17.341091Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.654593399s","expected-duration":"1s"} {"level":"info","ts":"2026-05-12T16:29:17.349566Z","caller":"traceutil/trace.go:171","msg":"trace[1736751613] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"3.773577861s","start":"2026-05-12T16:29:13.575956Z","end":"2026-05-12T16:29:17.349534Z","steps":["trace[1736751613] 'process raft request' (duration: 3.766208983s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:17.349778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:13.575931Z","time spent":"3.773700615s","remote":"127.0.0.1:56182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T16:29:17.590429Z","caller":"traceutil/trace.go:171","msg":"trace[1262517096] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"2.97407274s","start":"2026-05-12T16:29:14.616319Z","end":"2026-05-12T16:29:17.590392Z","steps":["trace[1262517096] 'process raft request' (duration: 2.913993292s)","trace[1262517096] 'compare' (duration: 59.862523ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:29:17.590699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:14.616299Z","time spent":"2.974270235s","remote":"127.0.0.1:58638","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-05-12T16:29:17.590993Z","caller":"traceutil/trace.go:171","msg":"trace[645506068] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:695; }","duration":"3.963989534s","start":"2026-05-12T16:29:13.626944Z","end":"2026-05-12T16:29:17.590934Z","steps":["trace[645506068] 'read index received' (duration: 3.714505596s)","trace[645506068] 'applied index is now lower than readState.Index' (duration: 249.480858ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:29:17.591237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.964279531s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hk69r\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-12T16:29:17.591274Z","caller":"traceutil/trace.go:171","msg":"trace[432412176] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hk69r; range_end:; response_count:1; response_revision:676; }","duration":"3.964371354s","start":"2026-05-12T16:29:13.62689Z","end":"2026-05-12T16:29:17.591261Z","steps":["trace[432412176] 'agreement among raft nodes before linearized reading' (duration: 3.964184479s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:17.591308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:13.626868Z","time spent":"3.964431666s","remote":"127.0.0.1:56262","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-hk69r\" "} {"level":"info","ts":"2026-05-12T16:29:17.630183Z","caller":"traceutil/trace.go:171","msg":"trace[933387368] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"207.851417ms","start":"2026-05-12T16:29:17.422313Z","end":"2026-05-12T16:29:17.630165Z","steps":["trace[933387368] 'process raft request' (duration: 207.752135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:17.630536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.447988615s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-12T16:29:17.630557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.441764705s","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-05-12T16:29:17.63062Z","caller":"traceutil/trace.go:171","msg":"trace[1780992215] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:677; }","duration":"2.448195561s","start":"2026-05-12T16:29:15.182407Z","end":"2026-05-12T16:29:17.630603Z","steps":["trace[1780992215] 'agreement among raft nodes before linearized reading' (duration: 2.447861342s)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:17.630636Z","caller":"traceutil/trace.go:171","msg":"trace[901846127] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:677; }","duration":"2.441881048s","start":"2026-05-12T16:29:15.188734Z","end":"2026-05-12T16:29:17.630615Z","steps":["trace[901846127] 'agreement among raft nodes before linearized reading' (duration: 2.441678663s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:17.630649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.441378724s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-12T16:29:17.630633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.537318169s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T16:29:17.630681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.44192499s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-12T16:29:17.630693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:15.188719Z","time spent":"2.44196113s","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-12T16:29:17.630732Z","caller":"traceutil/trace.go:171","msg":"trace[1111694204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:677; }","duration":"2.442051663s","start":"2026-05-12T16:29:15.188668Z","end":"2026-05-12T16:29:17.630719Z","steps":["trace[1111694204] 'agreement among raft nodes before linearized reading' (duration: 2.44195597s)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:17.630738Z","caller":"traceutil/trace.go:171","msg":"trace[2053539593] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:677; }","duration":"1.537490444s","start":"2026-05-12T16:29:16.093226Z","end":"2026-05-12T16:29:17.630716Z","steps":["trace[2053539593] 'agreement among raft nodes before linearized reading' (duration: 1.537230457s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:17.630668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:15.182386Z","time spent":"2.448271493s","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-12T16:29:17.630762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.092783383s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.193\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-05-12T16:29:17.630627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.434060434s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-05-12T16:29:17.630769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:15.188638Z","time spent":"2.442123504s","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-12T16:29:17.630807Z","caller":"traceutil/trace.go:171","msg":"trace[2091068137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:677; }","duration":"2.434293s","start":"2026-05-12T16:29:15.196504Z","end":"2026-05-12T16:29:17.630797Z","steps":["trace[2091068137] 'agreement among raft nodes before linearized reading' (duration: 2.433843788s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:17.630844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:15.196482Z","time spent":"2.434353152s","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-12T16:29:17.630839Z","caller":"traceutil/trace.go:171","msg":"trace[1415667655] range","detail":"{range_begin:/registry/masterleases/199.19.213.193; range_end:; response_count:1; response_revision:677; }","duration":"2.092860565s","start":"2026-05-12T16:29:15.537932Z","end":"2026-05-12T16:29:17.630792Z","steps":["trace[1415667655] 'agreement among raft nodes before linearized reading' (duration: 2.092764792s)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:17.630738Z","caller":"traceutil/trace.go:171","msg":"trace[1074714927] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:677; }","duration":"2.441477656s","start":"2026-05-12T16:29:15.189234Z","end":"2026-05-12T16:29:17.630711Z","steps":["trace[1074714927] 'agreement among raft nodes before linearized reading' (duration: 2.441312111s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:17.630917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:15.537909Z","time spent":"2.092966948s","remote":"127.0.0.1:56112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.193\" "} {"level":"warn","ts":"2026-05-12T16:29:17.6308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:16.093208Z","time spent":"1.537578256s","remote":"127.0.0.1:56098","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-05-12T16:29:17.63096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:15.189226Z","time spent":"2.441702553s","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-12T16:29:34.2991Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4638037038732623772,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T16:29:34.863217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.519215ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T16:29:34.86334Z","caller":"traceutil/trace.go:171","msg":"trace[1596596622] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"1.10067109s","start":"2026-05-12T16:29:33.762644Z","end":"2026-05-12T16:29:34.863315Z","steps":["trace[1596596622] 'process raft request' (duration: 974.981971ms)","trace[1596596622] 'compare' (duration: 125.414642ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:29:34.863454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:33.762625Z","time spent":"1.100778283s","remote":"127.0.0.1:58638","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-05-12T16:29:34.868569Z","caller":"traceutil/trace.go:171","msg":"trace[93793991] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"1.098521559s","start":"2026-05-12T16:29:33.77004Z","end":"2026-05-12T16:29:34.868561Z","steps":["trace[93793991] 'process raft request' (duration: 1.098435856s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:34.868664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:33.769997Z","time spent":"1.098631522s","remote":"127.0.0.1:56262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T16:29:34.868821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.069912435s","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-05-12T16:29:34.86896Z","caller":"traceutil/trace.go:171","msg":"trace[1395060861] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:801; }","duration":"1.070026408s","start":"2026-05-12T16:29:33.79882Z","end":"2026-05-12T16:29:34.868847Z","steps":["trace[1395060861] 'agreement among raft nodes before linearized reading' (duration: 1.069826453s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:34.868994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:33.798802Z","time spent":"1.070183212s","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-12T16:29:34.868991Z","caller":"traceutil/trace.go:171","msg":"trace[1556011586] linearizableReadLoop","detail":"{readStateIndex:827; appliedIndex:825; }","duration":"1.069676349s","start":"2026-05-12T16:29:33.798858Z","end":"2026-05-12T16:29:34.868534Z","steps":["trace[1556011586] 'read index received' (duration: 938.778748ms)","trace[1556011586] 'applied index is now lower than readState.Index' (duration: 130.896981ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:29:34.86909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.914739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:29:34.869133Z","caller":"traceutil/trace.go:171","msg":"trace[1237091685] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:801; }","duration":"776.985271ms","start":"2026-05-12T16:29:34.092129Z","end":"2026-05-12T16:29:34.869114Z","steps":["trace[1237091685] 'agreement among raft nodes before linearized reading' (duration: 776.93443ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:34.869159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:34.092098Z","time spent":"777.055553ms","remote":"127.0.0.1:56098","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-05-12T16:29:34.869158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.066701749s","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-05-12T16:29:34.8692Z","caller":"traceutil/trace.go:171","msg":"trace[1910979160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:801; }","duration":"1.066766991s","start":"2026-05-12T16:29:33.802422Z","end":"2026-05-12T16:29:34.869189Z","steps":["trace[1910979160] 'agreement among raft nodes before linearized reading' (duration: 1.066628628s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:34.869233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:33.802409Z","time spent":"1.066816552s","remote":"127.0.0.1:58638","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-05-12T16:29:34.869427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.059969598s","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-05-12T16:29:34.869501Z","caller":"traceutil/trace.go:171","msg":"trace[1219917159] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:801; }","duration":"1.06005084s","start":"2026-05-12T16:29:33.80944Z","end":"2026-05-12T16:29:34.86949Z","steps":["trace[1219917159] 'agreement among raft nodes before linearized reading' (duration: 1.059861305s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:34.869746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:29:33.8094Z","time spent":"1.060217684s","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-12T16:29:43.925737Z","caller":"traceutil/trace.go:171","msg":"trace[124007602] linearizableReadLoop","detail":"{readStateIndex:926; appliedIndex:925; }","duration":"124.16882ms","start":"2026-05-12T16:29:43.801547Z","end":"2026-05-12T16:29:43.925716Z","steps":["trace[124007602] 'read index received' (duration: 124.011307ms)","trace[124007602] 'applied index is now lower than readState.Index' (duration: 156.553µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:29:43.925824Z","caller":"traceutil/trace.go:171","msg":"trace[234751059] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"127.925773ms","start":"2026-05-12T16:29:43.797867Z","end":"2026-05-12T16:29:43.925793Z","steps":["trace[234751059] 'process raft request' (duration: 127.692258ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:29:43.925966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.403225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-12T16:29:43.926016Z","caller":"traceutil/trace.go:171","msg":"trace[1662061300] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:897; }","duration":"124.496078ms","start":"2026-05-12T16:29:43.801507Z","end":"2026-05-12T16:29:43.926004Z","steps":["trace[1662061300] 'agreement among raft nodes before linearized reading' (duration: 124.312794ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:44.11756Z","caller":"traceutil/trace.go:171","msg":"trace[1989820359] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"187.160197ms","start":"2026-05-12T16:29:43.930378Z","end":"2026-05-12T16:29:44.117538Z","steps":["trace[1989820359] 'process raft request' (duration: 125.92764ms)","trace[1989820359] 'compare' (duration: 61.059003ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:29:44.128874Z","caller":"traceutil/trace.go:171","msg":"trace[1187378555] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"197.910476ms","start":"2026-05-12T16:29:43.930939Z","end":"2026-05-12T16:29:44.12885Z","steps":["trace[1187378555] 'process raft request' (duration: 197.716062ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:44.129226Z","caller":"traceutil/trace.go:171","msg":"trace[830485276] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"194.318075ms","start":"2026-05-12T16:29:43.934893Z","end":"2026-05-12T16:29:44.129211Z","steps":["trace[830485276] 'process raft request' (duration: 194.200282ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:44.12928Z","caller":"traceutil/trace.go:171","msg":"trace[1346519275] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"197.395004ms","start":"2026-05-12T16:29:43.931866Z","end":"2026-05-12T16:29:44.129261Z","steps":["trace[1346519275] 'process raft request' (duration: 196.929434ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:44.301858Z","caller":"traceutil/trace.go:171","msg":"trace[1416311384] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"164.833403ms","start":"2026-05-12T16:29:44.136983Z","end":"2026-05-12T16:29:44.301816Z","steps":["trace[1416311384] 'process raft request' (duration: 123.800793ms)","trace[1416311384] 'compare' (duration: 40.57528ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:29:44.306225Z","caller":"traceutil/trace.go:171","msg":"trace[1353643363] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"169.166248ms","start":"2026-05-12T16:29:44.137035Z","end":"2026-05-12T16:29:44.306201Z","steps":["trace[1353643363] 'process raft request' (duration: 168.964054ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:44.30642Z","caller":"traceutil/trace.go:171","msg":"trace[158172329] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"169.343024ms","start":"2026-05-12T16:29:44.137056Z","end":"2026-05-12T16:29:44.306399Z","steps":["trace[158172329] 'process raft request' (duration: 169.084497ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:44.474997Z","caller":"traceutil/trace.go:171","msg":"trace[897784213] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"161.704704ms","start":"2026-05-12T16:29:44.313266Z","end":"2026-05-12T16:29:44.47497Z","steps":["trace[897784213] 'process raft request' (duration: 93.361129ms)","trace[897784213] 'compare' (duration: 68.223332ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:29:44.699098Z","caller":"traceutil/trace.go:171","msg":"trace[1692792713] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"218.267957ms","start":"2026-05-12T16:29:44.48081Z","end":"2026-05-12T16:29:44.699078Z","steps":["trace[1692792713] 'process raft request' (duration: 218.207515ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:44.699515Z","caller":"traceutil/trace.go:171","msg":"trace[1504215923] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"218.840009ms","start":"2026-05-12T16:29:44.48066Z","end":"2026-05-12T16:29:44.6995Z","steps":["trace[1504215923] 'process raft request' (duration: 217.693623ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:29:44.915734Z","caller":"traceutil/trace.go:171","msg":"trace[1711599943] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"113.344021ms","start":"2026-05-12T16:29:44.802362Z","end":"2026-05-12T16:29:44.915706Z","steps":["trace[1711599943] 'process raft request' (duration: 113.210118ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:30:28.227409Z","caller":"traceutil/trace.go:171","msg":"trace[1228067023] linearizableReadLoop","detail":"{readStateIndex:1153; appliedIndex:1152; }","duration":"298.186572ms","start":"2026-05-12T16:30:27.929205Z","end":"2026-05-12T16:30:28.227392Z","steps":["trace[1228067023] 'read index received' (duration: 298.08101ms)","trace[1228067023] 'applied index is now lower than readState.Index' (duration: 102.942µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:30:28.227477Z","caller":"traceutil/trace.go:171","msg":"trace[1067467949] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"364.363334ms","start":"2026-05-12T16:30:27.863075Z","end":"2026-05-12T16:30:28.227438Z","steps":["trace[1067467949] 'process raft request' (duration: 364.205162ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:30:28.227546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.330194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-12T16:30:28.227576Z","caller":"traceutil/trace.go:171","msg":"trace[862421749] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1113; }","duration":"298.403566ms","start":"2026-05-12T16:30:27.929164Z","end":"2026-05-12T16:30:28.227567Z","steps":["trace[862421749] 'agreement among raft nodes before linearized reading' (duration: 298.330084ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:30:28.227638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.261364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T16:30:28.227658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:30:27.862892Z","time spent":"364.67594ms","remote":"127.0.0.1:58638","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-05-12T16:30:28.22769Z","caller":"traceutil/trace.go:171","msg":"trace[1342508521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1113; }","duration":"137.357736ms","start":"2026-05-12T16:30:28.090318Z","end":"2026-05-12T16:30:28.227676Z","steps":["trace[1342508521] 'agreement among raft nodes before linearized reading' (duration: 137.287584ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:30:30.312855Z","caller":"traceutil/trace.go:171","msg":"trace[2128224072] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"116.926088ms","start":"2026-05-12T16:30:30.195782Z","end":"2026-05-12T16:30:30.312709Z","steps":["trace[2128224072] 'process raft request' (duration: 116.802725ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:30:31.12326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.604255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-12T16:30:31.123352Z","caller":"traceutil/trace.go:171","msg":"trace[1273484786] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1121; }","duration":"721.743427ms","start":"2026-05-12T16:30:30.401583Z","end":"2026-05-12T16:30:31.123327Z","steps":["trace[1273484786] 'range keys from in-memory index tree' (duration: 721.429612ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:30:31.123963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:30:30.401564Z","time spent":"722.258356ms","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-12T16:30:35.505046Z","caller":"traceutil/trace.go:171","msg":"trace[964796966] linearizableReadLoop","detail":"{readStateIndex:1177; appliedIndex:1175; }","duration":"179.755419ms","start":"2026-05-12T16:30:35.325266Z","end":"2026-05-12T16:30:35.505021Z","steps":["trace[964796966] 'read index received' (duration: 45.200186ms)","trace[964796966] 'applied index is now lower than readState.Index' (duration: 134.554213ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:30:35.50536Z","caller":"traceutil/trace.go:171","msg":"trace[1899965933] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"181.459749ms","start":"2026-05-12T16:30:35.323886Z","end":"2026-05-12T16:30:35.505346Z","steps":["trace[1899965933] 'process raft request' (duration: 128.483789ms)","trace[1899965933] 'compare' (duration: 52.549303ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:30:35.505641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.36428ms","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-05-12T16:30:35.505682Z","caller":"traceutil/trace.go:171","msg":"trace[1977524005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1136; }","duration":"180.475491ms","start":"2026-05-12T16:30:35.325198Z","end":"2026-05-12T16:30:35.505673Z","steps":["trace[1977524005] 'agreement among raft nodes before linearized reading' (duration: 180.335359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:30:35.505865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.646943ms","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-05-12T16:30:35.505902Z","caller":"traceutil/trace.go:171","msg":"trace[713306090] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1136; }","duration":"177.700084ms","start":"2026-05-12T16:30:35.328192Z","end":"2026-05-12T16:30:35.505892Z","steps":["trace[713306090] 'agreement among raft nodes before linearized reading' (duration: 177.612722ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:30:53.612186Z","caller":"traceutil/trace.go:171","msg":"trace[1013274195] linearizableReadLoop","detail":"{readStateIndex:1239; appliedIndex:1238; }","duration":"127.288641ms","start":"2026-05-12T16:30:53.484884Z","end":"2026-05-12T16:30:53.612173Z","steps":["trace[1013274195] 'read index received' (duration: 127.19758ms)","trace[1013274195] 'applied index is now lower than readState.Index' (duration: 90.341µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:30:53.612243Z","caller":"traceutil/trace.go:171","msg":"trace[492063775] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"133.072455ms","start":"2026-05-12T16:30:53.479137Z","end":"2026-05-12T16:30:53.61221Z","steps":["trace[492063775] 'process raft request' (duration: 132.945723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:30:53.612357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.429124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-12T16:30:53.612386Z","caller":"traceutil/trace.go:171","msg":"trace[657390154] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1194; }","duration":"127.528886ms","start":"2026-05-12T16:30:53.484849Z","end":"2026-05-12T16:30:53.612378Z","steps":["trace[657390154] 'agreement among raft nodes before linearized reading' (duration: 127.408994ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:30:53.734605Z","caller":"traceutil/trace.go:171","msg":"trace[1722773389] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"117.253729ms","start":"2026-05-12T16:30:53.617328Z","end":"2026-05-12T16:30:53.734582Z","steps":["trace[1722773389] 'process raft request' (duration: 117.167338ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:30:53.734771Z","caller":"traceutil/trace.go:171","msg":"trace[522830305] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"117.420121ms","start":"2026-05-12T16:30:53.6173Z","end":"2026-05-12T16:30:53.73472Z","steps":["trace[522830305] 'process raft request' (duration: 88.883069ms)","trace[522830305] 'compare' (duration: 28.195707ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:30:53.7348Z","caller":"traceutil/trace.go:171","msg":"trace[2106675472] linearizableReadLoop","detail":"{readStateIndex:1243; appliedIndex:1239; }","duration":"108.354104ms","start":"2026-05-12T16:30:53.626428Z","end":"2026-05-12T16:30:53.734782Z","steps":["trace[2106675472] 'read index received' (duration: 25.005735ms)","trace[2106675472] 'applied index is now lower than readState.Index' (duration: 83.346989ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:30:53.734833Z","caller":"traceutil/trace.go:171","msg":"trace[2013004146] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"114.747278ms","start":"2026-05-12T16:30:53.620077Z","end":"2026-05-12T16:30:53.734824Z","steps":["trace[2013004146] 'process raft request' (duration: 114.456523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:30:53.734992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.550777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T16:30:53.735179Z","caller":"traceutil/trace.go:171","msg":"trace[901771278] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1198; }","duration":"108.75829ms","start":"2026-05-12T16:30:53.6264Z","end":"2026-05-12T16:30:53.735158Z","steps":["trace[901771278] 'agreement among raft nodes before linearized reading' (duration: 108.549107ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:31:13.198735Z","caller":"traceutil/trace.go:171","msg":"trace[1660781101] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"101.079424ms","start":"2026-05-12T16:31:13.09763Z","end":"2026-05-12T16:31:13.198709Z","steps":["trace[1660781101] 'process raft request' (duration: 95.889915ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:31:15.879865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.229603ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-05-12T16:31:15.879965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:31:15.545913Z","time spent":"334.047942ms","remote":"127.0.0.1:56112","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-12T16:31:15.936874Z","caller":"traceutil/trace.go:171","msg":"trace[1069893723] linearizableReadLoop","detail":"{readStateIndex:1332; appliedIndex:1331; }","duration":"150.152978ms","start":"2026-05-12T16:31:15.786699Z","end":"2026-05-12T16:31:15.936852Z","steps":["trace[1069893723] 'read index received' (duration: 150.066987ms)","trace[1069893723] 'applied index is now lower than readState.Index' (duration: 84.901µs)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:31:15.937249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.543434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-12T16:31:15.937311Z","caller":"traceutil/trace.go:171","msg":"trace[1271434486] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1281; }","duration":"150.651546ms","start":"2026-05-12T16:31:15.786647Z","end":"2026-05-12T16:31:15.937299Z","steps":["trace[1271434486] 'agreement among raft nodes before linearized reading' (duration: 150.322121ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:31:15.936911Z","caller":"traceutil/trace.go:171","msg":"trace[2016016540] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"384.398993ms","start":"2026-05-12T16:31:15.552488Z","end":"2026-05-12T16:31:15.936887Z","steps":["trace[2016016540] 'process raft request' (duration: 384.22993ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:31:15.937625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:31:15.552466Z","time spent":"385.088743ms","remote":"127.0.0.1:56162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":853,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T16:31:16.106964Z","caller":"traceutil/trace.go:171","msg":"trace[1393688427] linearizableReadLoop","detail":"{readStateIndex:1333; appliedIndex:1332; }","duration":"169.996389ms","start":"2026-05-12T16:31:15.936942Z","end":"2026-05-12T16:31:16.106939Z","steps":["trace[1393688427] 'read index received' (duration: 142.176114ms)","trace[1393688427] 'applied index is now lower than readState.Index' (duration: 27.819165ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T16:31:16.107117Z","caller":"traceutil/trace.go:171","msg":"trace[1703390186] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"226.198558ms","start":"2026-05-12T16:31:15.880887Z","end":"2026-05-12T16:31:16.107085Z","steps":["trace[1703390186] 'process raft request' (duration: 198.1559ms)","trace[1703390186] 'compare' (duration: 27.783923ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T16:31:16.107144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.909078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-12T16:31:16.107152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.903803ms","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":"warn","ts":"2026-05-12T16:31:16.107164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.10592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-12T16:31:16.107193Z","caller":"traceutil/trace.go:171","msg":"trace[1487041268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1282; }","duration":"203.998939ms","start":"2026-05-12T16:31:15.90318Z","end":"2026-05-12T16:31:16.107179Z","steps":["trace[1487041268] 'agreement among raft nodes before linearized reading' (duration: 203.789675ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:31:16.107198Z","caller":"traceutil/trace.go:171","msg":"trace[151177480] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1282; }","duration":"223.982625ms","start":"2026-05-12T16:31:15.883202Z","end":"2026-05-12T16:31:16.107185Z","steps":["trace[151177480] 'agreement among raft nodes before linearized reading' (duration: 223.855403ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:31:16.107202Z","caller":"traceutil/trace.go:171","msg":"trace[1124241071] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1282; }","duration":"319.210602ms","start":"2026-05-12T16:31:15.787981Z","end":"2026-05-12T16:31:16.107192Z","steps":["trace[1124241071] 'agreement among raft nodes before linearized reading' (duration: 319.056429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T16:31:16.10721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.324643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-12T16:31:16.10726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T16:31:15.787956Z","time spent":"319.292634ms","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-12T16:31:16.10728Z","caller":"traceutil/trace.go:171","msg":"trace[183351865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1282; }","duration":"217.441435ms","start":"2026-05-12T16:31:15.889821Z","end":"2026-05-12T16:31:16.107263Z","steps":["trace[183351865] 'agreement among raft nodes before linearized reading' (duration: 217.222491ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T16:31:16.108644Z","caller":"traceutil/trace.go:171","msg":"trace[572838894] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"167.185815ms","start":"2026-05-12T16:31:15.941442Z","end":"2026-05-12T16:31:16.108628Z","steps":["trace[572838894] 'process raft request' (duration: 167.094074ms)"],"step_count":1}