{"level":"warn","ts":"2026-06-24T00:54:55.847185Z","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-24T00:54:55.84726Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.216: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.216:2380","--initial-cluster=instance=https://199.204.45.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.216: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-24T00:54:55.847318Z","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-24T00:54:55.847326Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-06-24T00:54:55.847341Z","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-24T00:54:55.848Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"]} {"level":"info","ts":"2026-06-24T00:54:55.848138Z","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.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.216: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-24T00:54:55.853879Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.546465ms"} {"level":"info","ts":"2026-06-24T00:54:55.861787Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e98569549cc430c","cluster-id":"65d70b4d1d4a8bf9"} {"level":"info","ts":"2026-06-24T00:54:55.861857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T00:54:55.861885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 0"} {"level":"info","ts":"2026-06-24T00:54:55.8619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e98569549cc430c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T00:54:55.861909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 1"} {"level":"info","ts":"2026-06-24T00:54:55.861949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"warn","ts":"2026-06-24T00:54:55.871222Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T00:54:55.872873Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T00:54:55.874096Z","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-24T00:54:55.877318Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e98569549cc430c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T00:54:55.879204Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e98569549cc430c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T00:54:55.879084Z","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-24T00:54:55.879432Z","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-24T00:54:55.879452Z","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-24T00:54:55.880715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"info","ts":"2026-06-24T00:54:55.880941Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","added-peer-id":"4e98569549cc430c","added-peer-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-06-24T00:54:55.881632Z","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-24T00:54:55.88179Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-06-24T00:54:55.881884Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-06-24T00:54:55.882282Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e98569549cc430c","initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T00:54:55.882308Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T00:54:56.764118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T00:54:56.764169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T00:54:56.764189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgPreVoteResp from 4e98569549cc430c at term 1"} {"level":"info","ts":"2026-06-24T00:54:56.7642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became candidate at term 2"} {"level":"info","ts":"2026-06-24T00:54:56.764205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgVoteResp from 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-06-24T00:54:56.764217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became leader at term 2"} {"level":"info","ts":"2026-06-24T00:54:56.764224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e98569549cc430c elected leader 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-06-24T00:54:56.764971Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:54:56.76609Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e98569549cc430c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.216:2379]}","request-path":"/0/members/4e98569549cc430c/attributes","cluster-id":"65d70b4d1d4a8bf9","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T00:54:56.766138Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T00:54:56.766171Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T00:54:56.766364Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T00:54:56.766447Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-24T00:54:56.766586Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:54:56.766672Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:54:56.766696Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:54:56.768529Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.216:2379"} {"level":"info","ts":"2026-06-24T00:54:56.771317Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-24T00:54:57.151203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.592493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.15131Z","caller":"traceutil/trace.go:171","msg":"trace[597289506] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"199.718824ms","start":"2026-06-24T00:54:56.951579Z","end":"2026-06-24T00:54:57.151297Z","steps":["trace[597289506] 'count revisions from in-memory index tree' (duration: 199.518031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.15132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.917972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.151374Z","caller":"traceutil/trace.go:171","msg":"trace[1338889645] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"148.987033ms","start":"2026-06-24T00:54:57.002372Z","end":"2026-06-24T00:54:57.151359Z","steps":["trace[1338889645] 'count revisions from in-memory index tree' (duration: 148.857771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.151367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.60161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.151445Z","caller":"traceutil/trace.go:171","msg":"trace[1560814906] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"230.720653ms","start":"2026-06-24T00:54:56.920717Z","end":"2026-06-24T00:54:57.151438Z","steps":["trace[1560814906] 'count revisions from in-memory index tree' (duration: 230.525508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.151525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.43332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.151564Z","caller":"traceutil/trace.go:171","msg":"trace[1378441705] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"141.486032ms","start":"2026-06-24T00:54:57.010064Z","end":"2026-06-24T00:54:57.15155Z","steps":["trace[1378441705] 'range keys from in-memory index tree' (duration: 141.39462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.15172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.577423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.151757Z","caller":"traceutil/trace.go:171","msg":"trace[1087994237] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"141.626935ms","start":"2026-06-24T00:54:57.01012Z","end":"2026-06-24T00:54:57.151747Z","steps":["trace[1087994237] 'count revisions from in-memory index tree' (duration: 141.539393ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.151739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.423846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-24T00:54:57.151173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.604653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-24T00:54:57.151873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.238397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.151904Z","caller":"traceutil/trace.go:171","msg":"trace[361743242] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"132.280307ms","start":"2026-06-24T00:54:57.019616Z","end":"2026-06-24T00:54:57.151896Z","steps":["trace[361743242] 'range keys from in-memory index tree' (duration: 132.204017ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:54:57.151857Z","caller":"traceutil/trace.go:171","msg":"trace[1404225887] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"200.307036ms","start":"2026-06-24T00:54:56.951543Z","end":"2026-06-24T00:54:57.15185Z","steps":["trace[1404225887] 'range keys from in-memory index tree' (duration: 199.521511ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:54:57.15184Z","caller":"traceutil/trace.go:171","msg":"trace[1108137499] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"183.529128ms","start":"2026-06-24T00:54:56.968292Z","end":"2026-06-24T00:54:57.151822Z","steps":["trace[1108137499] 'range keys from in-memory index tree' (duration: 183.384026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.152053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.288998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.152123Z","caller":"traceutil/trace.go:171","msg":"trace[99431837] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"132.346629ms","start":"2026-06-24T00:54:57.019739Z","end":"2026-06-24T00:54:57.152086Z","steps":["trace[99431837] 'count revisions from in-memory index tree' (duration: 132.252397ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.152201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.790203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.152252Z","caller":"traceutil/trace.go:171","msg":"trace[1329915852] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"183.859305ms","start":"2026-06-24T00:54:56.968383Z","end":"2026-06-24T00:54:57.152242Z","steps":["trace[1329915852] 'count revisions from in-memory index tree' (duration: 183.656981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.152365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.183162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.152397Z","caller":"traceutil/trace.go:171","msg":"trace[38113638] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"117.216082ms","start":"2026-06-24T00:54:57.035172Z","end":"2026-06-24T00:54:57.152388Z","steps":["trace[38113638] 'count revisions from in-memory index tree' (duration: 117.099249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.152542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.845624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-24T00:54:57.152578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.488457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.152601Z","caller":"traceutil/trace.go:171","msg":"trace[18076780] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"174.917405ms","start":"2026-06-24T00:54:56.977671Z","end":"2026-06-24T00:54:57.152588Z","steps":["trace[18076780] 'count revisions from in-memory index tree' (duration: 174.756383ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.151214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.275839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-24T00:54:57.151244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.096495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-24T00:54:57.15126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.613501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-24T00:54:57.152307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.921578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-24T00:54:57.151162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.274669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-24T00:54:57.151102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.37139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.152813Z","caller":"traceutil/trace.go:171","msg":"trace[1021505520] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"217.9228ms","start":"2026-06-24T00:54:56.934878Z","end":"2026-06-24T00:54:57.152801Z","steps":["trace[1021505520] 'count revisions from in-memory index tree' (duration: 216.150847ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.15118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.768773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.152851Z","caller":"traceutil/trace.go:171","msg":"trace[1248915314] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"261.457456ms","start":"2026-06-24T00:54:56.891387Z","end":"2026-06-24T00:54:57.152845Z","steps":["trace[1248915314] 'count revisions from in-memory index tree' (duration: 259.700762ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:54:57.152867Z","caller":"traceutil/trace.go:171","msg":"trace[154455586] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"125.426217ms","start":"2026-06-24T00:54:57.027361Z","end":"2026-06-24T00:54:57.152788Z","steps":["trace[154455586] 'range keys from in-memory index tree' (duration: 124.848626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.151092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.936342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.153002Z","caller":"traceutil/trace.go:171","msg":"trace[763250424] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"150.870159ms","start":"2026-06-24T00:54:57.002122Z","end":"2026-06-24T00:54:57.152992Z","steps":["trace[763250424] 'range keys from in-memory index tree' (duration: 148.883991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.15116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.4257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.153136Z","caller":"traceutil/trace.go:171","msg":"trace[1366985887] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"277.398988ms","start":"2026-06-24T00:54:56.875728Z","end":"2026-06-24T00:54:57.153127Z","steps":["trace[1366985887] 'range keys from in-memory index tree' (duration: 275.362839ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:54:57.153182Z","caller":"traceutil/trace.go:171","msg":"trace[39094994] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"247.158705ms","start":"2026-06-24T00:54:56.905922Z","end":"2026-06-24T00:54:57.153081Z","steps":["trace[39094994] 'range keys from in-memory index tree' (duration: 245.240998ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:54:57.153333Z","caller":"traceutil/trace.go:171","msg":"trace[938569168] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"247.183615ms","start":"2026-06-24T00:54:56.906143Z","end":"2026-06-24T00:54:57.153326Z","steps":["trace[938569168] 'count revisions from in-memory index tree' (duration: 245.036944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.152255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.832516ms","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:4"} {"level":"info","ts":"2026-06-24T00:54:57.153547Z","caller":"traceutil/trace.go:171","msg":"trace[314074253] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"232.923954ms","start":"2026-06-24T00:54:56.920615Z","end":"2026-06-24T00:54:57.153539Z","steps":["trace[314074253] 'range keys from in-memory index tree' (duration: 230.509549ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:54:57.153533Z","caller":"traceutil/trace.go:171","msg":"trace[1268140258] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"126.088519ms","start":"2026-06-24T00:54:57.0274Z","end":"2026-06-24T00:54:57.153489Z","steps":["trace[1268140258] 'count revisions from in-memory index tree' (duration: 124.815905ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.152332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.260933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.153744Z","caller":"traceutil/trace.go:171","msg":"trace[2145644972] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"118.682ms","start":"2026-06-24T00:54:57.035055Z","end":"2026-06-24T00:54:57.153737Z","steps":["trace[2145644972] 'range keys from in-memory index tree' (duration: 117.234362ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.152779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.141383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-24T00:54:57.15117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.314277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.153994Z","caller":"traceutil/trace.go:171","msg":"trace[388678757] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"278.157901ms","start":"2026-06-24T00:54:56.875828Z","end":"2026-06-24T00:54:57.153986Z","steps":["trace[388678757] 'count revisions from in-memory index tree' (duration: 275.293057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.152671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.952936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.154217Z","caller":"traceutil/trace.go:171","msg":"trace[2016534022] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"176.488785ms","start":"2026-06-24T00:54:56.977681Z","end":"2026-06-24T00:54:57.15417Z","steps":["trace[2016534022] 'range keys from in-memory index tree' (duration: 174.866794ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:54:57.15282Z","caller":"traceutil/trace.go:171","msg":"trace[272834744] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"218.110913ms","start":"2026-06-24T00:54:56.934701Z","end":"2026-06-24T00:54:57.152812Z","steps":["trace[272834744] 'range keys from in-memory index tree' (duration: 216.304279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.152717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.659823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.154513Z","caller":"traceutil/trace.go:171","msg":"trace[913482871] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"163.469179ms","start":"2026-06-24T00:54:56.99103Z","end":"2026-06-24T00:54:57.154499Z","steps":["trace[913482871] 'count revisions from in-memory index tree' (duration: 161.606362ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.152746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.689374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.154669Z","caller":"traceutil/trace.go:171","msg":"trace[2083138733] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"163.630182ms","start":"2026-06-24T00:54:56.991028Z","end":"2026-06-24T00:54:57.154658Z","steps":["trace[2083138733] 'range keys from in-memory index tree' (duration: 161.620713ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:54:57.152622Z","caller":"traceutil/trace.go:171","msg":"trace[2060077371] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"107.556427ms","start":"2026-06-24T00:54:57.045057Z","end":"2026-06-24T00:54:57.152613Z","steps":["trace[2060077371] 'count revisions from in-memory index tree' (duration: 107.430815ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:57.151205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.702712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:57.154849Z","caller":"traceutil/trace.go:171","msg":"trace[719149875] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"263.368152ms","start":"2026-06-24T00:54:56.891473Z","end":"2026-06-24T00:54:57.154841Z","steps":["trace[719149875] 'range keys from in-memory index tree' (duration: 259.646211ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:54:57.154044Z","caller":"traceutil/trace.go:171","msg":"trace[2041669450] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"105.304466ms","start":"2026-06-24T00:54:57.04861Z","end":"2026-06-24T00:54:57.153915Z","steps":["trace[2041669450] 'range keys from in-memory index tree' (duration: 104.097672ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:19.718869Z","caller":"traceutil/trace.go:171","msg":"trace[596725113] linearizableReadLoop","detail":"{readStateIndex:401; appliedIndex:400; }","duration":"211.983973ms","start":"2026-06-24T00:55:19.506862Z","end":"2026-06-24T00:55:19.718846Z","steps":["trace[596725113] 'read index received' (duration: 211.87804ms)","trace[596725113] 'applied index is now lower than readState.Index' (duration: 105.023µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:19.718991Z","caller":"traceutil/trace.go:171","msg":"trace[1278011255] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"376.596872ms","start":"2026-06-24T00:55:19.342382Z","end":"2026-06-24T00:55:19.718979Z","steps":["trace[1278011255] 'process raft request' (duration: 376.321466ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:19.719272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.461302ms","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-24T00:55:19.719354Z","caller":"traceutil/trace.go:171","msg":"trace[2003119029] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:388; }","duration":"212.585044ms","start":"2026-06-24T00:55:19.506747Z","end":"2026-06-24T00:55:19.719332Z","steps":["trace[2003119029] 'agreement among raft nodes before linearized reading' (duration: 212.461612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:19.719557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:19.342366Z","time spent":"376.648852ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:55:19.71962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.891511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"} {"level":"info","ts":"2026-06-24T00:55:19.719659Z","caller":"traceutil/trace.go:171","msg":"trace[797442194] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:388; }","duration":"168.973022ms","start":"2026-06-24T00:55:19.550676Z","end":"2026-06-24T00:55:19.719649Z","steps":["trace[797442194] 'agreement among raft nodes before linearized reading' (duration: 168.435362ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:28.011507Z","caller":"traceutil/trace.go:171","msg":"trace[1712897077] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"144.77148ms","start":"2026-06-24T00:55:27.866713Z","end":"2026-06-24T00:55:28.011485Z","steps":["trace[1712897077] 'process raft request' (duration: 105.587722ms)","trace[1712897077] 'compare' (duration: 39.095516ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:28.440627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.602733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:28.440697Z","caller":"traceutil/trace.go:171","msg":"trace[1317330065] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:438; }","duration":"149.716066ms","start":"2026-06-24T00:55:28.290965Z","end":"2026-06-24T00:55:28.440681Z","steps":["trace[1317330065] 'range keys from in-memory index tree' (duration: 149.513911ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:30.059619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.858708ms","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-24T00:55:30.059725Z","caller":"traceutil/trace.go:171","msg":"trace[1227175000] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:442; }","duration":"193.040021ms","start":"2026-06-24T00:55:29.866667Z","end":"2026-06-24T00:55:30.059707Z","steps":["trace[1227175000] 'range keys from in-memory index tree' (duration: 192.750436ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:32.660717Z","caller":"traceutil/trace.go:171","msg":"trace[1875421847] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"126.35845ms","start":"2026-06-24T00:55:32.534342Z","end":"2026-06-24T00:55:32.660701Z","steps":["trace[1875421847] 'process raft request' (duration: 125.970882ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:33.715444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.062327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:33.715525Z","caller":"traceutil/trace.go:171","msg":"trace[1952237917] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:484; }","duration":"424.186269ms","start":"2026-06-24T00:55:33.291317Z","end":"2026-06-24T00:55:33.715504Z","steps":["trace[1952237917] 'range keys from in-memory index tree' (duration: 423.961175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:33.715564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:33.291298Z","time spent":"424.25649ms","remote":"127.0.0.1:48832","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-24T00:55:33.715664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.307695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:33.715761Z","caller":"traceutil/trace.go:171","msg":"trace[379465389] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:484; }","duration":"838.459428ms","start":"2026-06-24T00:55:32.877279Z","end":"2026-06-24T00:55:33.715738Z","steps":["trace[379465389] 'range keys from in-memory index tree' (duration: 838.155693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:33.715812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:32.877261Z","time spent":"838.54273ms","remote":"127.0.0.1:48920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-06-24T00:55:40.315543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.381123ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-06-24T00:55:40.315653Z","caller":"traceutil/trace.go:171","msg":"trace[251472992] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"618.381342ms","start":"2026-06-24T00:55:39.697255Z","end":"2026-06-24T00:55:40.315637Z","steps":["trace[251472992] 'read index received' (duration: 141.648972ms)","trace[251472992] 'applied index is now lower than readState.Index' (duration: 476.731ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:40.31573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:39.696101Z","time spent":"619.625826ms","remote":"127.0.0.1:48852","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-24T00:55:40.315955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.679028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T00:55:40.316068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.131553ms","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-24T00:55:40.316133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.572771ms","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-24T00:55:40.316163Z","caller":"traceutil/trace.go:171","msg":"trace[1099887186] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:589; }","duration":"193.279627ms","start":"2026-06-24T00:55:40.122865Z","end":"2026-06-24T00:55:40.316144Z","steps":["trace[1099887186] 'agreement among raft nodes before linearized reading' (duration: 193.084672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.316179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.155956ms","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-24T00:55:40.31598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.973966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2ch29\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-24T00:55:40.316223Z","caller":"traceutil/trace.go:171","msg":"trace[260008027] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:589; }","duration":"204.698185ms","start":"2026-06-24T00:55:40.111504Z","end":"2026-06-24T00:55:40.316203Z","steps":["trace[260008027] 'agreement among raft nodes before linearized reading' (duration: 204.5098ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:40.316115Z","caller":"traceutil/trace.go:171","msg":"trace[1013557951] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:589; }","duration":"618.860392ms","start":"2026-06-24T00:55:39.697238Z","end":"2026-06-24T00:55:40.316099Z","steps":["trace[1013557951] 'agreement among raft nodes before linearized reading' (duration: 618.658328ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:40.316299Z","caller":"traceutil/trace.go:171","msg":"trace[1948786521] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:589; }","duration":"480.202757ms","start":"2026-06-24T00:55:39.836014Z","end":"2026-06-24T00:55:40.316216Z","steps":["trace[1948786521] 'agreement among raft nodes before linearized reading' (duration: 480.015323ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:40.316289Z","caller":"traceutil/trace.go:171","msg":"trace[1784039359] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2ch29; range_end:; response_count:1; response_revision:589; }","duration":"616.286774ms","start":"2026-06-24T00:55:39.699966Z","end":"2026-06-24T00:55:40.316252Z","steps":["trace[1784039359] 'agreement among raft nodes before linearized reading' (duration: 615.922846ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.316396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:39.699958Z","time spent":"616.409616ms","remote":"127.0.0.1:49032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-2ch29\" "} {"level":"warn","ts":"2026-06-24T00:55:40.316359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:39.83593Z","time spent":"480.418171ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T00:55:40.316411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:39.697231Z","time spent":"619.101437ms","remote":"127.0.0.1:49396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"info","ts":"2026-06-24T00:55:40.539274Z","caller":"traceutil/trace.go:171","msg":"trace[707650582] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"218.69532ms","start":"2026-06-24T00:55:40.320546Z","end":"2026-06-24T00:55:40.539241Z","steps":["trace[707650582] 'process raft request' (duration: 155.345162ms)","trace[707650582] 'compare' (duration: 63.163264ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:40.539692Z","caller":"traceutil/trace.go:171","msg":"trace[84719233] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"218.65819ms","start":"2026-06-24T00:55:40.32102Z","end":"2026-06-24T00:55:40.539679Z","steps":["trace[84719233] 'process raft request' (duration: 218.166231ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:40.539801Z","caller":"traceutil/trace.go:171","msg":"trace[1863898524] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"218.768302ms","start":"2026-06-24T00:55:40.321023Z","end":"2026-06-24T00:55:40.539792Z","steps":["trace[1863898524] 'process raft request' (duration: 218.556628ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:40.540242Z","caller":"traceutil/trace.go:171","msg":"trace[393951036] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"209.817681ms","start":"2026-06-24T00:55:40.330404Z","end":"2026-06-24T00:55:40.540221Z","steps":["trace[393951036] 'process raft request' (duration: 209.28366ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.540403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.440174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-24T00:55:40.540526Z","caller":"traceutil/trace.go:171","msg":"trace[519294733] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:594; }","duration":"188.595687ms","start":"2026-06-24T00:55:40.351894Z","end":"2026-06-24T00:55:40.540489Z","steps":["trace[519294733] 'agreement among raft nodes before linearized reading' (duration: 188.361762ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:40.54098Z","caller":"traceutil/trace.go:171","msg":"trace[874849328] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:614; }","duration":"187.824851ms","start":"2026-06-24T00:55:40.351928Z","end":"2026-06-24T00:55:40.539753Z","steps":["trace[874849328] 'read index received' (duration: 123.912823ms)","trace[874849328] 'applied index is now lower than readState.Index' (duration: 63.911048ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:41.698415Z","caller":"traceutil/trace.go:171","msg":"trace[1773173861] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"405.975522ms","start":"2026-06-24T00:55:41.292412Z","end":"2026-06-24T00:55:41.698387Z","steps":["trace[1773173861] 'read index received' (duration: 405.050094ms)","trace[1773173861] 'applied index is now lower than readState.Index' (duration: 924.498µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:41.698498Z","caller":"traceutil/trace.go:171","msg":"trace[5367112] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"978.009371ms","start":"2026-06-24T00:55:40.720452Z","end":"2026-06-24T00:55:41.698461Z","steps":["trace[5367112] 'process raft request' (duration: 977.281177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:41.698612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.190316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:41.698648Z","caller":"traceutil/trace.go:171","msg":"trace[719846260] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"406.279987ms","start":"2026-06-24T00:55:41.292357Z","end":"2026-06-24T00:55:41.698637Z","steps":["trace[719846260] 'agreement among raft nodes before linearized reading' (duration: 406.127555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:41.69868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:41.292336Z","time spent":"406.336948ms","remote":"127.0.0.1:48832","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-24T00:55:41.698721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:40.72043Z","time spent":"978.144073ms","remote":"127.0.0.1:48920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:55:43.04367Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483930943,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:55:43.512874Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.28155734s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T00:55:43.51597Z","caller":"traceutil/trace.go:171","msg":"trace[958963092] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:621; }","duration":"972.284212ms","start":"2026-06-24T00:55:42.543581Z","end":"2026-06-24T00:55:43.515865Z","steps":["trace[958963092] 'read index received' (duration: 969.55489ms)","trace[958963092] 'applied index is now lower than readState.Index' (duration: 2.728162ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:43.516206Z","caller":"traceutil/trace.go:171","msg":"trace[78423425] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"1.027767629s","start":"2026-06-24T00:55:42.488342Z","end":"2026-06-24T00:55:43.51611Z","steps":["trace[78423425] 'process raft request' (duration: 1.027417643s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:43.516353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:42.488313Z","time spent":"1.027929593s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:43.516437Z","caller":"traceutil/trace.go:171","msg":"trace[354624200] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"1.286981402s","start":"2026-06-24T00:55:42.229358Z","end":"2026-06-24T00:55:43.51634Z","steps":["trace[354624200] 'process raft request' (duration: 1.284144668s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:43.51661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:42.229332Z","time spent":"1.287192456s","remote":"127.0.0.1:48920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:55:43.516664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.073616ms","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-24T00:55:43.516706Z","caller":"traceutil/trace.go:171","msg":"trace[1009926385] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:599; }","duration":"973.142548ms","start":"2026-06-24T00:55:42.543551Z","end":"2026-06-24T00:55:43.516694Z","steps":["trace[1009926385] 'agreement among raft nodes before linearized reading' (duration: 972.996615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:43.516737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:42.543541Z","time spent":"973.189499ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T00:55:43.516904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.167882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T00:55:43.516939Z","caller":"traceutil/trace.go:171","msg":"trace[1696911345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:599; }","duration":"787.243583ms","start":"2026-06-24T00:55:42.729685Z","end":"2026-06-24T00:55:43.516928Z","steps":["trace[1696911345] 'agreement among raft nodes before linearized reading' (duration: 787.11794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:43.516945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.866314ms","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-24T00:55:43.51697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:42.729668Z","time spent":"787.295044ms","remote":"127.0.0.1:49116","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-24T00:55:43.516916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"972.399774ms","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-24T00:55:43.516998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.419829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:43.517011Z","caller":"traceutil/trace.go:171","msg":"trace[1214477839] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:599; }","duration":"972.043237ms","start":"2026-06-24T00:55:42.544947Z","end":"2026-06-24T00:55:43.516991Z","steps":["trace[1214477839] 'agreement among raft nodes before linearized reading' (duration: 971.868593ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:43.517026Z","caller":"traceutil/trace.go:171","msg":"trace[101224054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:599; }","duration":"972.522256ms","start":"2026-06-24T00:55:42.544488Z","end":"2026-06-24T00:55:43.51701Z","steps":["trace[101224054] 'agreement among raft nodes before linearized reading' (duration: 972.310141ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:43.517031Z","caller":"traceutil/trace.go:171","msg":"trace[591172033] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"225.45291ms","start":"2026-06-24T00:55:43.291569Z","end":"2026-06-24T00:55:43.517021Z","steps":["trace[591172033] 'agreement among raft nodes before linearized reading' (duration: 225.403659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:43.517058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:42.544937Z","time spent":"972.109818ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T00:55:43.517077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:42.544481Z","time spent":"972.586608ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T00:55:45.36074Z","caller":"traceutil/trace.go:171","msg":"trace[1734230824] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"411.64421ms","start":"2026-06-24T00:55:44.949071Z","end":"2026-06-24T00:55:45.360715Z","steps":["trace[1734230824] 'process raft request' (duration: 411.495367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:45.360875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:44.949039Z","time spent":"411.774503ms","remote":"127.0.0.1:48874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:45.366225Z","caller":"traceutil/trace.go:171","msg":"trace[1899032365] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"214.699654ms","start":"2026-06-24T00:55:45.151484Z","end":"2026-06-24T00:55:45.366184Z","steps":["trace[1899032365] 'process raft request' (duration: 214.44608ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:48.110663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.570459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-06-24T00:55:48.11074Z","caller":"traceutil/trace.go:171","msg":"trace[2107999282] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:676; }","duration":"163.698042ms","start":"2026-06-24T00:55:47.947022Z","end":"2026-06-24T00:55:48.11072Z","steps":["trace[2107999282] 'range keys from in-memory index tree' (duration: 163.365885ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:55.035028Z","caller":"traceutil/trace.go:171","msg":"trace[2015076233] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"102.869771ms","start":"2026-06-24T00:55:54.93214Z","end":"2026-06-24T00:55:55.035009Z","steps":["trace[2015076233] 'process raft request' (duration: 102.756309ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:59.404803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.112281531s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:59.404891Z","caller":"traceutil/trace.go:171","msg":"trace[1150432343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:763; }","duration":"1.112408753s","start":"2026-06-24T00:55:58.292457Z","end":"2026-06-24T00:55:59.404866Z","steps":["trace[1150432343] 'range keys from in-memory index tree' (duration: 1.112176569s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:59.404953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:58.292434Z","time spent":"1.112504306s","remote":"127.0.0.1:48832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T00:55:59.406213Z","caller":"traceutil/trace.go:171","msg":"trace[2091620084] linearizableReadLoop","detail":"{readStateIndex:792; appliedIndex:791; }","duration":"465.707702ms","start":"2026-06-24T00:55:58.940487Z","end":"2026-06-24T00:55:59.406194Z","steps":["trace[2091620084] 'read index received' (duration: 462.368309ms)","trace[2091620084] 'applied index is now lower than readState.Index' (duration: 3.338473ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:59.406445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.951556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T00:55:59.406498Z","caller":"traceutil/trace.go:171","msg":"trace[1833952701] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:764; }","duration":"466.009537ms","start":"2026-06-24T00:55:58.940473Z","end":"2026-06-24T00:55:59.406483Z","steps":["trace[1833952701] 'agreement among raft nodes before linearized reading' (duration: 465.807533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:59.406547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:58.940453Z","time spent":"466.081498ms","remote":"127.0.0.1:49116","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-24T00:55:59.406742Z","caller":"traceutil/trace.go:171","msg":"trace[2118018075] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"578.365369ms","start":"2026-06-24T00:55:58.828353Z","end":"2026-06-24T00:55:59.406719Z","steps":["trace[2118018075] 'process raft request' (duration: 574.495596ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:59.406946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:58.828324Z","time spent":"578.516022ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:59.655695Z","caller":"traceutil/trace.go:171","msg":"trace[1399890640] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"244.623945ms","start":"2026-06-24T00:55:59.411053Z","end":"2026-06-24T00:55:59.655677Z","steps":["trace[1399890640] 'process raft request' (duration: 233.846799ms)","trace[1399890640] 'compare' (duration: 10.633014ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:59.655771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.338823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:59.655826Z","caller":"traceutil/trace.go:171","msg":"trace[2023028169] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:765; }","duration":"240.425954ms","start":"2026-06-24T00:55:59.415388Z","end":"2026-06-24T00:55:59.655814Z","steps":["trace[2023028169] 'agreement among raft nodes before linearized reading' (duration: 240.333942ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:59.655661Z","caller":"traceutil/trace.go:171","msg":"trace[690342012] linearizableReadLoop","detail":"{readStateIndex:793; appliedIndex:792; }","duration":"240.226361ms","start":"2026-06-24T00:55:59.415412Z","end":"2026-06-24T00:55:59.655638Z","steps":["trace[690342012] 'read index received' (duration: 229.522856ms)","trace[690342012] 'applied index is now lower than readState.Index' (duration: 10.702615ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:59.656483Z","caller":"traceutil/trace.go:171","msg":"trace[846181846] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"110.204512ms","start":"2026-06-24T00:55:59.546269Z","end":"2026-06-24T00:55:59.656473Z","steps":["trace[846181846] 'process raft request' (duration: 109.944567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:34.334022Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483931707,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:56:34.835176Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483931707,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:56:35.125554Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.356342806s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T00:56:35.125892Z","caller":"traceutil/trace.go:171","msg":"trace[181801386] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"1.356747255s","start":"2026-06-24T00:56:33.769117Z","end":"2026-06-24T00:56:35.125865Z","steps":["trace[181801386] 'process raft request' (duration: 1.356613051s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:35.126022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:33.769099Z","time spent":"1.356854086s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:56:35.149965Z","caller":"traceutil/trace.go:171","msg":"trace[2027986906] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"473.174696ms","start":"2026-06-24T00:56:34.676771Z","end":"2026-06-24T00:56:35.149946Z","steps":["trace[2027986906] 'process raft request' (duration: 472.926702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:35.150075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:34.67675Z","time spent":"473.271499ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:56:35.703268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.40284ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-24T00:56:35.703367Z","caller":"traceutil/trace.go:171","msg":"trace[1812073423] linearizableReadLoop","detail":"{readStateIndex:1019; appliedIndex:1017; }","duration":"1.869559058s","start":"2026-06-24T00:56:33.833791Z","end":"2026-06-24T00:56:35.70335Z","steps":["trace[1812073423] 'read index received' (duration: 1.291988712s)","trace[1812073423] 'applied index is now lower than readState.Index' (duration: 577.568966ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:56:35.704074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.870224361s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T00:56:35.70417Z","caller":"traceutil/trace.go:171","msg":"trace[281244976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:982; }","duration":"1.870406974s","start":"2026-06-24T00:56:33.833741Z","end":"2026-06-24T00:56:35.704148Z","steps":["trace[281244976] 'agreement among raft nodes before linearized reading' (duration: 1.870098298s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:35.704301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:33.833706Z","time spent":"1.870501886s","remote":"127.0.0.1:49116","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-24T00:56:35.704333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.856042104s","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-24T00:56:35.704422Z","caller":"traceutil/trace.go:171","msg":"trace[2133133910] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:982; }","duration":"1.856139926s","start":"2026-06-24T00:56:33.848262Z","end":"2026-06-24T00:56:35.704402Z","steps":["trace[2133133910] 'agreement among raft nodes before linearized reading' (duration: 1.855931082s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:35.704483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:33.848243Z","time spent":"1.856226767s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T00:56:35.704653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.628745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:56:35.704694Z","caller":"traceutil/trace.go:171","msg":"trace[823960752] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:982; }","duration":"340.697167ms","start":"2026-06-24T00:56:35.363986Z","end":"2026-06-24T00:56:35.704683Z","steps":["trace[823960752] 'agreement among raft nodes before linearized reading' (duration: 340.629746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:35.704724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:35.363972Z","time spent":"340.744308ms","remote":"127.0.0.1:49280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:56:35.704907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.733873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:56:35.704945Z","caller":"traceutil/trace.go:171","msg":"trace[80583348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:982; }","duration":"415.803245ms","start":"2026-06-24T00:56:35.289132Z","end":"2026-06-24T00:56:35.704936Z","steps":["trace[80583348] 'agreement among raft nodes before linearized reading' (duration: 415.747284ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:35.704952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.823247915s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:56:35.705014Z","caller":"traceutil/trace.go:171","msg":"trace[1023154274] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:982; }","duration":"1.823344587s","start":"2026-06-24T00:56:33.881656Z","end":"2026-06-24T00:56:35.705Z","steps":["trace[1023154274] 'agreement among raft nodes before linearized reading' (duration: 1.823243385s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:35.705068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:33.88164Z","time spent":"1.823411038s","remote":"127.0.0.1:48920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":9,"response size":29,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:56:35.705073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.852875314s","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-24T00:56:35.705136Z","caller":"traceutil/trace.go:171","msg":"trace[598167230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:982; }","duration":"1.852949225s","start":"2026-06-24T00:56:33.852177Z","end":"2026-06-24T00:56:35.705127Z","steps":["trace[598167230] 'agreement among raft nodes before linearized reading' (duration: 1.852816073s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:35.705173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:33.852171Z","time spent":"1.852993206s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T00:56:35.705161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.855820679s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T00:56:35.705227Z","caller":"traceutil/trace.go:171","msg":"trace[1279526231] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:982; }","duration":"1.855906951s","start":"2026-06-24T00:56:33.849303Z","end":"2026-06-24T00:56:35.70521Z","steps":["trace[1279526231] 'agreement among raft nodes before linearized reading' (duration: 1.855723667s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:35.705287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:33.849296Z","time spent":"1.855979492s","remote":"127.0.0.1:49116","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-24T00:56:35.705242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.855224838s","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-24T00:56:35.705378Z","caller":"traceutil/trace.go:171","msg":"trace[607127963] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:982; }","duration":"1.855376291s","start":"2026-06-24T00:56:33.849975Z","end":"2026-06-24T00:56:35.705351Z","steps":["trace[607127963] 'agreement among raft nodes before linearized reading' (duration: 1.855094766s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:35.705435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:33.849969Z","time spent":"1.855454853s","remote":"127.0.0.1:49116","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-24T00:56:35.70549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.814286836s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T00:56:35.704973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:35.289116Z","time spent":"415.851015ms","remote":"127.0.0.1:48832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T00:56:35.70555Z","caller":"traceutil/trace.go:171","msg":"trace[253576439] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:982; }","duration":"1.814369427s","start":"2026-06-24T00:56:33.891167Z","end":"2026-06-24T00:56:35.705536Z","steps":["trace[253576439] 'agreement among raft nodes before linearized reading' (duration: 1.814273006s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:35.705493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.297435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-24T00:56:35.705538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.190186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:56:35.705696Z","caller":"traceutil/trace.go:171","msg":"trace[800824112] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:982; }","duration":"527.374309ms","start":"2026-06-24T00:56:35.178303Z","end":"2026-06-24T00:56:35.705677Z","steps":["trace[800824112] 'agreement among raft nodes before linearized reading' (duration: 527.187906ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:35.70576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:35.17829Z","time spent":"527.451341ms","remote":"127.0.0.1:49396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:56:35.7056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:33.891159Z","time spent":"1.814428599s","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"info","ts":"2026-06-24T00:56:35.705776Z","caller":"traceutil/trace.go:171","msg":"trace[580804784] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:982; }","duration":"986.626283ms","start":"2026-06-24T00:56:34.719033Z","end":"2026-06-24T00:56:35.705659Z","steps":["trace[580804784] 'agreement among raft nodes before linearized reading' (duration: 985.892898ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:35.705959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:34.719017Z","time spent":"986.912618ms","remote":"127.0.0.1:49412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":29,"response size":29,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"info","ts":"2026-06-24T00:56:36.017478Z","caller":"traceutil/trace.go:171","msg":"trace[780135860] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"306.43792ms","start":"2026-06-24T00:56:35.711017Z","end":"2026-06-24T00:56:36.017455Z","steps":["trace[780135860] 'process raft request' (duration: 306.240736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:36.017674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:35.711002Z","time spent":"306.550104ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:56:36.104764Z","caller":"traceutil/trace.go:171","msg":"trace[863176595] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"392.301841ms","start":"2026-06-24T00:56:35.712428Z","end":"2026-06-24T00:56:36.10473Z","steps":["trace[863176595] 'process raft request' (duration: 392.018294ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:36.104792Z","caller":"traceutil/trace.go:171","msg":"trace[1125077428] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"392.198978ms","start":"2026-06-24T00:56:35.712556Z","end":"2026-06-24T00:56:36.104755Z","steps":["trace[1125077428] 'process raft request' (duration: 392.027165ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:36.10487Z","caller":"traceutil/trace.go:171","msg":"trace[224569811] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"392.079066ms","start":"2026-06-24T00:56:35.71277Z","end":"2026-06-24T00:56:36.104849Z","steps":["trace[224569811] 'process raft request' (duration: 391.880172ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:36.104766Z","caller":"traceutil/trace.go:171","msg":"trace[875216500] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"392.141948ms","start":"2026-06-24T00:56:35.712599Z","end":"2026-06-24T00:56:36.104741Z","steps":["trace[875216500] 'process raft request' (duration: 392.021216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:36.104954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:35.712409Z","time spent":"392.450724ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:56:36.104991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:35.712759Z","time spent":"392.162118ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:56:36.105011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:35.712544Z","time spent":"392.324021ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:56:36.105055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:35.712588Z","time spent":"392.372622ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:56:48.667281Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483931815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:56:49.16743Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483931815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:56:49.707739Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483931815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:56:50.208553Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483931815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:56:50.292439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000265895s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-24T00:56:50.292498Z","caller":"traceutil/trace.go:171","msg":"trace[209153914] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000360406s","start":"2026-06-24T00:56:48.292124Z","end":"2026-06-24T00:56:50.292485Z","steps":["trace[209153914] 'agreement among raft nodes before linearized reading' (duration: 2.000289395s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:50.292541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:48.292118Z","time spent":"2.000407898s","remote":"127.0.0.1:48832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T00:56:50.7091Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483931815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:56:51.210045Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483931815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:56:51.513366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000326146s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-24T00:56:51.513445Z","caller":"traceutil/trace.go:171","msg":"trace[343473740] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000468328s","start":"2026-06-24T00:56:49.512963Z","end":"2026-06-24T00:56:51.513431Z","steps":["trace[343473740] 'agreement among raft nodes before linearized reading' (duration: 2.000372446s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:51.513491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:49.512929Z","time spent":"2.000551959s","remote":"127.0.0.1:48832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/24 00:56:51 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-24T00:56:51.710691Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483931815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:56:52.211883Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483931815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:56:52.293007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00004231s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-24T00:56:52.293089Z","caller":"traceutil/trace.go:171","msg":"trace[107346588] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000183583s","start":"2026-06-24T00:56:50.292888Z","end":"2026-06-24T00:56:52.293072Z","steps":["trace[107346588] 'agreement among raft nodes before linearized reading' (duration: 2.000076361s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:52.293138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:50.292871Z","time spent":"2.000257714s","remote":"127.0.0.1:48816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/24 00:56:52 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-24T00:56:52.456162Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.382418932s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T00:56:52.45748Z","caller":"traceutil/trace.go:171","msg":"trace[192798911] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"4.383807478s","start":"2026-06-24T00:56:48.073643Z","end":"2026-06-24T00:56:52.45745Z","steps":["trace[192798911] 'process raft request' (duration: 4.382678557s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:52.457685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:48.073623Z","time spent":"4.383976701s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:56:52.46436Z","caller":"traceutil/trace.go:171","msg":"trace[1798622177] linearizableReadLoop","detail":"{readStateIndex:1064; appliedIndex:1061; }","duration":"4.298013191s","start":"2026-06-24T00:56:48.166329Z","end":"2026-06-24T00:56:52.464342Z","steps":["trace[1798622177] 'read index received' (duration: 4.290000939s)","trace[1798622177] 'applied index is now lower than readState.Index' (duration: 8.011262ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:56:52.464379Z","caller":"traceutil/trace.go:171","msg":"trace[1757384506] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"3.293571551s","start":"2026-06-24T00:56:49.170792Z","end":"2026-06-24T00:56:52.464363Z","steps":["trace[1757384506] 'process raft request' (duration: 3.293388328s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:52.464498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:49.170768Z","time spent":"3.293646443s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:56:52.464503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.298162693s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T00:56:52.46453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.288758705s","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-24T00:56:52.464557Z","caller":"traceutil/trace.go:171","msg":"trace[572619588] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1025; }","duration":"4.298273955s","start":"2026-06-24T00:56:48.166272Z","end":"2026-06-24T00:56:52.464545Z","steps":["trace[572619588] 'agreement among raft nodes before linearized reading' (duration: 4.298163063s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:52.464567Z","caller":"traceutil/trace.go:171","msg":"trace[2102538421] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1025; }","duration":"4.288808886s","start":"2026-06-24T00:56:48.175748Z","end":"2026-06-24T00:56:52.464557Z","steps":["trace[2102538421] 'agreement among raft nodes before linearized reading' (duration: 4.288688923s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:52.464593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:48.166249Z","time spent":"4.298336626s","remote":"127.0.0.1:49148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:56:52.464616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:48.175741Z","time spent":"4.288864447s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T00:56:52.464651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.075557774s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:56:52.464685Z","caller":"traceutil/trace.go:171","msg":"trace[469250692] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1025; }","duration":"2.075640486s","start":"2026-06-24T00:56:50.389037Z","end":"2026-06-24T00:56:52.464677Z","steps":["trace[469250692] 'agreement among raft nodes before linearized reading' (duration: 2.075575085s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:52.464715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:50.389012Z","time spent":"2.075695126s","remote":"127.0.0.1:48930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":14,"response size":29,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:56:52.464735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.766635072s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.216\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-24T00:56:52.464759Z","caller":"traceutil/trace.go:171","msg":"trace[1675501152] range","detail":"{range_begin:/registry/masterleases/199.204.45.216; range_end:; response_count:1; response_revision:1025; }","duration":"2.766693022s","start":"2026-06-24T00:56:49.698058Z","end":"2026-06-24T00:56:52.464752Z","steps":["trace[1675501152] 'agreement among raft nodes before linearized reading' (duration: 2.766621501s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:52.464772Z","caller":"traceutil/trace.go:171","msg":"trace[1332170945] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"1.648507428s","start":"2026-06-24T00:56:50.816255Z","end":"2026-06-24T00:56:52.464762Z","steps":["trace[1332170945] 'process raft request' (duration: 1.64802659s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:52.464787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:49.698043Z","time spent":"2.766737633s","remote":"127.0.0.1:48852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.216\" "} {"level":"warn","ts":"2026-06-24T00:56:52.464837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:50.816231Z","time spent":"1.648559329s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:56:52.464905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.030455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:56:52.464966Z","caller":"traceutil/trace.go:171","msg":"trace[1883221895] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1025; }","duration":"163.113077ms","start":"2026-06-24T00:56:52.301842Z","end":"2026-06-24T00:56:52.464955Z","steps":["trace[1883221895] 'agreement among raft nodes before linearized reading' (duration: 163.033975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:52.464994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.012200853s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:56:52.46504Z","caller":"traceutil/trace.go:171","msg":"trace[1157049753] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1025; }","duration":"3.012292836s","start":"2026-06-24T00:56:49.452737Z","end":"2026-06-24T00:56:52.465029Z","steps":["trace[1157049753] 'agreement among raft nodes before linearized reading' (duration: 3.012215724s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:52.465052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.578502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T00:56:52.465074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:49.452717Z","time spent":"3.012348677s","remote":"127.0.0.1:38152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-06-24T00:56:52.46509Z","caller":"traceutil/trace.go:171","msg":"trace[1535584053] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1025; }","duration":"369.642643ms","start":"2026-06-24T00:56:52.095436Z","end":"2026-06-24T00:56:52.465079Z","steps":["trace[1535584053] 'agreement among raft nodes before linearized reading' (duration: 369.590742ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:52.465135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:52.095426Z","time spent":"369.700724ms","remote":"127.0.0.1:48312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:56:52.465145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"767.775434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-24T00:56:52.465172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.243348669s","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-24T00:56:52.465187Z","caller":"traceutil/trace.go:171","msg":"trace[1154330386] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1025; }","duration":"767.847146ms","start":"2026-06-24T00:56:51.697328Z","end":"2026-06-24T00:56:52.465175Z","steps":["trace[1154330386] 'agreement among raft nodes before linearized reading' (duration: 767.785645ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:52.465197Z","caller":"traceutil/trace.go:171","msg":"trace[219686583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1025; }","duration":"4.24338917s","start":"2026-06-24T00:56:48.2218Z","end":"2026-06-24T00:56:52.465189Z","steps":["trace[219686583] 'agreement among raft nodes before linearized reading' (duration: 4.243296948s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:52.465218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:48.221791Z","time spent":"4.24342224s","remote":"127.0.0.1:49116","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-24T00:56:52.465225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:51.697312Z","time spent":"767.903806ms","remote":"127.0.0.1:48294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:56:52.465278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.286131736s","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-24T00:56:52.465316Z","caller":"traceutil/trace.go:171","msg":"trace[2084000780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1025; }","duration":"4.286182427s","start":"2026-06-24T00:56:48.179125Z","end":"2026-06-24T00:56:52.465308Z","steps":["trace[2084000780] 'agreement among raft nodes before linearized reading' (duration: 4.286075335s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:52.465319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.239439575s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-24T00:56:52.465346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:48.179119Z","time spent":"4.286219548s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T00:56:52.465002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.62478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:56:52.464911Z","caller":"traceutil/trace.go:171","msg":"trace[684104622] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"166.589973ms","start":"2026-06-24T00:56:52.298305Z","end":"2026-06-24T00:56:52.464895Z","steps":["trace[684104622] 'process raft request' (duration: 166.007092ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:52.465417Z","caller":"traceutil/trace.go:171","msg":"trace[654612103] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1025; }","duration":"556.08687ms","start":"2026-06-24T00:56:51.909322Z","end":"2026-06-24T00:56:52.465408Z","steps":["trace[654612103] 'agreement among raft nodes before linearized reading' (duration: 555.634311ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:52.465449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:51.909301Z","time spent":"556.140302ms","remote":"127.0.0.1:49252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":29,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-06-24T00:56:52.465348Z","caller":"traceutil/trace.go:171","msg":"trace[1184855691] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1025; }","duration":"4.239481456s","start":"2026-06-24T00:56:48.225861Z","end":"2026-06-24T00:56:52.465343Z","steps":["trace[1184855691] 'agreement among raft nodes before linearized reading' (duration: 4.239418585s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:52.465487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:48.225853Z","time spent":"4.239623948s","remote":"127.0.0.1:49116","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-24T00:56:55.790715Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483931843,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:56:56.290877Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483931843,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:56:56.392352Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.88399197s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T00:56:56.394374Z","caller":"traceutil/trace.go:171","msg":"trace[1182953411] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"1.88607941s","start":"2026-06-24T00:56:54.508266Z","end":"2026-06-24T00:56:56.394345Z","steps":["trace[1182953411] 'process raft request' (duration: 1.884416909s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:56.394534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:54.50825Z","time spent":"1.886192472s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:56:56.396866Z","caller":"traceutil/trace.go:171","msg":"trace[1678317850] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"1.888543467s","start":"2026-06-24T00:56:54.508299Z","end":"2026-06-24T00:56:56.396843Z","steps":["trace[1678317850] 'process raft request' (duration: 1.88821644s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:56.396975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:54.50829Z","time spent":"1.888632588s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:56:56.397142Z","caller":"traceutil/trace.go:171","msg":"trace[1921863469] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"1.887011818s","start":"2026-06-24T00:56:54.510113Z","end":"2026-06-24T00:56:56.397125Z","steps":["trace[1921863469] 'process raft request' (duration: 1.886940836s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:56.39725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:54.510104Z","time spent":"1.887084829s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:56:56.397365Z","caller":"traceutil/trace.go:171","msg":"trace[1788522625] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"1.888247411s","start":"2026-06-24T00:56:54.509105Z","end":"2026-06-24T00:56:56.397353Z","steps":["trace[1788522625] 'process raft request' (duration: 1.887688901s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:56.39751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:54.509085Z","time spent":"1.888383954s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:56:56.400276Z","caller":"traceutil/trace.go:171","msg":"trace[829211246] linearizableReadLoop","detail":"{readStateIndex:1079; appliedIndex:1073; }","duration":"1.109607781s","start":"2026-06-24T00:56:55.290644Z","end":"2026-06-24T00:56:56.400252Z","steps":["trace[829211246] 'read index received' (duration: 1.102003049s)","trace[829211246] 'applied index is now lower than readState.Index' (duration: 7.603782ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:56:56.400457Z","caller":"traceutil/trace.go:171","msg":"trace[866469929] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"708.574767ms","start":"2026-06-24T00:56:55.691868Z","end":"2026-06-24T00:56:56.400443Z","steps":["trace[866469929] 'process raft request' (duration: 708.135809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:56.400559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:55.691849Z","time spent":"708.646788ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:56:56.400583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.100867627s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:56:56.400661Z","caller":"traceutil/trace.go:171","msg":"trace[709080053] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1037; }","duration":"1.100973409s","start":"2026-06-24T00:56:55.29967Z","end":"2026-06-24T00:56:56.400643Z","steps":["trace[709080053] 'agreement among raft nodes before linearized reading' (duration: 1.100849226s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:56.400707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:55.299662Z","time spent":"1.101036311s","remote":"127.0.0.1:48946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":29,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:56:56.400918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.770553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:56:56.400971Z","caller":"traceutil/trace.go:171","msg":"trace[143270851] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1037; }","duration":"265.860945ms","start":"2026-06-24T00:56:56.135092Z","end":"2026-06-24T00:56:56.400953Z","steps":["trace[143270851] 'agreement among raft nodes before linearized reading' (duration: 265.789244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:56.401044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110399407s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:56:56.401084Z","caller":"traceutil/trace.go:171","msg":"trace[1549656615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1037; }","duration":"1.110478548s","start":"2026-06-24T00:56:55.290595Z","end":"2026-06-24T00:56:56.401074Z","steps":["trace[1549656615] 'agreement among raft nodes before linearized reading' (duration: 1.110418997s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:56.401116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:55.290574Z","time spent":"1.110536789s","remote":"127.0.0.1:48832","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-24T00:57:00.76253Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.062184869s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T00:57:00.762921Z","caller":"traceutil/trace.go:171","msg":"trace[761482786] linearizableReadLoop","detail":"{readStateIndex:1088; appliedIndex:1087; }","duration":"471.163259ms","start":"2026-06-24T00:57:00.291734Z","end":"2026-06-24T00:57:00.762898Z","steps":["trace[761482786] 'read index received' (duration: 470.956655ms)","trace[761482786] 'applied index is now lower than readState.Index' (duration: 205.324µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:00.762987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:59.700214Z","time spent":"1.062760849s","remote":"127.0.0.1:48852","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-24T00:57:00.763049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.295101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:00.763081Z","caller":"traceutil/trace.go:171","msg":"trace[1956146055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1045; }","duration":"471.378103ms","start":"2026-06-24T00:57:00.291693Z","end":"2026-06-24T00:57:00.763071Z","steps":["trace[1956146055] 'agreement among raft nodes before linearized reading' (duration: 471.303212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:00.763145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:00.291677Z","time spent":"471.441084ms","remote":"127.0.0.1:48832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T00:57:00.934003Z","caller":"traceutil/trace.go:171","msg":"trace[1234281135] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1088; }","duration":"170.997636ms","start":"2026-06-24T00:57:00.762974Z","end":"2026-06-24T00:57:00.933972Z","steps":["trace[1234281135] 'read index received' (duration: 141.237745ms)","trace[1234281135] 'applied index is now lower than readState.Index' (duration: 29.758671ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:00.934219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.640535ms","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-24T00:57:00.934262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.104589ms","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-24T00:57:00.934298Z","caller":"traceutil/trace.go:171","msg":"trace[195737977] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1046; }","duration":"438.758808ms","start":"2026-06-24T00:57:00.495521Z","end":"2026-06-24T00:57:00.934279Z","steps":["trace[195737977] 'agreement among raft nodes before linearized reading' (duration: 438.476163ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:00.934306Z","caller":"traceutil/trace.go:171","msg":"trace[1200780638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1046; }","duration":"523.206731ms","start":"2026-06-24T00:57:00.411085Z","end":"2026-06-24T00:57:00.934291Z","steps":["trace[1200780638] 'agreement among raft nodes before linearized reading' (duration: 523.040318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:00.934334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:00.495507Z","time spent":"438.817559ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T00:57:00.934347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:00.411068Z","time spent":"523.269742ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T00:57:00.934517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.270662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T00:57:00.934566Z","caller":"traceutil/trace.go:171","msg":"trace[198782671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1046; }","duration":"524.353764ms","start":"2026-06-24T00:57:00.410199Z","end":"2026-06-24T00:57:00.934553Z","steps":["trace[198782671] 'agreement among raft nodes before linearized reading' (duration: 524.227352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:00.934598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:00.410183Z","time spent":"524.408775ms","remote":"127.0.0.1:49116","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-24T00:57:00.934617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.495168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:57:00.934638Z","caller":"traceutil/trace.go:171","msg":"trace[652832508] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1046; }","duration":"311.572029ms","start":"2026-06-24T00:57:00.62306Z","end":"2026-06-24T00:57:00.934632Z","steps":["trace[652832508] 'agreement among raft nodes before linearized reading' (duration: 311.408276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:00.934657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:00.623031Z","time spent":"311.62035ms","remote":"127.0.0.1:49400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":96,"response size":29,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-06-24T00:57:00.93448Z","caller":"traceutil/trace.go:171","msg":"trace[549827977] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"446.76824ms","start":"2026-06-24T00:57:00.48768Z","end":"2026-06-24T00:57:00.934448Z","steps":["trace[549827977] 'process raft request' (duration: 416.514139ms)","trace[549827977] 'compare' (duration: 29.616138ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:00.934891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.771622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T00:57:00.934928Z","caller":"traceutil/trace.go:171","msg":"trace[1660140085] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1046; }","duration":"523.831184ms","start":"2026-06-24T00:57:00.411088Z","end":"2026-06-24T00:57:00.934919Z","steps":["trace[1660140085] 'agreement among raft nodes before linearized reading' (duration: 523.736622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:00.934958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:00.411076Z","time spent":"523.874354ms","remote":"127.0.0.1:49116","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-24T00:57:00.935007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:00.487662Z","time spent":"447.258979ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:00.935257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.809122ms","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-24T00:57:00.935297Z","caller":"traceutil/trace.go:171","msg":"trace[1648588713] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1046; }","duration":"524.882793ms","start":"2026-06-24T00:57:00.410402Z","end":"2026-06-24T00:57:00.935285Z","steps":["trace[1648588713] 'agreement among raft nodes before linearized reading' (duration: 523.861294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:00.935327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:00.410386Z","time spent":"524.934184ms","remote":"127.0.0.1:49116","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-24T00:57:00.952362Z","caller":"traceutil/trace.go:171","msg":"trace[2115602841] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"188.130759ms","start":"2026-06-24T00:57:00.764214Z","end":"2026-06-24T00:57:00.952345Z","steps":["trace[2115602841] 'process raft request' (duration: 188.033488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:00.952552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.250322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:00.952628Z","caller":"traceutil/trace.go:171","msg":"trace[1734842475] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1047; }","duration":"188.392984ms","start":"2026-06-24T00:57:00.764216Z","end":"2026-06-24T00:57:00.952609Z","steps":["trace[1734842475] 'agreement among raft nodes before linearized reading' (duration: 188.200431ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:03.29616Z","caller":"traceutil/trace.go:171","msg":"trace[529116041] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"266.954326ms","start":"2026-06-24T00:57:03.029184Z","end":"2026-06-24T00:57:03.296138Z","steps":["trace[529116041] 'process raft request' (duration: 210.757366ms)","trace[529116041] 'compare' (duration: 56.089758ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:03.550893Z","caller":"traceutil/trace.go:171","msg":"trace[1663654221] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"521.592519ms","start":"2026-06-24T00:57:03.029252Z","end":"2026-06-24T00:57:03.550845Z","steps":["trace[1663654221] 'process raft request' (duration: 483.164645ms)","trace[1663654221] 'compare' (duration: 37.870964ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:03.551057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:03.029224Z","time spent":"521.751973ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:03.551582Z","caller":"traceutil/trace.go:171","msg":"trace[1746896755] linearizableReadLoop","detail":"{readStateIndex:1102; appliedIndex:1098; }","duration":"260.75914ms","start":"2026-06-24T00:57:03.290748Z","end":"2026-06-24T00:57:03.551507Z","steps":["trace[1746896755] 'read index received' (duration: 221.575051ms)","trace[1746896755] 'applied index is now lower than readState.Index' (duration: 39.182269ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:03.551875Z","caller":"traceutil/trace.go:171","msg":"trace[663121344] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"522.490127ms","start":"2026-06-24T00:57:03.029364Z","end":"2026-06-24T00:57:03.551854Z","steps":["trace[663121344] 'process raft request' (duration: 521.420436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:03.551896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.054626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:03.551967Z","caller":"traceutil/trace.go:171","msg":"trace[226492562] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1059; }","duration":"261.247049ms","start":"2026-06-24T00:57:03.290689Z","end":"2026-06-24T00:57:03.551936Z","steps":["trace[226492562] 'agreement among raft nodes before linearized reading' (duration: 260.975654ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:03.552068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:03.029355Z","time spent":"522.576109ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:03.552649Z","caller":"traceutil/trace.go:171","msg":"trace[1381648604] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"523.116889ms","start":"2026-06-24T00:57:03.029509Z","end":"2026-06-24T00:57:03.552626Z","steps":["trace[1381648604] 'process raft request' (duration: 521.878926ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:03.55276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:03.029501Z","time spent":"523.184111ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:03.552802Z","caller":"traceutil/trace.go:171","msg":"trace[1567548020] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"523.200321ms","start":"2026-06-24T00:57:03.029559Z","end":"2026-06-24T00:57:03.55276Z","steps":["trace[1567548020] 'process raft request' (duration: 521.886886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:03.552962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:03.029555Z","time spent":"523.329743ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:05.359812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.167862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:05.359969Z","caller":"traceutil/trace.go:171","msg":"trace[1570257098] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1060; }","duration":"151.383426ms","start":"2026-06-24T00:57:05.208564Z","end":"2026-06-24T00:57:05.359948Z","steps":["trace[1570257098] 'count revisions from in-memory index tree' (duration: 151.092331ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:05.765187Z","caller":"traceutil/trace.go:171","msg":"trace[1176186218] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"128.256331ms","start":"2026-06-24T00:57:05.636906Z","end":"2026-06-24T00:57:05.765162Z","steps":["trace[1176186218] 'process raft request' (duration: 109.088679ms)","trace[1176186218] 'compare' (duration: 18.974578ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:05.765187Z","caller":"traceutil/trace.go:171","msg":"trace[1977393593] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"127.780183ms","start":"2026-06-24T00:57:05.637388Z","end":"2026-06-24T00:57:05.765168Z","steps":["trace[1977393593] 'process raft request' (duration: 127.706021ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:05.765334Z","caller":"traceutil/trace.go:171","msg":"trace[1250944505] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"127.666809ms","start":"2026-06-24T00:57:05.637638Z","end":"2026-06-24T00:57:05.765305Z","steps":["trace[1250944505] 'process raft request' (duration: 127.497156ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:20.093902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:19.702138Z","time spent":"391.759429ms","remote":"127.0.0.1:48852","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-24T00:57:20.09625Z","caller":"traceutil/trace.go:171","msg":"trace[1126718494] linearizableReadLoop","detail":"{readStateIndex:1207; appliedIndex:1207; }","duration":"307.883624ms","start":"2026-06-24T00:57:19.788344Z","end":"2026-06-24T00:57:20.096228Z","steps":["trace[1126718494] 'read index received' (duration: 307.877454ms)","trace[1126718494] 'applied index is now lower than readState.Index' (duration: 5.2µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:20.096421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.3689ms","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-24T00:57:20.096458Z","caller":"traceutil/trace.go:171","msg":"trace[402907041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1158; }","duration":"266.466062ms","start":"2026-06-24T00:57:19.829978Z","end":"2026-06-24T00:57:20.096444Z","steps":["trace[402907041] 'agreement among raft nodes before linearized reading' (duration: 266.33686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:20.09668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.334713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T00:57:20.096708Z","caller":"traceutil/trace.go:171","msg":"trace[610299546] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1158; }","duration":"308.423695ms","start":"2026-06-24T00:57:19.788276Z","end":"2026-06-24T00:57:20.0967Z","steps":["trace[610299546] 'agreement among raft nodes before linearized reading' (duration: 308.344402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:20.096736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:19.788249Z","time spent":"308.477556ms","remote":"127.0.0.1:49116","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-24T00:57:20.096868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.103595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:20.096894Z","caller":"traceutil/trace.go:171","msg":"trace[419604880] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1158; }","duration":"258.159836ms","start":"2026-06-24T00:57:19.838726Z","end":"2026-06-24T00:57:20.096886Z","steps":["trace[419604880] 'agreement among raft nodes before linearized reading' (duration: 258.107125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:20.097081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.930181ms","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-24T00:57:20.097105Z","caller":"traceutil/trace.go:171","msg":"trace[1570302065] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1158; }","duration":"266.970562ms","start":"2026-06-24T00:57:19.830127Z","end":"2026-06-24T00:57:20.097098Z","steps":["trace[1570302065] 'agreement among raft nodes before linearized reading' (duration: 266.898381ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:23.184558Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483932150,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:57:23.68475Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483932150,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:57:24.185219Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483932150,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:57:24.686079Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483932150,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:57:24.710196Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.030618362s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T00:57:24.710532Z","caller":"traceutil/trace.go:171","msg":"trace[265161083] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"2.031009409s","start":"2026-06-24T00:57:22.679497Z","end":"2026-06-24T00:57:24.710506Z","steps":["trace[265161083] 'process raft request' (duration: 2.030858916s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:24.710683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:22.679485Z","time spent":"2.031102891s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:24.729409Z","caller":"traceutil/trace.go:171","msg":"trace[595208258] linearizableReadLoop","detail":"{readStateIndex:1219; appliedIndex:1214; }","duration":"2.045141355s","start":"2026-06-24T00:57:22.684229Z","end":"2026-06-24T00:57:24.729371Z","steps":["trace[595208258] 'read index received' (duration: 2.026206408s)","trace[595208258] 'applied index is now lower than readState.Index' (duration: 18.933507ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:24.729871Z","caller":"traceutil/trace.go:171","msg":"trace[86728752] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"1.550136658s","start":"2026-06-24T00:57:23.179691Z","end":"2026-06-24T00:57:24.729827Z","steps":["trace[86728752] 'process raft request' (duration: 1.549572687s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:24.729987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.045721817s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T00:57:24.730038Z","caller":"traceutil/trace.go:171","msg":"trace[1137420514] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1170; }","duration":"2.045816328s","start":"2026-06-24T00:57:22.684208Z","end":"2026-06-24T00:57:24.730024Z","steps":["trace[1137420514] 'agreement among raft nodes before linearized reading' (duration: 2.045611974s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:24.730076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:22.6842Z","time spent":"2.045866279s","remote":"127.0.0.1:49116","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-24T00:57:24.730079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:23.179658Z","time spent":"1.550300901s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:24.730255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.438739244s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:24.730282Z","caller":"traceutil/trace.go:171","msg":"trace[315496687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1170; }","duration":"1.438802734s","start":"2026-06-24T00:57:23.291471Z","end":"2026-06-24T00:57:24.730273Z","steps":["trace[315496687] 'agreement among raft nodes before linearized reading' (duration: 1.438757044s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:24.730308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:23.291448Z","time spent":"1.438853456s","remote":"127.0.0.1:48832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T00:57:24.730334Z","caller":"traceutil/trace.go:171","msg":"trace[1848793285] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"2.050238521s","start":"2026-06-24T00:57:22.680088Z","end":"2026-06-24T00:57:24.730327Z","steps":["trace[1848793285] 'process raft request' (duration: 2.047867926s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:24.730369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:22.680028Z","time spent":"2.050323613s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:24.730445Z","caller":"traceutil/trace.go:171","msg":"trace[1273838582] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"2.04962944s","start":"2026-06-24T00:57:22.680809Z","end":"2026-06-24T00:57:24.730439Z","steps":["trace[1273838582] 'process raft request' (duration: 2.048366967s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:24.73047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:22.680793Z","time spent":"2.049663051s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:24.730542Z","caller":"traceutil/trace.go:171","msg":"trace[252177503] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"1.642330608s","start":"2026-06-24T00:57:23.088206Z","end":"2026-06-24T00:57:24.730536Z","steps":["trace[252177503] 'process raft request' (duration: 1.641014413s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:24.730541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.781169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T00:57:24.730566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:23.088186Z","time spent":"1.642366419s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:24.73058Z","caller":"traceutil/trace.go:171","msg":"trace[1521473101] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1170; }","duration":"418.860541ms","start":"2026-06-24T00:57:24.311705Z","end":"2026-06-24T00:57:24.730565Z","steps":["trace[1521473101] 'agreement among raft nodes before linearized reading' (duration: 418.79538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:24.730612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:24.311686Z","time spent":"418.916261ms","remote":"127.0.0.1:48342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:57:24.730695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.540093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:24.730721Z","caller":"traceutil/trace.go:171","msg":"trace[549300614] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1170; }","duration":"672.615844ms","start":"2026-06-24T00:57:24.058096Z","end":"2026-06-24T00:57:24.730712Z","steps":["trace[549300614] 'agreement among raft nodes before linearized reading' (duration: 672.554803ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:24.730738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:24.058057Z","time spent":"672.676915ms","remote":"127.0.0.1:38190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:57:24.730935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.215512317s","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-24T00:57:24.730949Z","caller":"traceutil/trace.go:171","msg":"trace[926431991] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1170; }","duration":"1.215556638s","start":"2026-06-24T00:57:23.515388Z","end":"2026-06-24T00:57:24.730944Z","steps":["trace[926431991] 'agreement among raft nodes before linearized reading' (duration: 1.215447716s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:24.730962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:23.515371Z","time spent":"1.215588069s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T00:57:27.126581Z","caller":"traceutil/trace.go:171","msg":"trace[542615772] linearizableReadLoop","detail":"{readStateIndex:1223; appliedIndex:1222; }","duration":"412.065462ms","start":"2026-06-24T00:57:26.71449Z","end":"2026-06-24T00:57:27.126555Z","steps":["trace[542615772] 'read index received' (duration: 411.821088ms)","trace[542615772] 'applied index is now lower than readState.Index' (duration: 243.474µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:27.126696Z","caller":"traceutil/trace.go:171","msg":"trace[311821814] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"478.502066ms","start":"2026-06-24T00:57:26.648164Z","end":"2026-06-24T00:57:27.126666Z","steps":["trace[311821814] 'process raft request' (duration: 478.228151ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:27.126817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:26.648141Z","time spent":"478.610719ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:27.126852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.345588ms","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-24T00:57:27.126891Z","caller":"traceutil/trace.go:171","msg":"trace[790520205] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1173; }","duration":"412.44383ms","start":"2026-06-24T00:57:26.714436Z","end":"2026-06-24T00:57:27.12688Z","steps":["trace[790520205] 'agreement among raft nodes before linearized reading' (duration: 412.261786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:27.126929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:26.714415Z","time spent":"412.505451ms","remote":"127.0.0.1:49116","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-24T00:57:27.142008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.464031ms","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-24T00:57:27.142089Z","caller":"traceutil/trace.go:171","msg":"trace[197795089] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1174; }","duration":"402.562562ms","start":"2026-06-24T00:57:26.739508Z","end":"2026-06-24T00:57:27.14207Z","steps":["trace[197795089] 'agreement among raft nodes before linearized reading' (duration: 402.388109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:27.142112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.381161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-24T00:57:27.142133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:26.739498Z","time spent":"402.625694ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T00:57:27.142165Z","caller":"traceutil/trace.go:171","msg":"trace[939796569] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1174; }","duration":"400.481764ms","start":"2026-06-24T00:57:26.741666Z","end":"2026-06-24T00:57:27.142148Z","steps":["trace[939796569] 'agreement among raft nodes before linearized reading' (duration: 400.387401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:27.142203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:26.741647Z","time spent":"400.548905ms","remote":"127.0.0.1:49116","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-24T00:57:27.141995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.723551ms","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-24T00:57:27.142276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.936586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T00:57:27.142325Z","caller":"traceutil/trace.go:171","msg":"trace[1986690807] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1174; }","duration":"407.14036ms","start":"2026-06-24T00:57:26.735178Z","end":"2026-06-24T00:57:27.142317Z","steps":["trace[1986690807] 'agreement among raft nodes before linearized reading' (duration: 406.64983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:27.142355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:26.73515Z","time spent":"407.19927ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T00:57:27.142366Z","caller":"traceutil/trace.go:171","msg":"trace[1404027491] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1174; }","duration":"407.089908ms","start":"2026-06-24T00:57:26.735256Z","end":"2026-06-24T00:57:27.142346Z","steps":["trace[1404027491] 'agreement among raft nodes before linearized reading' (duration: 406.68567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:27.142421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:26.735231Z","time spent":"407.18075ms","remote":"127.0.0.1:49116","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-24T00:57:27.142603Z","caller":"traceutil/trace.go:171","msg":"trace[2019963256] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"406.07734ms","start":"2026-06-24T00:57:26.736513Z","end":"2026-06-24T00:57:27.14259Z","steps":["trace[2019963256] 'process raft request' (duration: 405.165352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:27.142737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:26.736486Z","time spent":"406.14981ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:27.14281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.397824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:27.142894Z","caller":"traceutil/trace.go:171","msg":"trace[765958148] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1174; }","duration":"156.544047ms","start":"2026-06-24T00:57:26.986319Z","end":"2026-06-24T00:57:27.142863Z","steps":["trace[765958148] 'agreement among raft nodes before linearized reading' (duration: 156.417254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:35.695271Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483932233,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T00:57:36.066148Z","caller":"traceutil/trace.go:171","msg":"trace[2135978467] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"873.111149ms","start":"2026-06-24T00:57:35.193019Z","end":"2026-06-24T00:57:36.06613Z","steps":["trace[2135978467] 'process raft request' (duration: 872.902515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:36.066257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:35.19301Z","time spent":"873.18904ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:36.066359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"871.410127ms","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-24T00:57:36.066404Z","caller":"traceutil/trace.go:171","msg":"trace[1478796376] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1203; }","duration":"871.488668ms","start":"2026-06-24T00:57:35.194904Z","end":"2026-06-24T00:57:36.066393Z","steps":["trace[1478796376] 'agreement among raft nodes before linearized reading' (duration: 871.314115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:36.066437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:35.194892Z","time spent":"871.537809ms","remote":"127.0.0.1:49116","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":"info","ts":"2026-06-24T00:57:36.06616Z","caller":"traceutil/trace.go:171","msg":"trace[1213595974] linearizableReadLoop","detail":"{readStateIndex:1255; appliedIndex:1254; }","duration":"871.158952ms","start":"2026-06-24T00:57:35.194939Z","end":"2026-06-24T00:57:36.066098Z","steps":["trace[1213595974] 'read index received' (duration: 870.47734ms)","trace[1213595974] 'applied index is now lower than readState.Index' (duration: 679.592µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:36.066886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"870.544741ms","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-24T00:57:36.066933Z","caller":"traceutil/trace.go:171","msg":"trace[1681939097] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1203; }","duration":"870.600092ms","start":"2026-06-24T00:57:35.196317Z","end":"2026-06-24T00:57:36.066917Z","steps":["trace[1681939097] 'agreement among raft nodes before linearized reading' (duration: 870.45524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:36.066971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:35.196309Z","time spent":"870.652993ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T00:57:36.066976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.295702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:36.067083Z","caller":"traceutil/trace.go:171","msg":"trace[1549313768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1203; }","duration":"776.433614ms","start":"2026-06-24T00:57:35.29061Z","end":"2026-06-24T00:57:36.067044Z","steps":["trace[1549313768] 'agreement among raft nodes before linearized reading' (duration: 776.267581ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:36.067127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:35.290589Z","time spent":"776.531036ms","remote":"127.0.0.1:48832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T00:57:38.302242Z","caller":"traceutil/trace.go:171","msg":"trace[252632569] linearizableReadLoop","detail":"{readStateIndex:1262; appliedIndex:1261; }","duration":"224.369247ms","start":"2026-06-24T00:57:38.077846Z","end":"2026-06-24T00:57:38.302215Z","steps":["trace[252632569] 'read index received' (duration: 224.128492ms)","trace[252632569] 'applied index is now lower than readState.Index' (duration: 239.275µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:38.302376Z","caller":"traceutil/trace.go:171","msg":"trace[178076295] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"226.759073ms","start":"2026-06-24T00:57:38.075562Z","end":"2026-06-24T00:57:38.302321Z","steps":["trace[178076295] 'process raft request' (duration: 226.433967ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:38.3025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.626832ms","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-24T00:57:38.30255Z","caller":"traceutil/trace.go:171","msg":"trace[1173545167] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1210; }","duration":"224.747545ms","start":"2026-06-24T00:57:38.077789Z","end":"2026-06-24T00:57:38.302537Z","steps":["trace[1173545167] 'agreement among raft nodes before linearized reading' (duration: 224.570131ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:38.347081Z","caller":"traceutil/trace.go:171","msg":"trace[312506521] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"266.812768ms","start":"2026-06-24T00:57:38.080211Z","end":"2026-06-24T00:57:38.347023Z","steps":["trace[312506521] 'process raft request' (duration: 266.584784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:46.924591Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483932345,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T00:57:47.0032Z","caller":"traceutil/trace.go:171","msg":"trace[1255262700] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1309; }","duration":"578.988995ms","start":"2026-06-24T00:57:46.424184Z","end":"2026-06-24T00:57:47.003173Z","steps":["trace[1255262700] 'read index received' (duration: 578.161129ms)","trace[1255262700] 'applied index is now lower than readState.Index' (duration: 826.676µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:47.003333Z","caller":"traceutil/trace.go:171","msg":"trace[1162335775] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"650.336423ms","start":"2026-06-24T00:57:46.352986Z","end":"2026-06-24T00:57:47.003323Z","steps":["trace[1162335775] 'process raft request' (duration: 649.448145ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:47.003486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:46.352955Z","time spent":"650.433745ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:47.003562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.123381ms","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-24T00:57:47.003661Z","caller":"traceutil/trace.go:171","msg":"trace[1725667545] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1256; }","duration":"576.266163ms","start":"2026-06-24T00:57:46.427373Z","end":"2026-06-24T00:57:47.003639Z","steps":["trace[1725667545] 'agreement among raft nodes before linearized reading' (duration: 575.993368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:47.00371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:46.427361Z","time spent":"576.339826ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T00:57:47.003779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.573156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-24T00:57:47.003864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.887537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:57:47.003874Z","caller":"traceutil/trace.go:171","msg":"trace[933325158] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1256; }","duration":"579.741189ms","start":"2026-06-24T00:57:46.424109Z","end":"2026-06-24T00:57:47.00385Z","steps":["trace[933325158] 'agreement among raft nodes before linearized reading' (duration: 579.469734ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:47.003897Z","caller":"traceutil/trace.go:171","msg":"trace[1164375240] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1256; }","duration":"511.972819ms","start":"2026-06-24T00:57:46.491913Z","end":"2026-06-24T00:57:47.003886Z","steps":["trace[1164375240] 'agreement among raft nodes before linearized reading' (duration: 511.916698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:47.00393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:46.424083Z","time spent":"579.837621ms","remote":"127.0.0.1:49116","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-24T00:57:47.003934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:46.491889Z","time spent":"512.036041ms","remote":"127.0.0.1:38272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:57:47.791216Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483932348,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:57:48.291746Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483932348,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:57:48.792768Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483932348,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:57:49.204338Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.195577797s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T00:57:49.27523Z","caller":"traceutil/trace.go:171","msg":"trace[1869608129] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"2.266562876s","start":"2026-06-24T00:57:47.008628Z","end":"2026-06-24T00:57:49.275191Z","steps":["trace[1869608129] 'process raft request' (duration: 2.196009784s)","trace[1869608129] 'compare' (duration: 69.402881ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:49.275419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:47.008605Z","time spent":"2.26671198s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:49.473226Z","caller":"traceutil/trace.go:171","msg":"trace[29085732] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"2.462183762s","start":"2026-06-24T00:57:47.010992Z","end":"2026-06-24T00:57:49.473176Z","steps":["trace[29085732] 'process raft request' (duration: 2.411846371s)","trace[29085732] 'compare' (duration: 50.078346ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:49.473257Z","caller":"traceutil/trace.go:171","msg":"trace[1712627192] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"2.184433406s","start":"2026-06-24T00:57:47.288785Z","end":"2026-06-24T00:57:49.473218Z","steps":["trace[1712627192] 'process raft request' (duration: 2.184293043s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:49.473422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:47.010962Z","time spent":"2.462361576s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:49.473451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:47.28874Z","time spent":"2.184601749s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:49.473476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.182383738s","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-24T00:57:49.473547Z","caller":"traceutil/trace.go:171","msg":"trace[1101849269] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1260; }","duration":"2.18253533s","start":"2026-06-24T00:57:47.291Z","end":"2026-06-24T00:57:49.473535Z","steps":["trace[1101849269] 'agreement among raft nodes before linearized reading' (duration: 2.182297476s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:49.473236Z","caller":"traceutil/trace.go:171","msg":"trace[1384476263] linearizableReadLoop","detail":"{readStateIndex:1314; appliedIndex:1310; }","duration":"2.182138253s","start":"2026-06-24T00:57:47.291066Z","end":"2026-06-24T00:57:49.473205Z","steps":["trace[1384476263] 'read index received' (duration: 1.9135218s)","trace[1384476263] 'applied index is now lower than readState.Index' (duration: 268.615333ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:49.473587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:47.290971Z","time spent":"2.182608022s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-24T00:57:49.473725Z","caller":"traceutil/trace.go:171","msg":"trace[898699592] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"1.876870717s","start":"2026-06-24T00:57:47.596843Z","end":"2026-06-24T00:57:49.473714Z","steps":["trace[898699592] 'process raft request' (duration: 1.876283486s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:49.473806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.179683916s","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-24T00:57:49.47383Z","caller":"traceutil/trace.go:171","msg":"trace[481372918] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1260; }","duration":"2.179761548s","start":"2026-06-24T00:57:47.294061Z","end":"2026-06-24T00:57:49.473823Z","steps":["trace[481372918] 'agreement among raft nodes before linearized reading' (duration: 2.179597385s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:49.473822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:47.596812Z","time spent":"1.876943688s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:49.473849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:47.294036Z","time spent":"2.179809749s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T00:57:49.473918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"868.270268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:49.473931Z","caller":"traceutil/trace.go:171","msg":"trace[1446092792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1260; }","duration":"868.33764ms","start":"2026-06-24T00:57:48.605588Z","end":"2026-06-24T00:57:49.473926Z","steps":["trace[1446092792] 'agreement among raft nodes before linearized reading' (duration: 868.312639ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:49.473944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:48.60556Z","time spent":"868.38133ms","remote":"127.0.0.1:48832","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-24T00:57:49.473965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.402783ms","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-24T00:57:49.473993Z","caller":"traceutil/trace.go:171","msg":"trace[1097054178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1260; }","duration":"461.474005ms","start":"2026-06-24T00:57:49.01251Z","end":"2026-06-24T00:57:49.473984Z","steps":["trace[1097054178] 'agreement among raft nodes before linearized reading' (duration: 461.386973ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:49.474019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:49.012482Z","time spent":"461.531286ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T00:57:49.474098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.352263888s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:49.474117Z","caller":"traceutil/trace.go:171","msg":"trace[745375032] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1260; }","duration":"1.352287769s","start":"2026-06-24T00:57:48.121822Z","end":"2026-06-24T00:57:49.47411Z","steps":["trace[745375032] 'agreement among raft nodes before linearized reading' (duration: 1.352245298s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:49.474133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:48.12176Z","time spent":"1.35236923s","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-06-24T00:57:49.942707Z","caller":"traceutil/trace.go:171","msg":"trace[496214277] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"196.836917ms","start":"2026-06-24T00:57:49.74583Z","end":"2026-06-24T00:57:49.942667Z","steps":["trace[496214277] 'process raft request' (duration: 196.002391ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:50.090979Z","caller":"traceutil/trace.go:171","msg":"trace[467978297] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"117.449719ms","start":"2026-06-24T00:57:49.973489Z","end":"2026-06-24T00:57:50.090939Z","steps":["trace[467978297] 'process raft request' (duration: 30.563948ms)","trace[467978297] 'compare' (duration: 86.689507ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:51.458809Z","caller":"traceutil/trace.go:171","msg":"trace[433609500] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"171.765314ms","start":"2026-06-24T00:57:51.287015Z","end":"2026-06-24T00:57:51.458781Z","steps":["trace[433609500] 'process raft request' (duration: 171.599751ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:51.459496Z","caller":"traceutil/trace.go:171","msg":"trace[386445231] linearizableReadLoop","detail":"{readStateIndex:1321; appliedIndex:1321; }","duration":"169.635733ms","start":"2026-06-24T00:57:51.289848Z","end":"2026-06-24T00:57:51.459484Z","steps":["trace[386445231] 'read index received' (duration: 169.629923ms)","trace[386445231] 'applied index is now lower than readState.Index' (duration: 4.83µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:51.459585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.719795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:51.459619Z","caller":"traceutil/trace.go:171","msg":"trace[338105703] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"169.791647ms","start":"2026-06-24T00:57:51.289819Z","end":"2026-06-24T00:57:51.459611Z","steps":["trace[338105703] 'agreement among raft nodes before linearized reading' (duration: 169.716465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:52.021929Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483932373,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:57:52.518829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:52.143741Z","time spent":"375.081134ms","remote":"127.0.0.1:59194","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-24T00:57:52.51899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.714012ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:57:52.519239Z","caller":"traceutil/trace.go:171","msg":"trace[1537448957] linearizableReadLoop","detail":"{readStateIndex:1323; appliedIndex:1321; }","duration":"997.585869ms","start":"2026-06-24T00:57:51.521635Z","end":"2026-06-24T00:57:52.519221Z","steps":["trace[1537448957] 'read index received' (duration: 744.573302ms)","trace[1537448957] 'applied index is now lower than readState.Index' (duration: 253.011437ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:52.519255Z","caller":"traceutil/trace.go:171","msg":"trace[648123521] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"1.036357722s","start":"2026-06-24T00:57:51.48286Z","end":"2026-06-24T00:57:52.519218Z","steps":["trace[648123521] 'process raft request' (duration: 783.329804ms)","trace[648123521] 'compare' (duration: 252.385157ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:52.519299Z","caller":"traceutil/trace.go:171","msg":"trace[614193215] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"1.036004026s","start":"2026-06-24T00:57:51.483282Z","end":"2026-06-24T00:57:52.519286Z","steps":["trace[614193215] 'process raft request' (duration: 1.035843043s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:52.519382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:51.483252Z","time spent":"1.036070627s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:52.519392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:51.482829Z","time spent":"1.036494814s","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:52.519421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.784363ms","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-24T00:57:52.519451Z","caller":"traceutil/trace.go:171","msg":"trace[1723157666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1268; }","duration":"997.847804ms","start":"2026-06-24T00:57:51.521593Z","end":"2026-06-24T00:57:52.51944Z","steps":["trace[1723157666] 'agreement among raft nodes before linearized reading' (duration: 997.723632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:52.519446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.720322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T00:57:52.519483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:51.52157Z","time spent":"997.905635ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T00:57:52.519503Z","caller":"traceutil/trace.go:171","msg":"trace[27544729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1268; }","duration":"997.823504ms","start":"2026-06-24T00:57:51.521663Z","end":"2026-06-24T00:57:52.519486Z","steps":["trace[27544729] 'agreement among raft nodes before linearized reading' (duration: 997.741993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:52.519546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:51.521639Z","time spent":"997.897346ms","remote":"127.0.0.1:48832","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-24T00:57:52.519571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"966.28557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T00:57:52.519587Z","caller":"traceutil/trace.go:171","msg":"trace[829272225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1268; }","duration":"966.342971ms","start":"2026-06-24T00:57:51.553239Z","end":"2026-06-24T00:57:52.519582Z","steps":["trace[829272225] 'agreement among raft nodes before linearized reading' (duration: 966.267429ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:52.5196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:51.553218Z","time spent":"966.379301ms","remote":"127.0.0.1:49116","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-24T00:57:52.51961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.327163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:52.519637Z","caller":"traceutil/trace.go:171","msg":"trace[10449997] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1268; }","duration":"228.404475ms","start":"2026-06-24T00:57:52.291222Z","end":"2026-06-24T00:57:52.519627Z","steps":["trace[10449997] 'agreement among raft nodes before linearized reading' (duration: 228.365684ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:52.519663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"966.420642ms","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-24T00:57:52.519679Z","caller":"traceutil/trace.go:171","msg":"trace[577828014] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1268; }","duration":"966.448483ms","start":"2026-06-24T00:57:51.553224Z","end":"2026-06-24T00:57:52.519672Z","steps":["trace[577828014] 'agreement among raft nodes before linearized reading' (duration: 966.406352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:52.519693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:51.553214Z","time spent":"966.475604ms","remote":"127.0.0.1:49116","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-24T00:57:52.70787Z","caller":"traceutil/trace.go:171","msg":"trace[1677195643] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"182.997717ms","start":"2026-06-24T00:57:52.524836Z","end":"2026-06-24T00:57:52.707834Z","steps":["trace[1677195643] 'process raft request' (duration: 148.530915ms)","trace[1677195643] 'compare' (duration: 34.310469ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:52.731233Z","caller":"traceutil/trace.go:171","msg":"trace[1008714664] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"206.187334ms","start":"2026-06-24T00:57:52.525012Z","end":"2026-06-24T00:57:52.731199Z","steps":["trace[1008714664] 'process raft request' (duration: 205.982291ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:52.731255Z","caller":"traceutil/trace.go:171","msg":"trace[1908500493] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"205.729966ms","start":"2026-06-24T00:57:52.525498Z","end":"2026-06-24T00:57:52.731227Z","steps":["trace[1908500493] 'process raft request' (duration: 205.639124ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:52.731713Z","caller":"traceutil/trace.go:171","msg":"trace[1709411223] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"142.817877ms","start":"2026-06-24T00:57:52.588656Z","end":"2026-06-24T00:57:52.731473Z","steps":["trace[1709411223] 'process raft request' (duration: 142.521892ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:52.909175Z","caller":"traceutil/trace.go:171","msg":"trace[1488217631] linearizableReadLoop","detail":"{readStateIndex:1329; appliedIndex:1328; }","duration":"121.020306ms","start":"2026-06-24T00:57:52.788125Z","end":"2026-06-24T00:57:52.909145Z","steps":["trace[1488217631] 'read index received' (duration: 39.242731ms)","trace[1488217631] 'applied index is now lower than readState.Index' (duration: 81.776635ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:52.909178Z","caller":"traceutil/trace.go:171","msg":"trace[437274886] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"121.507305ms","start":"2026-06-24T00:57:52.787637Z","end":"2026-06-24T00:57:52.909144Z","steps":["trace[437274886] 'process raft request' (duration: 39.810231ms)","trace[437274886] 'compare' (duration: 81.544561ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:52.909666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.508835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-24T00:57:52.909759Z","caller":"traceutil/trace.go:171","msg":"trace[1165275103] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1274; }","duration":"121.663767ms","start":"2026-06-24T00:57:52.788075Z","end":"2026-06-24T00:57:52.909739Z","steps":["trace[1165275103] 'agreement among raft nodes before linearized reading' (duration: 121.156538ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:53.064245Z","caller":"traceutil/trace.go:171","msg":"trace[1814783607] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"227.879144ms","start":"2026-06-24T00:57:52.836326Z","end":"2026-06-24T00:57:53.064205Z","steps":["trace[1814783607] 'process raft request' (duration: 179.624323ms)","trace[1814783607] 'compare' (duration: 47.871553ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:53.098074Z","caller":"traceutil/trace.go:171","msg":"trace[741545121] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"184.75743ms","start":"2026-06-24T00:57:52.913267Z","end":"2026-06-24T00:57:53.098025Z","steps":["trace[741545121] 'process raft request' (duration: 184.604827ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:53.722621Z","caller":"traceutil/trace.go:171","msg":"trace[2108919477] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"255.437495ms","start":"2026-06-24T00:57:53.467151Z","end":"2026-06-24T00:57:53.722589Z","steps":["trace[2108919477] 'process raft request' (duration: 255.195951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:54.462355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.357469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:54.46244Z","caller":"traceutil/trace.go:171","msg":"trace[402915754] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1278; }","duration":"169.501651ms","start":"2026-06-24T00:57:54.292919Z","end":"2026-06-24T00:57:54.462421Z","steps":["trace[402915754] 'range keys from in-memory index tree' (duration: 169.265137ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:54.702552Z","caller":"traceutil/trace.go:171","msg":"trace[1041097516] linearizableReadLoop","detail":"{readStateIndex:1334; appliedIndex:1333; }","duration":"176.382561ms","start":"2026-06-24T00:57:54.526129Z","end":"2026-06-24T00:57:54.702512Z","steps":["trace[1041097516] 'read index received' (duration: 176.125466ms)","trace[1041097516] 'applied index is now lower than readState.Index' (duration: 256.215µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:54.70279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.645106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T00:57:54.70277Z","caller":"traceutil/trace.go:171","msg":"trace[1267884665] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"177.646465ms","start":"2026-06-24T00:57:54.525078Z","end":"2026-06-24T00:57:54.702725Z","steps":["trace[1267884665] 'process raft request' (duration: 177.251928ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:54.702855Z","caller":"traceutil/trace.go:171","msg":"trace[149347948] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1279; }","duration":"176.779108ms","start":"2026-06-24T00:57:54.526066Z","end":"2026-06-24T00:57:54.702845Z","steps":["trace[149347948] 'agreement among raft nodes before linearized reading' (duration: 176.565815ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:54.961013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.379572ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:57:54.961126Z","caller":"traceutil/trace.go:171","msg":"trace[709454321] linearizableReadLoop","detail":"{readStateIndex:1335; appliedIndex:1334; }","duration":"248.198458ms","start":"2026-06-24T00:57:54.712908Z","end":"2026-06-24T00:57:54.961107Z","steps":["trace[709454321] 'read index received' (duration: 54.542911ms)","trace[709454321] 'applied index is now lower than readState.Index' (duration: 193.653907ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:54.961228Z","caller":"traceutil/trace.go:171","msg":"trace[1251760792] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"254.526867ms","start":"2026-06-24T00:57:54.706687Z","end":"2026-06-24T00:57:54.961214Z","steps":["trace[1251760792] 'process raft request' (duration: 60.847119ms)","trace[1251760792] 'compare' (duration: 193.181289ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:54.961391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.461003ms","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-24T00:57:54.96147Z","caller":"traceutil/trace.go:171","msg":"trace[957146363] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1280; }","duration":"248.593705ms","start":"2026-06-24T00:57:54.712856Z","end":"2026-06-24T00:57:54.96145Z","steps":["trace[957146363] 'agreement among raft nodes before linearized reading' (duration: 248.38928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:54.961703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.668732ms","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-24T00:57:54.961788Z","caller":"traceutil/trace.go:171","msg":"trace[1259287835] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1280; }","duration":"225.794745ms","start":"2026-06-24T00:57:54.735974Z","end":"2026-06-24T00:57:54.961768Z","steps":["trace[1259287835] 'agreement among raft nodes before linearized reading' (duration: 225.619711ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:54.962218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.195972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T00:57:54.96235Z","caller":"traceutil/trace.go:171","msg":"trace[2045464793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1280; }","duration":"226.350745ms","start":"2026-06-24T00:57:54.735976Z","end":"2026-06-24T00:57:54.962327Z","steps":["trace[2045464793] 'agreement among raft nodes before linearized reading' (duration: 225.287394ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:58.235593Z","caller":"traceutil/trace.go:171","msg":"trace[1623662098] linearizableReadLoop","detail":"{readStateIndex:1354; appliedIndex:1353; }","duration":"458.515419ms","start":"2026-06-24T00:57:57.777051Z","end":"2026-06-24T00:57:58.235566Z","steps":["trace[1623662098] 'read index received' (duration: 458.303985ms)","trace[1623662098] 'applied index is now lower than readState.Index' (duration: 210.443µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:58.235668Z","caller":"traceutil/trace.go:171","msg":"trace[885598777] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"494.833765ms","start":"2026-06-24T00:57:57.740797Z","end":"2026-06-24T00:57:58.23563Z","steps":["trace[885598777] 'process raft request' (duration: 494.616631ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:58.235823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.741183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:57:58.235884Z","caller":"traceutil/trace.go:171","msg":"trace[37157757] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1298; }","duration":"458.851375ms","start":"2026-06-24T00:57:57.777019Z","end":"2026-06-24T00:57:58.235871Z","steps":["trace[37157757] 'agreement among raft nodes before linearized reading' (duration: 458.727833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:58.235908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:57.740773Z","time spent":"495.055898ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:58.235937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:57.776993Z","time spent":"458.929827ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:57:58.236014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.00254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-24T00:57:58.236109Z","caller":"traceutil/trace.go:171","msg":"trace[1247045690] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1298; }","duration":"134.119702ms","start":"2026-06-24T00:57:58.101972Z","end":"2026-06-24T00:57:58.236091Z","steps":["trace[1247045690] 'agreement among raft nodes before linearized reading' (duration: 133.909538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:58.236332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.140984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:66627"} {"level":"info","ts":"2026-06-24T00:57:58.236452Z","caller":"traceutil/trace.go:171","msg":"trace[976665989] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1298; }","duration":"214.295497ms","start":"2026-06-24T00:57:58.022143Z","end":"2026-06-24T00:57:58.236439Z","steps":["trace[976665989] 'agreement among raft nodes before linearized reading' (duration: 213.766357ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:58.236427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.087619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-06-24T00:57:58.236767Z","caller":"traceutil/trace.go:171","msg":"trace[1143448697] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1298; }","duration":"218.460726ms","start":"2026-06-24T00:57:58.018242Z","end":"2026-06-24T00:57:58.236702Z","steps":["trace[1143448697] 'agreement among raft nodes before linearized reading' (duration: 217.6284ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:58.563611Z","caller":"traceutil/trace.go:171","msg":"trace[1159181579] linearizableReadLoop","detail":"{readStateIndex:1355; appliedIndex:1354; }","duration":"321.210496ms","start":"2026-06-24T00:57:58.242377Z","end":"2026-06-24T00:57:58.563587Z","steps":["trace[1159181579] 'read index received' (duration: 239.936621ms)","trace[1159181579] 'applied index is now lower than readState.Index' (duration: 81.263905ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:58.563911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.514991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-06-24T00:57:58.563953Z","caller":"traceutil/trace.go:171","msg":"trace[1445578151] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1299; }","duration":"321.571043ms","start":"2026-06-24T00:57:58.242371Z","end":"2026-06-24T00:57:58.563942Z","steps":["trace[1445578151] 'agreement among raft nodes before linearized reading' (duration: 321.488031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:58.563986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:58.242339Z","time spent":"321.639364ms","remote":"127.0.0.1:48898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":140,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-06-24T00:57:58.564004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:66627"} {"level":"info","ts":"2026-06-24T00:57:58.564081Z","caller":"traceutil/trace.go:171","msg":"trace[1645027246] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1299; }","duration":"321.516132ms","start":"2026-06-24T00:57:58.242552Z","end":"2026-06-24T00:57:58.564068Z","steps":["trace[1645027246] 'agreement among raft nodes before linearized reading' (duration: 321.301688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:58.56412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:58.24253Z","time spent":"321.582863ms","remote":"127.0.0.1:48886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":66649,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"info","ts":"2026-06-24T00:57:58.564036Z","caller":"traceutil/trace.go:171","msg":"trace[1017427852] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"322.923509ms","start":"2026-06-24T00:57:58.240998Z","end":"2026-06-24T00:57:58.563922Z","steps":["trace[1017427852] 'process raft request' (duration: 241.381658ms)","trace[1017427852] 'compare' (duration: 81.055171ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:58.565689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:58.240975Z","time spent":"323.895866ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:59.167903Z","caller":"traceutil/trace.go:171","msg":"trace[2002614759] linearizableReadLoop","detail":"{readStateIndex:1356; appliedIndex:1355; }","duration":"189.805875ms","start":"2026-06-24T00:57:58.978055Z","end":"2026-06-24T00:57:59.167861Z","steps":["trace[2002614759] 'read index received' (duration: 187.39425ms)","trace[2002614759] 'applied index is now lower than readState.Index' (duration: 2.410605ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:59.167987Z","caller":"traceutil/trace.go:171","msg":"trace[1287367354] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"451.970266ms","start":"2026-06-24T00:57:58.715965Z","end":"2026-06-24T00:57:59.167936Z","steps":["trace[1287367354] 'process raft request' (duration: 449.55537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:59.168201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.129841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T00:57:59.168247Z","caller":"traceutil/trace.go:171","msg":"trace[1016356409] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1300; }","duration":"190.235393ms","start":"2026-06-24T00:57:58.978Z","end":"2026-06-24T00:57:59.168236Z","steps":["trace[1016356409] 'agreement among raft nodes before linearized reading' (duration: 190.007429ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:59.16825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:58.715937Z","time spent":"452.18867ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:59.168282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.424345ms","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-24T00:57:59.168378Z","caller":"traceutil/trace.go:171","msg":"trace[238425470] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1300; }","duration":"155.528897ms","start":"2026-06-24T00:57:59.012824Z","end":"2026-06-24T00:57:59.168353Z","steps":["trace[238425470] 'agreement among raft nodes before linearized reading' (duration: 155.294093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:59.16854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.597806ms","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-24T00:57:59.168575Z","caller":"traceutil/trace.go:171","msg":"trace[916164517] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1300; }","duration":"131.677106ms","start":"2026-06-24T00:57:59.036889Z","end":"2026-06-24T00:57:59.168566Z","steps":["trace[916164517] 'agreement among raft nodes before linearized reading' (duration: 131.580564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:59.168648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.737108ms","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-24T00:57:59.168693Z","caller":"traceutil/trace.go:171","msg":"trace[1054780871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1300; }","duration":"131.825089ms","start":"2026-06-24T00:57:59.036856Z","end":"2026-06-24T00:57:59.168681Z","steps":["trace[1054780871] 'agreement among raft nodes before linearized reading' (duration: 131.617356ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:58:06.248199Z","caller":"traceutil/trace.go:171","msg":"trace[1670580348] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"186.706357ms","start":"2026-06-24T00:58:06.061462Z","end":"2026-06-24T00:58:06.248168Z","steps":["trace[1670580348] 'process raft request' (duration: 186.492243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T01:00:19.80279Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411284483934053,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T01:00:20.195825Z","caller":"traceutil/trace.go:171","msg":"trace[1074782525] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"894.789781ms","start":"2026-06-24T01:00:19.301008Z","end":"2026-06-24T01:00:20.195798Z","steps":["trace[1074782525] 'process raft request' (duration: 894.658117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T01:00:20.195964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T01:00:19.300991Z","time spent":"894.904993ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T01:00:20.197181Z","caller":"traceutil/trace.go:171","msg":"trace[1523089143] linearizableReadLoop","detail":"{readStateIndex:2052; appliedIndex:2051; }","duration":"894.899701ms","start":"2026-06-24T01:00:19.302246Z","end":"2026-06-24T01:00:20.197146Z","steps":["trace[1523089143] 'read index received' (duration: 893.581377ms)","trace[1523089143] 'applied index is now lower than readState.Index' (duration: 1.316624ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T01:00:20.197658Z","caller":"traceutil/trace.go:171","msg":"trace[1900704197] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"450.001855ms","start":"2026-06-24T01:00:19.747631Z","end":"2026-06-24T01:00:20.197633Z","steps":["trace[1900704197] 'process raft request' (duration: 449.355432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T01:00:20.198169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T01:00:19.747548Z","time spent":"450.167979ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T01:00:20.198674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.126322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T01:00:20.198778Z","caller":"traceutil/trace.go:171","msg":"trace[1461601094] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1968; }","duration":"611.258755ms","start":"2026-06-24T01:00:19.587493Z","end":"2026-06-24T01:00:20.198752Z","steps":["trace[1461601094] 'agreement among raft nodes before linearized reading' (duration: 611.06912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T01:00:20.198835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T01:00:19.587475Z","time spent":"611.349617ms","remote":"127.0.0.1:38190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-24T01:00:20.199109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.855329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T01:00:20.199156Z","caller":"traceutil/trace.go:171","msg":"trace[821123518] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1968; }","duration":"896.909071ms","start":"2026-06-24T01:00:19.302233Z","end":"2026-06-24T01:00:20.199142Z","steps":["trace[821123518] 'agreement among raft nodes before linearized reading' (duration: 896.84073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T01:00:20.199193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T01:00:19.302228Z","time spent":"896.959022ms","remote":"127.0.0.1:48816","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-24T01:00:20.199365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.503933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-06-24T01:00:20.199393Z","caller":"traceutil/trace.go:171","msg":"trace[1351514833] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1968; }","duration":"541.551093ms","start":"2026-06-24T01:00:19.657834Z","end":"2026-06-24T01:00:20.199385Z","steps":["trace[1351514833] 'agreement among raft nodes before linearized reading' (duration: 541.452892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T01:00:20.199412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T01:00:19.657828Z","time spent":"541.578664ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-24T01:00:20.199441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.749218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-24T01:00:20.199488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.017657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-24T01:00:20.199501Z","caller":"traceutil/trace.go:171","msg":"trace[1469331165] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1968; }","duration":"247.053168ms","start":"2026-06-24T01:00:19.952443Z","end":"2026-06-24T01:00:20.199496Z","steps":["trace[1469331165] 'agreement among raft nodes before linearized reading' (duration: 247.011588ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T01:00:20.199497Z","caller":"traceutil/trace.go:171","msg":"trace[2055230938] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1968; }","duration":"239.82066ms","start":"2026-06-24T01:00:19.95966Z","end":"2026-06-24T01:00:20.199481Z","steps":["trace[2055230938] 'agreement among raft nodes before linearized reading' (duration: 239.625387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T01:00:20.199541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.080772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.216\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-24T01:00:20.199622Z","caller":"traceutil/trace.go:171","msg":"trace[1881775497] range","detail":"{range_begin:/registry/masterleases/199.204.45.216; range_end:; response_count:1; response_revision:1968; }","duration":"488.189713ms","start":"2026-06-24T01:00:19.711409Z","end":"2026-06-24T01:00:20.199599Z","steps":["trace[1881775497] 'agreement among raft nodes before linearized reading' (duration: 487.969299ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T01:00:20.199674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T01:00:19.71139Z","time spent":"488.267685ms","remote":"127.0.0.1:48852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.216\" "} {"level":"warn","ts":"2026-06-24T01:00:20.200261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.691489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T01:00:20.201688Z","caller":"traceutil/trace.go:171","msg":"trace[1155808029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1968; }","duration":"249.822072ms","start":"2026-06-24T01:00:19.9505Z","end":"2026-06-24T01:00:20.200323Z","steps":["trace[1155808029] 'agreement among raft nodes before linearized reading' (duration: 248.627459ms)"],"step_count":1}