{"level":"warn","ts":"2026-06-26T10:16:09.667449Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T10:16:09.667572Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19: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-06-26T10:16:09.667649Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T10:16:09.667662Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-06-26T10:16:09.667691Z","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-06-26T10:16:09.668875Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-06-26T10:16:09.669Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19: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-06-26T10:16:09.673643Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.367052ms"} {"level":"info","ts":"2026-06-26T10:16:09.679253Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-06-26T10:16:09.679335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-26T10:16:09.679355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-06-26T10:16:09.679367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-26T10:16:09.679375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-06-26T10:16:09.67941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-06-26T10:16:09.688218Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-26T10:16:09.690714Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-26T10:16:09.692681Z","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-06-26T10:16:09.696911Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-26T10:16:09.700849Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-26T10:16:09.701112Z","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-06-26T10:16:09.701165Z","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-06-26T10:16:09.701237Z","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-06-26T10:16:09.703279Z","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-06-26T10:16:09.703646Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-26T10:16:09.70368Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-06-26T10:16:09.703753Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-06-26T10:16:09.703708Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-26T10:16:09.703807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-06-26T10:16:09.704137Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-06-26T10:16:09.883977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-26T10:16:09.88403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-26T10:16:09.884061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-06-26T10:16:09.884079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-06-26T10:16:09.884086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-06-26T10:16:09.884098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-06-26T10:16:09.884107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-06-26T10:16:09.892165Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T10:16:09.896459Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T10:16:09.896466Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-06-26T10:16:09.897442Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T10:16:09.897571Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T10:16:09.897815Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T10:16:09.897879Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T10:16:09.900579Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-06-26T10:16:09.900684Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-26T10:16:09.900741Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-26T10:16:09.900715Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-26T10:16:11.596489Z","caller":"traceutil/trace.go:171","msg":"trace[384924179] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"100.587071ms","start":"2026-06-26T10:16:11.495881Z","end":"2026-06-26T10:16:11.596468Z","steps":["trace[384924179] 'process raft request' (duration: 100.417757ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:11.781979Z","caller":"traceutil/trace.go:171","msg":"trace[1462526635] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"207.256076ms","start":"2026-06-26T10:16:11.57469Z","end":"2026-06-26T10:16:11.781946Z","steps":["trace[1462526635] 'process raft request' (duration: 206.930867ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:11.781984Z","caller":"traceutil/trace.go:171","msg":"trace[150643627] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"284.183859ms","start":"2026-06-26T10:16:11.497769Z","end":"2026-06-26T10:16:11.781953Z","steps":["trace[150643627] 'process raft request' (duration: 265.239961ms)","trace[150643627] 'compare' (duration: 18.428465ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:16:11.782151Z","caller":"traceutil/trace.go:171","msg":"trace[838338420] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"284.22292ms","start":"2026-06-26T10:16:11.497907Z","end":"2026-06-26T10:16:11.78213Z","steps":["trace[838338420] 'read index received' (duration: 98.890518ms)","trace[838338420] 'applied index is now lower than readState.Index' (duration: 185.331092ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:16:11.782316Z","caller":"traceutil/trace.go:171","msg":"trace[2045809872] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"207.283836ms","start":"2026-06-26T10:16:11.575001Z","end":"2026-06-26T10:16:11.782285Z","steps":["trace[2045809872] 'process raft request' (duration: 206.869716ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:11.782524Z","caller":"traceutil/trace.go:171","msg":"trace[1507279930] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"198.72626ms","start":"2026-06-26T10:16:11.583773Z","end":"2026-06-26T10:16:11.7825Z","steps":["trace[1507279930] 'process raft request' (duration: 198.140765ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:11.782538Z","caller":"traceutil/trace.go:171","msg":"trace[1371346294] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"193.039627ms","start":"2026-06-26T10:16:11.589479Z","end":"2026-06-26T10:16:11.782518Z","steps":["trace[1371346294] 'process raft request' (duration: 192.502773ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:11.78265Z","caller":"traceutil/trace.go:171","msg":"trace[660051157] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"207.645506ms","start":"2026-06-26T10:16:11.574973Z","end":"2026-06-26T10:16:11.782619Z","steps":["trace[660051157] 'process raft request' (duration: 206.809545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:11.782775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.007627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T10:16:11.782825Z","caller":"traceutil/trace.go:171","msg":"trace[920726431] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"155.083369ms","start":"2026-06-26T10:16:11.627731Z","end":"2026-06-26T10:16:11.782815Z","steps":["trace[920726431] 'agreement among raft nodes before linearized reading' (duration: 154.961636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:11.782736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.303537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T10:16:11.782648Z","caller":"traceutil/trace.go:171","msg":"trace[1179205390] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"207.621685ms","start":"2026-06-26T10:16:11.575009Z","end":"2026-06-26T10:16:11.782631Z","steps":["trace[1179205390] 'process raft request' (duration: 206.803885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:11.78299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.472711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T10:16:11.782952Z","caller":"traceutil/trace.go:171","msg":"trace[351191428] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"207.661766ms","start":"2026-06-26T10:16:11.575277Z","end":"2026-06-26T10:16:11.782939Z","steps":["trace[351191428] 'agreement among raft nodes before linearized reading' (duration: 207.248746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:11.783037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.120353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-06-26T10:16:11.783054Z","caller":"traceutil/trace.go:171","msg":"trace[1270726997] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"207.564743ms","start":"2026-06-26T10:16:11.575472Z","end":"2026-06-26T10:16:11.783037Z","steps":["trace[1270726997] 'agreement among raft nodes before linearized reading' (duration: 207.472671ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:11.783093Z","caller":"traceutil/trace.go:171","msg":"trace[755854634] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"285.187154ms","start":"2026-06-26T10:16:11.497897Z","end":"2026-06-26T10:16:11.783084Z","steps":["trace[755854634] 'agreement among raft nodes before linearized reading' (duration: 285.099682ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:11.783202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.717418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T10:16:11.783259Z","caller":"traceutil/trace.go:171","msg":"trace[1393472475] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"208.400815ms","start":"2026-06-26T10:16:11.574849Z","end":"2026-06-26T10:16:11.78325Z","steps":["trace[1393472475] 'process raft request' (duration: 206.840905ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:11.783321Z","caller":"traceutil/trace.go:171","msg":"trace[809050524] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:0; response_revision:11; }","duration":"207.81795ms","start":"2026-06-26T10:16:11.575438Z","end":"2026-06-26T10:16:11.783256Z","steps":["trace[809050524] 'agreement among raft nodes before linearized reading' (duration: 207.697146ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:11.783363Z","caller":"traceutil/trace.go:171","msg":"trace[1433976397] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"208.025465ms","start":"2026-06-26T10:16:11.574905Z","end":"2026-06-26T10:16:11.782931Z","steps":["trace[1433976397] 'process raft request' (duration: 206.819745ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:11.783221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.326923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T10:16:11.783481Z","caller":"traceutil/trace.go:171","msg":"trace[500237241] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"134.603ms","start":"2026-06-26T10:16:11.648857Z","end":"2026-06-26T10:16:11.78346Z","steps":["trace[500237241] 'agreement among raft nodes before linearized reading' (duration: 134.340194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.19877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.449853ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-26T10:16:12.199206Z","caller":"traceutil/trace.go:171","msg":"trace[545990930] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"411.985571ms","start":"2026-06-26T10:16:11.7872Z","end":"2026-06-26T10:16:12.199186Z","steps":["trace[545990930] 'process raft request' (duration: 186.564453ms)","trace[545990930] 'compare' (duration: 224.29531ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:16:12.199441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:11.787185Z","time spent":"412.186056ms","remote":"127.0.0.1:37616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:16:12.203624Z","caller":"traceutil/trace.go:171","msg":"trace[882980718] linearizableReadLoop","detail":"{readStateIndex:16; appliedIndex:14; }","duration":"414.995836ms","start":"2026-06-26T10:16:11.788614Z","end":"2026-06-26T10:16:12.20361Z","steps":["trace[882980718] 'read index received' (duration: 185.207319ms)","trace[882980718] 'applied index is now lower than readState.Index' (duration: 229.787967ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:16:12.203777Z","caller":"traceutil/trace.go:171","msg":"trace[500062922] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"414.151304ms","start":"2026-06-26T10:16:11.789619Z","end":"2026-06-26T10:16:12.20377Z","steps":["trace[500062922] 'process raft request' (duration: 413.927539ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:12.203778Z","caller":"traceutil/trace.go:171","msg":"trace[989761269] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"415.199662ms","start":"2026-06-26T10:16:11.788555Z","end":"2026-06-26T10:16:12.203754Z","steps":["trace[989761269] 'process raft request' (duration: 414.839273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.203852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:11.789609Z","time spent":"414.188735ms","remote":"127.0.0.1:37914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T10:16:12.203958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:11.788539Z","time spent":"415.318684ms","remote":"127.0.0.1:37960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:16:12.203642Z","caller":"traceutil/trace.go:171","msg":"trace[57719961] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"414.101944ms","start":"2026-06-26T10:16:11.789521Z","end":"2026-06-26T10:16:12.203623Z","steps":["trace[57719961] 'process raft request' (duration: 414.002211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.204059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:11.789496Z","time spent":"414.528374ms","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T10:16:12.204204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.004707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-dczkf\" ","response":"range_response_count:1 size:861"} {"level":"warn","ts":"2026-06-26T10:16:12.204178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.53372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T10:16:12.204227Z","caller":"traceutil/trace.go:171","msg":"trace[220693389] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-dczkf; range_end:; response_count:1; response_revision:20; }","duration":"415.067088ms","start":"2026-06-26T10:16:11.789154Z","end":"2026-06-26T10:16:12.204221Z","steps":["trace[220693389] 'agreement among raft nodes before linearized reading' (duration: 415.010946ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.204246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:11.789143Z","time spent":"415.099999ms","remote":"127.0.0.1:37762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-dczkf\" "} {"level":"info","ts":"2026-06-26T10:16:12.20426Z","caller":"traceutil/trace.go:171","msg":"trace[530902156] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"415.652073ms","start":"2026-06-26T10:16:11.788586Z","end":"2026-06-26T10:16:12.204238Z","steps":["trace[530902156] 'agreement among raft nodes before linearized reading' (duration: 415.410527ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.204332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:11.788554Z","time spent":"415.757586ms","remote":"127.0.0.1:37522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T10:16:12.204383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.23938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T10:16:12.204413Z","caller":"traceutil/trace.go:171","msg":"trace[1060671189] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:20; }","duration":"215.282381ms","start":"2026-06-26T10:16:11.989116Z","end":"2026-06-26T10:16:12.204398Z","steps":["trace[1060671189] 'agreement among raft nodes before linearized reading' (duration: 215.25209ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.204579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.170296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-06-26T10:16:12.204601Z","caller":"traceutil/trace.go:171","msg":"trace[909793968] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"359.241628ms","start":"2026-06-26T10:16:11.845353Z","end":"2026-06-26T10:16:12.204594Z","steps":["trace[909793968] 'agreement among raft nodes before linearized reading' (duration: 359.181206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.204614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:11.845336Z","time spent":"359.275418ms","remote":"127.0.0.1:37616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-26T10:16:12.204759Z","caller":"traceutil/trace.go:171","msg":"trace[724754230] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"415.94515ms","start":"2026-06-26T10:16:11.788774Z","end":"2026-06-26T10:16:12.204719Z","steps":["trace[724754230] 'process raft request' (duration: 414.697658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.204845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:11.788755Z","time spent":"416.044513ms","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:16:12.204871Z","caller":"traceutil/trace.go:171","msg":"trace[2068480979] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"412.792501ms","start":"2026-06-26T10:16:11.79206Z","end":"2026-06-26T10:16:12.204852Z","steps":["trace[2068480979] 'process raft request' (duration: 411.524289ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:12.204917Z","caller":"traceutil/trace.go:171","msg":"trace[1767290808] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"415.596492ms","start":"2026-06-26T10:16:11.789305Z","end":"2026-06-26T10:16:12.204901Z","steps":["trace[1767290808] 'process raft request' (duration: 414.186776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.205012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:11.789295Z","time spent":"415.672993ms","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T10:16:12.205237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:11.792053Z","time spent":"412.860962ms","remote":"127.0.0.1:37692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:16:12.20525Z","caller":"traceutil/trace.go:171","msg":"trace[1671907095] transaction","detail":"{read_only:false; number_of_response:0; response_revision:15; }","duration":"415.832047ms","start":"2026-06-26T10:16:11.789405Z","end":"2026-06-26T10:16:12.205237Z","steps":["trace[1671907095] 'process raft request' (duration: 414.107484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.205447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:11.789393Z","time spent":"416.035723ms","remote":"127.0.0.1:37616","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:16:12.205474Z","caller":"traceutil/trace.go:171","msg":"trace[1186885139] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"415.797166ms","start":"2026-06-26T10:16:11.789641Z","end":"2026-06-26T10:16:12.205438Z","steps":["trace[1186885139] 'process raft request' (duration: 413.919939ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.205579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:11.78963Z","time spent":"415.883128ms","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:16:12.209759Z","caller":"traceutil/trace.go:171","msg":"trace[141674266] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"414.054143ms","start":"2026-06-26T10:16:11.790149Z","end":"2026-06-26T10:16:12.204203Z","steps":["trace[141674266] 'process raft request' (duration: 413.422537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.209972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:11.790129Z","time spent":"419.787896ms","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T10:16:12.661588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.926717ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-06-26T10:16:12.661904Z","caller":"traceutil/trace.go:171","msg":"trace[1731196374] linearizableReadLoop","detail":"{readStateIndex:52; appliedIndex:50; }","duration":"302.513785ms","start":"2026-06-26T10:16:12.359372Z","end":"2026-06-26T10:16:12.661886Z","steps":["trace[1731196374] 'read index received' (duration: 291.96039ms)","trace[1731196374] 'applied index is now lower than readState.Index' (duration: 10.551495ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:16:12.66191Z","caller":"traceutil/trace.go:171","msg":"trace[1860527901] transaction","detail":"{read_only:false; response_revision:47; number_of_response:1; }","duration":"400.175364ms","start":"2026-06-26T10:16:12.261678Z","end":"2026-06-26T10:16:12.661853Z","steps":["trace[1860527901] 'process raft request' (duration: 68.882147ms)","trace[1860527901] 'compare' (duration: 330.783594ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:16:12.661952Z","caller":"traceutil/trace.go:171","msg":"trace[1371233115] transaction","detail":"{read_only:false; response_revision:48; number_of_response:1; }","duration":"398.748568ms","start":"2026-06-26T10:16:12.26318Z","end":"2026-06-26T10:16:12.661928Z","steps":["trace[1371233115] 'process raft request' (duration: 398.538332ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.662098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:12.263154Z","time spent":"398.876431ms","remote":"127.0.0.1:37954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":779,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T10:16:12.662067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:12.261662Z","time spent":"400.318117ms","remote":"127.0.0.1:37954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1120,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:16:12.662353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.213743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T10:16:12.662397Z","caller":"traceutil/trace.go:171","msg":"trace[86147005] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:48; }","duration":"153.258554ms","start":"2026-06-26T10:16:12.509128Z","end":"2026-06-26T10:16:12.662387Z","steps":["trace[86147005] 'agreement among raft nodes before linearized reading' (duration: 153.141701ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.662405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.751372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T10:16:12.66245Z","caller":"traceutil/trace.go:171","msg":"trace[901350044] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:48; }","duration":"188.824184ms","start":"2026-06-26T10:16:12.473609Z","end":"2026-06-26T10:16:12.662433Z","steps":["trace[901350044] 'agreement among raft nodes before linearized reading' (duration: 188.774333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.662356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.025353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T10:16:12.662605Z","caller":"traceutil/trace.go:171","msg":"trace[1689775747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:48; }","duration":"302.28693ms","start":"2026-06-26T10:16:12.360279Z","end":"2026-06-26T10:16:12.662566Z","steps":["trace[1689775747] 'agreement among raft nodes before linearized reading' (duration: 301.975162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.662669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.166643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T10:16:12.662702Z","caller":"traceutil/trace.go:171","msg":"trace[1078119531] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:48; }","duration":"189.247426ms","start":"2026-06-26T10:16:12.473446Z","end":"2026-06-26T10:16:12.662694Z","steps":["trace[1078119531] 'agreement among raft nodes before linearized reading' (duration: 189.198665ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.662649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:12.360233Z","time spent":"302.401823ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T10:16:12.663015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.644242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T10:16:12.663094Z","caller":"traceutil/trace.go:171","msg":"trace[386975198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:48; }","duration":"303.761676ms","start":"2026-06-26T10:16:12.359312Z","end":"2026-06-26T10:16:12.663074Z","steps":["trace[386975198] 'agreement among raft nodes before linearized reading' (duration: 302.794852ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:12.6632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:12.35929Z","time spent":"303.89163ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T10:16:16.435768Z","caller":"traceutil/trace.go:171","msg":"trace[1432150613] linearizableReadLoop","detail":"{readStateIndex:292; appliedIndex:289; }","duration":"328.835737ms","start":"2026-06-26T10:16:16.106895Z","end":"2026-06-26T10:16:16.43573Z","steps":["trace[1432150613] 'read index received' (duration: 328.660063ms)","trace[1432150613] 'applied index is now lower than readState.Index' (duration: 174.654µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:16:16.435874Z","caller":"traceutil/trace.go:171","msg":"trace[122221789] transaction","detail":"{read_only:false; number_of_response:0; response_revision:278; }","duration":"330.462366ms","start":"2026-06-26T10:16:16.105403Z","end":"2026-06-26T10:16:16.435865Z","steps":["trace[122221789] 'process raft request' (duration: 330.164549ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:16.43591Z","caller":"traceutil/trace.go:171","msg":"trace[1874564223] transaction","detail":"{read_only:false; number_of_response:0; response_revision:278; }","duration":"329.782229ms","start":"2026-06-26T10:16:16.10612Z","end":"2026-06-26T10:16:16.435902Z","steps":["trace[1874564223] 'process raft request' (duration: 329.587004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:16.436023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:16.106107Z","time spent":"329.837431ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T10:16:16.436023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:16.105386Z","time spent":"330.530557ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:16:16.435819Z","caller":"traceutil/trace.go:171","msg":"trace[1432714493] transaction","detail":"{read_only:false; number_of_response:0; response_revision:278; }","duration":"330.316192ms","start":"2026-06-26T10:16:16.105478Z","end":"2026-06-26T10:16:16.435794Z","steps":["trace[1432714493] 'process raft request' (duration: 330.19026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:16.436224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.311109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"info","ts":"2026-06-26T10:16:16.436264Z","caller":"traceutil/trace.go:171","msg":"trace[902878029] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:278; }","duration":"329.38338ms","start":"2026-06-26T10:16:16.106868Z","end":"2026-06-26T10:16:16.436251Z","steps":["trace[902878029] 'agreement among raft nodes before linearized reading' (duration: 329.291498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:16.436302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:16.106858Z","time spent":"329.433292ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4345,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-06-26T10:16:16.436357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:16.105474Z","time spent":"330.778524ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:16:16.44003Z","caller":"traceutil/trace.go:171","msg":"trace[58527775] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"328.182951ms","start":"2026-06-26T10:16:16.111822Z","end":"2026-06-26T10:16:16.440005Z","steps":["trace[58527775] 'process raft request' (duration: 327.980417ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:16.440077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.21163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-26T10:16:16.440362Z","caller":"traceutil/trace.go:171","msg":"trace[2052989951] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:279; }","duration":"330.500227ms","start":"2026-06-26T10:16:16.109834Z","end":"2026-06-26T10:16:16.440334Z","steps":["trace[2052989951] 'agreement among raft nodes before linearized reading' (duration: 330.169378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:16.440449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:16.109826Z","time spent":"330.5965ms","remote":"127.0.0.1:37616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-26T10:16:16.440304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:16.111807Z","time spent":"328.384027ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4307,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:16:22.41102Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152005333930561,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T10:16:22.841222Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.107227857s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T10:16:22.841994Z","caller":"traceutil/trace.go:171","msg":"trace[594609467] linearizableReadLoop","detail":"{readStateIndex:378; appliedIndex:377; }","duration":"931.507727ms","start":"2026-06-26T10:16:21.910451Z","end":"2026-06-26T10:16:22.841959Z","steps":["trace[594609467] 'read index received' (duration: 931.19496ms)","trace[594609467] 'applied index is now lower than readState.Index' (duration: 311.257µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:16:22.842082Z","caller":"traceutil/trace.go:171","msg":"trace[1941880178] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"1.108115957s","start":"2026-06-26T10:16:21.733933Z","end":"2026-06-26T10:16:22.842049Z","steps":["trace[1941880178] 'process raft request' (duration: 1.107765539s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:22.842206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"931.724742ms","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-06-26T10:16:22.842257Z","caller":"traceutil/trace.go:171","msg":"trace[368385025] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:363; }","duration":"931.838855ms","start":"2026-06-26T10:16:21.910405Z","end":"2026-06-26T10:16:22.842243Z","steps":["trace[368385025] 'agreement among raft nodes before linearized reading' (duration: 931.728092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:22.842262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:21.733921Z","time spent":"1.108247431s","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:16:22.842298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:21.9103Z","time spent":"931.987688ms","remote":"127.0.0.1:37768","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-06-26T10:16:23.342169Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152005333930564,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T10:16:23.953105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.393183ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T10:16:23.953255Z","caller":"traceutil/trace.go:171","msg":"trace[1512426794] linearizableReadLoop","detail":"{readStateIndex:380; appliedIndex:378; }","duration":"1.111148255s","start":"2026-06-26T10:16:22.842094Z","end":"2026-06-26T10:16:23.953243Z","steps":["trace[1512426794] 'read index received' (duration: 569.549268ms)","trace[1512426794] 'applied index is now lower than readState.Index' (duration: 541.598237ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:16:23.95332Z","caller":"traceutil/trace.go:171","msg":"trace[2088598011] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"1.475625873s","start":"2026-06-26T10:16:22.477685Z","end":"2026-06-26T10:16:23.953311Z","steps":["trace[2088598011] 'process raft request' (duration: 933.965044ms)","trace[2088598011] 'compare' (duration: 541.27699ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:16:23.95336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:22.477663Z","time spent":"1.475675554s","remote":"127.0.0.1:37768","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-06-26T10:16:23.953451Z","caller":"traceutil/trace.go:171","msg":"trace[1276426163] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"1.10578345s","start":"2026-06-26T10:16:22.847662Z","end":"2026-06-26T10:16:23.953445Z","steps":["trace[1276426163] 'process raft request' (duration: 1.105544204s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:23.953487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:22.847643Z","time spent":"1.10582747s","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:16:23.953571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.297718919s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:16:23.953599Z","caller":"traceutil/trace.go:171","msg":"trace[1355076031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:365; }","duration":"1.297773982s","start":"2026-06-26T10:16:22.655818Z","end":"2026-06-26T10:16:23.953592Z","steps":["trace[1355076031] 'agreement among raft nodes before linearized reading' (duration: 1.29771274s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:23.95362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:22.655803Z","time spent":"1.297813202s","remote":"127.0.0.1:37506","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-06-26T10:16:23.953745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.139047586s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:16:23.953836Z","caller":"traceutil/trace.go:171","msg":"trace[1677297874] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:365; }","duration":"1.13919652s","start":"2026-06-26T10:16:22.814616Z","end":"2026-06-26T10:16:23.953813Z","steps":["trace[1677297874] 'agreement among raft nodes before linearized reading' (duration: 1.139026216s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:23.953835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.978512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-06-26T10:16:23.953887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:22.814594Z","time spent":"1.139284461s","remote":"127.0.0.1:37522","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-06-26T10:16:23.953904Z","caller":"traceutil/trace.go:171","msg":"trace[1818893616] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:365; }","duration":"544.099954ms","start":"2026-06-26T10:16:23.409789Z","end":"2026-06-26T10:16:23.953888Z","steps":["trace[1818893616] 'agreement among raft nodes before linearized reading' (duration: 543.988632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:23.953934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:23.409764Z","time spent":"544.163116ms","remote":"127.0.0.1:37536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.19\" "} {"level":"warn","ts":"2026-06-26T10:16:23.954058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.200907261s","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-06-26T10:16:23.954345Z","caller":"traceutil/trace.go:171","msg":"trace[1001680313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:365; }","duration":"1.201408873s","start":"2026-06-26T10:16:22.752904Z","end":"2026-06-26T10:16:23.954313Z","steps":["trace[1001680313] 'agreement among raft nodes before linearized reading' (duration: 1.200620564s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:23.954428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:22.752882Z","time spent":"1.201528356s","remote":"127.0.0.1:37768","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-06-26T10:16:23.954566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.198272269s","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-06-26T10:16:23.954715Z","caller":"traceutil/trace.go:171","msg":"trace[1835354616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:365; }","duration":"1.198475373s","start":"2026-06-26T10:16:22.756206Z","end":"2026-06-26T10:16:23.954681Z","steps":["trace[1835354616] 'agreement among raft nodes before linearized reading' (duration: 1.197529022s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:23.954786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:22.756198Z","time spent":"1.198572835s","remote":"127.0.0.1:37768","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":"warn","ts":"2026-06-26T10:16:24.461004Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152005333930567,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T10:16:24.567003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:23.956354Z","time spent":"610.64426ms","remote":"127.0.0.1:37536","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-26T10:16:25.121895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.19059ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T10:16:25.122081Z","caller":"traceutil/trace.go:171","msg":"trace[811591141] linearizableReadLoop","detail":"{readStateIndex:383; appliedIndex:380; }","duration":"1.16122211s","start":"2026-06-26T10:16:23.960835Z","end":"2026-06-26T10:16:25.122057Z","steps":["trace[811591141] 'read index received' (duration: 606.045293ms)","trace[811591141] 'applied index is now lower than readState.Index' (duration: 555.175987ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:16:25.122206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.161368073s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:16:25.122179Z","caller":"traceutil/trace.go:171","msg":"trace[1501361429] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"553.429907ms","start":"2026-06-26T10:16:24.568714Z","end":"2026-06-26T10:16:25.122143Z","steps":["trace[1501361429] 'process raft request' (duration: 553.319073ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:25.122207Z","caller":"traceutil/trace.go:171","msg":"trace[1830101037] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"1.16215322s","start":"2026-06-26T10:16:23.960031Z","end":"2026-06-26T10:16:25.122184Z","steps":["trace[1830101037] 'process raft request' (duration: 1.161948085s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:25.122335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:23.960006Z","time spent":"1.162262423s","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:16:25.122345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:24.568689Z","time spent":"553.562379ms","remote":"127.0.0.1:37536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:16:25.122269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.059716ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:16:25.122443Z","caller":"traceutil/trace.go:171","msg":"trace[358756280] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:368; }","duration":"493.24894ms","start":"2026-06-26T10:16:24.629169Z","end":"2026-06-26T10:16:25.122418Z","steps":["trace[358756280] 'agreement among raft nodes before linearized reading' (duration: 493.025966ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:25.12254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.906164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-26T10:16:25.122236Z","caller":"traceutil/trace.go:171","msg":"trace[2061518938] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:368; }","duration":"1.161427213s","start":"2026-06-26T10:16:23.960801Z","end":"2026-06-26T10:16:25.122228Z","steps":["trace[2061518938] 'agreement among raft nodes before linearized reading' (duration: 1.161354992s)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:25.122592Z","caller":"traceutil/trace.go:171","msg":"trace[1952799250] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:368; }","duration":"203.004826ms","start":"2026-06-26T10:16:24.919573Z","end":"2026-06-26T10:16:25.122578Z","steps":["trace[1952799250] 'agreement among raft nodes before linearized reading' (duration: 202.883883ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:25.122594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:23.960793Z","time spent":"1.161793391s","remote":"127.0.0.1:37506","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-06-26T10:16:25.122841Z","caller":"traceutil/trace.go:171","msg":"trace[1797712522] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"1.16294106s","start":"2026-06-26T10:16:23.959172Z","end":"2026-06-26T10:16:25.122113Z","steps":["trace[1797712522] 'process raft request' (duration: 1.032460883s)","trace[1797712522] 'compare' (duration: 130.079587ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:16:25.123021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:23.959145Z","time spent":"1.163820429s","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:16:51.826661Z","caller":"traceutil/trace.go:171","msg":"trace[1370768628] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"174.812991ms","start":"2026-06-26T10:16:51.651814Z","end":"2026-06-26T10:16:51.826627Z","steps":["trace[1370768628] 'process raft request' (duration: 114.336735ms)","trace[1370768628] 'compare' (duration: 60.339794ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:16:51.827347Z","caller":"traceutil/trace.go:171","msg":"trace[1527658737] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"153.538833ms","start":"2026-06-26T10:16:51.673781Z","end":"2026-06-26T10:16:51.82732Z","steps":["trace[1527658737] 'process raft request' (duration: 153.208266ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.555219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.072578ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T10:16:54.555918Z","caller":"traceutil/trace.go:171","msg":"trace[1348809900] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:528; }","duration":"1.202320701s","start":"2026-06-26T10:16:53.353564Z","end":"2026-06-26T10:16:54.555885Z","steps":["trace[1348809900] 'read index received' (duration: 3.541548ms)","trace[1348809900] 'applied index is now lower than readState.Index' (duration: 1.198777263s)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:16:54.555966Z","caller":"traceutil/trace.go:171","msg":"trace[810686681] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"1.203067056s","start":"2026-06-26T10:16:53.352811Z","end":"2026-06-26T10:16:54.555878Z","steps":["trace[810686681] 'process raft request' (duration: 403.198102ms)","trace[810686681] 'compare' (duration: 798.746072ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:16:54.556037Z","caller":"traceutil/trace.go:171","msg":"trace[402676622] transaction","detail":"{read_only:false; number_of_response:1; response_revision:510; }","duration":"1.201885493s","start":"2026-06-26T10:16:53.354142Z","end":"2026-06-26T10:16:54.556027Z","steps":["trace[402676622] 'process raft request' (duration: 1.201622078s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.556149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.352806Z","time spent":"1.20325398s","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:16:54.55596Z","caller":"traceutil/trace.go:171","msg":"trace[1928773924] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"1.202908753s","start":"2026-06-26T10:16:53.353005Z","end":"2026-06-26T10:16:54.555914Z","steps":["trace[1928773924] 'process raft request' (duration: 1.202436825s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.556184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.35413Z","time spent":"1.201933274s","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:16:54.55616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.2316248s","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-06-26T10:16:54.556297Z","caller":"traceutil/trace.go:171","msg":"trace[519172122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:510; }","duration":"1.231767355s","start":"2026-06-26T10:16:53.324503Z","end":"2026-06-26T10:16:54.55627Z","steps":["trace[519172122] 'agreement among raft nodes before linearized reading' (duration: 1.231578981s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.556235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.352999Z","time spent":"1.203202589s","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T10:16:54.556423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.324499Z","time spent":"1.231905637s","remote":"127.0.0.1:37768","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-06-26T10:16:54.555979Z","caller":"traceutil/trace.go:171","msg":"trace[819512970] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.202012445s","start":"2026-06-26T10:16:53.353945Z","end":"2026-06-26T10:16:54.555957Z","steps":["trace[819512970] 'process raft request' (duration: 1.201684059s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.556972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.353932Z","time spent":"1.202930153s","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:16:54.559381Z","caller":"traceutil/trace.go:171","msg":"trace[12541197] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"1.198227362s","start":"2026-06-26T10:16:53.361137Z","end":"2026-06-26T10:16:54.559364Z","steps":["trace[12541197] 'process raft request' (duration: 1.197892426s)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:54.55939Z","caller":"traceutil/trace.go:171","msg":"trace[1329034257] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"1.196424847s","start":"2026-06-26T10:16:53.362946Z","end":"2026-06-26T10:16:54.559371Z","steps":["trace[1329034257] 'process raft request' (duration: 1.196221233s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.559457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.361121Z","time spent":"1.198300643s","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T10:16:54.559484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.362935Z","time spent":"1.196504348s","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:16:54.559612Z","caller":"traceutil/trace.go:171","msg":"trace[200131466] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"1.198368545s","start":"2026-06-26T10:16:53.361233Z","end":"2026-06-26T10:16:54.559601Z","steps":["trace[200131466] 'process raft request' (duration: 1.197888046s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.559658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.361227Z","time spent":"1.198407986s","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:16:54.55975Z","caller":"traceutil/trace.go:171","msg":"trace[1193391951] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.196545369s","start":"2026-06-26T10:16:53.363185Z","end":"2026-06-26T10:16:54.55973Z","steps":["trace[1193391951] 'process raft request' (duration: 1.196030429s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.559853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.363179Z","time spent":"1.196631211s","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:16:54.56014Z","caller":"traceutil/trace.go:171","msg":"trace[1106538901] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.196037919s","start":"2026-06-26T10:16:53.364094Z","end":"2026-06-26T10:16:54.560132Z","steps":["trace[1106538901] 'process raft request' (duration: 1.195167992s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.560185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.364087Z","time spent":"1.196077321s","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:16:54.560313Z","caller":"traceutil/trace.go:171","msg":"trace[111200865] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.183924064s","start":"2026-06-26T10:16:53.376381Z","end":"2026-06-26T10:16:54.560305Z","steps":["trace[111200865] 'process raft request' (duration: 1.183425604s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.560357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.376351Z","time spent":"1.183980955s","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:16:54.560878Z","caller":"traceutil/trace.go:171","msg":"trace[2119037113] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"1.172258658s","start":"2026-06-26T10:16:53.388611Z","end":"2026-06-26T10:16:54.56087Z","steps":["trace[2119037113] 'process raft request' (duration: 1.17185797s)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:54.560898Z","caller":"traceutil/trace.go:171","msg":"trace[151836985] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"1.031261059s","start":"2026-06-26T10:16:53.529621Z","end":"2026-06-26T10:16:54.560883Z","steps":["trace[151836985] 'process raft request' (duration: 1.031164686s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.560923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.388604Z","time spent":"1.172293378s","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:16:54.560984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.529573Z","time spent":"1.031367091s","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:16:54.561014Z","caller":"traceutil/trace.go:171","msg":"trace[842897369] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.172634964s","start":"2026-06-26T10:16:53.388372Z","end":"2026-06-26T10:16:54.561007Z","steps":["trace[842897369] 'process raft request' (duration: 1.171594014s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.561047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.388354Z","time spent":"1.172676656s","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:16:54.561244Z","caller":"traceutil/trace.go:171","msg":"trace[532418744] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"1.160793684s","start":"2026-06-26T10:16:53.400444Z","end":"2026-06-26T10:16:54.561237Z","steps":["trace[532418744] 'process raft request' (duration: 1.160148392s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.561296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.400426Z","time spent":"1.160845775s","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:16:54.567218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.151714158s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-26T10:16:54.567387Z","caller":"traceutil/trace.go:171","msg":"trace[1661408488] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:521; }","duration":"1.152159496s","start":"2026-06-26T10:16:53.415212Z","end":"2026-06-26T10:16:54.567372Z","steps":["trace[1661408488] 'agreement among raft nodes before linearized reading' (duration: 1.151643946s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.569976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.415181Z","time spent":"1.154777706s","remote":"127.0.0.1:37536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.19\" "} {"level":"warn","ts":"2026-06-26T10:16:54.567507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.25106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-26T10:16:54.570185Z","caller":"traceutil/trace.go:171","msg":"trace[1436718277] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:521; }","duration":"485.989363ms","start":"2026-06-26T10:16:54.084182Z","end":"2026-06-26T10:16:54.570171Z","steps":["trace[1436718277] 'agreement among raft nodes before linearized reading' (duration: 483.132198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.570238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:54.084163Z","time spent":"486.060454ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-26T10:16:54.567738Z","caller":"traceutil/trace.go:171","msg":"trace[2124569522] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"207.473519ms","start":"2026-06-26T10:16:54.360244Z","end":"2026-06-26T10:16:54.567717Z","steps":["trace[2124569522] 'process raft request' (duration: 206.478ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.567827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.688576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:16:54.570394Z","caller":"traceutil/trace.go:171","msg":"trace[380975552] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:522; }","duration":"755.306327ms","start":"2026-06-26T10:16:53.815081Z","end":"2026-06-26T10:16:54.570387Z","steps":["trace[380975552] 'agreement among raft nodes before linearized reading' (duration: 752.638235ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.570433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.815063Z","time spent":"755.364038ms","remote":"127.0.0.1:37506","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-06-26T10:16:54.56795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.095703869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-26T10:16:54.570577Z","caller":"traceutil/trace.go:171","msg":"trace[1519785291] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:522; }","duration":"1.098330309s","start":"2026-06-26T10:16:53.472224Z","end":"2026-06-26T10:16:54.570554Z","steps":["trace[1519785291] 'agreement among raft nodes before linearized reading' (duration: 1.095543525s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:54.570678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:53.47217Z","time spent":"1.098481323s","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T10:16:55.394887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.70469ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T10:16:55.394981Z","caller":"traceutil/trace.go:171","msg":"trace[57539788] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"369.617599ms","start":"2026-06-26T10:16:55.025346Z","end":"2026-06-26T10:16:55.394963Z","steps":["trace[57539788] 'process raft request' (duration: 103.774496ms)","trace[57539788] 'compare' (duration: 265.474925ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:16:55.39504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:55.025324Z","time spent":"369.69117ms","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:16:55.400279Z","caller":"traceutil/trace.go:171","msg":"trace[659407965] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"348.062774ms","start":"2026-06-26T10:16:55.052198Z","end":"2026-06-26T10:16:55.400261Z","steps":["trace[659407965] 'process raft request' (duration: 347.937542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:55.400387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:55.052179Z","time spent":"348.158917ms","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:16:56.329011Z","caller":"traceutil/trace.go:171","msg":"trace[257250662] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"108.769901ms","start":"2026-06-26T10:16:56.220221Z","end":"2026-06-26T10:16:56.32899Z","steps":["trace[257250662] 'read index received' (duration: 108.522286ms)","trace[257250662] 'applied index is now lower than readState.Index' (duration: 246.855µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:16:56.329111Z","caller":"traceutil/trace.go:171","msg":"trace[189956067] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"114.693555ms","start":"2026-06-26T10:16:56.214388Z","end":"2026-06-26T10:16:56.329082Z","steps":["trace[189956067] 'process raft request' (duration: 114.437761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:56.329198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.957354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31126"} {"level":"info","ts":"2026-06-26T10:16:56.329229Z","caller":"traceutil/trace.go:171","msg":"trace[256117804] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:578; }","duration":"109.021246ms","start":"2026-06-26T10:16:56.220198Z","end":"2026-06-26T10:16:56.329219Z","steps":["trace[256117804] 'agreement among raft nodes before linearized reading' (duration: 108.873423ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:56.545349Z","caller":"traceutil/trace.go:171","msg":"trace[572225745] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"154.595199ms","start":"2026-06-26T10:16:56.390728Z","end":"2026-06-26T10:16:56.545323Z","steps":["trace[572225745] 'read index received' (duration: 66.913741ms)","trace[572225745] 'applied index is now lower than readState.Index' (duration: 87.680498ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:16:56.545481Z","caller":"traceutil/trace.go:171","msg":"trace[45260493] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"166.003477ms","start":"2026-06-26T10:16:56.379454Z","end":"2026-06-26T10:16:56.545457Z","steps":["trace[45260493] 'process raft request' (duration: 78.292789ms)","trace[45260493] 'compare' (duration: 87.464634ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:16:56.545509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.750901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-06-26T10:16:56.545533Z","caller":"traceutil/trace.go:171","msg":"trace[83218167] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:579; }","duration":"154.827862ms","start":"2026-06-26T10:16:56.390698Z","end":"2026-06-26T10:16:56.545525Z","steps":["trace[83218167] 'agreement among raft nodes before linearized reading' (duration: 154.69415ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:58.797201Z","caller":"traceutil/trace.go:171","msg":"trace[1251101002] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"110.411884ms","start":"2026-06-26T10:16:58.686771Z","end":"2026-06-26T10:16:58.797182Z","steps":["trace[1251101002] 'read index received' (duration: 110.053746ms)","trace[1251101002] 'applied index is now lower than readState.Index' (duration: 357.588µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:16:58.797283Z","caller":"traceutil/trace.go:171","msg":"trace[1428006615] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"215.26ms","start":"2026-06-26T10:16:58.582016Z","end":"2026-06-26T10:16:58.797276Z","steps":["trace[1428006615] 'process raft request' (duration: 214.874572ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:58.797602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.81578ms","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-06-26T10:16:58.797676Z","caller":"traceutil/trace.go:171","msg":"trace[348930843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:587; }","duration":"110.951383ms","start":"2026-06-26T10:16:58.686706Z","end":"2026-06-26T10:16:58.797658Z","steps":["trace[348930843] 'agreement among raft nodes before linearized reading' (duration: 110.687658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:59.292394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.303029ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-26T10:16:59.292696Z","caller":"traceutil/trace.go:171","msg":"trace[1853089818] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"495.374522ms","start":"2026-06-26T10:16:58.797259Z","end":"2026-06-26T10:16:59.292634Z","steps":["trace[1853089818] 'read index received' (duration: 7.91356ms)","trace[1853089818] 'applied index is now lower than readState.Index' (duration: 487.458172ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:16:59.292929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.805247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-26T10:16:59.293023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.169777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:16:59.29298Z","caller":"traceutil/trace.go:171","msg":"trace[1022995542] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"491.770375ms","start":"2026-06-26T10:16:58.801186Z","end":"2026-06-26T10:16:59.292956Z","steps":["trace[1022995542] 'process raft request' (duration: 491.401357ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:59.293067Z","caller":"traceutil/trace.go:171","msg":"trace[1111117558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"478.221377ms","start":"2026-06-26T10:16:58.814821Z","end":"2026-06-26T10:16:59.293042Z","steps":["trace[1111117558] 'agreement among raft nodes before linearized reading' (duration: 478.155416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:59.293089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:58.814805Z","time spent":"478.278959ms","remote":"127.0.0.1:37506","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-06-26T10:16:59.293008Z","caller":"traceutil/trace.go:171","msg":"trace[568716473] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:587; }","duration":"605.918749ms","start":"2026-06-26T10:16:58.687068Z","end":"2026-06-26T10:16:59.292987Z","steps":["trace[568716473] 'agreement among raft nodes before linearized reading' (duration: 605.705816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:59.292954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.665653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-26T10:16:59.293127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.152123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T10:16:59.293162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:58.687052Z","time spent":"606.088002ms","remote":"127.0.0.1:37768","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-06-26T10:16:59.293179Z","caller":"traceutil/trace.go:171","msg":"trace[771663688] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:588; }","duration":"433.309936ms","start":"2026-06-26T10:16:58.859851Z","end":"2026-06-26T10:16:59.293161Z","steps":["trace[771663688] 'agreement among raft nodes before linearized reading' (duration: 433.235245ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:16:59.293187Z","caller":"traceutil/trace.go:171","msg":"trace[1519746435] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:587; }","duration":"605.901287ms","start":"2026-06-26T10:16:58.68725Z","end":"2026-06-26T10:16:59.293151Z","steps":["trace[1519746435] 'agreement among raft nodes before linearized reading' (duration: 605.494659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:59.293227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:58.687246Z","time spent":"605.971428ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T10:16:59.293226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:58.859807Z","time spent":"433.406198ms","remote":"127.0.0.1:37716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-06-26T10:16:59.292952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.972029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-26T10:16:59.293316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:58.801163Z","time spent":"491.911498ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:16:59.293414Z","caller":"traceutil/trace.go:171","msg":"trace[2016848945] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"606.468089ms","start":"2026-06-26T10:16:58.686938Z","end":"2026-06-26T10:16:59.293406Z","steps":["trace[2016848945] 'agreement among raft nodes before linearized reading' (duration: 605.856838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:59.29344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:58.686929Z","time spent":"606.502389ms","remote":"127.0.0.1:37768","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-06-26T10:16:59.770864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.285981ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T10:16:59.771068Z","caller":"traceutil/trace.go:171","msg":"trace[1247164675] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"473.325678ms","start":"2026-06-26T10:16:59.297715Z","end":"2026-06-26T10:16:59.771041Z","steps":["trace[1247164675] 'process raft request' (duration: 257.67503ms)","trace[1247164675] 'compare' (duration: 215.068477ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:16:59.771246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:59.2977Z","time spent":"473.494502ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:16:59.771427Z","caller":"traceutil/trace.go:171","msg":"trace[1137682981] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"473.39694ms","start":"2026-06-26T10:16:59.298006Z","end":"2026-06-26T10:16:59.771403Z","steps":["trace[1137682981] 'process raft request' (duration: 473.343059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:59.771584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:59.297985Z","time spent":"473.523172ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:16:59.771583Z","caller":"traceutil/trace.go:171","msg":"trace[902677824] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"473.604063ms","start":"2026-06-26T10:16:59.297961Z","end":"2026-06-26T10:16:59.771565Z","steps":["trace[902677824] 'process raft request' (duration: 473.239877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:16:59.77168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:16:59.297947Z","time spent":"473.684306ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:17:00.024102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.068284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:00.02417Z","caller":"traceutil/trace.go:171","msg":"trace[1642704639] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:593; }","duration":"146.175575ms","start":"2026-06-26T10:16:59.877979Z","end":"2026-06-26T10:17:00.024154Z","steps":["trace[1642704639] 'range keys from in-memory index tree' (duration: 145.981632ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:01.284294Z","caller":"traceutil/trace.go:171","msg":"trace[1029435212] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"330.429289ms","start":"2026-06-26T10:17:00.953834Z","end":"2026-06-26T10:17:01.284263Z","steps":["trace[1029435212] 'process raft request' (duration: 329.819937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:01.284525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:00.953807Z","time spent":"330.637573ms","remote":"127.0.0.1:37596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036201,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:17:03.631007Z","caller":"traceutil/trace.go:171","msg":"trace[1189365625] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"409.140355ms","start":"2026-06-26T10:17:03.221844Z","end":"2026-06-26T10:17:03.630984Z","steps":["trace[1189365625] 'read index received' (duration: 408.518224ms)","trace[1189365625] 'applied index is now lower than readState.Index' (duration: 621.531µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:17:03.631239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.381119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-x84jm\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-26T10:17:03.631181Z","caller":"traceutil/trace.go:171","msg":"trace[1822468820] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"733.233456ms","start":"2026-06-26T10:17:02.897863Z","end":"2026-06-26T10:17:03.631097Z","steps":["trace[1822468820] 'process raft request' (duration: 732.714507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:03.631333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.764024ms","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-06-26T10:17:03.631355Z","caller":"traceutil/trace.go:171","msg":"trace[237608230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:609; }","duration":"324.817805ms","start":"2026-06-26T10:17:03.306533Z","end":"2026-06-26T10:17:03.631351Z","steps":["trace[237608230] 'agreement among raft nodes before linearized reading' (duration: 324.755564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:03.631379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:03.306519Z","time spent":"324.853985ms","remote":"127.0.0.1:37768","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-06-26T10:17:03.631542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:02.897839Z","time spent":"733.479401ms","remote":"127.0.0.1:37596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:17:03.631633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.197813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-26T10:17:03.631659Z","caller":"traceutil/trace.go:171","msg":"trace[197931605] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:609; }","duration":"216.261235ms","start":"2026-06-26T10:17:03.415391Z","end":"2026-06-26T10:17:03.631653Z","steps":["trace[197931605] 'agreement among raft nodes before linearized reading' (duration: 216.196484ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:03.631272Z","caller":"traceutil/trace.go:171","msg":"trace[1421038758] range","detail":"{range_begin:/registry/pods/kube-system/cilium-x84jm; range_end:; response_count:1; response_revision:609; }","duration":"409.429901ms","start":"2026-06-26T10:17:03.221833Z","end":"2026-06-26T10:17:03.631262Z","steps":["trace[1421038758] 'agreement among raft nodes before linearized reading' (duration: 409.258487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:03.631807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:03.22177Z","time spent":"410.021971ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-x84jm\" "} {"level":"warn","ts":"2026-06-26T10:17:04.314298Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152005333931033,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T10:17:04.814916Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152005333931033,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T10:17:04.837914Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.17828866s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-26T10:17:05.813527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000295286s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-26T10:17:05.813599Z","caller":"traceutil/trace.go:171","msg":"trace[931387572] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000408377s","start":"2026-06-26T10:17:03.813174Z","end":"2026-06-26T10:17:05.813582Z","steps":["trace[931387572] 'agreement among raft nodes before linearized reading' (duration: 2.000317796s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:05.813637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:03.813159Z","time spent":"2.000470408s","remote":"127.0.0.1:37506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/26 10:17:05 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T10:17:06.123819Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.285717752s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-26T10:17:06.124217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.285795041s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T10:17:06.124549Z","caller":"traceutil/trace.go:171","msg":"trace[1289588685] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"2.485710753s","start":"2026-06-26T10:17:03.638796Z","end":"2026-06-26T10:17:06.124506Z","steps":["trace[1289588685] 'process raft request' (duration: 1.199462503s)","trace[1289588685] 'compare' (duration: 1.285559578s)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:06.124597Z","caller":"traceutil/trace.go:171","msg":"trace[1538875176] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"2.475192378s","start":"2026-06-26T10:17:03.649376Z","end":"2026-06-26T10:17:06.124568Z","steps":["trace[1538875176] 'process raft request' (duration: 2.475010535s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:06.124709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:03.649353Z","time spent":"2.47530616s","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:17:06.124765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:03.63875Z","time spent":"2.485886246s","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:17:06.124856Z","caller":"traceutil/trace.go:171","msg":"trace[1135514311] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:636; }","duration":"2.31163171s","start":"2026-06-26T10:17:03.813203Z","end":"2026-06-26T10:17:06.124835Z","steps":["trace[1135514311] 'read index received' (duration: 1.025042484s)","trace[1135514311] 'applied index is now lower than readState.Index' (duration: 1.286588636s)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:06.124865Z","caller":"traceutil/trace.go:171","msg":"trace[1495002340] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"2.471581831s","start":"2026-06-26T10:17:03.653245Z","end":"2026-06-26T10:17:06.124827Z","steps":["trace[1495002340] 'process raft request' (duration: 2.471257905s)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:06.12494Z","caller":"traceutil/trace.go:171","msg":"trace[1502852868] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"2.433644208s","start":"2026-06-26T10:17:03.691289Z","end":"2026-06-26T10:17:06.124933Z","steps":["trace[1502852868] 'process raft request' (duration: 2.433444085s)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:06.12493Z","caller":"traceutil/trace.go:171","msg":"trace[191889343] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.435197426s","start":"2026-06-26T10:17:04.689709Z","end":"2026-06-26T10:17:06.124907Z","steps":["trace[191889343] 'process raft request' (duration: 1.435087824s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:06.125006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:03.691264Z","time spent":"2.43369441s","remote":"127.0.0.1:38010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T10:17:06.125047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:03.65323Z","time spent":"2.471729224s","remote":"127.0.0.1:37536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:17:06.125052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:04.689683Z","time spent":"1.435295449s","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:17:06.189434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.510518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T10:17:06.189475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.341089638s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-26T10:17:06.189524Z","caller":"traceutil/trace.go:171","msg":"trace[15771008] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"375.661481ms","start":"2026-06-26T10:17:05.813843Z","end":"2026-06-26T10:17:06.189504Z","steps":["trace[15771008] 'agreement among raft nodes before linearized reading' (duration: 375.462286ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:06.189536Z","caller":"traceutil/trace.go:171","msg":"trace[720078098] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:615; }","duration":"2.34117523s","start":"2026-06-26T10:17:03.848344Z","end":"2026-06-26T10:17:06.189519Z","steps":["trace[720078098] 'agreement among raft nodes before linearized reading' (duration: 2.340962185s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:06.189528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.372620483s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-26T10:17:06.18957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:03.848338Z","time spent":"2.341223911s","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T10:17:06.189584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:05.813821Z","time spent":"375.739592ms","remote":"127.0.0.1:37522","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-06-26T10:17:06.189592Z","caller":"traceutil/trace.go:171","msg":"trace[2114315726] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:615; }","duration":"2.372722644s","start":"2026-06-26T10:17:03.816853Z","end":"2026-06-26T10:17:06.189576Z","steps":["trace[2114315726] 'agreement among raft nodes before linearized reading' (duration: 2.372469699s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:06.189635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:03.816842Z","time spent":"2.372779375s","remote":"127.0.0.1:37768","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":"warn","ts":"2026-06-26T10:17:06.189786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.341544777s","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-06-26T10:17:06.189849Z","caller":"traceutil/trace.go:171","msg":"trace[1729537778] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:615; }","duration":"2.341683699s","start":"2026-06-26T10:17:03.848147Z","end":"2026-06-26T10:17:06.189831Z","steps":["trace[1729537778] 'agreement among raft nodes before linearized reading' (duration: 2.341456406s)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:06.189852Z","caller":"traceutil/trace.go:171","msg":"trace[1705669130] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"218.443584ms","start":"2026-06-26T10:17:05.971395Z","end":"2026-06-26T10:17:06.189838Z","steps":["trace[1705669130] 'process raft request' (duration: 217.779742ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:06.189881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:03.848122Z","time spent":"2.341753071s","remote":"127.0.0.1:37768","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-06-26T10:17:06.358188Z","caller":"traceutil/trace.go:171","msg":"trace[104584477] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"163.05924ms","start":"2026-06-26T10:17:06.195106Z","end":"2026-06-26T10:17:06.358165Z","steps":["trace[104584477] 'process raft request' (duration: 120.291538ms)","trace[104584477] 'compare' (duration: 42.67204ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:06.418442Z","caller":"traceutil/trace.go:171","msg":"trace[449056824] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:642; }","duration":"218.037175ms","start":"2026-06-26T10:17:06.200386Z","end":"2026-06-26T10:17:06.418423Z","steps":["trace[449056824] 'read index received' (duration: 115.027793ms)","trace[449056824] 'applied index is now lower than readState.Index' (duration: 103.008672ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:17:06.41858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.175427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:06.41861Z","caller":"traceutil/trace.go:171","msg":"trace[940914766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"218.250669ms","start":"2026-06-26T10:17:06.200352Z","end":"2026-06-26T10:17:06.418602Z","steps":["trace[940914766] 'agreement among raft nodes before linearized reading' (duration: 218.160717ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:06.418938Z","caller":"traceutil/trace.go:171","msg":"trace[2015222682] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"223.752948ms","start":"2026-06-26T10:17:06.195176Z","end":"2026-06-26T10:17:06.418929Z","steps":["trace[2015222682] 'process raft request' (duration: 223.079836ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:06.419276Z","caller":"traceutil/trace.go:171","msg":"trace[1723749897] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"223.967693ms","start":"2026-06-26T10:17:06.195283Z","end":"2026-06-26T10:17:06.419251Z","steps":["trace[1723749897] 'process raft request' (duration: 223.070667ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:06.419623Z","caller":"traceutil/trace.go:171","msg":"trace[480740176] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"223.791018ms","start":"2026-06-26T10:17:06.195775Z","end":"2026-06-26T10:17:06.419566Z","steps":["trace[480740176] 'process raft request' (duration: 222.611387ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:06.691523Z","caller":"traceutil/trace.go:171","msg":"trace[1775400270] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"101.699738ms","start":"2026-06-26T10:17:06.589798Z","end":"2026-06-26T10:17:06.691497Z","steps":["trace[1775400270] 'process raft request' (duration: 101.223119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:07.11198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.01898ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T10:17:07.112197Z","caller":"traceutil/trace.go:171","msg":"trace[1629236854] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"266.749245ms","start":"2026-06-26T10:17:06.8454Z","end":"2026-06-26T10:17:07.11215Z","steps":["trace[1629236854] 'process raft request' (duration: 138.454109ms)","trace[1629236854] 'compare' (duration: 127.913349ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:07.112218Z","caller":"traceutil/trace.go:171","msg":"trace[272330554] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"265.008354ms","start":"2026-06-26T10:17:06.847196Z","end":"2026-06-26T10:17:07.112205Z","steps":["trace[272330554] 'process raft request' (duration: 264.906842ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:07.112426Z","caller":"traceutil/trace.go:171","msg":"trace[1442289869] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"264.231959ms","start":"2026-06-26T10:17:06.848169Z","end":"2026-06-26T10:17:07.112401Z","steps":["trace[1442289869] 'process raft request' (duration: 263.987685ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:08.77285Z","caller":"traceutil/trace.go:171","msg":"trace[959180161] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"518.617655ms","start":"2026-06-26T10:17:08.2542Z","end":"2026-06-26T10:17:08.772818Z","steps":["trace[959180161] 'process raft request' (duration: 518.422531ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:08.772854Z","caller":"traceutil/trace.go:171","msg":"trace[339323559] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"409.689461ms","start":"2026-06-26T10:17:08.363124Z","end":"2026-06-26T10:17:08.772813Z","steps":["trace[339323559] 'read index received' (duration: 409.668791ms)","trace[339323559] 'applied index is now lower than readState.Index' (duration: 17.14µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:17:08.773013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:08.254166Z","time spent":"518.764797ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17412,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:17:08.773256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.103409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-26T10:17:08.773265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.214025ms","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-06-26T10:17:08.773302Z","caller":"traceutil/trace.go:171","msg":"trace[1381076146] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"410.218481ms","start":"2026-06-26T10:17:08.363067Z","end":"2026-06-26T10:17:08.773286Z","steps":["trace[1381076146] 'agreement among raft nodes before linearized reading' (duration: 409.925266ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:08.773344Z","caller":"traceutil/trace.go:171","msg":"trace[975659520] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"350.329587ms","start":"2026-06-26T10:17:08.422981Z","end":"2026-06-26T10:17:08.773311Z","steps":["trace[975659520] 'agreement among raft nodes before linearized reading' (duration: 350.060722ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:08.77336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:08.363045Z","time spent":"410.292852ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T10:17:08.773383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:08.422948Z","time spent":"350.425179ms","remote":"127.0.0.1:37768","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":"warn","ts":"2026-06-26T10:17:08.773376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.619965ms","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-06-26T10:17:08.773499Z","caller":"traceutil/trace.go:171","msg":"trace[588427491] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:632; }","duration":"348.747339ms","start":"2026-06-26T10:17:08.424709Z","end":"2026-06-26T10:17:08.773456Z","steps":["trace[588427491] 'agreement among raft nodes before linearized reading' (duration: 348.384392ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:08.773636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:08.424695Z","time spent":"348.929392ms","remote":"127.0.0.1:37768","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-06-26T10:17:09.554795Z","caller":"traceutil/trace.go:171","msg":"trace[951305361] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"292.067739ms","start":"2026-06-26T10:17:09.262702Z","end":"2026-06-26T10:17:09.55477Z","steps":["trace[951305361] 'process raft request' (duration: 233.703236ms)","trace[951305361] 'compare' (duration: 58.25144ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:10.589612Z","caller":"traceutil/trace.go:171","msg":"trace[1267361492] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"106.681807ms","start":"2026-06-26T10:17:10.482912Z","end":"2026-06-26T10:17:10.589594Z","steps":["trace[1267361492] 'process raft request' (duration: 106.565935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:10.879632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.900227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T10:17:10.87975Z","caller":"traceutil/trace.go:171","msg":"trace[1385048400] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"220.838326ms","start":"2026-06-26T10:17:10.658879Z","end":"2026-06-26T10:17:10.879717Z","steps":["trace[1385048400] 'process raft request' (duration: 38.808067ms)","trace[1385048400] 'compare' (duration: 181.799646ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:11.097143Z","caller":"traceutil/trace.go:171","msg":"trace[30797039] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"213.705172ms","start":"2026-06-26T10:17:10.883402Z","end":"2026-06-26T10:17:11.097107Z","steps":["trace[30797039] 'process raft request' (duration: 213.496008ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:11.183811Z","caller":"traceutil/trace.go:171","msg":"trace[109577797] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"300.038437ms","start":"2026-06-26T10:17:10.88375Z","end":"2026-06-26T10:17:11.183788Z","steps":["trace[109577797] 'process raft request' (duration: 299.980045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:11.183988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:10.883648Z","time spent":"300.23538ms","remote":"127.0.0.1:37768","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-06-26T10:17:11.184118Z","caller":"traceutil/trace.go:171","msg":"trace[270938946] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"300.572195ms","start":"2026-06-26T10:17:10.883535Z","end":"2026-06-26T10:17:11.184107Z","steps":["trace[270938946] 'process raft request' (duration: 291.716547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:11.184187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:10.88352Z","time spent":"300.634367ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:17:11.881464Z","caller":"traceutil/trace.go:171","msg":"trace[1642582644] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"124.021238ms","start":"2026-06-26T10:17:11.757406Z","end":"2026-06-26T10:17:11.881427Z","steps":["trace[1642582644] 'process raft request' (duration: 123.874136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:12.671677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.947875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-x84jm\" ","response":"range_response_count:1 size:17786"} {"level":"warn","ts":"2026-06-26T10:17:12.671678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.071024ms","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-06-26T10:17:12.671691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.650352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:12.67175Z","caller":"traceutil/trace.go:171","msg":"trace[2073516030] range","detail":"{range_begin:/registry/pods/kube-system/cilium-x84jm; range_end:; response_count:1; response_revision:647; }","duration":"405.099868ms","start":"2026-06-26T10:17:12.266631Z","end":"2026-06-26T10:17:12.671731Z","steps":["trace[2073516030] 'range keys from in-memory index tree' (duration: 404.734552ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:12.671761Z","caller":"traceutil/trace.go:171","msg":"trace[499183095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:647; }","duration":"452.215247ms","start":"2026-06-26T10:17:12.219529Z","end":"2026-06-26T10:17:12.671744Z","steps":["trace[499183095] 'range keys from in-memory index tree' (duration: 451.864681ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:12.671774Z","caller":"traceutil/trace.go:171","msg":"trace[2098462781] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:647; }","duration":"449.790444ms","start":"2026-06-26T10:17:12.221965Z","end":"2026-06-26T10:17:12.671756Z","steps":["trace[2098462781] 'count revisions from in-memory index tree' (duration: 449.57547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:12.671796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:12.266594Z","time spent":"405.19244ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17809,"request content":"key:\"/registry/pods/kube-system/cilium-x84jm\" "} {"level":"warn","ts":"2026-06-26T10:17:12.671819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:12.2195Z","time spent":"452.297298ms","remote":"127.0.0.1:37768","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":"warn","ts":"2026-06-26T10:17:12.671829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:12.221952Z","time spent":"449.856475ms","remote":"127.0.0.1:37894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"info","ts":"2026-06-26T10:17:12.831974Z","caller":"traceutil/trace.go:171","msg":"trace[1375561146] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"147.452687ms","start":"2026-06-26T10:17:12.684499Z","end":"2026-06-26T10:17:12.831952Z","steps":["trace[1375561146] 'process raft request' (duration: 147.257583ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:13.484401Z","caller":"traceutil/trace.go:171","msg":"trace[604729054] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"206.23207ms","start":"2026-06-26T10:17:13.278122Z","end":"2026-06-26T10:17:13.484354Z","steps":["trace[604729054] 'process raft request' (duration: 196.372925ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:13.491845Z","caller":"traceutil/trace.go:171","msg":"trace[107500118] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"204.384056ms","start":"2026-06-26T10:17:13.287412Z","end":"2026-06-26T10:17:13.491796Z","steps":["trace[107500118] 'process raft request' (duration: 204.098932ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:14.613354Z","caller":"traceutil/trace.go:171","msg":"trace[950126915] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:687; }","duration":"323.68693ms","start":"2026-06-26T10:17:14.28955Z","end":"2026-06-26T10:17:14.613237Z","steps":["trace[950126915] 'read index received' (duration: 323.440096ms)","trace[950126915] 'applied index is now lower than readState.Index' (duration: 245.424µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:14.613356Z","caller":"traceutil/trace.go:171","msg":"trace[168782853] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"416.946048ms","start":"2026-06-26T10:17:14.196357Z","end":"2026-06-26T10:17:14.613303Z","steps":["trace[168782853] 'process raft request' (duration: 416.723394ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:14.613541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.970984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-x84jm\" ","response":"range_response_count:1 size:18063"} {"level":"warn","ts":"2026-06-26T10:17:14.613593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.6193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:14.61367Z","caller":"traceutil/trace.go:171","msg":"trace[2142075826] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:658; }","duration":"198.756433ms","start":"2026-06-26T10:17:14.414897Z","end":"2026-06-26T10:17:14.613653Z","steps":["trace[2142075826] 'agreement among raft nodes before linearized reading' (duration: 198.62282ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:14.61361Z","caller":"traceutil/trace.go:171","msg":"trace[597962208] range","detail":"{range_begin:/registry/pods/kube-system/cilium-x84jm; range_end:; response_count:1; response_revision:658; }","duration":"324.093168ms","start":"2026-06-26T10:17:14.289501Z","end":"2026-06-26T10:17:14.613594Z","steps":["trace[597962208] 'agreement among raft nodes before linearized reading' (duration: 323.859993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:14.613745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:14.289481Z","time spent":"324.25515ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18086,"request content":"key:\"/registry/pods/kube-system/cilium-x84jm\" "} {"level":"warn","ts":"2026-06-26T10:17:14.61367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:14.196323Z","time spent":"417.164361ms","remote":"127.0.0.1:37580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:17:15.25507Z","caller":"traceutil/trace.go:171","msg":"trace[1552682637] linearizableReadLoop","detail":"{readStateIndex:689; appliedIndex:688; }","duration":"486.979339ms","start":"2026-06-26T10:17:14.768069Z","end":"2026-06-26T10:17:15.255049Z","steps":["trace[1552682637] 'read index received' (duration: 452.574653ms)","trace[1552682637] 'applied index is now lower than readState.Index' (duration: 34.403836ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:15.255189Z","caller":"traceutil/trace.go:171","msg":"trace[250591561] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"627.917699ms","start":"2026-06-26T10:17:14.627256Z","end":"2026-06-26T10:17:15.255174Z","steps":["trace[250591561] 'process raft request' (duration: 593.512133ms)","trace[250591561] 'compare' (duration: 33.846166ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:17:15.255275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:14.627227Z","time spent":"627.98635ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18232,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:17:15.255389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.247928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T10:17:15.255515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.448678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T10:17:15.255476Z","caller":"traceutil/trace.go:171","msg":"trace[2076012808] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:659; }","duration":"442.390939ms","start":"2026-06-26T10:17:14.813061Z","end":"2026-06-26T10:17:15.255452Z","steps":["trace[2076012808] 'agreement among raft nodes before linearized reading' (duration: 442.241237ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:15.255574Z","caller":"traceutil/trace.go:171","msg":"trace[1174594896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:659; }","duration":"487.549779ms","start":"2026-06-26T10:17:14.768004Z","end":"2026-06-26T10:17:15.255554Z","steps":["trace[1174594896] 'agreement among raft nodes before linearized reading' (duration: 487.381705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:15.255618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:14.767974Z","time spent":"487.632771ms","remote":"127.0.0.1:37768","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":"warn","ts":"2026-06-26T10:17:15.255676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:14.813037Z","time spent":"442.625436ms","remote":"127.0.0.1:37506","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-06-26T10:17:15.607342Z","caller":"traceutil/trace.go:171","msg":"trace[1994483255] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"346.088631ms","start":"2026-06-26T10:17:15.261235Z","end":"2026-06-26T10:17:15.607323Z","steps":["trace[1994483255] 'process raft request' (duration: 346.03058ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:15.607337Z","caller":"traceutil/trace.go:171","msg":"trace[1018505074] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"346.463819ms","start":"2026-06-26T10:17:15.260836Z","end":"2026-06-26T10:17:15.6073Z","steps":["trace[1018505074] 'process raft request' (duration: 346.396098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:15.607461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:15.261194Z","time spent":"346.198023ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:17:15.607502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:15.260823Z","time spent":"346.641432ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:17:15.607319Z","caller":"traceutil/trace.go:171","msg":"trace[2004468952] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"346.799834ms","start":"2026-06-26T10:17:15.260494Z","end":"2026-06-26T10:17:15.607294Z","steps":["trace[2004468952] 'process raft request' (duration: 346.626121ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:15.607606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:15.260475Z","time spent":"347.105749ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:17:15.607741Z","caller":"traceutil/trace.go:171","msg":"trace[1502262406] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:689; }","duration":"343.331974ms","start":"2026-06-26T10:17:15.264395Z","end":"2026-06-26T10:17:15.607727Z","steps":["trace[1502262406] 'read index received' (duration: 62.825726ms)","trace[1502262406] 'applied index is now lower than readState.Index' (duration: 280.504058ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:17:15.608034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.607849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-x84jm\" ","response":"range_response_count:1 size:18247"} {"level":"info","ts":"2026-06-26T10:17:15.608148Z","caller":"traceutil/trace.go:171","msg":"trace[1148395501] range","detail":"{range_begin:/registry/pods/kube-system/cilium-x84jm; range_end:; response_count:1; response_revision:663; }","duration":"343.774421ms","start":"2026-06-26T10:17:15.264349Z","end":"2026-06-26T10:17:15.608123Z","steps":["trace[1148395501] 'agreement among raft nodes before linearized reading' (duration: 343.493727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:15.608211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:15.264334Z","time spent":"343.867552ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18270,"request content":"key:\"/registry/pods/kube-system/cilium-x84jm\" "} {"level":"info","ts":"2026-06-26T10:17:15.611032Z","caller":"traceutil/trace.go:171","msg":"trace[672298343] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"248.972562ms","start":"2026-06-26T10:17:15.362041Z","end":"2026-06-26T10:17:15.611014Z","steps":["trace[672298343] 'process raft request' (duration: 248.500454ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:16.108446Z","caller":"traceutil/trace.go:171","msg":"trace[2114808461] linearizableReadLoop","detail":"{readStateIndex:696; appliedIndex:695; }","duration":"343.50437ms","start":"2026-06-26T10:17:15.764908Z","end":"2026-06-26T10:17:16.108412Z","steps":["trace[2114808461] 'read index received' (duration: 343.225034ms)","trace[2114808461] 'applied index is now lower than readState.Index' (duration: 278.186µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:16.108643Z","caller":"traceutil/trace.go:171","msg":"trace[69247950] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"483.85657ms","start":"2026-06-26T10:17:15.624756Z","end":"2026-06-26T10:17:16.108612Z","steps":["trace[69247950] 'process raft request' (duration: 483.437492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:16.108674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.721183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-26T10:17:16.108723Z","caller":"traceutil/trace.go:171","msg":"trace[1006205864] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:666; }","duration":"343.842235ms","start":"2026-06-26T10:17:15.76487Z","end":"2026-06-26T10:17:16.108712Z","steps":["trace[1006205864] 'agreement among raft nodes before linearized reading' (duration: 343.703533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:16.10876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:15.764848Z","time spent":"343.902146ms","remote":"127.0.0.1:37616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-26T10:17:16.108805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:15.624736Z","time spent":"483.984152ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18318,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:17:16.429116Z","caller":"traceutil/trace.go:171","msg":"trace[260632822] linearizableReadLoop","detail":"{readStateIndex:698; appliedIndex:696; }","duration":"320.55347ms","start":"2026-06-26T10:17:16.108544Z","end":"2026-06-26T10:17:16.429097Z","steps":["trace[260632822] 'read index received' (duration: 287.823666ms)","trace[260632822] 'applied index is now lower than readState.Index' (duration: 32.728854ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:16.429212Z","caller":"traceutil/trace.go:171","msg":"trace[465942900] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"416.767817ms","start":"2026-06-26T10:17:16.012435Z","end":"2026-06-26T10:17:16.429202Z","steps":["trace[465942900] 'process raft request' (duration: 416.585184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:16.429291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.64676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:16.429339Z","caller":"traceutil/trace.go:171","msg":"trace[1055819455] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:668; }","duration":"614.785682ms","start":"2026-06-26T10:17:15.814542Z","end":"2026-06-26T10:17:16.429327Z","steps":["trace[1055819455] 'agreement among raft nodes before linearized reading' (duration: 614.67664ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:16.429361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:15.814521Z","time spent":"614.835433ms","remote":"127.0.0.1:37506","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-06-26T10:17:16.429351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.0124Z","time spent":"416.835208ms","remote":"127.0.0.1:37580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":763,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T10:17:16.429605Z","caller":"traceutil/trace.go:171","msg":"trace[1792339222] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"561.187588ms","start":"2026-06-26T10:17:15.868174Z","end":"2026-06-26T10:17:16.429362Z","steps":["trace[1792339222] 'process raft request' (duration: 528.18099ms)","trace[1792339222] 'compare' (duration: 32.373527ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:17:16.429723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:15.868143Z","time spent":"561.503134ms","remote":"127.0.0.1:37692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4736,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:17:16.463578Z","caller":"traceutil/trace.go:171","msg":"trace[231087711] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"315.115315ms","start":"2026-06-26T10:17:16.148362Z","end":"2026-06-26T10:17:16.463477Z","steps":["trace[231087711] 'process raft request' (duration: 315.009003ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:16.463691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.727176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:16.463714Z","caller":"traceutil/trace.go:171","msg":"trace[477078703] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:669; }","duration":"335.829558ms","start":"2026-06-26T10:17:16.127878Z","end":"2026-06-26T10:17:16.463708Z","steps":["trace[477078703] 'agreement among raft nodes before linearized reading' (duration: 335.788697ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:16.463729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.12785Z","time spent":"335.875329ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T10:17:16.463744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.148333Z","time spent":"315.309128ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:17:16.671488Z","caller":"traceutil/trace.go:171","msg":"trace[1292544430] linearizableReadLoop","detail":"{readStateIndex:701; appliedIndex:700; }","duration":"139.206111ms","start":"2026-06-26T10:17:16.532249Z","end":"2026-06-26T10:17:16.671455Z","steps":["trace[1292544430] 'read index received' (duration: 139.083059ms)","trace[1292544430] 'applied index is now lower than readState.Index' (duration: 121.892µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:16.671514Z","caller":"traceutil/trace.go:171","msg":"trace[108870048] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"198.544792ms","start":"2026-06-26T10:17:16.472938Z","end":"2026-06-26T10:17:16.671483Z","steps":["trace[108870048] 'process raft request' (duration: 198.370899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:16.672353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.490656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-26T10:17:16.672449Z","caller":"traceutil/trace.go:171","msg":"trace[1962428463] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:671; }","duration":"140.236649ms","start":"2026-06-26T10:17:16.532194Z","end":"2026-06-26T10:17:16.672431Z","steps":["trace[1962428463] 'agreement among raft nodes before linearized reading' (duration: 139.376334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:16.999719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.347609ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T10:17:16.99998Z","caller":"traceutil/trace.go:171","msg":"trace[774311628] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"451.012798ms","start":"2026-06-26T10:17:16.548943Z","end":"2026-06-26T10:17:16.999956Z","steps":["trace[774311628] 'process raft request' (duration: 220.329073ms)","trace[774311628] 'compare' (duration: 230.224117ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:17:17.00022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.678608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:17.000451Z","caller":"traceutil/trace.go:171","msg":"trace[1367263485] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:674; }","duration":"464.980083ms","start":"2026-06-26T10:17:16.535433Z","end":"2026-06-26T10:17:17.000413Z","steps":["trace[1367263485] 'agreement among raft nodes before linearized reading' (duration: 464.678817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.000475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.548928Z","time spent":"451.474666ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:17:17.000042Z","caller":"traceutil/trace.go:171","msg":"trace[1761034939] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"322.22323ms","start":"2026-06-26T10:17:16.6778Z","end":"2026-06-26T10:17:17.000023Z","steps":["trace[1761034939] 'process raft request' (duration: 322.097098ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:17.000088Z","caller":"traceutil/trace.go:171","msg":"trace[2040382717] linearizableReadLoop","detail":"{readStateIndex:703; appliedIndex:701; }","duration":"328.478639ms","start":"2026-06-26T10:17:16.671551Z","end":"2026-06-26T10:17:17.00003Z","steps":["trace[2040382717] 'read index received' (duration: 97.817045ms)","trace[2040382717] 'applied index is now lower than readState.Index' (duration: 230.658764ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:17:17.000181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.210257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T10:17:17.000748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.677788Z","time spent":"322.81909ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:17:17.000179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.816388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T10:17:17.000823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.27954ms","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":"warn","ts":"2026-06-26T10:17:17.000847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.798105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-2mrb5\" ","response":"range_response_count:1 size:4884"} {"level":"info","ts":"2026-06-26T10:17:17.000856Z","caller":"traceutil/trace.go:171","msg":"trace[287826580] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:674; }","duration":"466.4957ms","start":"2026-06-26T10:17:16.534344Z","end":"2026-06-26T10:17:17.00084Z","steps":["trace[287826580] 'agreement among raft nodes before linearized reading' (duration: 465.778147ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:17.000933Z","caller":"traceutil/trace.go:171","msg":"trace[1907965397] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-2mrb5; range_end:; response_count:1; response_revision:674; }","duration":"324.912266ms","start":"2026-06-26T10:17:16.676006Z","end":"2026-06-26T10:17:17.000919Z","steps":["trace[1907965397] 'agreement among raft nodes before linearized reading' (duration: 324.714832ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:17.000946Z","caller":"traceutil/trace.go:171","msg":"trace[1176057401] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:674; }","duration":"265.398244ms","start":"2026-06-26T10:17:16.735461Z","end":"2026-06-26T10:17:17.000859Z","steps":["trace[1176057401] 'agreement among raft nodes before linearized reading' (duration: 265.298842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.000972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.675992Z","time spent":"324.969898ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4907,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-2mrb5\" "} {"level":"warn","ts":"2026-06-26T10:17:17.000981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.534291Z","time spent":"466.653533ms","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"warn","ts":"2026-06-26T10:17:17.000212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.57305ms","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-06-26T10:17:17.001076Z","caller":"traceutil/trace.go:171","msg":"trace[913692816] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:674; }","duration":"431.526927ms","start":"2026-06-26T10:17:16.569511Z","end":"2026-06-26T10:17:17.001038Z","steps":["trace[913692816] 'agreement among raft nodes before linearized reading' (duration: 430.644552ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:17.001102Z","caller":"traceutil/trace.go:171","msg":"trace[1128450488] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:674; }","duration":"465.788847ms","start":"2026-06-26T10:17:16.534922Z","end":"2026-06-26T10:17:17.000711Z","steps":["trace[1128450488] 'agreement among raft nodes before linearized reading' (duration: 465.213928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.00121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.534899Z","time spent":"466.293356ms","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"warn","ts":"2026-06-26T10:17:17.000242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.766347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:17.001341Z","caller":"traceutil/trace.go:171","msg":"trace[1041556742] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:674; }","duration":"462.883676ms","start":"2026-06-26T10:17:16.538445Z","end":"2026-06-26T10:17:17.001328Z","steps":["trace[1041556742] 'agreement among raft nodes before linearized reading' (duration: 461.647244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.001389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.538429Z","time spent":"462.946187ms","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-06-26T10:17:17.000238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.204317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:17.001499Z","caller":"traceutil/trace.go:171","msg":"trace[888795344] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:674; }","duration":"462.464378ms","start":"2026-06-26T10:17:16.539016Z","end":"2026-06-26T10:17:17.00148Z","steps":["trace[888795344] 'agreement among raft nodes before linearized reading' (duration: 461.204047ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.001554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.539012Z","time spent":"462.52681ms","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-06-26T10:17:17.000258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.842268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:17.001614Z","caller":"traceutil/trace.go:171","msg":"trace[1200474863] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:0; response_revision:674; }","duration":"467.208762ms","start":"2026-06-26T10:17:16.534388Z","end":"2026-06-26T10:17:17.001597Z","steps":["trace[1200474863] 'agreement among raft nodes before linearized reading' (duration: 465.836258ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.001666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.534382Z","time spent":"467.268034ms","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"info","ts":"2026-06-26T10:17:17.00027Z","caller":"traceutil/trace.go:171","msg":"trace[1077637367] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"346.7017ms","start":"2026-06-26T10:17:16.653552Z","end":"2026-06-26T10:17:17.000254Z","steps":["trace[1077637367] 'process raft request' (duration: 346.269042ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.001768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.653532Z","time spent":"348.182646ms","remote":"127.0.0.1:37580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T10:17:17.000305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.37785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:17.001919Z","caller":"traceutil/trace.go:171","msg":"trace[183139838] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:674; }","duration":"462.997828ms","start":"2026-06-26T10:17:16.538905Z","end":"2026-06-26T10:17:17.001903Z","steps":["trace[183139838] 'agreement among raft nodes before linearized reading' (duration: 461.37542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.002001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.538898Z","time spent":"463.087619ms","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-06-26T10:17:17.000321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.190569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T10:17:17.000328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.737262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:17.002345Z","caller":"traceutil/trace.go:171","msg":"trace[291076508] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:674; }","duration":"465.721116ms","start":"2026-06-26T10:17:16.536575Z","end":"2026-06-26T10:17:17.002296Z","steps":["trace[291076508] 'agreement among raft nodes before linearized reading' (duration: 463.714291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.00055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.535395Z","time spent":"465.105415ms","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"warn","ts":"2026-06-26T10:17:17.002451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.536536Z","time spent":"465.89399ms","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"warn","ts":"2026-06-26T10:17:17.001142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.569493Z","time spent":"431.632969ms","remote":"127.0.0.1:37552","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":"info","ts":"2026-06-26T10:17:17.002835Z","caller":"traceutil/trace.go:171","msg":"trace[429318152] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:674; }","duration":"466.121533ms","start":"2026-06-26T10:17:16.536106Z","end":"2026-06-26T10:17:17.002227Z","steps":["trace[429318152] 'agreement among raft nodes before linearized reading' (duration: 464.190369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.002926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:16.536092Z","time spent":"466.813484ms","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"info","ts":"2026-06-26T10:17:17.633552Z","caller":"traceutil/trace.go:171","msg":"trace[143562591] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"621.84177ms","start":"2026-06-26T10:17:17.01168Z","end":"2026-06-26T10:17:17.633522Z","steps":["trace[143562591] 'process raft request' (duration: 621.634557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.634177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:17.011661Z","time spent":"622.011713ms","remote":"127.0.0.1:37552","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-06-26T10:17:17.651092Z","caller":"traceutil/trace.go:171","msg":"trace[1210580579] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"638.517872ms","start":"2026-06-26T10:17:17.012545Z","end":"2026-06-26T10:17:17.651063Z","steps":["trace[1210580579] 'process raft request' (duration: 638.270318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.651373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:17.012526Z","time spent":"638.681305ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4675,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:17:17.651402Z","caller":"traceutil/trace.go:171","msg":"trace[2016227149] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:704; }","duration":"319.970678ms","start":"2026-06-26T10:17:17.331396Z","end":"2026-06-26T10:17:17.651366Z","steps":["trace[2016227149] 'read index received' (duration: 301.816151ms)","trace[2016227149] 'applied index is now lower than readState.Index' (duration: 18.153617ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:17.651466Z","caller":"traceutil/trace.go:171","msg":"trace[1289559336] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"501.148173ms","start":"2026-06-26T10:17:17.150253Z","end":"2026-06-26T10:17:17.651401Z","steps":["trace[1289559336] 'process raft request' (duration: 500.922288ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:17.651511Z","caller":"traceutil/trace.go:171","msg":"trace[1250726281] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"314.415302ms","start":"2026-06-26T10:17:17.337086Z","end":"2026-06-26T10:17:17.651502Z","steps":["trace[1250726281] 'process raft request' (duration: 314.149237ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:17.651435Z","caller":"traceutil/trace.go:171","msg":"trace[861863706] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"638.558683ms","start":"2026-06-26T10:17:17.012774Z","end":"2026-06-26T10:17:17.651333Z","steps":["trace[861863706] 'process raft request' (duration: 638.216606ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:17.65162Z","caller":"traceutil/trace.go:171","msg":"trace[1976021769] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"110.653562ms","start":"2026-06-26T10:17:17.540876Z","end":"2026-06-26T10:17:17.65153Z","steps":["trace[1976021769] 'process raft request' (duration: 110.434999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.651834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.427626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-26T10:17:17.651912Z","caller":"traceutil/trace.go:171","msg":"trace[631912035] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:680; }","duration":"320.555238ms","start":"2026-06-26T10:17:17.331341Z","end":"2026-06-26T10:17:17.651897Z","steps":["trace[631912035] 'agreement among raft nodes before linearized reading' (duration: 320.312164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.652013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:17.33132Z","time spent":"320.66502ms","remote":"127.0.0.1:37768","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-06-26T10:17:17.653022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:17.337063Z","time spent":"314.478232ms","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T10:17:17.653199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:17.1502Z","time spent":"501.340766ms","remote":"127.0.0.1:37552","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-06-26T10:17:17.653222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:17.012766Z","time spent":"638.856638ms","remote":"127.0.0.1:37580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T10:17:17.719427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.570932ms","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-06-26T10:17:17.71951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.803656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-26T10:17:17.719536Z","caller":"traceutil/trace.go:171","msg":"trace[1129147324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:682; }","duration":"106.745355ms","start":"2026-06-26T10:17:17.612779Z","end":"2026-06-26T10:17:17.719524Z","steps":["trace[1129147324] 'agreement among raft nodes before linearized reading' (duration: 106.506631ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:17.719583Z","caller":"traceutil/trace.go:171","msg":"trace[599631726] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:682; }","duration":"106.929338ms","start":"2026-06-26T10:17:17.612637Z","end":"2026-06-26T10:17:17.719566Z","steps":["trace[599631726] 'agreement among raft nodes before linearized reading' (duration: 106.740075ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.71962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.215716ms","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-06-26T10:17:17.719667Z","caller":"traceutil/trace.go:171","msg":"trace[172433153] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:682; }","duration":"106.276367ms","start":"2026-06-26T10:17:17.613378Z","end":"2026-06-26T10:17:17.719654Z","steps":["trace[172433153] 'agreement among raft nodes before linearized reading' (duration: 105.898731ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:17.798383Z","caller":"traceutil/trace.go:171","msg":"trace[1095069919] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"139.887354ms","start":"2026-06-26T10:17:17.658464Z","end":"2026-06-26T10:17:17.798351Z","steps":["trace[1095069919] 'process raft request' (duration: 136.731328ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:17.798558Z","caller":"traceutil/trace.go:171","msg":"trace[1457499089] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"139.054269ms","start":"2026-06-26T10:17:17.659485Z","end":"2026-06-26T10:17:17.798539Z","steps":["trace[1457499089] 'process raft request' (duration: 138.710482ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:17.798693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.758124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-x84jm\" ","response":"range_response_count:1 size:18333"} {"level":"info","ts":"2026-06-26T10:17:17.798749Z","caller":"traceutil/trace.go:171","msg":"trace[878116713] range","detail":"{range_begin:/registry/pods/kube-system/cilium-x84jm; range_end:; response_count:1; response_revision:685; }","duration":"142.848035ms","start":"2026-06-26T10:17:17.655888Z","end":"2026-06-26T10:17:17.798736Z","steps":["trace[878116713] 'agreement among raft nodes before linearized reading' (duration: 142.667022ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:17.798782Z","caller":"traceutil/trace.go:171","msg":"trace[84950669] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"125.4388ms","start":"2026-06-26T10:17:17.673335Z","end":"2026-06-26T10:17:17.798774Z","steps":["trace[84950669] 'process raft request' (duration: 125.120155ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:18.031125Z","caller":"traceutil/trace.go:171","msg":"trace[499843862] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"127.905252ms","start":"2026-06-26T10:17:17.903195Z","end":"2026-06-26T10:17:18.0311Z","steps":["trace[499843862] 'process raft request' (duration: 127.580237ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:18.118654Z","caller":"traceutil/trace.go:171","msg":"trace[970707301] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"182.383577ms","start":"2026-06-26T10:17:17.936233Z","end":"2026-06-26T10:17:18.118617Z","steps":["trace[970707301] 'process raft request' (duration: 177.533212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:23.158484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.159169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-26T10:17:23.158596Z","caller":"traceutil/trace.go:171","msg":"trace[433661368] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:752; }","duration":"128.326151ms","start":"2026-06-26T10:17:23.030246Z","end":"2026-06-26T10:17:23.158572Z","steps":["trace[433661368] 'range keys from in-memory index tree' (duration: 127.936316ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:29.309366Z","caller":"traceutil/trace.go:171","msg":"trace[959305158] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"178.7627ms","start":"2026-06-26T10:17:29.130543Z","end":"2026-06-26T10:17:29.309306Z","steps":["trace[959305158] 'process raft request' (duration: 178.431944ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:29.503669Z","caller":"traceutil/trace.go:171","msg":"trace[367907986] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"111.399464ms","start":"2026-06-26T10:17:29.392241Z","end":"2026-06-26T10:17:29.50364Z","steps":["trace[367907986] 'process raft request' (duration: 85.956749ms)","trace[367907986] 'compare' (duration: 24.785084ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:17:30.397901Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152005333931460,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T10:17:30.898055Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152005333931460,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T10:17:31.398479Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152005333931460,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T10:17:31.899733Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152005333931460,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T10:17:31.942864Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.235917182s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T10:17:31.943226Z","caller":"traceutil/trace.go:171","msg":"trace[1397499908] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"2.258709893s","start":"2026-06-26T10:17:29.684492Z","end":"2026-06-26T10:17:31.943201Z","steps":["trace[1397499908] 'process raft request' (duration: 2.258564161s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:31.94337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:29.684476Z","time spent":"2.258819115s","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4856,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:17:32.09057Z","caller":"traceutil/trace.go:171","msg":"trace[143941703] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:827; }","duration":"2.193128875s","start":"2026-06-26T10:17:29.89741Z","end":"2026-06-26T10:17:32.090539Z","steps":["trace[143941703] 'read index received' (duration: 2.045692439s)","trace[143941703] 'applied index is now lower than readState.Index' (duration: 147.435166ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:32.090698Z","caller":"traceutil/trace.go:171","msg":"trace[1972608719] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"1.467010982s","start":"2026-06-26T10:17:30.62367Z","end":"2026-06-26T10:17:32.090681Z","steps":["trace[1972608719] 'process raft request' (duration: 1.443499112s)","trace[1972608719] 'compare' (duration: 23.233414ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:17:32.090855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:30.623627Z","time spent":"1.467109033s","remote":"127.0.0.1:37748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:17:32.091008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.193594083s","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-06-26T10:17:32.091072Z","caller":"traceutil/trace.go:171","msg":"trace[1263666767] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:795; }","duration":"2.193662844s","start":"2026-06-26T10:17:29.897388Z","end":"2026-06-26T10:17:32.091051Z","steps":["trace[1263666767] 'agreement among raft nodes before linearized reading' (duration: 2.19341616s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:32.091122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:29.897317Z","time spent":"2.193791406s","remote":"127.0.0.1:37768","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-06-26T10:17:32.128303Z","caller":"traceutil/trace.go:171","msg":"trace[606338229] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"176.560397ms","start":"2026-06-26T10:17:31.951694Z","end":"2026-06-26T10:17:32.128254Z","steps":["trace[606338229] 'process raft request' (duration: 176.387305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:32.128386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.229550049s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-26T10:17:32.128401Z","caller":"traceutil/trace.go:171","msg":"trace[412838499] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"160.147475ms","start":"2026-06-26T10:17:31.968232Z","end":"2026-06-26T10:17:32.12838Z","steps":["trace[412838499] 'process raft request' (duration: 159.947351ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:32.128411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.093228126s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T10:17:32.128487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.313091561s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:32.12851Z","caller":"traceutil/trace.go:171","msg":"trace[1929913677] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"1.313143401s","start":"2026-06-26T10:17:30.81536Z","end":"2026-06-26T10:17:32.128504Z","steps":["trace[1929913677] 'agreement among raft nodes before linearized reading' (duration: 1.313107281s)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:32.128515Z","caller":"traceutil/trace.go:171","msg":"trace[1484471511] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:798; }","duration":"1.093348798s","start":"2026-06-26T10:17:31.035143Z","end":"2026-06-26T10:17:32.128492Z","steps":["trace[1484471511] 'agreement among raft nodes before linearized reading' (duration: 1.093173224s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:32.128576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:31.035085Z","time spent":"1.09347564s","remote":"127.0.0.1:37800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"info","ts":"2026-06-26T10:17:32.128449Z","caller":"traceutil/trace.go:171","msg":"trace[1866083764] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:798; }","duration":"2.22964547s","start":"2026-06-26T10:17:29.898788Z","end":"2026-06-26T10:17:32.128434Z","steps":["trace[1866083764] 'agreement among raft nodes before linearized reading' (duration: 2.229449716s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:32.128627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:29.89878Z","time spent":"2.229843493s","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T10:17:32.128625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.219057774s","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-06-26T10:17:32.12861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.542333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-26T10:17:32.128663Z","caller":"traceutil/trace.go:171","msg":"trace[1064633380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:798; }","duration":"2.219131814s","start":"2026-06-26T10:17:29.90952Z","end":"2026-06-26T10:17:32.128652Z","steps":["trace[1064633380] 'agreement among raft nodes before linearized reading' (duration: 2.219019443s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:32.128693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:29.909501Z","time spent":"2.219184565s","remote":"127.0.0.1:37768","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-06-26T10:17:32.128699Z","caller":"traceutil/trace.go:171","msg":"trace[1941109892] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"799.702126ms","start":"2026-06-26T10:17:31.328975Z","end":"2026-06-26T10:17:32.128677Z","steps":["trace[1941109892] 'agreement among raft nodes before linearized reading' (duration: 799.421382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:32.12875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:31.328943Z","time spent":"799.791907ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T10:17:32.128803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.943753517s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T10:17:32.128835Z","caller":"traceutil/trace.go:171","msg":"trace[166646296] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:798; }","duration":"1.943829448s","start":"2026-06-26T10:17:30.184996Z","end":"2026-06-26T10:17:32.128826Z","steps":["trace[166646296] 'agreement among raft nodes before linearized reading' (duration: 1.943780517s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:32.128533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:30.815343Z","time spent":"1.313184593s","remote":"127.0.0.1:37506","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-06-26T10:17:32.128862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:30.18497Z","time spent":"1.94388449s","remote":"127.0.0.1:37748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":30,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-06-26T10:17:32.128588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.220010989s","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-06-26T10:17:32.128916Z","caller":"traceutil/trace.go:171","msg":"trace[1363230264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"2.220379374s","start":"2026-06-26T10:17:29.908525Z","end":"2026-06-26T10:17:32.128904Z","steps":["trace[1363230264] 'agreement among raft nodes before linearized reading' (duration: 2.220022249s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:32.128948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:29.908499Z","time spent":"2.220440546s","remote":"127.0.0.1:37768","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-06-26T10:17:32.128287Z","caller":"traceutil/trace.go:171","msg":"trace[1309020823] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"176.964954ms","start":"2026-06-26T10:17:31.951276Z","end":"2026-06-26T10:17:32.128241Z","steps":["trace[1309020823] 'process raft request' (duration: 176.556828ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:32.352585Z","caller":"traceutil/trace.go:171","msg":"trace[490618684] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"217.435713ms","start":"2026-06-26T10:17:32.135122Z","end":"2026-06-26T10:17:32.352557Z","steps":["trace[490618684] 'process raft request' (duration: 197.683666ms)","trace[490618684] 'compare' (duration: 19.472822ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:32.352754Z","caller":"traceutil/trace.go:171","msg":"trace[1168834211] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:833; }","duration":"160.990007ms","start":"2026-06-26T10:17:32.191706Z","end":"2026-06-26T10:17:32.352696Z","steps":["trace[1168834211] 'read index received' (duration: 141.106898ms)","trace[1168834211] 'applied index is now lower than readState.Index' (duration: 19.881939ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:32.352827Z","caller":"traceutil/trace.go:171","msg":"trace[1952783174] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"217.30043ms","start":"2026-06-26T10:17:32.135516Z","end":"2026-06-26T10:17:32.352816Z","steps":["trace[1952783174] 'process raft request' (duration: 217.010026ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:32.352904Z","caller":"traceutil/trace.go:171","msg":"trace[690447740] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"217.679966ms","start":"2026-06-26T10:17:32.135216Z","end":"2026-06-26T10:17:32.352896Z","steps":["trace[690447740] 'process raft request' (duration: 217.22952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:32.35298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.256891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:32.352978Z","caller":"traceutil/trace.go:171","msg":"trace[1433160258] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"212.077904ms","start":"2026-06-26T10:17:32.140872Z","end":"2026-06-26T10:17:32.35295Z","steps":["trace[1433160258] 'process raft request' (duration: 211.692568ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:32.353018Z","caller":"traceutil/trace.go:171","msg":"trace[128865988] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:804; }","duration":"161.336252ms","start":"2026-06-26T10:17:32.191671Z","end":"2026-06-26T10:17:32.353007Z","steps":["trace[128865988] 'agreement among raft nodes before linearized reading' (duration: 161.237371ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:32.353345Z","caller":"traceutil/trace.go:171","msg":"trace[1777932964] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"181.693001ms","start":"2026-06-26T10:17:32.171635Z","end":"2026-06-26T10:17:32.353328Z","steps":["trace[1777932964] 'process raft request' (duration: 180.995409ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:33.253745Z","caller":"traceutil/trace.go:171","msg":"trace[557608295] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"154.329128ms","start":"2026-06-26T10:17:33.099382Z","end":"2026-06-26T10:17:33.253712Z","steps":["trace[557608295] 'process raft request' (duration: 154.027644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:33.653866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.427693ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T10:17:33.653976Z","caller":"traceutil/trace.go:171","msg":"trace[1504288239] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"164.464436ms","start":"2026-06-26T10:17:33.489493Z","end":"2026-06-26T10:17:33.653958Z","steps":["trace[1504288239] 'process raft request' (duration: 24.86972ms)","trace[1504288239] 'compare' (duration: 139.023006ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:17:34.273251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.647393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T10:17:34.273333Z","caller":"traceutil/trace.go:171","msg":"trace[2090230953] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:808; }","duration":"135.786776ms","start":"2026-06-26T10:17:34.137528Z","end":"2026-06-26T10:17:34.273315Z","steps":["trace[2090230953] 'count revisions from in-memory index tree' (duration: 135.551421ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:34.466617Z","caller":"traceutil/trace.go:171","msg":"trace[1484744503] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"106.044226ms","start":"2026-06-26T10:17:34.360547Z","end":"2026-06-26T10:17:34.466592Z","steps":["trace[1484744503] 'process raft request' (duration: 27.082856ms)","trace[1484744503] 'compare' (duration: 78.530153ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:34.512114Z","caller":"traceutil/trace.go:171","msg":"trace[1691132076] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"151.346452ms","start":"2026-06-26T10:17:34.360742Z","end":"2026-06-26T10:17:34.512088Z","steps":["trace[1691132076] 'process raft request' (duration: 151.036297ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:34.5123Z","caller":"traceutil/trace.go:171","msg":"trace[424260018] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"151.292831ms","start":"2026-06-26T10:17:34.360998Z","end":"2026-06-26T10:17:34.512291Z","steps":["trace[424260018] 'process raft request' (duration: 150.961695ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:34.512411Z","caller":"traceutil/trace.go:171","msg":"trace[574775363] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"151.198509ms","start":"2026-06-26T10:17:34.361198Z","end":"2026-06-26T10:17:34.512397Z","steps":["trace[574775363] 'process raft request' (duration: 150.804802ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:35.833673Z","caller":"traceutil/trace.go:171","msg":"trace[53761624] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"187.144521ms","start":"2026-06-26T10:17:35.646508Z","end":"2026-06-26T10:17:35.833652Z","steps":["trace[53761624] 'process raft request' (duration: 183.536372ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:36.085713Z","caller":"traceutil/trace.go:171","msg":"trace[318930997] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"155.542659ms","start":"2026-06-26T10:17:35.930135Z","end":"2026-06-26T10:17:36.085678Z","steps":["trace[318930997] 'process raft request' (duration: 132.524452ms)","trace[318930997] 'compare' (duration: 22.847364ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:36.520043Z","caller":"traceutil/trace.go:171","msg":"trace[1020080420] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"164.869588ms","start":"2026-06-26T10:17:36.355148Z","end":"2026-06-26T10:17:36.520018Z","steps":["trace[1020080420] 'process raft request' (duration: 91.942414ms)","trace[1020080420] 'compare' (duration: 72.675999ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:36.736215Z","caller":"traceutil/trace.go:171","msg":"trace[546929469] transaction","detail":"{read_only:false; response_revision:835; number_of_response:1; }","duration":"209.502588ms","start":"2026-06-26T10:17:36.526691Z","end":"2026-06-26T10:17:36.736194Z","steps":["trace[546929469] 'process raft request' (duration: 205.630964ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:36.736341Z","caller":"traceutil/trace.go:171","msg":"trace[1344683595] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"190.600409ms","start":"2026-06-26T10:17:36.545725Z","end":"2026-06-26T10:17:36.736325Z","steps":["trace[1344683595] 'process raft request' (duration: 190.564978ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:36.736393Z","caller":"traceutil/trace.go:171","msg":"trace[75221899] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"209.54883ms","start":"2026-06-26T10:17:36.526814Z","end":"2026-06-26T10:17:36.736363Z","steps":["trace[75221899] 'process raft request' (duration: 209.357186ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:36.736471Z","caller":"traceutil/trace.go:171","msg":"trace[54667594] transaction","detail":"{read_only:false; response_revision:836; number_of_response:1; }","duration":"209.725832ms","start":"2026-06-26T10:17:36.52673Z","end":"2026-06-26T10:17:36.736456Z","steps":["trace[54667594] 'process raft request' (duration: 209.389006ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:36.736562Z","caller":"traceutil/trace.go:171","msg":"trace[311840249] transaction","detail":"{read_only:false; response_revision:838; number_of_response:1; }","duration":"209.033961ms","start":"2026-06-26T10:17:36.527517Z","end":"2026-06-26T10:17:36.736551Z","steps":["trace[311840249] 'process raft request' (duration: 208.701345ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:36.736656Z","caller":"traceutil/trace.go:171","msg":"trace[817927573] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"208.954799ms","start":"2026-06-26T10:17:36.527677Z","end":"2026-06-26T10:17:36.736632Z","steps":["trace[817927573] 'process raft request' (duration: 208.573882ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:36.859416Z","caller":"traceutil/trace.go:171","msg":"trace[937301249] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"100.687177ms","start":"2026-06-26T10:17:36.758707Z","end":"2026-06-26T10:17:36.859395Z","steps":["trace[937301249] 'process raft request' (duration: 99.171253ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:36.863716Z","caller":"traceutil/trace.go:171","msg":"trace[829437068] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"101.423968ms","start":"2026-06-26T10:17:36.762255Z","end":"2026-06-26T10:17:36.863679Z","steps":["trace[829437068] 'process raft request' (duration: 100.25481ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:40.626147Z","caller":"traceutil/trace.go:171","msg":"trace[175138061] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"179.548723ms","start":"2026-06-26T10:17:40.446573Z","end":"2026-06-26T10:17:40.626121Z","steps":["trace[175138061] 'process raft request' (duration: 179.38382ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:40.81646Z","caller":"traceutil/trace.go:171","msg":"trace[407627292] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"174.764186ms","start":"2026-06-26T10:17:40.641674Z","end":"2026-06-26T10:17:40.816438Z","steps":["trace[407627292] 'process raft request' (duration: 79.477703ms)","trace[407627292] 'compare' (duration: 95.14277ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:17:41.085528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.916394ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T10:17:41.085734Z","caller":"traceutil/trace.go:171","msg":"trace[699101111] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"265.062092ms","start":"2026-06-26T10:17:40.820641Z","end":"2026-06-26T10:17:41.085703Z","steps":["trace[699101111] 'process raft request' (duration: 120.843963ms)","trace[699101111] 'compare' (duration: 143.7352ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:17:41.620493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.086127ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T10:17:41.620627Z","caller":"traceutil/trace.go:171","msg":"trace[1477355717] linearizableReadLoop","detail":"{readStateIndex:921; appliedIndex:919; }","duration":"263.564359ms","start":"2026-06-26T10:17:41.35705Z","end":"2026-06-26T10:17:41.620614Z","steps":["trace[1477355717] 'read index received' (duration: 55.451µs)","trace[1477355717] 'applied index is now lower than readState.Index' (duration: 263.508138ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:41.620684Z","caller":"traceutil/trace.go:171","msg":"trace[581173260] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"799.826943ms","start":"2026-06-26T10:17:40.820836Z","end":"2026-06-26T10:17:41.620663Z","steps":["trace[581173260] 'process raft request' (duration: 496.506763ms)","trace[581173260] 'compare' (duration: 302.990966ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:17:41.620703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.664381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:41.620724Z","caller":"traceutil/trace.go:171","msg":"trace[373968594] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:885; }","duration":"263.731001ms","start":"2026-06-26T10:17:41.356986Z","end":"2026-06-26T10:17:41.620717Z","steps":["trace[373968594] 'agreement among raft nodes before linearized reading' (duration: 263.66216ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:17:41.620717Z","caller":"traceutil/trace.go:171","msg":"trace[1308957634] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"799.54284ms","start":"2026-06-26T10:17:40.821154Z","end":"2026-06-26T10:17:41.620697Z","steps":["trace[1308957634] 'process raft request' (duration: 799.411378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:41.620877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:40.820828Z","time spent":"799.894514ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:17:41.620969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:17:40.821136Z","time spent":"799.605411ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T10:17:47.938114Z","caller":"traceutil/trace.go:171","msg":"trace[1425846074] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1009; }","duration":"124.19774ms","start":"2026-06-26T10:17:47.81386Z","end":"2026-06-26T10:17:47.938058Z","steps":["trace[1425846074] 'read index received' (duration: 124.047597ms)","trace[1425846074] 'applied index is now lower than readState.Index' (duration: 149.113µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:17:47.93814Z","caller":"traceutil/trace.go:171","msg":"trace[341432212] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"173.890787ms","start":"2026-06-26T10:17:47.764227Z","end":"2026-06-26T10:17:47.938118Z","steps":["trace[341432212] 'process raft request' (duration: 173.674294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:17:47.938214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.346632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:17:47.938239Z","caller":"traceutil/trace.go:171","msg":"trace[786118067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:973; }","duration":"124.388072ms","start":"2026-06-26T10:17:47.813843Z","end":"2026-06-26T10:17:47.938231Z","steps":["trace[786118067] 'agreement among raft nodes before linearized reading' (duration: 124.329761ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:18:05.1722Z","caller":"traceutil/trace.go:171","msg":"trace[50113140] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"159.570936ms","start":"2026-06-26T10:18:05.012612Z","end":"2026-06-26T10:18:05.172183Z","steps":["trace[50113140] 'process raft request' (duration: 159.118359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:23.671965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.130423ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-06-26T10:19:25.019453Z","caller":"traceutil/trace.go:171","msg":"trace[2114352612] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"124.154127ms","start":"2026-06-26T10:19:24.895264Z","end":"2026-06-26T10:19:25.019418Z","steps":["trace[2114352612] 'process raft request' (duration: 123.885519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:32.563315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.022137ms","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-06-26T10:19:32.563401Z","caller":"traceutil/trace.go:171","msg":"trace[1818136881] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1364; }","duration":"147.168371ms","start":"2026-06-26T10:19:32.416216Z","end":"2026-06-26T10:19:32.563385Z","steps":["trace[1818136881] 'range keys from in-memory index tree' (duration: 146.830981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:48.923512Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152005333933291,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T10:19:49.142655Z","caller":"traceutil/trace.go:171","msg":"trace[273063484] transaction","detail":"{read_only:false; response_revision:1419; number_of_response:1; }","duration":"754.247872ms","start":"2026-06-26T10:19:48.388381Z","end":"2026-06-26T10:19:49.142629Z","steps":["trace[273063484] 'process raft request' (duration: 754.118808ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:49.142803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:48.388357Z","time spent":"754.369716ms","remote":"127.0.0.1:37768","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-06-26T10:19:49.150965Z","caller":"traceutil/trace.go:171","msg":"trace[412608118] linearizableReadLoop","detail":"{readStateIndex:1484; appliedIndex:1482; }","duration":"727.801317ms","start":"2026-06-26T10:19:48.423141Z","end":"2026-06-26T10:19:49.150943Z","steps":["trace[412608118] 'read index received' (duration: 719.341311ms)","trace[412608118] 'applied index is now lower than readState.Index' (duration: 8.458956ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:19:49.151167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.008073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-26T10:19:49.151193Z","caller":"traceutil/trace.go:171","msg":"trace[728872845] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1419; }","duration":"728.084955ms","start":"2026-06-26T10:19:48.423102Z","end":"2026-06-26T10:19:49.151187Z","steps":["trace[728872845] 'agreement among raft nodes before linearized reading' (duration: 727.948601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:49.151213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:48.423081Z","time spent":"728.127607ms","remote":"127.0.0.1:37768","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-06-26T10:19:49.151237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.92341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kubelet-api-admin\" ","response":"range_response_count:1 size:662"} {"level":"info","ts":"2026-06-26T10:19:49.151322Z","caller":"traceutil/trace.go:171","msg":"trace[854539635] range","detail":"{range_begin:/registry/clusterroles/system:kubelet-api-admin; range_end:; response_count:1; response_revision:1419; }","duration":"727.040094ms","start":"2026-06-26T10:19:48.424262Z","end":"2026-06-26T10:19:49.151302Z","steps":["trace[854539635] 'agreement among raft nodes before linearized reading' (duration: 726.860997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:49.151362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:48.424255Z","time spent":"727.097206ms","remote":"127.0.0.1:37860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":685,"request content":"key:\"/registry/clusterroles/system:kubelet-api-admin\" "} {"level":"warn","ts":"2026-06-26T10:19:49.151539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.286598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T10:19:49.151568Z","caller":"traceutil/trace.go:171","msg":"trace[507575119] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1419; }","duration":"336.345ms","start":"2026-06-26T10:19:48.815216Z","end":"2026-06-26T10:19:49.151561Z","steps":["trace[507575119] 'agreement among raft nodes before linearized reading' (duration: 336.302219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:49.151584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:48.815195Z","time spent":"336.386373ms","remote":"127.0.0.1:37506","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-06-26T10:19:49.15173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.16498ms","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-06-26T10:19:49.151757Z","caller":"traceutil/trace.go:171","msg":"trace[1405083267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1419; }","duration":"485.229883ms","start":"2026-06-26T10:19:48.66652Z","end":"2026-06-26T10:19:49.15175Z","steps":["trace[1405083267] 'agreement among raft nodes before linearized reading' (duration: 485.095079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:49.151769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.106642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:coredns\" ","response":"range_response_count:1 size:415"} {"level":"info","ts":"2026-06-26T10:19:49.151822Z","caller":"traceutil/trace.go:171","msg":"trace[1680670525] range","detail":"{range_begin:/registry/clusterrolebindings/system:coredns; range_end:; response_count:1; response_revision:1419; }","duration":"719.168034ms","start":"2026-06-26T10:19:48.432627Z","end":"2026-06-26T10:19:49.151795Z","steps":["trace[1680670525] 'agreement among raft nodes before linearized reading' (duration: 719.099252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:49.151847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:48.432608Z","time spent":"719.233805ms","remote":"127.0.0.1:37874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":438,"request content":"key:\"/registry/clusterrolebindings/system:coredns\" "} {"level":"warn","ts":"2026-06-26T10:19:49.151775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:48.666491Z","time spent":"485.279933ms","remote":"127.0.0.1:37768","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-06-26T10:19:50.399847Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152005333933307,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T10:19:50.402666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096011991s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:monitoring\" ","response":"range_response_count:1 size:634"} {"level":"info","ts":"2026-06-26T10:19:50.402733Z","caller":"traceutil/trace.go:171","msg":"trace[1514924598] range","detail":"{range_begin:/registry/clusterroles/system:monitoring; range_end:; response_count:1; response_revision:1423; }","duration":"1.096107293s","start":"2026-06-26T10:19:49.306608Z","end":"2026-06-26T10:19:50.402715Z","steps":["trace[1514924598] 'range keys from in-memory index tree' (duration: 1.095944018s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:50.402755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:49.306593Z","time spent":"1.096157495s","remote":"127.0.0.1:37860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":657,"request content":"key:\"/registry/clusterroles/system:monitoring\" "} {"level":"warn","ts":"2026-06-26T10:19:50.402965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.905108ms","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-06-26T10:19:50.403023Z","caller":"traceutil/trace.go:171","msg":"trace[284944664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1423; }","duration":"883.97648ms","start":"2026-06-26T10:19:49.519014Z","end":"2026-06-26T10:19:50.40299Z","steps":["trace[284944664] 'range keys from in-memory index tree' (duration: 883.567098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:50.403051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:49.518992Z","time spent":"884.051924ms","remote":"127.0.0.1:37768","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-06-26T10:19:50.403079Z","caller":"traceutil/trace.go:171","msg":"trace[399948091] linearizableReadLoop","detail":"{readStateIndex:1489; appliedIndex:1488; }","duration":"606.086605ms","start":"2026-06-26T10:19:49.796985Z","end":"2026-06-26T10:19:50.403072Z","steps":["trace[399948091] 'read index received' (duration: 605.993832ms)","trace[399948091] 'applied index is now lower than readState.Index' (duration: 92.233µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T10:19:50.403158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.180739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-26T10:19:50.403183Z","caller":"traceutil/trace.go:171","msg":"trace[510284298] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1424; }","duration":"606.235939ms","start":"2026-06-26T10:19:49.79694Z","end":"2026-06-26T10:19:50.403176Z","steps":["trace[510284298] 'agreement among raft nodes before linearized reading' (duration: 606.157167ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:50.403201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:49.796922Z","time spent":"606.274241ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-26T10:19:50.403332Z","caller":"traceutil/trace.go:171","msg":"trace[1954308589] transaction","detail":"{read_only:false; response_revision:1424; number_of_response:1; }","duration":"730.22323ms","start":"2026-06-26T10:19:49.673102Z","end":"2026-06-26T10:19:50.403326Z","steps":["trace[1954308589] 'process raft request' (duration: 729.889149ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:50.403392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:49.673075Z","time spent":"730.275601ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:19:50.402494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.093667779s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:discovery\" ","response":"range_response_count:1 size:694"} {"level":"info","ts":"2026-06-26T10:19:50.404733Z","caller":"traceutil/trace.go:171","msg":"trace[805572032] range","detail":"{range_begin:/registry/clusterrolebindings/system:discovery; range_end:; response_count:1; response_revision:1423; }","duration":"1.095932828s","start":"2026-06-26T10:19:49.308781Z","end":"2026-06-26T10:19:50.404714Z","steps":["trace[805572032] 'range keys from in-memory index tree' (duration: 1.093593807s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:50.404799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:49.308773Z","time spent":"1.095987529s","remote":"127.0.0.1:37874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":717,"request content":"key:\"/registry/clusterrolebindings/system:discovery\" "} {"level":"warn","ts":"2026-06-26T10:19:51.216795Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152005333933313,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T10:19:51.717382Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152005333933313,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T10:19:51.916039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:51.510627Z","time spent":"405.399439ms","remote":"127.0.0.1:54788","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-26T10:19:51.916656Z","caller":"traceutil/trace.go:171","msg":"trace[1229406261] linearizableReadLoop","detail":"{readStateIndex:1493; appliedIndex:1491; }","duration":"1.200463754s","start":"2026-06-26T10:19:50.716161Z","end":"2026-06-26T10:19:51.916624Z","steps":["trace[1229406261] 'read index received' (duration: 1.19732411s)","trace[1229406261] 'applied index is now lower than readState.Index' (duration: 3.138544ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T10:19:51.916819Z","caller":"traceutil/trace.go:171","msg":"trace[358800462] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"768.593128ms","start":"2026-06-26T10:19:51.148203Z","end":"2026-06-26T10:19:51.916797Z","steps":["trace[358800462] 'process raft request' (duration: 768.34435ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:19:51.916824Z","caller":"traceutil/trace.go:171","msg":"trace[1375659899] transaction","detail":"{read_only:false; response_revision:1427; number_of_response:1; }","duration":"1.232148614s","start":"2026-06-26T10:19:50.684648Z","end":"2026-06-26T10:19:51.916797Z","steps":["trace[1375659899] 'process raft request' (duration: 1.228836694s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:51.916956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:51.148182Z","time spent":"768.682131ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:19:51.917292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.201119665s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:discovery\" ","response":"range_response_count:1 size:694"} {"level":"info","ts":"2026-06-26T10:19:51.917406Z","caller":"traceutil/trace.go:171","msg":"trace[1152370386] range","detail":"{range_begin:/registry/clusterrolebindings/system:discovery; range_end:; response_count:1; response_revision:1428; }","duration":"1.201245589s","start":"2026-06-26T10:19:50.716114Z","end":"2026-06-26T10:19:51.917359Z","steps":["trace[1152370386] 'agreement among raft nodes before linearized reading' (duration: 1.201092854s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:51.91748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:50.716095Z","time spent":"1.201348742s","remote":"127.0.0.1:37874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":717,"request content":"key:\"/registry/clusterrolebindings/system:discovery\" "} {"level":"warn","ts":"2026-06-26T10:19:51.918351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.442573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T10:19:51.918385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.52957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T10:19:51.918376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.397675ms","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-06-26T10:19:51.918489Z","caller":"traceutil/trace.go:171","msg":"trace[831924554] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1428; }","duration":"138.58358ms","start":"2026-06-26T10:19:51.779891Z","end":"2026-06-26T10:19:51.918474Z","steps":["trace[831924554] 'agreement among raft nodes before linearized reading' (duration: 138.437546ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:19:51.918497Z","caller":"traceutil/trace.go:171","msg":"trace[1681548701] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1428; }","duration":"157.619193ms","start":"2026-06-26T10:19:51.760799Z","end":"2026-06-26T10:19:51.918418Z","steps":["trace[1681548701] 'agreement among raft nodes before linearized reading' (duration: 157.50975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:51.918618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.164643ms","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-06-26T10:19:51.918609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.108331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-26T10:19:51.918665Z","caller":"traceutil/trace.go:171","msg":"trace[292908150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1428; }","duration":"746.261616ms","start":"2026-06-26T10:19:51.172389Z","end":"2026-06-26T10:19:51.918651Z","steps":["trace[292908150] 'agreement among raft nodes before linearized reading' (duration: 746.078281ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T10:19:51.918407Z","caller":"traceutil/trace.go:171","msg":"trace[168508075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1428; }","duration":"105.534687ms","start":"2026-06-26T10:19:51.81286Z","end":"2026-06-26T10:19:51.918395Z","steps":["trace[168508075] 'agreement among raft nodes before linearized reading' (duration: 105.461945ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:51.918757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:51.172372Z","time spent":"746.349198ms","remote":"127.0.0.1:37768","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-06-26T10:19:51.918683Z","caller":"traceutil/trace.go:171","msg":"trace[519079135] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1428; }","duration":"745.223375ms","start":"2026-06-26T10:19:51.17344Z","end":"2026-06-26T10:19:51.918663Z","steps":["trace[519079135] 'agreement among raft nodes before linearized reading' (duration: 744.975408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:51.918959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.434642ms","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-06-26T10:19:51.919131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.201252229s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:monitoring\" ","response":"range_response_count:1 size:634"} {"level":"warn","ts":"2026-06-26T10:19:51.919213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:50.68462Z","time spent":"1.232322059s","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T10:19:51.918977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:51.173421Z","time spent":"745.517084ms","remote":"127.0.0.1:37768","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":"info","ts":"2026-06-26T10:19:51.919231Z","caller":"traceutil/trace.go:171","msg":"trace[1539666251] range","detail":"{range_begin:/registry/clusterroles/system:monitoring; range_end:; response_count:1; response_revision:1428; }","duration":"1.201363253s","start":"2026-06-26T10:19:50.717856Z","end":"2026-06-26T10:19:51.919219Z","steps":["trace[1539666251] 'agreement among raft nodes before linearized reading' (duration: 1.200417295s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:51.919518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:50.71785Z","time spent":"1.201576039s","remote":"127.0.0.1:37860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":657,"request content":"key:\"/registry/clusterroles/system:monitoring\" "} {"level":"info","ts":"2026-06-26T10:19:51.919029Z","caller":"traceutil/trace.go:171","msg":"trace[2135927916] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1428; }","duration":"745.527924ms","start":"2026-06-26T10:19:51.173485Z","end":"2026-06-26T10:19:51.919013Z","steps":["trace[2135927916] 'agreement among raft nodes before linearized reading' (duration: 745.228394ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T10:19:51.920007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T10:19:51.173472Z","time spent":"746.520744ms","remote":"127.0.0.1:37768","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\" "}