{"level":"warn","ts":"2026-05-09T21:41:40.783487Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T21:41:40.783607Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70: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.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-09T21:41:40.783703Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T21:41:40.783784Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-05-09T21:41:40.783817Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-09T21:41:40.784736Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-05-09T21:41:40.78488Z","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.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-09T21:41:40.806951Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"21.779448ms"} {"level":"info","ts":"2026-05-09T21:41:40.841929Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-05-09T21:41:40.842076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-05-09T21:41:40.842113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-05-09T21:41:40.842139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-09T21:41:40.842158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-05-09T21:41:40.842219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-05-09T21:41:40.859008Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-09T21:41:40.863416Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-09T21:41:40.865234Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-09T21:41:40.86946Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-09T21:41:40.869776Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-09T21:41:40.869805Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T21:41:40.869937Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T21:41:40.870013Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T21:41:40.873611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-05-09T21:41:40.873907Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-05-09T21:41:40.879446Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-09T21:41:40.879707Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-05-09T21:41:40.879749Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-05-09T21:41:40.880638Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-09T21:41:40.880542Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-09T21:41:41.043495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-05-09T21:41:41.043669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-09T21:41:41.043735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-05-09T21:41:41.043803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-05-09T21:41:41.043848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-05-09T21:41:41.043889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-05-09T21:41:41.043958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-05-09T21:41:41.05307Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:41:41.057472Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-05-09T21:41:41.057531Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T21:41:41.057956Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:41:41.058181Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:41:41.058436Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:41:41.058264Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T21:41:41.058622Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-09T21:41:41.060341Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-09T21:41:41.061938Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-09T21:41:41.069632Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"warn","ts":"2026-05-09T21:41:43.805066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.537573ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-09T21:41:43.805391Z","caller":"traceutil/trace.go:171","msg":"trace[1962562252] transaction","detail":"{read_only:false; response_revision:82; number_of_response:1; }","duration":"166.231583ms","start":"2026-05-09T21:41:43.639131Z","end":"2026-05-09T21:41:43.805363Z","steps":["trace[1962562252] 'process raft request' (duration: 39.58433ms)","trace[1962562252] 'compare' (duration: 125.363142ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:41:43.985761Z","caller":"traceutil/trace.go:171","msg":"trace[209410322] transaction","detail":"{read_only:false; number_of_response:0; response_revision:83; }","duration":"150.534453ms","start":"2026-05-09T21:41:43.83515Z","end":"2026-05-09T21:41:43.985684Z","steps":["trace[209410322] 'process raft request' (duration: 70.340774ms)","trace[209410322] 'compare' (duration: 80.075098ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:41:44.801745Z","caller":"traceutil/trace.go:171","msg":"trace[1435648526] transaction","detail":"{read_only:false; response_revision:115; number_of_response:1; }","duration":"166.208074ms","start":"2026-05-09T21:41:44.635497Z","end":"2026-05-09T21:41:44.801705Z","steps":["trace[1435648526] 'process raft request' (duration: 93.216033ms)","trace[1435648526] 'compare' (duration: 72.82699ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:41:45.063676Z","caller":"traceutil/trace.go:171","msg":"trace[1456997152] transaction","detail":"{read_only:false; response_revision:118; number_of_response:1; }","duration":"161.383184ms","start":"2026-05-09T21:41:44.902257Z","end":"2026-05-09T21:41:45.06364Z","steps":["trace[1456997152] 'process raft request' (duration: 65.493184ms)","trace[1456997152] 'compare' (duration: 95.717599ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:41:45.299494Z","caller":"traceutil/trace.go:171","msg":"trace[1460403550] transaction","detail":"{read_only:false; response_revision:123; number_of_response:1; }","duration":"132.755675ms","start":"2026-05-09T21:41:45.166707Z","end":"2026-05-09T21:41:45.299463Z","steps":["trace[1460403550] 'process raft request' (duration: 132.569923ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:41:45.703853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.926498ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:41:45.704123Z","caller":"traceutil/trace.go:171","msg":"trace[413715465] linearizableReadLoop","detail":"{readStateIndex:134; appliedIndex:133; }","duration":"117.821953ms","start":"2026-05-09T21:41:45.586277Z","end":"2026-05-09T21:41:45.704099Z","steps":["trace[413715465] 'read index received' (duration: 30.29µs)","trace[413715465] 'applied index is now lower than readState.Index' (duration: 117.789963ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:41:45.704173Z","caller":"traceutil/trace.go:171","msg":"trace[527399296] transaction","detail":"{read_only:false; response_revision:129; number_of_response:1; }","duration":"205.54525ms","start":"2026-05-09T21:41:45.498583Z","end":"2026-05-09T21:41:45.704129Z","steps":["trace[527399296] 'process raft request' (duration: 37.253609ms)","trace[527399296] 'compare' (duration: 167.797517ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:41:45.704354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.079075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:41:45.704411Z","caller":"traceutil/trace.go:171","msg":"trace[856218545] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:129; }","duration":"118.169207ms","start":"2026-05-09T21:41:45.586226Z","end":"2026-05-09T21:41:45.704395Z","steps":["trace[856218545] 'agreement among raft nodes before linearized reading' (duration: 118.051166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:41:46.025812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.534287ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:41:46.026172Z","caller":"traceutil/trace.go:171","msg":"trace[935035971] transaction","detail":"{read_only:false; response_revision:133; number_of_response:1; }","duration":"236.149228ms","start":"2026-05-09T21:41:45.790006Z","end":"2026-05-09T21:41:46.026155Z","steps":["trace[935035971] 'process raft request' (duration: 236.091078ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:41:46.026252Z","caller":"traceutil/trace.go:171","msg":"trace[1549427263] transaction","detail":"{read_only:false; response_revision:132; number_of_response:1; }","duration":"237.175675ms","start":"2026-05-09T21:41:45.789022Z","end":"2026-05-09T21:41:46.026197Z","steps":["trace[1549427263] 'process raft request' (duration: 53.992764ms)","trace[1549427263] 'compare' (duration: 182.440316ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:41:46.052834Z","caller":"traceutil/trace.go:171","msg":"trace[253115954] transaction","detail":"{read_only:false; response_revision:134; number_of_response:1; }","duration":"173.247306ms","start":"2026-05-09T21:41:45.879554Z","end":"2026-05-09T21:41:46.052801Z","steps":["trace[253115954] 'process raft request' (duration: 173.086965ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:41:46.220666Z","caller":"traceutil/trace.go:171","msg":"trace[1642840653] transaction","detail":"{read_only:false; response_revision:138; number_of_response:1; }","duration":"102.368524ms","start":"2026-05-09T21:41:46.118262Z","end":"2026-05-09T21:41:46.220631Z","steps":["trace[1642840653] 'process raft request' (duration: 82.186673ms)","trace[1642840653] 'compare' (duration: 20.02663ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:41:46.644192Z","caller":"traceutil/trace.go:171","msg":"trace[1353768253] transaction","detail":"{read_only:false; response_revision:187; number_of_response:1; }","duration":"124.88302ms","start":"2026-05-09T21:41:46.519281Z","end":"2026-05-09T21:41:46.644164Z","steps":["trace[1353768253] 'process raft request' (duration: 124.373526ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:41:59.078087Z","caller":"traceutil/trace.go:171","msg":"trace[1841514570] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"105.640868ms","start":"2026-05-09T21:41:58.972406Z","end":"2026-05-09T21:41:59.078047Z","steps":["trace[1841514570] 'process raft request' (duration: 105.486267ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:02.305148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.087847ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:42:02.30526Z","caller":"traceutil/trace.go:171","msg":"trace[458896361] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"133.62191ms","start":"2026-05-09T21:42:02.171618Z","end":"2026-05-09T21:42:02.30524Z","steps":["trace[458896361] 'process raft request' (duration: 13.350033ms)","trace[458896361] 'compare' (duration: 119.965095ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:42:06.190257Z","caller":"traceutil/trace.go:171","msg":"trace[419968444] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"587.001434ms","start":"2026-05-09T21:42:05.603227Z","end":"2026-05-09T21:42:06.190228Z","steps":["trace[419968444] 'process raft request' (duration: 586.623636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:06.190484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:05.603209Z","time spent":"587.197385ms","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:42:06.676361Z","caller":"traceutil/trace.go:171","msg":"trace[1980439787] linearizableReadLoop","detail":"{readStateIndex:471; appliedIndex:470; }","duration":"358.205043ms","start":"2026-05-09T21:42:06.318139Z","end":"2026-05-09T21:42:06.676344Z","steps":["trace[1980439787] 'read index received' (duration: 321.256675ms)","trace[1980439787] 'applied index is now lower than readState.Index' (duration: 36.947648ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:42:06.676536Z","caller":"traceutil/trace.go:171","msg":"trace[1900832426] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"482.818522ms","start":"2026-05-09T21:42:06.19371Z","end":"2026-05-09T21:42:06.676528Z","steps":["trace[1900832426] 'process raft request' (duration: 445.764059ms)","trace[1900832426] 'compare' (duration: 36.573ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:42:06.676615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:06.193692Z","time spent":"482.869574ms","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:42:06.676765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.603162ms","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-05-09T21:42:06.676845Z","caller":"traceutil/trace.go:171","msg":"trace[1708833301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:456; }","duration":"358.726988ms","start":"2026-05-09T21:42:06.318098Z","end":"2026-05-09T21:42:06.676825Z","steps":["trace[1708833301] 'agreement among raft nodes before linearized reading' (duration: 358.55838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:06.676894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:06.318078Z","time spent":"358.806612ms","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-09T21:42:12.717601Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566936402226758,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-09T21:42:12.95481Z","caller":"traceutil/trace.go:171","msg":"trace[2036250398] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"773.794876ms","start":"2026-05-09T21:42:12.180989Z","end":"2026-05-09T21:42:12.954783Z","steps":["trace[2036250398] 'process raft request' (duration: 773.65878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:12.954946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:12.180961Z","time spent":"773.919722ms","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:42:12.965839Z","caller":"traceutil/trace.go:171","msg":"trace[1064729382] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"782.855139ms","start":"2026-05-09T21:42:12.18295Z","end":"2026-05-09T21:42:12.965805Z","steps":["trace[1064729382] 'process raft request' (duration: 782.6613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:12.965983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:12.182932Z","time spent":"782.978994ms","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:42:12.96602Z","caller":"traceutil/trace.go:171","msg":"trace[1240256471] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"751.807725ms","start":"2026-05-09T21:42:12.21416Z","end":"2026-05-09T21:42:12.965968Z","steps":["trace[1240256471] 'process raft request' (duration: 751.681699ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:12.965928Z","caller":"traceutil/trace.go:171","msg":"trace[1351450077] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"765.75552ms","start":"2026-05-09T21:42:12.200141Z","end":"2026-05-09T21:42:12.965896Z","steps":["trace[1351450077] 'process raft request' (duration: 765.611613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:12.966218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:12.214156Z","time spent":"751.977953ms","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:42:12.966242Z","caller":"traceutil/trace.go:171","msg":"trace[1882284267] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"742.860949ms","start":"2026-05-09T21:42:12.223363Z","end":"2026-05-09T21:42:12.966224Z","steps":["trace[1882284267] 'process raft request' (duration: 742.612097ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:12.966292Z","caller":"traceutil/trace.go:171","msg":"trace[1596913296] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:520; }","duration":"749.190586ms","start":"2026-05-09T21:42:12.217085Z","end":"2026-05-09T21:42:12.966275Z","steps":["trace[1596913296] 'read index received' (duration: 737.984886ms)","trace[1596913296] 'applied index is now lower than readState.Index' (duration: 11.20488ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:42:12.96636Z","caller":"traceutil/trace.go:171","msg":"trace[1150728076] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"738.371074ms","start":"2026-05-09T21:42:12.227984Z","end":"2026-05-09T21:42:12.966355Z","steps":["trace[1150728076] 'process raft request' (duration: 738.030678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:12.966331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:12.223358Z","time spent":"742.925141ms","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:42:12.966396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:12.227964Z","time spent":"738.412336ms","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:42:12.966404Z","caller":"traceutil/trace.go:171","msg":"trace[876771373] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"717.383618ms","start":"2026-05-09T21:42:12.249012Z","end":"2026-05-09T21:42:12.966396Z","steps":["trace[876771373] 'process raft request' (duration: 717.121877ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:12.966101Z","caller":"traceutil/trace.go:171","msg":"trace[1916707757] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"743.236886ms","start":"2026-05-09T21:42:12.222811Z","end":"2026-05-09T21:42:12.966048Z","steps":["trace[1916707757] 'process raft request' (duration: 743.062628ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:12.966461Z","caller":"traceutil/trace.go:171","msg":"trace[1828038935] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"743.579811ms","start":"2026-05-09T21:42:12.222871Z","end":"2026-05-09T21:42:12.966451Z","steps":["trace[1828038935] 'process raft request' (duration: 743.031086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:12.966486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:12.248994Z","time spent":"717.433111ms","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:42:12.966431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:12.200122Z","time spent":"766.127967ms","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:42:12.96655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.458408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-09T21:42:12.966539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:12.222865Z","time spent":"743.628833ms","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:42:12.966121Z","caller":"traceutil/trace.go:171","msg":"trace[2021731955] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"751.995593ms","start":"2026-05-09T21:42:12.214062Z","end":"2026-05-09T21:42:12.966058Z","steps":["trace[2021731955] 'process raft request' (duration: 751.723101ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:12.966604Z","caller":"traceutil/trace.go:171","msg":"trace[933136004] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:514; }","duration":"749.536551ms","start":"2026-05-09T21:42:12.217051Z","end":"2026-05-09T21:42:12.966587Z","steps":["trace[933136004] 'agreement among raft nodes before linearized reading' (duration: 749.407735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:12.966632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:12.214042Z","time spent":"752.570809ms","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:42:12.96632Z","caller":"traceutil/trace.go:171","msg":"trace[816621644] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"729.514131ms","start":"2026-05-09T21:42:12.236796Z","end":"2026-05-09T21:42:12.966311Z","steps":["trace[816621644] 'process raft request' (duration: 729.252699ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:12.966652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:12.217037Z","time spent":"749.604764ms","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-09T21:42:12.966677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:12.236779Z","time spent":"729.881237ms","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:42:12.966744Z","caller":"traceutil/trace.go:171","msg":"trace[301447469] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"609.928218ms","start":"2026-05-09T21:42:12.35679Z","end":"2026-05-09T21:42:12.966718Z","steps":["trace[301447469] 'process raft request' (duration: 609.435456ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:12.966735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:12.222793Z","time spent":"743.681996ms","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:42:12.966786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:12.356772Z","time spent":"609.99893ms","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:42:12.97488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.859071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:12.974962Z","caller":"traceutil/trace.go:171","msg":"trace[913620694] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:516; }","duration":"367.983347ms","start":"2026-05-09T21:42:12.606966Z","end":"2026-05-09T21:42:12.97495Z","steps":["trace[913620694] 'agreement among raft nodes before linearized reading' (duration: 367.854291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:12.975064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:12.606945Z","time spent":"368.095152ms","remote":"127.0.0.1:47884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T21:42:12.975108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.114368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-09T21:42:12.975158Z","caller":"traceutil/trace.go:171","msg":"trace[32119437] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:516; }","duration":"164.221373ms","start":"2026-05-09T21:42:12.810926Z","end":"2026-05-09T21:42:12.975147Z","steps":["trace[32119437] 'agreement among raft nodes before linearized reading' (duration: 164.116418ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:12.975289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.731479ms","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-05-09T21:42:12.975341Z","caller":"traceutil/trace.go:171","msg":"trace[1738236755] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:516; }","duration":"266.821663ms","start":"2026-05-09T21:42:12.708511Z","end":"2026-05-09T21:42:12.975333Z","steps":["trace[1738236755] 'agreement among raft nodes before linearized reading' (duration: 266.74259ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:12.975413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.817908ms","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-05-09T21:42:12.975454Z","caller":"traceutil/trace.go:171","msg":"trace[842146076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:516; }","duration":"267.970795ms","start":"2026-05-09T21:42:12.707473Z","end":"2026-05-09T21:42:12.975444Z","steps":["trace[842146076] 'agreement among raft nodes before linearized reading' (duration: 267.86036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:13.329547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.833504ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:42:13.329723Z","caller":"traceutil/trace.go:171","msg":"trace[326412232] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"158.53888ms","start":"2026-05-09T21:42:13.171163Z","end":"2026-05-09T21:42:13.329702Z","steps":["trace[326412232] 'process raft request' (duration: 11.386302ms)","trace[326412232] 'compare' (duration: 146.484978ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:42:14.701224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.897966ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:42:14.70136Z","caller":"traceutil/trace.go:171","msg":"trace[737286115] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"1.520155261s","start":"2026-05-09T21:42:13.181183Z","end":"2026-05-09T21:42:14.701338Z","steps":["trace[737286115] 'process raft request' (duration: 707.043125ms)","trace[737286115] 'compare' (duration: 812.513479ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:42:14.701447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:13.181164Z","time spent":"1.520249466s","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:42:14.703074Z","caller":"traceutil/trace.go:171","msg":"trace[518988892] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"1.508331258s","start":"2026-05-09T21:42:13.194728Z","end":"2026-05-09T21:42:14.703059Z","steps":["trace[518988892] 'process raft request' (duration: 1.507763263s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:14.703177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:13.194704Z","time spent":"1.508419592s","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:42:14.703479Z","caller":"traceutil/trace.go:171","msg":"trace[1930573052] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"1.458775059s","start":"2026-05-09T21:42:13.244688Z","end":"2026-05-09T21:42:14.703463Z","steps":["trace[1930573052] 'process raft request' (duration: 1.457915311s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:14.703576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:13.244662Z","time spent":"1.458865223s","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:42:14.703769Z","caller":"traceutil/trace.go:171","msg":"trace[1248406669] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"1.35005289s","start":"2026-05-09T21:42:13.353694Z","end":"2026-05-09T21:42:14.703746Z","steps":["trace[1248406669] 'process raft request' (duration: 1.348962442s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:14.703875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:13.353669Z","time spent":"1.350157965s","remote":"127.0.0.1:47930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:42:19.532703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.58677ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:42:19.532804Z","caller":"traceutil/trace.go:171","msg":"trace[348765362] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"406.144096ms","start":"2026-05-09T21:42:19.126645Z","end":"2026-05-09T21:42:19.532789Z","steps":["trace[348765362] 'process raft request' (duration: 302.397679ms)","trace[348765362] 'compare' (duration: 103.34305ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:42:19.532847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:19.126624Z","time spent":"406.206408ms","remote":"127.0.0.1:48190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:42:20.321628Z","caller":"traceutil/trace.go:171","msg":"trace[1736251304] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"554.021688ms","start":"2026-05-09T21:42:19.767571Z","end":"2026-05-09T21:42:20.321592Z","steps":["trace[1736251304] 'process raft request' (duration: 553.837071ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:20.321843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:19.767536Z","time spent":"554.222816ms","remote":"127.0.0.1:48054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:42:21.63713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.770705ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:42:21.637224Z","caller":"traceutil/trace.go:171","msg":"trace[402236095] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"563.320178ms","start":"2026-05-09T21:42:21.073889Z","end":"2026-05-09T21:42:21.637209Z","steps":["trace[402236095] 'read index received' (duration: 226.171388ms)","trace[402236095] 'applied index is now lower than readState.Index' (duration: 337.14784ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:42:21.637253Z","caller":"traceutil/trace.go:171","msg":"trace[1965953356] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"1.690058914s","start":"2026-05-09T21:42:19.947173Z","end":"2026-05-09T21:42:21.637232Z","steps":["trace[1965953356] 'process raft request' (duration: 1.353127993s)","trace[1965953356] 'compare' (duration: 336.433851ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:42:21.637453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.587207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-09T21:42:21.637495Z","caller":"traceutil/trace.go:171","msg":"trace[1992969020] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:611; }","duration":"562.65042ms","start":"2026-05-09T21:42:21.074835Z","end":"2026-05-09T21:42:21.637486Z","steps":["trace[1992969020] 'agreement among raft nodes before linearized reading' (duration: 562.512714ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:21.637462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.455353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-09T21:42:21.637526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.074819Z","time spent":"562.699642ms","remote":"127.0.0.1:48114","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":"info","ts":"2026-05-09T21:42:21.637575Z","caller":"traceutil/trace.go:171","msg":"trace[1317952931] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:611; }","duration":"563.604501ms","start":"2026-05-09T21:42:21.073943Z","end":"2026-05-09T21:42:21.637548Z","steps":["trace[1317952931] 'agreement among raft nodes before linearized reading' (duration: 563.397891ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:21.637613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.07392Z","time spent":"563.686784ms","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-09T21:42:21.637787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.796888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-09T21:42:21.637824Z","caller":"traceutil/trace.go:171","msg":"trace[1750131546] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:611; }","duration":"563.871101ms","start":"2026-05-09T21:42:21.073944Z","end":"2026-05-09T21:42:21.637816Z","steps":["trace[1750131546] 'agreement among raft nodes before linearized reading' (duration: 563.785618ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:21.637854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.073921Z","time spent":"563.926294ms","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-09T21:42:21.637877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:19.947145Z","time spent":"1.690181939s","remote":"127.0.0.1:47972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:42:21.638067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.177773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-09T21:42:21.638109Z","caller":"traceutil/trace.go:171","msg":"trace[1806917713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:611; }","duration":"564.256347ms","start":"2026-05-09T21:42:21.073846Z","end":"2026-05-09T21:42:21.638102Z","steps":["trace[1806917713] 'agreement among raft nodes before linearized reading' (duration: 563.473794ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:21.638136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.073821Z","time spent":"564.309209ms","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-09T21:42:22.352056Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566936402226941,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-09T21:42:22.427001Z","caller":"traceutil/trace.go:171","msg":"trace[1569111871] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"784.727064ms","start":"2026-05-09T21:42:21.642254Z","end":"2026-05-09T21:42:22.426982Z","steps":["trace[1569111871] 'process raft request' (duration: 780.435671ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.427253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.642231Z","time spent":"784.948433ms","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:42:22.445188Z","caller":"traceutil/trace.go:171","msg":"trace[932904236] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"802.399858ms","start":"2026-05-09T21:42:21.642726Z","end":"2026-05-09T21:42:22.445126Z","steps":["trace[932904236] 'process raft request' (duration: 802.147568ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:22.44524Z","caller":"traceutil/trace.go:171","msg":"trace[284849774] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"801.977091ms","start":"2026-05-09T21:42:21.643237Z","end":"2026-05-09T21:42:22.445214Z","steps":["trace[284849774] 'process raft request' (duration: 801.772543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.445384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.643226Z","time spent":"802.089005ms","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:42:22.445405Z","caller":"traceutil/trace.go:171","msg":"trace[1588447387] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"752.796118ms","start":"2026-05-09T21:42:21.692597Z","end":"2026-05-09T21:42:22.445393Z","steps":["trace[1588447387] 'process raft request' (duration: 752.672563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.445512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.692573Z","time spent":"752.912843ms","remote":"127.0.0.1:48196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:42:22.4457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.642705Z","time spent":"802.615167ms","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:42:22.445915Z","caller":"traceutil/trace.go:171","msg":"trace[439733271] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"801.811424ms","start":"2026-05-09T21:42:21.644075Z","end":"2026-05-09T21:42:22.445887Z","steps":["trace[439733271] 'process raft request' (duration: 800.96114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.446103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.64406Z","time spent":"801.943398ms","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:42:22.466744Z","caller":"traceutil/trace.go:171","msg":"trace[959806600] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:632; }","duration":"614.781778ms","start":"2026-05-09T21:42:21.851933Z","end":"2026-05-09T21:42:22.466715Z","steps":["trace[959806600] 'read index received' (duration: 570.865392ms)","trace[959806600] 'applied index is now lower than readState.Index' (duration: 43.914836ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:42:22.467103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.144554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.467139Z","caller":"traceutil/trace.go:171","msg":"trace[1647152747] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:616; }","duration":"615.233537ms","start":"2026-05-09T21:42:21.851895Z","end":"2026-05-09T21:42:22.467129Z","steps":["trace[1647152747] 'agreement among raft nodes before linearized reading' (duration: 615.141543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.467166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.851878Z","time spent":"615.280639ms","remote":"127.0.0.1:46092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T21:42:22.467334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.361722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.467353Z","caller":"traceutil/trace.go:171","msg":"trace[1595962256] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:616; }","duration":"615.410225ms","start":"2026-05-09T21:42:21.851937Z","end":"2026-05-09T21:42:22.467347Z","steps":["trace[1595962256] 'agreement among raft nodes before linearized reading' (duration: 615.377593ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.467374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.851915Z","time spent":"615.451415ms","remote":"127.0.0.1:46092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:42:22.467836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.842201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:42:22.467849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.896033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.467875Z","caller":"traceutil/trace.go:171","msg":"trace[2138703933] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:616; }","duration":"252.939195ms","start":"2026-05-09T21:42:22.214928Z","end":"2026-05-09T21:42:22.467868Z","steps":["trace[2138703933] 'agreement among raft nodes before linearized reading' (duration: 252.882292ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.467987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.279432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.468056Z","caller":"traceutil/trace.go:171","msg":"trace[1015346924] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:616; }","duration":"282.328164ms","start":"2026-05-09T21:42:22.185682Z","end":"2026-05-09T21:42:22.46801Z","steps":["trace[1015346924] 'agreement among raft nodes before linearized reading' (duration: 282.281672ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.468158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.705372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:42:22.468169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.72808ms","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-05-09T21:42:22.468183Z","caller":"traceutil/trace.go:171","msg":"trace[1138580070] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:616; }","duration":"202.766344ms","start":"2026-05-09T21:42:22.26541Z","end":"2026-05-09T21:42:22.468177Z","steps":["trace[1138580070] 'agreement among raft nodes before linearized reading' (duration: 202.730382ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:22.46819Z","caller":"traceutil/trace.go:171","msg":"trace[981963319] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:616; }","duration":"282.788112ms","start":"2026-05-09T21:42:22.185396Z","end":"2026-05-09T21:42:22.468184Z","steps":["trace[981963319] 'agreement among raft nodes before linearized reading' (duration: 282.754531ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.468197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.720402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.468267Z","caller":"traceutil/trace.go:171","msg":"trace[920669492] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:616; }","duration":"202.837637ms","start":"2026-05-09T21:42:22.26541Z","end":"2026-05-09T21:42:22.468248Z","steps":["trace[920669492] 'agreement among raft nodes before linearized reading' (duration: 202.706442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.468278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.844918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:42:22.468285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.940179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.468298Z","caller":"traceutil/trace.go:171","msg":"trace[2000700959] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:616; }","duration":"202.89808ms","start":"2026-05-09T21:42:22.265394Z","end":"2026-05-09T21:42:22.468293Z","steps":["trace[2000700959] 'agreement among raft nodes before linearized reading' (duration: 202.866168ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:22.468305Z","caller":"traceutil/trace.go:171","msg":"trace[392747021] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:616; }","duration":"282.987961ms","start":"2026-05-09T21:42:22.185311Z","end":"2026-05-09T21:42:22.468299Z","steps":["trace[392747021] 'agreement among raft nodes before linearized reading' (duration: 282.95711ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.468374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.558289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:42:22.468394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.843688ms","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-05-09T21:42:22.4684Z","caller":"traceutil/trace.go:171","msg":"trace[889485644] 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:616; }","duration":"228.58415ms","start":"2026-05-09T21:42:22.239809Z","end":"2026-05-09T21:42:22.468393Z","steps":["trace[889485644] 'agreement among raft nodes before linearized reading' (duration: 228.550958ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:22.468419Z","caller":"traceutil/trace.go:171","msg":"trace[888121101] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:616; }","duration":"398.881149ms","start":"2026-05-09T21:42:22.069529Z","end":"2026-05-09T21:42:22.46841Z","steps":["trace[888121101] 'agreement among raft nodes before linearized reading' (duration: 398.847798ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.468446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:22.069524Z","time spent":"398.913921ms","remote":"127.0.0.1:46114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:42:22.468493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.721635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.468516Z","caller":"traceutil/trace.go:171","msg":"trace[1365561769] 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:616; }","duration":"228.752976ms","start":"2026-05-09T21:42:22.239758Z","end":"2026-05-09T21:42:22.46851Z","steps":["trace[1365561769] 'agreement among raft nodes before linearized reading' (duration: 228.717725ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.468545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.038046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.468577Z","caller":"traceutil/trace.go:171","msg":"trace[1552845065] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:616; }","duration":"399.097749ms","start":"2026-05-09T21:42:22.069471Z","end":"2026-05-09T21:42:22.468569Z","steps":["trace[1552845065] 'agreement among raft nodes before linearized reading' (duration: 399.050957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.468606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:22.06946Z","time spent":"399.13786ms","remote":"127.0.0.1:46114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T21:42:22.46864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.932044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.468678Z","caller":"traceutil/trace.go:171","msg":"trace[34507063] 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:616; }","duration":"229.001107ms","start":"2026-05-09T21:42:22.239667Z","end":"2026-05-09T21:42:22.468668Z","steps":["trace[34507063] 'agreement among raft nodes before linearized reading' (duration: 228.939044ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.468661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.193843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:42:22.46874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.733122ms","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":"warn","ts":"2026-05-09T21:42:22.468745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.368597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.468769Z","caller":"traceutil/trace.go:171","msg":"trace[651559940] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:616; }","duration":"546.792054ms","start":"2026-05-09T21:42:21.92197Z","end":"2026-05-09T21:42:22.468762Z","steps":["trace[651559940] 'agreement among raft nodes before linearized reading' (duration: 546.756133ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:22.468782Z","caller":"traceutil/trace.go:171","msg":"trace[1834440825] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:616; }","duration":"135.43041ms","start":"2026-05-09T21:42:22.333341Z","end":"2026-05-09T21:42:22.468772Z","steps":["trace[1834440825] 'agreement among raft nodes before linearized reading' (duration: 135.373687ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.468791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.921953Z","time spent":"546.832136ms","remote":"127.0.0.1:46104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:42:22.468811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.35165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.468872Z","caller":"traceutil/trace.go:171","msg":"trace[1056001924] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:616; }","duration":"164.413552ms","start":"2026-05-09T21:42:22.304447Z","end":"2026-05-09T21:42:22.468861Z","steps":["trace[1056001924] 'agreement among raft nodes before linearized reading' (duration: 164.306728ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.468893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.058995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.467877Z","caller":"traceutil/trace.go:171","msg":"trace[484922675] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:616; }","duration":"252.904224ms","start":"2026-05-09T21:42:22.214964Z","end":"2026-05-09T21:42:22.467868Z","steps":["trace[484922675] 'agreement among raft nodes before linearized reading' (duration: 252.834541ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:22.468913Z","caller":"traceutil/trace.go:171","msg":"trace[499302526] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:616; }","duration":"547.105247ms","start":"2026-05-09T21:42:21.9218Z","end":"2026-05-09T21:42:22.468906Z","steps":["trace[499302526] 'agreement among raft nodes before linearized reading' (duration: 547.072096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.468939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.92178Z","time spent":"547.152699ms","remote":"127.0.0.1:46104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T21:42:22.468987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.89973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.469041Z","caller":"traceutil/trace.go:171","msg":"trace[1292840388] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:616; }","duration":"580.003904ms","start":"2026-05-09T21:42:21.889029Z","end":"2026-05-09T21:42:22.469033Z","steps":["trace[1292840388] 'agreement among raft nodes before linearized reading' (duration: 579.937642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.46861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.617277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.469104Z","caller":"traceutil/trace.go:171","msg":"trace[104900898] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:616; }","duration":"136.149169ms","start":"2026-05-09T21:42:22.332945Z","end":"2026-05-09T21:42:22.469095Z","steps":["trace[104900898] 'agreement among raft nodes before linearized reading' (duration: 135.639868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.469065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.889002Z","time spent":"580.055546ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T21:42:22.468711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.43033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.46922Z","caller":"traceutil/trace.go:171","msg":"trace[1156320269] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:616; }","duration":"546.964241ms","start":"2026-05-09T21:42:21.922249Z","end":"2026-05-09T21:42:22.469213Z","steps":["trace[1156320269] 'agreement among raft nodes before linearized reading' (duration: 546.442291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.469252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.922235Z","time spent":"547.005803ms","remote":"127.0.0.1:46104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-05-09T21:42:22.469291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.362198ms","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":"warn","ts":"2026-05-09T21:42:22.468933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.857107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.469332Z","caller":"traceutil/trace.go:171","msg":"trace[2097507790] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:616; }","duration":"580.418881ms","start":"2026-05-09T21:42:21.888903Z","end":"2026-05-09T21:42:22.469322Z","steps":["trace[2097507790] 'agreement among raft nodes before linearized reading' (duration: 580.358008ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.469369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.888896Z","time spent":"580.462592ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:42:22.468747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.745617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.469416Z","caller":"traceutil/trace.go:171","msg":"trace[2054630240] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:616; }","duration":"254.426324ms","start":"2026-05-09T21:42:22.214985Z","end":"2026-05-09T21:42:22.469412Z","steps":["trace[2054630240] 'agreement among raft nodes before linearized reading' (duration: 253.745957ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:22.468739Z","caller":"traceutil/trace.go:171","msg":"trace[42866032] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:616; }","duration":"164.273766ms","start":"2026-05-09T21:42:22.304454Z","end":"2026-05-09T21:42:22.468727Z","steps":["trace[42866032] 'agreement among raft nodes before linearized reading' (duration: 164.178722ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.469508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.036289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:22.469543Z","caller":"traceutil/trace.go:171","msg":"trace[1769818143] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:616; }","duration":"617.112933ms","start":"2026-05-09T21:42:21.852422Z","end":"2026-05-09T21:42:22.469534Z","steps":["trace[1769818143] 'agreement among raft nodes before linearized reading' (duration: 617.05843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:22.469576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:21.852402Z","time spent":"617.164486ms","remote":"127.0.0.1:46092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-05-09T21:42:22.469341Z","caller":"traceutil/trace.go:171","msg":"trace[648104862] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:616; }","duration":"136.311605ms","start":"2026-05-09T21:42:22.333023Z","end":"2026-05-09T21:42:22.469335Z","steps":["trace[648104862] 'agreement among raft nodes before linearized reading' (duration: 135.884928ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:22.959451Z","caller":"traceutil/trace.go:171","msg":"trace[686528710] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"169.571371ms","start":"2026-05-09T21:42:22.789864Z","end":"2026-05-09T21:42:22.959435Z","steps":["trace[686528710] 'process raft request' (duration: 169.460647ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:24.380322Z","caller":"traceutil/trace.go:171","msg":"trace[52251380] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"453.384995ms","start":"2026-05-09T21:42:23.926916Z","end":"2026-05-09T21:42:24.380301Z","steps":["trace[52251380] 'process raft request' (duration: 450.906657ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:24.380608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:23.926885Z","time spent":"453.565062ms","remote":"127.0.0.1:47972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:42:27.159765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.477718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-05-09T21:42:27.159861Z","caller":"traceutil/trace.go:171","msg":"trace[1860689985] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:695; }","duration":"141.624764ms","start":"2026-05-09T21:42:27.018215Z","end":"2026-05-09T21:42:27.15984Z","steps":["trace[1860689985] 'range keys from in-memory index tree' (duration: 141.296242ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:35.998678Z","caller":"traceutil/trace.go:171","msg":"trace[1132413208] linearizableReadLoop","detail":"{readStateIndex:786; appliedIndex:785; }","duration":"392.439658ms","start":"2026-05-09T21:42:35.606215Z","end":"2026-05-09T21:42:35.998655Z","steps":["trace[1132413208] 'read index received' (duration: 392.19734ms)","trace[1132413208] 'applied index is now lower than readState.Index' (duration: 241.568µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:42:35.998766Z","caller":"traceutil/trace.go:171","msg":"trace[1968352715] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"771.032632ms","start":"2026-05-09T21:42:35.227715Z","end":"2026-05-09T21:42:35.998747Z","steps":["trace[1968352715] 'process raft request' (duration: 770.767543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:35.998824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.578373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:35.998913Z","caller":"traceutil/trace.go:171","msg":"trace[307832498] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:761; }","duration":"392.695148ms","start":"2026-05-09T21:42:35.606153Z","end":"2026-05-09T21:42:35.998849Z","steps":["trace[307832498] 'agreement among raft nodes before linearized reading' (duration: 392.599375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:35.99899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:35.606125Z","time spent":"392.853703ms","remote":"127.0.0.1:47884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T21:42:35.999043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:35.227688Z","time spent":"771.289971ms","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:42:38.702738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.685788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-09T21:42:38.702814Z","caller":"traceutil/trace.go:171","msg":"trace[1363566911] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:775; }","duration":"115.808642ms","start":"2026-05-09T21:42:38.586989Z","end":"2026-05-09T21:42:38.702798Z","steps":["trace[1363566911] 'range keys from in-memory index tree' (duration: 115.480802ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:38.703018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.753718ms","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-05-09T21:42:38.703058Z","caller":"traceutil/trace.go:171","msg":"trace[247730646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:775; }","duration":"109.8317ms","start":"2026-05-09T21:42:38.593215Z","end":"2026-05-09T21:42:38.703047Z","steps":["trace[247730646] 'range keys from in-memory index tree' (duration: 109.584432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:38.70324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.033316ms","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-05-09T21:42:38.703293Z","caller":"traceutil/trace.go:171","msg":"trace[1855396103] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:775; }","duration":"102.136479ms","start":"2026-05-09T21:42:38.601146Z","end":"2026-05-09T21:42:38.703282Z","steps":["trace[1855396103] 'range keys from in-memory index tree' (duration: 101.650583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:39.387055Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566936402227287,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:42:39.889564Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566936402227287,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:42:40.389991Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566936402227287,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:42:40.390941Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.658745634s","expected-duration":"1s"} {"level":"info","ts":"2026-05-09T21:42:40.394095Z","caller":"traceutil/trace.go:171","msg":"trace[1690353758] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"1.686798232s","start":"2026-05-09T21:42:38.707278Z","end":"2026-05-09T21:42:40.394076Z","steps":["trace[1690353758] 'process raft request' (duration: 1.683888745s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:40.394194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:38.707265Z","time spent":"1.686868905s","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:42:40.394184Z","caller":"traceutil/trace.go:171","msg":"trace[603095850] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"1.685753737s","start":"2026-05-09T21:42:38.708402Z","end":"2026-05-09T21:42:40.394155Z","steps":["trace[603095850] 'process raft request' (duration: 1.685707686s)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:40.394196Z","caller":"traceutil/trace.go:171","msg":"trace[1325328822] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"1.686610006s","start":"2026-05-09T21:42:38.707566Z","end":"2026-05-09T21:42:40.394176Z","steps":["trace[1325328822] 'process raft request' (duration: 1.686401319s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:40.394295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:38.708381Z","time spent":"1.685852611s","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:42:40.394303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:38.707553Z","time spent":"1.686700718s","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:42:40.394527Z","caller":"traceutil/trace.go:171","msg":"trace[1073676792] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"1.686476751s","start":"2026-05-09T21:42:38.70804Z","end":"2026-05-09T21:42:40.394516Z","steps":["trace[1073676792] 'process raft request' (duration: 1.686025026s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:40.39457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:38.708031Z","time spent":"1.686516542s","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:42:40.411958Z","caller":"traceutil/trace.go:171","msg":"trace[837372113] linearizableReadLoop","detail":"{readStateIndex:807; appliedIndex:802; }","duration":"1.5256144s","start":"2026-05-09T21:42:38.886328Z","end":"2026-05-09T21:42:40.411942Z","steps":["trace[837372113] 'read index received' (duration: 1.504930694s)","trace[837372113] 'applied index is now lower than readState.Index' (duration: 20.683276ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:42:40.412147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.00272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:42:40.412186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.525845777s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-qsvqf\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-05-09T21:42:40.412255Z","caller":"traceutil/trace.go:171","msg":"trace[679091171] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-qsvqf; range_end:; response_count:1; response_revision:781; }","duration":"1.525940041s","start":"2026-05-09T21:42:38.886297Z","end":"2026-05-09T21:42:40.412237Z","steps":["trace[679091171] 'agreement among raft nodes before linearized reading' (duration: 1.525733034s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:40.412286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:38.886283Z","time spent":"1.525996673s","remote":"127.0.0.1:48054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-qsvqf\" "} {"level":"info","ts":"2026-05-09T21:42:40.41235Z","caller":"traceutil/trace.go:171","msg":"trace[544038527] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:781; }","duration":"805.128125ms","start":"2026-05-09T21:42:39.607095Z","end":"2026-05-09T21:42:40.412224Z","steps":["trace[544038527] 'agreement among raft nodes before linearized reading' (duration: 805.006711ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:40.412408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:39.60707Z","time spent":"805.326651ms","remote":"127.0.0.1:47884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-09T21:42:40.412611Z","caller":"traceutil/trace.go:171","msg":"trace[412005403] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"217.416178ms","start":"2026-05-09T21:42:40.195146Z","end":"2026-05-09T21:42:40.412562Z","steps":["trace[412005403] 'process raft request' (duration: 216.739426ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:43:33.396523Z","caller":"traceutil/trace.go:171","msg":"trace[1334212460] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"143.701281ms","start":"2026-05-09T21:43:33.25279Z","end":"2026-05-09T21:43:33.396492Z","steps":["trace[1334212460] 'process raft request' (duration: 138.76489ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:12.200742Z","caller":"traceutil/trace.go:171","msg":"trace[1599250226] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"141.02278ms","start":"2026-05-09T21:44:12.059701Z","end":"2026-05-09T21:44:12.200724Z","steps":["trace[1599250226] 'process raft request' (duration: 140.931729ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:15.259269Z","caller":"traceutil/trace.go:171","msg":"trace[64522521] linearizableReadLoop","detail":"{readStateIndex:1273; appliedIndex:1272; }","duration":"109.966975ms","start":"2026-05-09T21:44:15.149277Z","end":"2026-05-09T21:44:15.259244Z","steps":["trace[64522521] 'read index received' (duration: 109.871343ms)","trace[64522521] 'applied index is now lower than readState.Index' (duration: 94.712µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:44:15.259306Z","caller":"traceutil/trace.go:171","msg":"trace[95890421] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"177.21577ms","start":"2026-05-09T21:44:15.082065Z","end":"2026-05-09T21:44:15.259281Z","steps":["trace[95890421] 'process raft request' (duration: 177.051288ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:15.259589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.28499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-09T21:44:15.259678Z","caller":"traceutil/trace.go:171","msg":"trace[1058876463] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1226; }","duration":"110.414891ms","start":"2026-05-09T21:44:15.149241Z","end":"2026-05-09T21:44:15.259656Z","steps":["trace[1058876463] 'agreement among raft nodes before linearized reading' (duration: 110.139377ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:31.91864Z","caller":"traceutil/trace.go:171","msg":"trace[169678607] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"117.169358ms","start":"2026-05-09T21:44:31.801448Z","end":"2026-05-09T21:44:31.918618Z","steps":["trace[169678607] 'process raft request' (duration: 117.034786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:32.104062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.021173ms","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-05-09T21:44:32.104151Z","caller":"traceutil/trace.go:171","msg":"trace[1761408046] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1322; }","duration":"105.152395ms","start":"2026-05-09T21:44:31.998981Z","end":"2026-05-09T21:44:32.104133Z","steps":["trace[1761408046] 'count revisions from in-memory index tree' (duration: 104.944332ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:32.345884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.597675ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-05-09T21:44:34.053409Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566936402228587,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:44:34.553837Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566936402228587,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:44:35.054429Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566936402228587,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:44:35.079036Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.561127739s","expected-duration":"1s"} {"level":"info","ts":"2026-05-09T21:44:35.079385Z","caller":"traceutil/trace.go:171","msg":"trace[1195949164] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"1.561735759s","start":"2026-05-09T21:44:33.517623Z","end":"2026-05-09T21:44:35.079358Z","steps":["trace[1195949164] 'process raft request' (duration: 1.561580477s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:35.07956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:33.517602Z","time spent":"1.56184978s","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:44:35.64914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.7321ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:44:35.649239Z","caller":"traceutil/trace.go:171","msg":"trace[894269010] linearizableReadLoop","detail":"{readStateIndex:1378; appliedIndex:1376; }","duration":"2.096788924s","start":"2026-05-09T21:44:33.552433Z","end":"2026-05-09T21:44:35.649222Z","steps":["trace[894269010] 'read index received' (duration: 1.526813657s)","trace[894269010] 'applied index is now lower than readState.Index' (duration: 569.973867ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:44:35.649397Z","caller":"traceutil/trace.go:171","msg":"trace[1725855475] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"1.72564295s","start":"2026-05-09T21:44:33.92367Z","end":"2026-05-09T21:44:35.649313Z","steps":["trace[1725855475] 'process raft request' (duration: 1.318650576s)","trace[1725855475] 'compare' (duration: 406.609738ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:44:35.649523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.097083599s","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-05-09T21:44:35.649558Z","caller":"traceutil/trace.go:171","msg":"trace[730079418] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1326; }","duration":"2.09714182s","start":"2026-05-09T21:44:33.552407Z","end":"2026-05-09T21:44:35.649549Z","steps":["trace[730079418] 'agreement among raft nodes before linearized reading' (duration: 2.096912507s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:35.649592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:33.552396Z","time spent":"2.097188781s","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-09T21:44:35.649707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:33.923641Z","time spent":"1.725841352s","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:44:35.649812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.043973967s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:44:35.649868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.034963912s","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-05-09T21:44:35.649892Z","caller":"traceutil/trace.go:171","msg":"trace[2003016258] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1326; }","duration":"1.04410344s","start":"2026-05-09T21:44:34.60577Z","end":"2026-05-09T21:44:35.649873Z","steps":["trace[2003016258] 'agreement among raft nodes before linearized reading' (duration: 1.043950077s)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:35.649915Z","caller":"traceutil/trace.go:171","msg":"trace[2075264127] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1326; }","duration":"2.035050653s","start":"2026-05-09T21:44:33.614851Z","end":"2026-05-09T21:44:35.649902Z","steps":["trace[2075264127] 'agreement among raft nodes before linearized reading' (duration: 2.034874721s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:35.649894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.131448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-09T21:44:35.649942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:34.605744Z","time spent":"1.04418666s","remote":"127.0.0.1:47884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T21:44:35.649961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:33.614831Z","time spent":"2.035122215s","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-09T21:44:35.649985Z","caller":"traceutil/trace.go:171","msg":"trace[1228033249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1326; }","duration":"132.26547ms","start":"2026-05-09T21:44:35.517697Z","end":"2026-05-09T21:44:35.649963Z","steps":["trace[1228033249] 'agreement among raft nodes before linearized reading' (duration: 132.024086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:35.649894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.044130976s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-09T21:44:35.650101Z","caller":"traceutil/trace.go:171","msg":"trace[1770149872] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1326; }","duration":"2.044376819s","start":"2026-05-09T21:44:33.605697Z","end":"2026-05-09T21:44:35.650074Z","steps":["trace[1770149872] 'agreement among raft nodes before linearized reading' (duration: 2.044018524s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:35.65016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:33.605671Z","time spent":"2.04447307s","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}