{"level":"warn","ts":"2026-04-28T13:52:13.980359Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-28T13:52:13.980436Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.207:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.207:2380","--initial-cluster=instance=https://199.19.213.207:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.207:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.207:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-28T13:52:13.980497Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-28T13:52:13.980504Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.207:2380"]} {"level":"info","ts":"2026-04-28T13:52:13.980521Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-28T13:52:13.981425Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.207:2379"]} {"level":"info","ts":"2026-04-28T13:52:13.981508Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.207:2380"],"listen-peer-urls":["https://199.19.213.207:2380"],"advertise-client-urls":["https://199.19.213.207:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.207:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.207:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-28T13:52:13.985694Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.953178ms"} {"level":"info","ts":"2026-04-28T13:52:13.995151Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"520ed656383c33a4","cluster-id":"21f34f1629612ac4"} {"level":"info","ts":"2026-04-28T13:52:13.995392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 switched to configuration voters=()"} {"level":"info","ts":"2026-04-28T13:52:13.995417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became follower at term 0"} {"level":"info","ts":"2026-04-28T13:52:13.995431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 520ed656383c33a4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-28T13:52:13.995439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became follower at term 1"} {"level":"info","ts":"2026-04-28T13:52:13.995495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 switched to configuration voters=(5912899026583040932)"} {"level":"warn","ts":"2026-04-28T13:52:14.001519Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-28T13:52:14.003241Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-28T13:52:14.005863Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-28T13:52:14.009327Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"520ed656383c33a4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-28T13:52:14.010065Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"520ed656383c33a4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-28T13:52:14.010336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 switched to configuration voters=(5912899026583040932)"} {"level":"info","ts":"2026-04-28T13:52:14.010428Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"21f34f1629612ac4","local-member-id":"520ed656383c33a4","added-peer-id":"520ed656383c33a4","added-peer-peer-urls":["https://199.19.213.207:2380"]} {"level":"info","ts":"2026-04-28T13:52:14.01048Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-28T13:52:14.010506Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-28T13:52:14.010515Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-28T13:52:14.013889Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-28T13:52:14.013971Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.207:2380"} {"level":"info","ts":"2026-04-28T13:52:14.014122Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"520ed656383c33a4","initial-advertise-peer-urls":["https://199.19.213.207:2380"],"listen-peer-urls":["https://199.19.213.207:2380"],"advertise-client-urls":["https://199.19.213.207:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.207:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-28T13:52:14.014118Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.207:2380"} {"level":"info","ts":"2026-04-28T13:52:14.014153Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-28T13:52:14.496409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 is starting a new election at term 1"} {"level":"info","ts":"2026-04-28T13:52:14.496478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-28T13:52:14.496529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 received MsgPreVoteResp from 520ed656383c33a4 at term 1"} {"level":"info","ts":"2026-04-28T13:52:14.496555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became candidate at term 2"} {"level":"info","ts":"2026-04-28T13:52:14.496571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 received MsgVoteResp from 520ed656383c33a4 at term 2"} {"level":"info","ts":"2026-04-28T13:52:14.496598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became leader at term 2"} {"level":"info","ts":"2026-04-28T13:52:14.496616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 520ed656383c33a4 elected leader 520ed656383c33a4 at term 2"} {"level":"info","ts":"2026-04-28T13:52:14.554984Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:52:14.556133Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"520ed656383c33a4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.207:2379]}","request-path":"/0/members/520ed656383c33a4/attributes","cluster-id":"21f34f1629612ac4","publish-timeout":"7s"} {"level":"info","ts":"2026-04-28T13:52:14.556291Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T13:52:14.556451Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-28T13:52:14.556375Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T13:52:14.556497Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-28T13:52:14.561187Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"21f34f1629612ac4","local-member-id":"520ed656383c33a4","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:52:14.56231Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-28T13:52:14.563103Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:52:14.563146Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:52:14.564617Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.207:2379"} {"level":"warn","ts":"2026-04-28T13:52:17.317842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.939876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-28T13:52:17.317966Z","caller":"traceutil/trace.go:171","msg":"trace[462232750] transaction","detail":"{read_only:false; response_revision:125; number_of_response:1; }","duration":"177.360179ms","start":"2026-04-28T13:52:17.140587Z","end":"2026-04-28T13:52:17.317947Z","steps":["trace[462232750] 'process raft request' (duration: 27.860768ms)","trace[462232750] 'compare' (duration: 148.813212ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:17.651136Z","caller":"traceutil/trace.go:171","msg":"trace[2069776288] transaction","detail":"{read_only:false; response_revision:151; number_of_response:1; }","duration":"150.221721ms","start":"2026-04-28T13:52:17.500855Z","end":"2026-04-28T13:52:17.651076Z","steps":["trace[2069776288] 'process raft request' (duration: 55.815275ms)","trace[2069776288] 'compare' (duration: 94.17974ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:17.827057Z","caller":"traceutil/trace.go:171","msg":"trace[159345459] transaction","detail":"{read_only:false; response_revision:154; number_of_response:1; }","duration":"102.094994ms","start":"2026-04-28T13:52:17.724939Z","end":"2026-04-28T13:52:17.827034Z","steps":["trace[159345459] 'process raft request' (duration: 91.66421ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:31.694629Z","caller":"traceutil/trace.go:171","msg":"trace[1711981001] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"106.456452ms","start":"2026-04-28T13:52:31.588144Z","end":"2026-04-28T13:52:31.6946Z","steps":["trace[1711981001] 'process raft request' (duration: 101.993561ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:31.928027Z","caller":"traceutil/trace.go:171","msg":"trace[902907579] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"227.974745ms","start":"2026-04-28T13:52:31.700016Z","end":"2026-04-28T13:52:31.927991Z","steps":["trace[902907579] 'process raft request' (duration: 226.948948ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:31.928137Z","caller":"traceutil/trace.go:171","msg":"trace[982381509] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"226.173405ms","start":"2026-04-28T13:52:31.701934Z","end":"2026-04-28T13:52:31.928108Z","steps":["trace[982381509] 'process raft request' (duration: 225.96071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:32.145329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.957968ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:52:32.145591Z","caller":"traceutil/trace.go:171","msg":"trace[176588593] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"379.951613ms","start":"2026-04-28T13:52:31.765606Z","end":"2026-04-28T13:52:32.145558Z","steps":["trace[176588593] 'process raft request' (duration: 276.702438ms)","trace[176588593] 'compare' (duration: 102.835744ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:32.145764Z","caller":"traceutil/trace.go:171","msg":"trace[662349832] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"377.141267ms","start":"2026-04-28T13:52:31.768581Z","end":"2026-04-28T13:52:32.145722Z","steps":["trace[662349832] 'process raft request' (duration: 376.983383ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:32.145793Z","caller":"traceutil/trace.go:171","msg":"trace[203571024] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"377.64342ms","start":"2026-04-28T13:52:31.768093Z","end":"2026-04-28T13:52:32.145737Z","steps":["trace[203571024] 'process raft request' (duration: 377.413514ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:32.145681Z","caller":"traceutil/trace.go:171","msg":"trace[2124258470] linearizableReadLoop","detail":"{readStateIndex:392; appliedIndex:386; }","duration":"341.248071ms","start":"2026-04-28T13:52:31.80441Z","end":"2026-04-28T13:52:32.145658Z","steps":["trace[2124258470] 'read index received' (duration: 122.537389ms)","trace[2124258470] 'applied index is now lower than readState.Index' (duration: 218.709732ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:32.145695Z","caller":"traceutil/trace.go:171","msg":"trace[1441707098] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"379.668865ms","start":"2026-04-28T13:52:31.76601Z","end":"2026-04-28T13:52:32.145679Z","steps":["trace[1441707098] 'process raft request' (duration: 379.427809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:32.145925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:31.765996Z","time spent":"379.898411ms","remote":"127.0.0.1:54320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:52:32.146492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:31.768565Z","time spent":"377.27134ms","remote":"127.0.0.1:54412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4037,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:52:32.147233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:31.765583Z","time spent":"380.230011ms","remote":"127.0.0.1:54320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:52:32.148413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:31.768068Z","time spent":"377.768183ms","remote":"127.0.0.1:54652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3795,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:52:32.148698Z","caller":"traceutil/trace.go:171","msg":"trace[1271584924] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"213.423549ms","start":"2026-04-28T13:52:31.93522Z","end":"2026-04-28T13:52:32.148644Z","steps":["trace[1271584924] 'process raft request' (duration: 210.386886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:32.149084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.646543ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:32.149195Z","caller":"traceutil/trace.go:171","msg":"trace[391685240] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:380; }","duration":"344.774186ms","start":"2026-04-28T13:52:31.804401Z","end":"2026-04-28T13:52:32.149175Z","steps":["trace[391685240] 'agreement among raft nodes before linearized reading' (duration: 341.339083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:32.384396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.6574ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:52:32.384626Z","caller":"traceutil/trace.go:171","msg":"trace[1536031887] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"228.005634ms","start":"2026-04-28T13:52:32.1566Z","end":"2026-04-28T13:52:32.384605Z","steps":["trace[1536031887] 'process raft request' (duration: 227.915012ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:32.384621Z","caller":"traceutil/trace.go:171","msg":"trace[1046548423] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"229.310539ms","start":"2026-04-28T13:52:32.155245Z","end":"2026-04-28T13:52:32.384555Z","steps":["trace[1046548423] 'process raft request' (duration: 91.437623ms)","trace[1046548423] 'compare' (duration: 137.432685ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:32.384751Z","caller":"traceutil/trace.go:171","msg":"trace[393876202] linearizableReadLoop","detail":"{readStateIndex:394; appliedIndex:393; }","duration":"229.409442ms","start":"2026-04-28T13:52:32.155281Z","end":"2026-04-28T13:52:32.38469Z","steps":["trace[393876202] 'read index received' (duration: 91.419112ms)","trace[393876202] 'applied index is now lower than readState.Index' (duration: 137.954409ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:32.384916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.619949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"warn","ts":"2026-04-28T13:52:32.385059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.814616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-ldv5g\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-04-28T13:52:32.38507Z","caller":"traceutil/trace.go:171","msg":"trace[1956917830] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:382; }","duration":"229.769882ms","start":"2026-04-28T13:52:32.155243Z","end":"2026-04-28T13:52:32.385013Z","steps":["trace[1956917830] 'agreement among raft nodes before linearized reading' (duration: 229.609338ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:32.385125Z","caller":"traceutil/trace.go:171","msg":"trace[2142831459] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-ldv5g; range_end:; response_count:1; response_revision:382; }","duration":"228.94281ms","start":"2026-04-28T13:52:32.156153Z","end":"2026-04-28T13:52:32.385096Z","steps":["trace[2142831459] 'agreement among raft nodes before linearized reading' (duration: 228.784296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:32.385115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.454436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-04-28T13:52:32.385189Z","caller":"traceutil/trace.go:171","msg":"trace[1880514419] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:382; }","duration":"228.548299ms","start":"2026-04-28T13:52:32.156625Z","end":"2026-04-28T13:52:32.385173Z","steps":["trace[1880514419] 'agreement among raft nodes before linearized reading' (duration: 228.432446ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:32.60699Z","caller":"traceutil/trace.go:171","msg":"trace[730153568] linearizableReadLoop","detail":"{readStateIndex:396; appliedIndex:395; }","duration":"214.342473ms","start":"2026-04-28T13:52:32.392617Z","end":"2026-04-28T13:52:32.60696Z","steps":["trace[730153568] 'read index received' (duration: 141.775321ms)","trace[730153568] 'applied index is now lower than readState.Index' (duration: 72.565922ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:32.607167Z","caller":"traceutil/trace.go:171","msg":"trace[189266180] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"219.512423ms","start":"2026-04-28T13:52:32.38762Z","end":"2026-04-28T13:52:32.607133Z","steps":["trace[189266180] 'process raft request' (duration: 146.760566ms)","trace[189266180] 'compare' (duration: 72.422359ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:32.607235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.598019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3855"} {"level":"info","ts":"2026-04-28T13:52:32.60727Z","caller":"traceutil/trace.go:171","msg":"trace[586630439] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:383; }","duration":"214.652812ms","start":"2026-04-28T13:52:32.39261Z","end":"2026-04-28T13:52:32.607262Z","steps":["trace[586630439] 'agreement among raft nodes before linearized reading' (duration: 214.542639ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:32.609471Z","caller":"traceutil/trace.go:171","msg":"trace[1798977759] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"213.336895ms","start":"2026-04-28T13:52:32.396109Z","end":"2026-04-28T13:52:32.609445Z","steps":["trace[1798977759] 'process raft request' (duration: 212.784861ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:36.92836Z","caller":"traceutil/trace.go:171","msg":"trace[2065771132] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"294.286345ms","start":"2026-04-28T13:52:36.634046Z","end":"2026-04-28T13:52:36.928332Z","steps":["trace[2065771132] 'process raft request' (duration: 294.044549ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:47.313109Z","caller":"traceutil/trace.go:171","msg":"trace[1958888533] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"879.058043ms","start":"2026-04-28T13:52:46.434021Z","end":"2026-04-28T13:52:47.313079Z","steps":["trace[1958888533] 'process raft request' (duration: 878.885699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:47.313259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:46.433998Z","time spent":"879.196677ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:52:47.323243Z","caller":"traceutil/trace.go:171","msg":"trace[392593170] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"876.882634ms","start":"2026-04-28T13:52:46.446331Z","end":"2026-04-28T13:52:47.323214Z","steps":["trace[392593170] 'process raft request' (duration: 876.675509ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:47.323331Z","caller":"traceutil/trace.go:171","msg":"trace[196845478] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"862.785441ms","start":"2026-04-28T13:52:46.460527Z","end":"2026-04-28T13:52:47.323312Z","steps":["trace[196845478] 'process raft request' (duration: 862.606676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:47.323393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:46.446312Z","time spent":"877.017577ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:52:47.323409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:46.460509Z","time spent":"862.862743ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:52:47.324116Z","caller":"traceutil/trace.go:171","msg":"trace[1754136582] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"850.267342ms","start":"2026-04-28T13:52:46.473835Z","end":"2026-04-28T13:52:47.324102Z","steps":["trace[1754136582] 'process raft request' (duration: 849.341746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:47.32422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:46.473817Z","time spent":"850.344734ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:52:47.324443Z","caller":"traceutil/trace.go:171","msg":"trace[1389656851] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"850.533289ms","start":"2026-04-28T13:52:46.4739Z","end":"2026-04-28T13:52:47.324433Z","steps":["trace[1389656851] 'process raft request' (duration: 850.021884ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:47.324442Z","caller":"traceutil/trace.go:171","msg":"trace[1496343831] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"842.798998ms","start":"2026-04-28T13:52:46.481619Z","end":"2026-04-28T13:52:47.324418Z","steps":["trace[1496343831] 'process raft request' (duration: 842.471299ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:47.324463Z","caller":"traceutil/trace.go:171","msg":"trace[6063241] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"833.168327ms","start":"2026-04-28T13:52:46.491273Z","end":"2026-04-28T13:52:47.324441Z","steps":["trace[6063241] 'process raft request' (duration: 832.882679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:47.324508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:46.473896Z","time spent":"850.5849ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:52:47.324535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:46.491255Z","time spent":"833.248298ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:52:47.324518Z","caller":"traceutil/trace.go:171","msg":"trace[365349916] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"842.902951ms","start":"2026-04-28T13:52:46.48156Z","end":"2026-04-28T13:52:47.324463Z","steps":["trace[365349916] 'process raft request' (duration: 842.431388ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:47.324664Z","caller":"traceutil/trace.go:171","msg":"trace[253467201] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"829.893717ms","start":"2026-04-28T13:52:46.494749Z","end":"2026-04-28T13:52:47.324642Z","steps":["trace[253467201] 'process raft request' (duration: 829.520087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:47.324695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:46.481543Z","time spent":"843.084986ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:52:47.324777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:46.494737Z","time spent":"830.001829ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:52:47.324857Z","caller":"traceutil/trace.go:171","msg":"trace[439047289] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"828.212252ms","start":"2026-04-28T13:52:46.49663Z","end":"2026-04-28T13:52:47.324842Z","steps":["trace[439047289] 'process raft request' (duration: 827.691418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:47.324675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:46.481615Z","time spent":"842.965932ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:52:47.324931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:46.496621Z","time spent":"828.277103ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:52:47.32507Z","caller":"traceutil/trace.go:171","msg":"trace[1051487089] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"809.178985ms","start":"2026-04-28T13:52:46.515879Z","end":"2026-04-28T13:52:47.325058Z","steps":["trace[1051487089] 'process raft request' (duration: 808.492266ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:47.325155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:46.515827Z","time spent":"809.288668ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:52:47.32563Z","caller":"traceutil/trace.go:171","msg":"trace[1887547172] linearizableReadLoop","detail":"{readStateIndex:498; appliedIndex:487; }","duration":"270.801137ms","start":"2026-04-28T13:52:47.054791Z","end":"2026-04-28T13:52:47.325592Z","steps":["trace[1887547172] 'read index received' (duration: 258.331968ms)","trace[1887547172] 'applied index is now lower than readState.Index' (duration: 12.468049ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:47.325727Z","caller":"traceutil/trace.go:171","msg":"trace[841685966] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"711.293855ms","start":"2026-04-28T13:52:46.614421Z","end":"2026-04-28T13:52:47.325715Z","steps":["trace[841685966] 'process raft request' (duration: 710.884454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:47.32593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.140277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-28T13:52:47.325929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:46.614327Z","time spent":"711.432409ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:52:47.32597Z","caller":"traceutil/trace.go:171","msg":"trace[1695260465] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:481; }","duration":"271.186968ms","start":"2026-04-28T13:52:47.054773Z","end":"2026-04-28T13:52:47.32596Z","steps":["trace[1695260465] 'agreement among raft nodes before linearized reading' (duration: 271.027984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:47.33468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.470475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-28T13:52:47.334735Z","caller":"traceutil/trace.go:171","msg":"trace[263976273] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:483; }","duration":"278.536627ms","start":"2026-04-28T13:52:47.056187Z","end":"2026-04-28T13:52:47.334724Z","steps":["trace[263976273] 'agreement among raft nodes before linearized reading' (duration: 278.383902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:47.334689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.080445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T13:52:47.334842Z","caller":"traceutil/trace.go:171","msg":"trace[2029407745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:483; }","duration":"236.27189ms","start":"2026-04-28T13:52:47.098562Z","end":"2026-04-28T13:52:47.334834Z","steps":["trace[2029407745] 'agreement among raft nodes before linearized reading' (duration: 236.028513ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:48.009242Z","caller":"traceutil/trace.go:171","msg":"trace[695312311] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"177.272176ms","start":"2026-04-28T13:52:47.831951Z","end":"2026-04-28T13:52:48.009223Z","steps":["trace[695312311] 'process raft request' (duration: 165.627689ms)","trace[695312311] 'compare' (duration: 11.558335ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:48.009761Z","caller":"traceutil/trace.go:171","msg":"trace[1202365566] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"152.377651ms","start":"2026-04-28T13:52:47.857332Z","end":"2026-04-28T13:52:48.00971Z","steps":["trace[1202365566] 'process raft request' (duration: 151.948529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.478886Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721272727527665657,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T13:52:54.625654Z","caller":"traceutil/trace.go:171","msg":"trace[1585135017] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"647.229262ms","start":"2026-04-28T13:52:53.978407Z","end":"2026-04-28T13:52:54.625636Z","steps":["trace[1585135017] 'read index received' (duration: 646.519723ms)","trace[1585135017] 'applied index is now lower than readState.Index' (duration: 708.739µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:54.62575Z","caller":"traceutil/trace.go:171","msg":"trace[2055754870] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"715.990226ms","start":"2026-04-28T13:52:53.909751Z","end":"2026-04-28T13:52:54.625741Z","steps":["trace[2055754870] 'process raft request' (duration: 715.458582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.625847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:53.909726Z","time spent":"716.056428ms","remote":"127.0.0.1:54338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:52:54.626063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.212047ms","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":"warn","ts":"2026-04-28T13:52:54.626206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.055533ms","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-04-28T13:52:54.626248Z","caller":"traceutil/trace.go:171","msg":"trace[651622149] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"425.101455ms","start":"2026-04-28T13:52:54.201136Z","end":"2026-04-28T13:52:54.626237Z","steps":["trace[651622149] 'agreement among raft nodes before linearized reading' (duration: 425.029033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.626314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.201108Z","time spent":"425.199838ms","remote":"127.0.0.1:43388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:52:54.626234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.958351ms","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-04-28T13:52:54.626356Z","caller":"traceutil/trace.go:171","msg":"trace[1844691094] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:582; }","duration":"487.129406ms","start":"2026-04-28T13:52:54.139212Z","end":"2026-04-28T13:52:54.626342Z","steps":["trace[1844691094] 'agreement among raft nodes before linearized reading' (duration: 486.926121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.626476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.415186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:52:54.626428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.692361ms","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-04-28T13:52:54.626493Z","caller":"traceutil/trace.go:171","msg":"trace[1223522069] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:582; }","duration":"548.453957ms","start":"2026-04-28T13:52:54.078033Z","end":"2026-04-28T13:52:54.626487Z","steps":["trace[1223522069] 'agreement among raft nodes before linearized reading' (duration: 548.428346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.62651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.078019Z","time spent":"548.485538ms","remote":"127.0.0.1:43360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:52:54.626517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.139207Z","time spent":"487.262689ms","remote":"127.0.0.1:43368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-28T13:52:54.626523Z","caller":"traceutil/trace.go:171","msg":"trace[1256114678] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:582; }","duration":"514.863705ms","start":"2026-04-28T13:52:54.111639Z","end":"2026-04-28T13:52:54.626502Z","steps":["trace[1256114678] 'agreement among raft nodes before linearized reading' (duration: 514.67451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.626583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.111616Z","time spent":"514.956547ms","remote":"127.0.0.1:43364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:52:54.626601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.413986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.626619Z","caller":"traceutil/trace.go:171","msg":"trace[508407974] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:582; }","duration":"548.469238ms","start":"2026-04-28T13:52:54.078145Z","end":"2026-04-28T13:52:54.626615Z","steps":["trace[508407974] 'agreement among raft nodes before linearized reading' (duration: 548.439837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.626618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.073667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:52:54.626634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.078141Z","time spent":"548.489498ms","remote":"127.0.0.1:43360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-28T13:52:54.626657Z","caller":"traceutil/trace.go:171","msg":"trace[1410525191] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:582; }","duration":"229.128308ms","start":"2026-04-28T13:52:54.397514Z","end":"2026-04-28T13:52:54.626643Z","steps":["trace[1410525191] 'agreement among raft nodes before linearized reading' (duration: 229.086907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.62667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.570435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:52:54.626775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.674596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.626801Z","caller":"traceutil/trace.go:171","msg":"trace[2076845946] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"426.727818ms","start":"2026-04-28T13:52:54.200068Z","end":"2026-04-28T13:52:54.626796Z","steps":["trace[2076845946] 'agreement among raft nodes before linearized reading' (duration: 426.691806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.626815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.200049Z","time spent":"426.762019ms","remote":"127.0.0.1:43388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:52:54.6269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.698631ms","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":"warn","ts":"2026-04-28T13:52:54.626914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.330781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.626932Z","caller":"traceutil/trace.go:171","msg":"trace[1655011433] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:582; }","duration":"304.368252ms","start":"2026-04-28T13:52:54.322559Z","end":"2026-04-28T13:52:54.626927Z","steps":["trace[1655011433] 'agreement among raft nodes before linearized reading' (duration: 304.340001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.626945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.322549Z","time spent":"304.393212ms","remote":"127.0.0.1:43412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:52:54.626932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.498945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dxtjw\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-04-28T13:52:54.62706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.05087ms","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-04-28T13:52:54.628267Z","caller":"traceutil/trace.go:171","msg":"trace[447988282] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:582; }","duration":"568.289512ms","start":"2026-04-28T13:52:54.059956Z","end":"2026-04-28T13:52:54.628246Z","steps":["trace[447988282] 'agreement among raft nodes before linearized reading' (duration: 567.0575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.628375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.059937Z","time spent":"568.397855ms","remote":"127.0.0.1:43350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:52:54.626582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.015416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.628482Z","caller":"traceutil/trace.go:171","msg":"trace[253572988] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:582; }","duration":"272.931485ms","start":"2026-04-28T13:52:54.355536Z","end":"2026-04-28T13:52:54.628467Z","steps":["trace[253572988] 'agreement among raft nodes before linearized reading' (duration: 271.021445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.626374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.418529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.628626Z","caller":"traceutil/trace.go:171","msg":"trace[58669098] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:582; }","duration":"354.689038ms","start":"2026-04-28T13:52:54.273926Z","end":"2026-04-28T13:52:54.628615Z","steps":["trace[58669098] 'agreement among raft nodes before linearized reading' (duration: 352.405899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.628664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.273917Z","time spent":"354.731959ms","remote":"127.0.0.1:43396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-04-28T13:52:54.626952Z","caller":"traceutil/trace.go:171","msg":"trace[540559448] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:582; }","duration":"487.762802ms","start":"2026-04-28T13:52:54.139161Z","end":"2026-04-28T13:52:54.626924Z","steps":["trace[540559448] 'agreement among raft nodes before linearized reading' (duration: 487.711111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.628728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.139142Z","time spent":"489.572058ms","remote":"127.0.0.1:43364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-04-28T13:52:54.62637Z","caller":"traceutil/trace.go:171","msg":"trace[150845698] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:582; }","duration":"566.431974ms","start":"2026-04-28T13:52:54.05977Z","end":"2026-04-28T13:52:54.626202Z","steps":["trace[150845698] 'agreement among raft nodes before linearized reading' (duration: 566.192627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.628827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.059745Z","time spent":"569.061992ms","remote":"127.0.0.1:43350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:52:54.626128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.81983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.628987Z","caller":"traceutil/trace.go:171","msg":"trace[80913503] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:582; }","duration":"330.714986ms","start":"2026-04-28T13:52:54.298263Z","end":"2026-04-28T13:52:54.628978Z","steps":["trace[80913503] 'agreement among raft nodes before linearized reading' (duration: 327.81123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.629015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.298244Z","time spent":"330.762016ms","remote":"127.0.0.1:43398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:52:54.626434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.623214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.629146Z","caller":"traceutil/trace.go:171","msg":"trace[1120001119] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:582; }","duration":"355.361476ms","start":"2026-04-28T13:52:54.273776Z","end":"2026-04-28T13:52:54.629138Z","steps":["trace[1120001119] 'agreement among raft nodes before linearized reading' (duration: 352.642405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.629173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.273758Z","time spent":"355.405776ms","remote":"127.0.0.1:43396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:52:54.626422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.224223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.629252Z","caller":"traceutil/trace.go:171","msg":"trace[1987766061] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:582; }","duration":"355.067767ms","start":"2026-04-28T13:52:54.274177Z","end":"2026-04-28T13:52:54.629245Z","steps":["trace[1987766061] 'agreement among raft nodes before linearized reading' (duration: 352.226504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.629273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.274169Z","time spent":"355.097238ms","remote":"127.0.0.1:43396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:52:54.626947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.473008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.629379Z","caller":"traceutil/trace.go:171","msg":"trace[2011366553] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:582; }","duration":"231.91581ms","start":"2026-04-28T13:52:54.397453Z","end":"2026-04-28T13:52:54.629369Z","steps":["trace[2011366553] 'agreement among raft nodes before linearized reading' (duration: 229.464657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.626932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.742545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.629496Z","caller":"traceutil/trace.go:171","msg":"trace[856316473] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"457.325251ms","start":"2026-04-28T13:52:54.172164Z","end":"2026-04-28T13:52:54.629489Z","steps":["trace[856316473] 'agreement among raft nodes before linearized reading' (duration: 454.734355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.62952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.172159Z","time spent":"457.352483ms","remote":"127.0.0.1:43378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:52:54.626988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.791303ms","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-04-28T13:52:54.629659Z","caller":"traceutil/trace.go:171","msg":"trace[601639269] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:582; }","duration":"490.491213ms","start":"2026-04-28T13:52:54.139161Z","end":"2026-04-28T13:52:54.629652Z","steps":["trace[601639269] 'agreement among raft nodes before linearized reading' (duration: 487.805773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.629685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.139142Z","time spent":"490.534094ms","remote":"127.0.0.1:43368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:52:54.626986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.55712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.6298Z","caller":"traceutil/trace.go:171","msg":"trace[1400427914] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:582; }","duration":"232.402863ms","start":"2026-04-28T13:52:54.39739Z","end":"2026-04-28T13:52:54.629793Z","steps":["trace[1400427914] 'agreement among raft nodes before linearized reading' (duration: 229.57966ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:54.626866Z","caller":"traceutil/trace.go:171","msg":"trace[1866589848] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:582; }","duration":"547.943714ms","start":"2026-04-28T13:52:54.078849Z","end":"2026-04-28T13:52:54.626792Z","steps":["trace[1866589848] 'agreement among raft nodes before linearized reading' (duration: 547.564754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.629914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.078838Z","time spent":"551.067325ms","remote":"127.0.0.1:43360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:52:54.627007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.963681ms","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-04-28T13:52:54.630017Z","caller":"traceutil/trace.go:171","msg":"trace[294259145] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"458.005039ms","start":"2026-04-28T13:52:54.172005Z","end":"2026-04-28T13:52:54.63001Z","steps":["trace[294259145] 'agreement among raft nodes before linearized reading' (duration: 454.979201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.630039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.171989Z","time spent":"458.043421ms","remote":"127.0.0.1:43378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:52:54.627022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.816758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.630167Z","caller":"traceutil/trace.go:171","msg":"trace[1622831460] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:582; }","duration":"292.082092ms","start":"2026-04-28T13:52:54.338078Z","end":"2026-04-28T13:52:54.63016Z","steps":["trace[1622831460] 'agreement among raft nodes before linearized reading' (duration: 288.92821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.627019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.235155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.63039Z","caller":"traceutil/trace.go:171","msg":"trace[152250943] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:582; }","duration":"251.602642ms","start":"2026-04-28T13:52:54.378777Z","end":"2026-04-28T13:52:54.63038Z","steps":["trace[152250943] 'agreement among raft nodes before linearized reading' (duration: 248.225544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.627034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.307037ms","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-04-28T13:52:54.630489Z","caller":"traceutil/trace.go:171","msg":"trace[1250403970] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:582; }","duration":"518.780427ms","start":"2026-04-28T13:52:54.111702Z","end":"2026-04-28T13:52:54.630483Z","steps":["trace[1250403970] 'agreement among raft nodes before linearized reading' (duration: 515.299176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.630516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.111694Z","time spent":"518.811217ms","remote":"127.0.0.1:43364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:52:54.627043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.014072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.630549Z","caller":"traceutil/trace.go:171","msg":"trace[503793489] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:582; }","duration":"292.520754ms","start":"2026-04-28T13:52:54.338017Z","end":"2026-04-28T13:52:54.630537Z","steps":["trace[503793489] 'agreement among raft nodes before linearized reading' (duration: 289.015913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.627051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.309956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.630649Z","caller":"traceutil/trace.go:171","msg":"trace[682393583] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:582; }","duration":"251.93196ms","start":"2026-04-28T13:52:54.37871Z","end":"2026-04-28T13:52:54.630642Z","steps":["trace[682393583] 'agreement among raft nodes before linearized reading' (duration: 248.325527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.627066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.064354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.630705Z","caller":"traceutil/trace.go:171","msg":"trace[988507038] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:582; }","duration":"292.721239ms","start":"2026-04-28T13:52:54.337975Z","end":"2026-04-28T13:52:54.630696Z","steps":["trace[988507038] 'agreement among raft nodes before linearized reading' (duration: 289.079545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.627082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.227481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.630791Z","caller":"traceutil/trace.go:171","msg":"trace[818294403] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:582; }","duration":"274.946798ms","start":"2026-04-28T13:52:54.355837Z","end":"2026-04-28T13:52:54.630784Z","steps":["trace[818294403] 'agreement among raft nodes before linearized reading' (duration: 271.229392ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:54.627139Z","caller":"traceutil/trace.go:171","msg":"trace[422989815] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dxtjw; range_end:; response_count:1; response_revision:582; }","duration":"648.732341ms","start":"2026-04-28T13:52:53.978377Z","end":"2026-04-28T13:52:54.62711Z","steps":["trace[422989815] 'agreement among raft nodes before linearized reading' (duration: 647.784777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.630877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:53.978362Z","time spent":"652.505388ms","remote":"127.0.0.1:54412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-dxtjw\" "} {"level":"warn","ts":"2026-04-28T13:52:54.627145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.579581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.631016Z","caller":"traceutil/trace.go:171","msg":"trace[1961294103] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:582; }","duration":"275.448421ms","start":"2026-04-28T13:52:54.355558Z","end":"2026-04-28T13:52:54.631007Z","steps":["trace[1961294103] 'agreement among raft nodes before linearized reading' (duration: 271.56941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.62719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.865948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.631065Z","caller":"traceutil/trace.go:171","msg":"trace[1540229606] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:582; }","duration":"332.750349ms","start":"2026-04-28T13:52:54.298307Z","end":"2026-04-28T13:52:54.631058Z","steps":["trace[1540229606] 'agreement among raft nodes before linearized reading' (duration: 328.868688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.631097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.298303Z","time spent":"332.783399ms","remote":"127.0.0.1:43398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:52:54.627191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.033789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.63117Z","caller":"traceutil/trace.go:171","msg":"trace[1228030460] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:582; }","duration":"309.076444ms","start":"2026-04-28T13:52:54.322075Z","end":"2026-04-28T13:52:54.631152Z","steps":["trace[1228030460] 'agreement among raft nodes before linearized reading' (duration: 305.099701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.631217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.322054Z","time spent":"309.144845ms","remote":"127.0.0.1:43412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:52:54.627216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.127341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.631299Z","caller":"traceutil/trace.go:171","msg":"trace[1163491836] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:582; }","duration":"309.298069ms","start":"2026-04-28T13:52:54.321993Z","end":"2026-04-28T13:52:54.631291Z","steps":["trace[1163491836] 'agreement among raft nodes before linearized reading' (duration: 305.176522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.631325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.321973Z","time spent":"309.34367ms","remote":"127.0.0.1:43412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:52:54.627216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.479797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:54.631423Z","caller":"traceutil/trace.go:171","msg":"trace[459905952] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:582; }","duration":"332.733527ms","start":"2026-04-28T13:52:54.298684Z","end":"2026-04-28T13:52:54.631417Z","steps":["trace[459905952] 'agreement among raft nodes before linearized reading' (duration: 328.489898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.631444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.298676Z","time spent":"332.761168ms","remote":"127.0.0.1:43398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:52:54.627292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.254551ms","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-04-28T13:52:54.631535Z","caller":"traceutil/trace.go:171","msg":"trace[1540222306] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"431.531271ms","start":"2026-04-28T13:52:54.199997Z","end":"2026-04-28T13:52:54.631528Z","steps":["trace[1540222306] 'agreement among raft nodes before linearized reading' (duration: 426.230424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:54.631555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.199978Z","time spent":"431.570653ms","remote":"127.0.0.1:43388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"info","ts":"2026-04-28T13:52:55.563913Z","caller":"traceutil/trace.go:171","msg":"trace[472351972] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"920.416804ms","start":"2026-04-28T13:52:54.643477Z","end":"2026-04-28T13:52:55.563894Z","steps":["trace[472351972] 'process raft request' (duration: 920.22954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:55.564032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.643422Z","time spent":"920.547077ms","remote":"127.0.0.1:54412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:52:55.568263Z","caller":"traceutil/trace.go:171","msg":"trace[672058608] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:604; }","duration":"169.678304ms","start":"2026-04-28T13:52:55.398558Z","end":"2026-04-28T13:52:55.568236Z","steps":["trace[672058608] 'read index received' (duration: 165.169648ms)","trace[672058608] 'applied index is now lower than readState.Index' (duration: 4.507246ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:55.568758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.260704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:52:55.568842Z","caller":"traceutil/trace.go:171","msg":"trace[250842395] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:584; }","duration":"164.367607ms","start":"2026-04-28T13:52:55.404452Z","end":"2026-04-28T13:52:55.56882Z","steps":["trace[250842395] 'agreement among raft nodes before linearized reading' (duration: 164.07922ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:55.568877Z","caller":"traceutil/trace.go:171","msg":"trace[1464008030] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"887.007876ms","start":"2026-04-28T13:52:54.681854Z","end":"2026-04-28T13:52:55.568862Z","steps":["trace[1464008030] 'process raft request' (duration: 886.241486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:55.568977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:54.681835Z","time spent":"887.080698ms","remote":"127.0.0.1:54462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:52:55.569156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.597839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:52:55.569192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.456232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:52:55.569241Z","caller":"traceutil/trace.go:171","msg":"trace[480339068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"146.577266ms","start":"2026-04-28T13:52:55.422648Z","end":"2026-04-28T13:52:55.569226Z","steps":["trace[480339068] 'agreement among raft nodes before linearized reading' (duration: 146.446581ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:55.569202Z","caller":"traceutil/trace.go:171","msg":"trace[861244591] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"170.679191ms","start":"2026-04-28T13:52:55.398506Z","end":"2026-04-28T13:52:55.569185Z","steps":["trace[861244591] 'agreement among raft nodes before linearized reading' (duration: 170.616429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:55.569679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.46053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-28T13:52:55.56972Z","caller":"traceutil/trace.go:171","msg":"trace[1106998937] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:584; }","duration":"156.544002ms","start":"2026-04-28T13:52:55.413164Z","end":"2026-04-28T13:52:55.569708Z","steps":["trace[1106998937] 'agreement among raft nodes before linearized reading' (duration: 156.421549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:56.077997Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721272727527665665,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T13:52:58.135487Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.866987975s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-28T13:52:58.274685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.298827916s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:58.274822Z","caller":"traceutil/trace.go:171","msg":"trace[1438462871] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:584; }","duration":"2.298982949s","start":"2026-04-28T13:52:55.97582Z","end":"2026-04-28T13:52:58.274803Z","steps":["trace[1438462871] 'range keys from in-memory index tree' (duration: 2.298803645s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:58.276377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.007855272s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:52:58.276517Z","caller":"traceutil/trace.go:171","msg":"trace[2104094473] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"2.699465796s","start":"2026-04-28T13:52:55.577033Z","end":"2026-04-28T13:52:58.276499Z","steps":["trace[2104094473] 'process raft request' (duration: 691.400648ms)","trace[2104094473] 'compare' (duration: 2.006277211s)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:58.276591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:55.577015Z","time spent":"2.699540757s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:52:58.276854Z","caller":"traceutil/trace.go:171","msg":"trace[1778867653] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"2.699458516s","start":"2026-04-28T13:52:55.577385Z","end":"2026-04-28T13:52:58.276844Z","steps":["trace[1778867653] 'process raft request' (duration: 2.6992393s)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:58.276855Z","caller":"traceutil/trace.go:171","msg":"trace[1304066607] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"2.699452975s","start":"2026-04-28T13:52:55.577385Z","end":"2026-04-28T13:52:58.276838Z","steps":["trace[1304066607] 'process raft request' (duration: 2.699094877s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:58.277087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:55.577352Z","time spent":"2.699683151s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:52:58.277143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.699486586s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-28T13:52:58.276874Z","caller":"traceutil/trace.go:171","msg":"trace[161032732] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"1.710889453s","start":"2026-04-28T13:52:56.565969Z","end":"2026-04-28T13:52:58.276858Z","steps":["trace[161032732] 'process raft request' (duration: 1.710847632s)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:58.27719Z","caller":"traceutil/trace.go:171","msg":"trace[461006192] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:589; }","duration":"2.699556898s","start":"2026-04-28T13:52:55.577623Z","end":"2026-04-28T13:52:58.27718Z","steps":["trace[461006192] 'agreement among raft nodes before linearized reading' (duration: 2.699310911s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:58.27723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:55.577616Z","time spent":"2.699606849s","remote":"127.0.0.1:54426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"info","ts":"2026-04-28T13:52:58.276914Z","caller":"traceutil/trace.go:171","msg":"trace[1662547234] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:606; }","duration":"2.69925872s","start":"2026-04-28T13:52:55.577647Z","end":"2026-04-28T13:52:58.276906Z","steps":["trace[1662547234] 'read index received' (duration: 690.877265ms)","trace[1662547234] 'applied index is now lower than readState.Index' (duration: 2.008380455s)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:58.277329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:56.565941Z","time spent":"1.711286464s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:52:58.276918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:55.577375Z","time spent":"2.699513857s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:52:58.277526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.876125683s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:58.277608Z","caller":"traceutil/trace.go:171","msg":"trace[924648655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"1.876235065s","start":"2026-04-28T13:52:56.401362Z","end":"2026-04-28T13:52:58.277597Z","steps":["trace[924648655] 'agreement among raft nodes before linearized reading' (duration: 1.876134042s)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:58.277672Z","caller":"traceutil/trace.go:171","msg":"trace[2077455842] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"2.699833796s","start":"2026-04-28T13:52:55.577484Z","end":"2026-04-28T13:52:58.277317Z","steps":["trace[2077455842] 'process raft request' (duration: 2.699280912s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:58.277713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:56.401324Z","time spent":"1.876340838s","remote":"127.0.0.1:54244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:52:58.277865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:55.577476Z","time spent":"2.700273447s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:53:00.702678Z","caller":"traceutil/trace.go:171","msg":"trace[1250990717] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"483.591704ms","start":"2026-04-28T13:53:00.218944Z","end":"2026-04-28T13:53:00.702536Z","steps":["trace[1250990717] 'process raft request' (duration: 483.45918ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:00.702678Z","caller":"traceutil/trace.go:171","msg":"trace[573349000] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:647; }","duration":"420.292889ms","start":"2026-04-28T13:53:00.282357Z","end":"2026-04-28T13:53:00.70265Z","steps":["trace[573349000] 'read index received' (duration: 420.279319ms)","trace[573349000] 'applied index is now lower than readState.Index' (duration: 11.36µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:53:00.702805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:00.218895Z","time spent":"483.85184ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:53:00.702982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.600459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:53:00.703042Z","caller":"traceutil/trace.go:171","msg":"trace[1654009999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:623; }","duration":"420.711671ms","start":"2026-04-28T13:53:00.282317Z","end":"2026-04-28T13:53:00.703028Z","steps":["trace[1654009999] 'agreement among raft nodes before linearized reading' (duration: 420.481204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:00.703081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:00.282297Z","time spent":"420.774463ms","remote":"127.0.0.1:54486","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-04-28T13:53:00.783532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.132769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-28T13:53:00.783905Z","caller":"traceutil/trace.go:171","msg":"trace[897124739] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"361.915565ms","start":"2026-04-28T13:53:00.421949Z","end":"2026-04-28T13:53:00.783865Z","steps":["trace[897124739] 'process raft request' (duration: 359.726108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:00.784091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:00.421915Z","time spent":"362.091619ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:53:00.784104Z","caller":"traceutil/trace.go:171","msg":"trace[2046841679] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"166.900772ms","start":"2026-04-28T13:53:00.617125Z","end":"2026-04-28T13:53:00.784025Z","steps":["trace[2046841679] 'process raft request' (duration: 165.828295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:00.784418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.429797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-28T13:53:00.784419Z","caller":"traceutil/trace.go:171","msg":"trace[1929152840] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"142.021486ms","start":"2026-04-28T13:53:00.642095Z","end":"2026-04-28T13:53:00.784117Z","steps":["trace[1929152840] 'process raft request' (duration: 140.976489ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:00.78448Z","caller":"traceutil/trace.go:171","msg":"trace[2136774103] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:626; }","duration":"501.505649ms","start":"2026-04-28T13:53:00.282959Z","end":"2026-04-28T13:53:00.784465Z","steps":["trace[2136774103] 'agreement among raft nodes before linearized reading' (duration: 501.216072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:00.784539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:00.282909Z","time spent":"501.621601ms","remote":"127.0.0.1:54486","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-04-28T13:53:00.78425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.424151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:53:00.784834Z","caller":"traceutil/trace.go:171","msg":"trace[292555132] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:626; }","duration":"501.033885ms","start":"2026-04-28T13:53:00.283782Z","end":"2026-04-28T13:53:00.784816Z","steps":["trace[292555132] 'agreement among raft nodes before linearized reading' (duration: 500.286036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:00.784999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:00.28377Z","time spent":"501.16287ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-28T13:53:00.783825Z","caller":"traceutil/trace.go:171","msg":"trace[1371891418] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:626; }","duration":"501.468997ms","start":"2026-04-28T13:53:00.282335Z","end":"2026-04-28T13:53:00.783804Z","steps":["trace[1371891418] 'agreement among raft nodes before linearized reading' (duration: 500.900482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:00.786029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:00.28232Z","time spent":"503.688925ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-28T13:53:03.156261Z","caller":"traceutil/trace.go:171","msg":"trace[803806661] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"105.819447ms","start":"2026-04-28T13:53:03.050412Z","end":"2026-04-28T13:53:03.156231Z","steps":["trace[803806661] 'process raft request' (duration: 105.57729ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:03.595298Z","caller":"traceutil/trace.go:171","msg":"trace[2126964593] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"138.429984ms","start":"2026-04-28T13:53:03.456839Z","end":"2026-04-28T13:53:03.595269Z","steps":["trace[2126964593] 'process raft request' (duration: 138.222169ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:03.724408Z","caller":"traceutil/trace.go:171","msg":"trace[1341480843] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"106.463514ms","start":"2026-04-28T13:53:03.617918Z","end":"2026-04-28T13:53:03.724381Z","steps":["trace[1341480843] 'process raft request' (duration: 106.31619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:03.982103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.72426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-04-28T13:53:03.98228Z","caller":"traceutil/trace.go:171","msg":"trace[522909145] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:665; }","duration":"163.976167ms","start":"2026-04-28T13:53:03.818277Z","end":"2026-04-28T13:53:03.982253Z","steps":["trace[522909145] 'range keys from in-memory index tree' (duration: 163.420621ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:03.985807Z","caller":"traceutil/trace.go:171","msg":"trace[1796229180] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"142.020437ms","start":"2026-04-28T13:53:03.843758Z","end":"2026-04-28T13:53:03.985778Z","steps":["trace[1796229180] 'process raft request' (duration: 141.798741ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:03.995903Z","caller":"traceutil/trace.go:171","msg":"trace[1041076498] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"152.034846ms","start":"2026-04-28T13:53:03.843819Z","end":"2026-04-28T13:53:03.995854Z","steps":["trace[1041076498] 'process raft request' (duration: 151.888482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:04.466082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.857756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-04-28T13:53:04.4662Z","caller":"traceutil/trace.go:171","msg":"trace[908864231] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:672; }","duration":"250.019291ms","start":"2026-04-28T13:53:04.216156Z","end":"2026-04-28T13:53:04.466176Z","steps":["trace[908864231] 'range keys from in-memory index tree' (duration: 249.64741ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:05.053698Z","caller":"traceutil/trace.go:171","msg":"trace[1348207414] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"171.999105ms","start":"2026-04-28T13:53:04.881675Z","end":"2026-04-28T13:53:05.053674Z","steps":["trace[1348207414] 'process raft request' (duration: 140.455766ms)","trace[1348207414] 'compare' (duration: 31.402346ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:53:05.053829Z","caller":"traceutil/trace.go:171","msg":"trace[1591735357] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:699; }","duration":"140.414194ms","start":"2026-04-28T13:53:04.913388Z","end":"2026-04-28T13:53:05.053802Z","steps":["trace[1591735357] 'read index received' (duration: 108.775433ms)","trace[1591735357] 'applied index is now lower than readState.Index' (duration: 31.636191ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:53:05.053975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.579005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:53:05.054034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.724451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:53:05.054069Z","caller":"traceutil/trace.go:171","msg":"trace[1077054415] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:675; }","duration":"215.782173ms","start":"2026-04-28T13:53:04.838276Z","end":"2026-04-28T13:53:05.054058Z","steps":["trace[1077054415] 'agreement among raft nodes before linearized reading' (duration: 215.658479ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:05.054089Z","caller":"traceutil/trace.go:171","msg":"trace[2081685243] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:675; }","duration":"166.723259ms","start":"2026-04-28T13:53:04.887323Z","end":"2026-04-28T13:53:05.054046Z","steps":["trace[2081685243] 'agreement among raft nodes before linearized reading' (duration: 166.525613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:05.054176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.121804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-28T13:53:05.054223Z","caller":"traceutil/trace.go:171","msg":"trace[126141670] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:675; }","duration":"141.195745ms","start":"2026-04-28T13:53:04.913019Z","end":"2026-04-28T13:53:05.054214Z","steps":["trace[126141670] 'agreement among raft nodes before linearized reading' (duration: 141.086003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:05.054319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.252384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-28T13:53:05.054451Z","caller":"traceutil/trace.go:171","msg":"trace[968405823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:675; }","duration":"216.48577ms","start":"2026-04-28T13:53:04.837938Z","end":"2026-04-28T13:53:05.054423Z","steps":["trace[968405823] 'agreement among raft nodes before linearized reading' (duration: 216.08862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:05.054461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.752473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:53:05.053987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.700077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:05.054521Z","caller":"traceutil/trace.go:171","msg":"trace[178302704] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:675; }","duration":"165.828185ms","start":"2026-04-28T13:53:04.88868Z","end":"2026-04-28T13:53:05.054508Z","steps":["trace[178302704] 'agreement among raft nodes before linearized reading' (duration: 165.691631ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:05.054536Z","caller":"traceutil/trace.go:171","msg":"trace[978797427] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:675; }","duration":"167.262942ms","start":"2026-04-28T13:53:04.887259Z","end":"2026-04-28T13:53:05.054522Z","steps":["trace[978797427] 'agreement among raft nodes before linearized reading' (duration: 166.619335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:05.054893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.775775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:05.054932Z","caller":"traceutil/trace.go:171","msg":"trace[1964204235] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:676; }","duration":"140.819016ms","start":"2026-04-28T13:53:04.914104Z","end":"2026-04-28T13:53:05.054923Z","steps":["trace[1964204235] 'agreement among raft nodes before linearized reading' (duration: 140.746994ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:05.055156Z","caller":"traceutil/trace.go:171","msg":"trace[1100140509] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"138.148766ms","start":"2026-04-28T13:53:04.917Z","end":"2026-04-28T13:53:05.055149Z","steps":["trace[1100140509] 'process raft request' (duration: 137.800198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:05.05531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.767164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:05.055349Z","caller":"traceutil/trace.go:171","msg":"trace[1759913287] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:676; }","duration":"140.825416ms","start":"2026-04-28T13:53:04.914512Z","end":"2026-04-28T13:53:05.055337Z","steps":["trace[1759913287] 'agreement among raft nodes before linearized reading' (duration: 140.763325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:05.055505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.074576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:05.055539Z","caller":"traceutil/trace.go:171","msg":"trace[1389400872] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:676; }","duration":"113.120597ms","start":"2026-04-28T13:53:04.942405Z","end":"2026-04-28T13:53:05.055526Z","steps":["trace[1389400872] 'agreement among raft nodes before linearized reading' (duration: 113.062545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:05.05654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.461101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:05.056594Z","caller":"traceutil/trace.go:171","msg":"trace[1328945293] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:676; }","duration":"114.543323ms","start":"2026-04-28T13:53:04.942039Z","end":"2026-04-28T13:53:05.056582Z","steps":["trace[1328945293] 'agreement among raft nodes before linearized reading' (duration: 114.464541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:05.056728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.657596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:05.056755Z","caller":"traceutil/trace.go:171","msg":"trace[753216460] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:676; }","duration":"114.688027ms","start":"2026-04-28T13:53:04.942059Z","end":"2026-04-28T13:53:05.056747Z","steps":["trace[753216460] 'agreement among raft nodes before linearized reading' (duration: 114.643806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:05.057287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.966931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:05.057323Z","caller":"traceutil/trace.go:171","msg":"trace[782273753] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:676; }","duration":"143.006902ms","start":"2026-04-28T13:53:04.914306Z","end":"2026-04-28T13:53:05.057313Z","steps":["trace[782273753] 'agreement among raft nodes before linearized reading' (duration: 142.947501ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:16.577484Z","caller":"traceutil/trace.go:171","msg":"trace[1971941059] linearizableReadLoop","detail":"{readStateIndex:767; appliedIndex:766; }","duration":"384.44092ms","start":"2026-04-28T13:53:16.193017Z","end":"2026-04-28T13:53:16.577457Z","steps":["trace[1971941059] 'read index received' (duration: 384.211244ms)","trace[1971941059] 'applied index is now lower than readState.Index' (duration: 228.376µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:53:16.577621Z","caller":"traceutil/trace.go:171","msg":"trace[1566329642] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"468.109802ms","start":"2026-04-28T13:53:16.109499Z","end":"2026-04-28T13:53:16.577609Z","steps":["trace[1566329642] 'process raft request' (duration: 467.751502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:16.577734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:16.109481Z","time spent":"468.174844ms","remote":"127.0.0.1:54412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4857,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:53:16.578014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.995534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-28T13:53:16.57807Z","caller":"traceutil/trace.go:171","msg":"trace[91210143] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:739; }","duration":"385.051126ms","start":"2026-04-28T13:53:16.193005Z","end":"2026-04-28T13:53:16.578056Z","steps":["trace[91210143] 'agreement among raft nodes before linearized reading' (duration: 384.900072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:16.578114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:16.19296Z","time spent":"385.142568ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-28T13:53:16.578149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.446823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:16.578231Z","caller":"traceutil/trace.go:171","msg":"trace[1791507805] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:739; }","duration":"180.576316ms","start":"2026-04-28T13:53:16.397636Z","end":"2026-04-28T13:53:16.578212Z","steps":["trace[1791507805] 'agreement among raft nodes before linearized reading' (duration: 180.411972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:19.61719Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721272727527666005,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T13:53:20.117312Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721272727527666005,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T13:53:20.594132Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.588988759s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T13:53:20.594514Z","caller":"traceutil/trace.go:171","msg":"trace[1929952018] linearizableReadLoop","detail":"{readStateIndex:789; appliedIndex:788; }","duration":"1.477677338s","start":"2026-04-28T13:53:19.116812Z","end":"2026-04-28T13:53:20.594489Z","steps":["trace[1929952018] 'read index received' (duration: 1.477461163s)","trace[1929952018] 'applied index is now lower than readState.Index' (duration: 214.935µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:53:20.594592Z","caller":"traceutil/trace.go:171","msg":"trace[525078644] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"1.589505441s","start":"2026-04-28T13:53:19.005044Z","end":"2026-04-28T13:53:20.594549Z","steps":["trace[525078644] 'process raft request' (duration: 1.589303286s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:20.594739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:19.005024Z","time spent":"1.589637854s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:53:20.594734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.196174482s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:53:20.594756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.477937136s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lj29p\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-28T13:53:20.594817Z","caller":"traceutil/trace.go:171","msg":"trace[490367573] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lj29p; range_end:; response_count:1; response_revision:760; }","duration":"1.478031848s","start":"2026-04-28T13:53:19.116764Z","end":"2026-04-28T13:53:20.594796Z","steps":["trace[490367573] 'agreement among raft nodes before linearized reading' (duration: 1.477840593s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:20.594845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.430491775s","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-04-28T13:53:20.594862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:19.116743Z","time spent":"1.478109991s","remote":"127.0.0.1:54412","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-lj29p\" "} {"level":"warn","ts":"2026-04-28T13:53:20.59484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.425165406s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:53:20.594902Z","caller":"traceutil/trace.go:171","msg":"trace[628204082] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:760; }","duration":"1.430609298s","start":"2026-04-28T13:53:19.16428Z","end":"2026-04-28T13:53:20.594889Z","steps":["trace[628204082] 'agreement among raft nodes before linearized reading' (duration: 1.430449274s)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:20.594924Z","caller":"traceutil/trace.go:171","msg":"trace[498358987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:760; }","duration":"1.425284739s","start":"2026-04-28T13:53:19.169622Z","end":"2026-04-28T13:53:20.594907Z","steps":["trace[498358987] 'agreement among raft nodes before linearized reading' (duration: 1.425067904s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:20.594958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:19.164258Z","time spent":"1.430691459s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T13:53:20.594964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:19.169609Z","time spent":"1.42534728s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-28T13:53:20.594956Z","caller":"traceutil/trace.go:171","msg":"trace[1545270570] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:760; }","duration":"1.196440479s","start":"2026-04-28T13:53:19.398495Z","end":"2026-04-28T13:53:20.594935Z","steps":["trace[1545270570] 'agreement among raft nodes before linearized reading' (duration: 1.196149591s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:20.595014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:19.398478Z","time spent":"1.19652178s","remote":"127.0.0.1:54244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:53:20.595126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.450574145s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T13:53:20.595154Z","caller":"traceutil/trace.go:171","msg":"trace[714982447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:760; }","duration":"1.450637487s","start":"2026-04-28T13:53:19.144508Z","end":"2026-04-28T13:53:20.595145Z","steps":["trace[714982447] 'agreement among raft nodes before linearized reading' (duration: 1.450116893s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:20.595183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:19.144489Z","time spent":"1.450686618s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-28T13:53:20.783848Z","caller":"traceutil/trace.go:171","msg":"trace[1158260886] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"184.676364ms","start":"2026-04-28T13:53:20.599144Z","end":"2026-04-28T13:53:20.78382Z","steps":["trace[1158260886] 'process raft request' (duration: 179.89476ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:20.785887Z","caller":"traceutil/trace.go:171","msg":"trace[1560327004] linearizableReadLoop","detail":"{readStateIndex:793; appliedIndex:789; }","duration":"180.734722ms","start":"2026-04-28T13:53:20.605127Z","end":"2026-04-28T13:53:20.785861Z","steps":["trace[1560327004] 'read index received' (duration: 173.997897ms)","trace[1560327004] 'applied index is now lower than readState.Index' (duration: 6.735595ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:53:20.786154Z","caller":"traceutil/trace.go:171","msg":"trace[1608223312] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"183.837213ms","start":"2026-04-28T13:53:20.602288Z","end":"2026-04-28T13:53:20.786125Z","steps":["trace[1608223312] 'process raft request' (duration: 183.499294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:20.786284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.139803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:20.786375Z","caller":"traceutil/trace.go:171","msg":"trace[962012369] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:764; }","duration":"181.246425ms","start":"2026-04-28T13:53:20.605096Z","end":"2026-04-28T13:53:20.786342Z","steps":["trace[962012369] 'agreement among raft nodes before linearized reading' (duration: 181.117492ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:20.786351Z","caller":"traceutil/trace.go:171","msg":"trace[363388330] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"186.281326ms","start":"2026-04-28T13:53:20.600042Z","end":"2026-04-28T13:53:20.786323Z","steps":["trace[363388330] 'process raft request' (duration: 185.67346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:20.78655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.672178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-28T13:53:20.786666Z","caller":"traceutil/trace.go:171","msg":"trace[1900604095] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:764; }","duration":"166.837612ms","start":"2026-04-28T13:53:20.619814Z","end":"2026-04-28T13:53:20.786651Z","steps":["trace[1900604095] 'agreement among raft nodes before linearized reading' (duration: 166.582014ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:20.786744Z","caller":"traceutil/trace.go:171","msg":"trace[1101564120] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"187.537869ms","start":"2026-04-28T13:53:20.599192Z","end":"2026-04-28T13:53:20.78673Z","steps":["trace[1101564120] 'process raft request' (duration: 186.43369ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:56.002858Z","caller":"traceutil/trace.go:171","msg":"trace[1599818437] linearizableReadLoop","detail":"{readStateIndex:1015; appliedIndex:1014; }","duration":"141.043982ms","start":"2026-04-28T13:53:55.861787Z","end":"2026-04-28T13:53:56.002831Z","steps":["trace[1599818437] 'read index received' (duration: 140.906149ms)","trace[1599818437] 'applied index is now lower than readState.Index' (duration: 136.843µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:53:56.003025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.199546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T13:53:56.003062Z","caller":"traceutil/trace.go:171","msg":"trace[732233917] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:977; }","duration":"141.300278ms","start":"2026-04-28T13:53:55.861753Z","end":"2026-04-28T13:53:56.003053Z","steps":["trace[732233917] 'agreement among raft nodes before linearized reading' (duration: 141.182515ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:56.003446Z","caller":"traceutil/trace.go:171","msg":"trace[1504414381] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"283.376727ms","start":"2026-04-28T13:53:55.720055Z","end":"2026-04-28T13:53:56.003432Z","steps":["trace[1504414381] 'process raft request' (duration: 282.617067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:57.224905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.843748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-28T13:53:57.22497Z","caller":"traceutil/trace.go:171","msg":"trace[1401007440] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:977; }","duration":"451.952091ms","start":"2026-04-28T13:53:56.773003Z","end":"2026-04-28T13:53:57.224956Z","steps":["trace[1401007440] 'range keys from in-memory index tree' (duration: 451.714726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:57.224998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:56.772984Z","time spent":"452.008183ms","remote":"127.0.0.1:54486","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-04-28T13:53:57.225002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"826.31926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:57.225089Z","caller":"traceutil/trace.go:171","msg":"trace[46149158] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:977; }","duration":"826.444334ms","start":"2026-04-28T13:53:56.398616Z","end":"2026-04-28T13:53:57.22506Z","steps":["trace[46149158] 'range keys from in-memory index tree' (duration: 826.182986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:57.225143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:56.398597Z","time spent":"826.518896ms","remote":"127.0.0.1:54244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:53:57.225139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.221781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-28T13:53:57.224899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.163934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:53:57.225181Z","caller":"traceutil/trace.go:171","msg":"trace[103306578] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:977; }","duration":"240.470093ms","start":"2026-04-28T13:53:56.984703Z","end":"2026-04-28T13:53:57.225173Z","steps":["trace[103306578] 'range keys from in-memory index tree' (duration: 239.938899ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:57.22518Z","caller":"traceutil/trace.go:171","msg":"trace[74425762] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:977; }","duration":"224.278252ms","start":"2026-04-28T13:53:57.000891Z","end":"2026-04-28T13:53:57.225169Z","steps":["trace[74425762] 'range keys from in-memory index tree' (duration: 224.115778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:57.225169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.506897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T13:53:57.225219Z","caller":"traceutil/trace.go:171","msg":"trace[72739960] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:977; }","duration":"875.594489ms","start":"2026-04-28T13:53:56.349615Z","end":"2026-04-28T13:53:57.225209Z","steps":["trace[72739960] 'count revisions from in-memory index tree' (duration: 875.425906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:57.225247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:56.349595Z","time spent":"875.643981ms","remote":"127.0.0.1:54552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":68,"response size":29,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:53:57.225295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.320011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-28T13:53:57.225323Z","caller":"traceutil/trace.go:171","msg":"trace[291073329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:977; }","duration":"227.346882ms","start":"2026-04-28T13:53:56.997967Z","end":"2026-04-28T13:53:57.225314Z","steps":["trace[291073329] 'range keys from in-memory index tree' (duration: 227.215178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:57.225436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.249403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:53:57.225492Z","caller":"traceutil/trace.go:171","msg":"trace[149387225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:977; }","duration":"226.315464ms","start":"2026-04-28T13:53:56.99916Z","end":"2026-04-28T13:53:57.225475Z","steps":["trace[149387225] 'range keys from in-memory index tree' (duration: 226.16306ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:58.717119Z","caller":"traceutil/trace.go:171","msg":"trace[783520879] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"1.48825741s","start":"2026-04-28T13:53:57.22884Z","end":"2026-04-28T13:53:58.717098Z","steps":["trace[783520879] 'process raft request' (duration: 1.488140567s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:58.71725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:57.228822Z","time spent":"1.488362433s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:53:58.721746Z","caller":"traceutil/trace.go:171","msg":"trace[1781173126] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1016; }","duration":"504.291075ms","start":"2026-04-28T13:53:58.217433Z","end":"2026-04-28T13:53:58.721724Z","steps":["trace[1781173126] 'read index received' (duration: 499.684895ms)","trace[1781173126] 'applied index is now lower than readState.Index' (duration: 4.60517ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:53:58.721999Z","caller":"traceutil/trace.go:171","msg":"trace[9406755] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"1.493142267s","start":"2026-04-28T13:53:57.228846Z","end":"2026-04-28T13:53:58.721988Z","steps":["trace[9406755] 'process raft request' (duration: 1.492649934s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:58.722123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:57.228819Z","time spent":"1.49321759s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:53:58.722255Z","caller":"traceutil/trace.go:171","msg":"trace[297656803] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"1.493313242s","start":"2026-04-28T13:53:57.228933Z","end":"2026-04-28T13:53:58.722246Z","steps":["trace[297656803] 'process raft request' (duration: 1.492661675s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:58.72231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:57.228924Z","time spent":"1.493359203s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:53:58.722467Z","caller":"traceutil/trace.go:171","msg":"trace[1560506034] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"1.493482426s","start":"2026-04-28T13:53:57.228975Z","end":"2026-04-28T13:53:58.722458Z","steps":["trace[1560506034] 'process raft request' (duration: 1.492655355s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:58.722524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:57.228969Z","time spent":"1.493524917s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:53:58.722642Z","caller":"traceutil/trace.go:171","msg":"trace[853990438] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"1.49362949s","start":"2026-04-28T13:53:57.229003Z","end":"2026-04-28T13:53:58.722633Z","steps":["trace[853990438] 'process raft request' (duration: 1.492657264s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:58.722694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:57.228986Z","time spent":"1.493682052s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:53:58.722812Z","caller":"traceutil/trace.go:171","msg":"trace[675847965] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"714.66265ms","start":"2026-04-28T13:53:58.00814Z","end":"2026-04-28T13:53:58.722803Z","steps":["trace[675847965] 'process raft request' (duration: 713.55337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:58.722886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:58.008094Z","time spent":"714.745842ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:53:58.72317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.734193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.207\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-28T13:53:58.723219Z","caller":"traceutil/trace.go:171","msg":"trace[760890211] range","detail":"{range_begin:/registry/masterleases/199.19.213.207; range_end:; response_count:1; response_revision:983; }","duration":"505.812755ms","start":"2026-04-28T13:53:58.217393Z","end":"2026-04-28T13:53:58.723205Z","steps":["trace[760890211] 'agreement among raft nodes before linearized reading' (duration: 505.668161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:58.723261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:58.217366Z","time spent":"505.886318ms","remote":"127.0.0.1:54270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.207\" "} {"level":"warn","ts":"2026-04-28T13:53:58.723448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.123355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:58.723486Z","caller":"traceutil/trace.go:171","msg":"trace[200821898] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:983; }","duration":"325.187676ms","start":"2026-04-28T13:53:58.39829Z","end":"2026-04-28T13:53:58.723477Z","steps":["trace[200821898] 'agreement among raft nodes before linearized reading' (duration: 325.133665ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:58.723515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:58.398274Z","time spent":"325.235308ms","remote":"127.0.0.1:54244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:53:58.723832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.527903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T13:53:58.723872Z","caller":"traceutil/trace.go:171","msg":"trace[674326424] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:983; }","duration":"137.599135ms","start":"2026-04-28T13:53:58.586263Z","end":"2026-04-28T13:53:58.723862Z","steps":["trace[674326424] 'agreement among raft nodes before linearized reading' (duration: 137.536423ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:06.973858Z","caller":"traceutil/trace.go:171","msg":"trace[513810275] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"154.118786ms","start":"2026-04-28T13:54:06.819704Z","end":"2026-04-28T13:54:06.973823Z","steps":["trace[513810275] 'process raft request' (duration: 145.119572ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:06.974093Z","caller":"traceutil/trace.go:171","msg":"trace[1649525823] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"152.825502ms","start":"2026-04-28T13:54:06.821246Z","end":"2026-04-28T13:54:06.974072Z","steps":["trace[1649525823] 'process raft request' (duration: 152.791471ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:06.974094Z","caller":"traceutil/trace.go:171","msg":"trace[1844040399] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"153.572543ms","start":"2026-04-28T13:54:06.820502Z","end":"2026-04-28T13:54:06.974075Z","steps":["trace[1844040399] 'process raft request' (duration: 153.45014ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:06.974103Z","caller":"traceutil/trace.go:171","msg":"trace[1668899290] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"154.375484ms","start":"2026-04-28T13:54:06.819713Z","end":"2026-04-28T13:54:06.974089Z","steps":["trace[1668899290] 'process raft request' (duration: 154.052275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:23.379941Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721272727527666687,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T13:54:23.533168Z","caller":"traceutil/trace.go:171","msg":"trace[477804471] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"670.283761ms","start":"2026-04-28T13:54:22.862858Z","end":"2026-04-28T13:54:23.533142Z","steps":["trace[477804471] 'process raft request' (duration: 670.114857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:23.533461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:22.862819Z","time spent":"670.435756ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:54:23.699651Z","caller":"traceutil/trace.go:171","msg":"trace[1861303741] linearizableReadLoop","detail":"{readStateIndex:1102; appliedIndex:1100; }","duration":"820.543388ms","start":"2026-04-28T13:54:22.879077Z","end":"2026-04-28T13:54:23.69962Z","steps":["trace[1861303741] 'read index received' (duration: 653.887044ms)","trace[1861303741] 'applied index is now lower than readState.Index' (duration: 166.655094ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:54:23.69971Z","caller":"traceutil/trace.go:171","msg":"trace[987677234] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"700.256254ms","start":"2026-04-28T13:54:22.999422Z","end":"2026-04-28T13:54:23.699678Z","steps":["trace[987677234] 'process raft request' (duration: 689.212317ms)","trace[987677234] 'compare' (duration: 10.74083ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:54:23.699847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:22.999402Z","time spent":"700.368788ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:54:23.69986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.771474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-28T13:54:23.699968Z","caller":"traceutil/trace.go:171","msg":"trace[390080735] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1059; }","duration":"820.924118ms","start":"2026-04-28T13:54:22.879031Z","end":"2026-04-28T13:54:23.699955Z","steps":["trace[390080735] 'agreement among raft nodes before linearized reading' (duration: 820.712852ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:23.700031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:22.878999Z","time spent":"821.017501ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-28T13:54:23.730309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.940949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-28T13:54:23.730372Z","caller":"traceutil/trace.go:171","msg":"trace[949950585] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1059; }","duration":"596.052192ms","start":"2026-04-28T13:54:23.134304Z","end":"2026-04-28T13:54:23.730357Z","steps":["trace[949950585] 'agreement among raft nodes before linearized reading' (duration: 595.881588ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:23.730366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.622652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-28T13:54:23.730379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.324305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-28T13:54:23.730416Z","caller":"traceutil/trace.go:171","msg":"trace[1430621090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1059; }","duration":"587.694044ms","start":"2026-04-28T13:54:23.14271Z","end":"2026-04-28T13:54:23.730404Z","steps":["trace[1430621090] 'agreement among raft nodes before linearized reading' (duration: 587.541191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:23.730453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:23.142703Z","time spent":"587.742125ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T13:54:23.73047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.563543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:54:23.730493Z","caller":"traceutil/trace.go:171","msg":"trace[951978007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1059; }","duration":"589.617724ms","start":"2026-04-28T13:54:23.140869Z","end":"2026-04-28T13:54:23.730486Z","steps":["trace[951978007] 'agreement among raft nodes before linearized reading' (duration: 589.557453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:23.730516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:23.140855Z","time spent":"589.656496ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-28T13:54:23.730572Z","caller":"traceutil/trace.go:171","msg":"trace[1192628009] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1059; }","duration":"587.431707ms","start":"2026-04-28T13:54:23.143Z","end":"2026-04-28T13:54:23.730432Z","steps":["trace[1192628009] 'agreement among raft nodes before linearized reading' (duration: 587.208992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:23.73063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:23.142988Z","time spent":"587.631234ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T13:54:23.730407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:23.134286Z","time spent":"596.112504ms","remote":"127.0.0.1:54486","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-04-28T13:54:23.885161Z","caller":"traceutil/trace.go:171","msg":"trace[798244725] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"149.949258ms","start":"2026-04-28T13:54:23.735173Z","end":"2026-04-28T13:54:23.885122Z","steps":["trace[798244725] 'process raft request' (duration: 109.180263ms)","trace[798244725] 'compare' (duration: 40.475487ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:54:23.885294Z","caller":"traceutil/trace.go:171","msg":"trace[997879339] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"149.947067ms","start":"2026-04-28T13:54:23.735311Z","end":"2026-04-28T13:54:23.885258Z","steps":["trace[997879339] 'process raft request' (duration: 149.67626ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:23.885682Z","caller":"traceutil/trace.go:171","msg":"trace[1577393867] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"150.269616ms","start":"2026-04-28T13:54:23.735386Z","end":"2026-04-28T13:54:23.885656Z","steps":["trace[1577393867] 'process raft request' (duration: 149.752992ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:23.88554Z","caller":"traceutil/trace.go:171","msg":"trace[264959375] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"149.489586ms","start":"2026-04-28T13:54:23.736026Z","end":"2026-04-28T13:54:23.885516Z","steps":["trace[264959375] 'process raft request' (duration: 149.188138ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:25.904341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.853637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-28T13:54:25.904449Z","caller":"traceutil/trace.go:171","msg":"trace[523417782] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1065; }","duration":"111.00444ms","start":"2026-04-28T13:54:25.79342Z","end":"2026-04-28T13:54:25.904424Z","steps":["trace[523417782] 'range keys from in-memory index tree' (duration: 110.643021ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:26.020126Z","caller":"traceutil/trace.go:171","msg":"trace[589643180] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"112.037787ms","start":"2026-04-28T13:54:25.908065Z","end":"2026-04-28T13:54:26.020103Z","steps":["trace[589643180] 'process raft request' (duration: 111.881013ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:26.034498Z","caller":"traceutil/trace.go:171","msg":"trace[1094506586] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"125.207592ms","start":"2026-04-28T13:54:25.90927Z","end":"2026-04-28T13:54:26.034477Z","steps":["trace[1094506586] 'process raft request' (duration: 125.14494ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:26.0349Z","caller":"traceutil/trace.go:171","msg":"trace[1051634947] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"125.54943ms","start":"2026-04-28T13:54:25.909342Z","end":"2026-04-28T13:54:26.034892Z","steps":["trace[1051634947] 'process raft request' (duration: 125.105678ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:26.034892Z","caller":"traceutil/trace.go:171","msg":"trace[824871532] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"124.749539ms","start":"2026-04-28T13:54:25.910121Z","end":"2026-04-28T13:54:26.034871Z","steps":["trace[824871532] 'process raft request' (duration: 124.671387ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:26.035454Z","caller":"traceutil/trace.go:171","msg":"trace[849050270] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"127.05732ms","start":"2026-04-28T13:54:25.908372Z","end":"2026-04-28T13:54:26.035429Z","steps":["trace[849050270] 'process raft request' (duration: 125.9357ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:40.59409Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721272727527666917,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T13:54:40.916222Z","caller":"traceutil/trace.go:171","msg":"trace[1426497213] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"831.077794ms","start":"2026-04-28T13:54:40.085084Z","end":"2026-04-28T13:54:40.916162Z","steps":["trace[1426497213] 'process raft request' (duration: 830.860478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:40.916435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:40.085049Z","time spent":"831.270289ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:54:41.992374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.955346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:54:41.992672Z","caller":"traceutil/trace.go:171","msg":"trace[915987195] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"300.811469ms","start":"2026-04-28T13:54:41.691829Z","end":"2026-04-28T13:54:41.992641Z","steps":["trace[915987195] 'process raft request' (duration: 300.715615ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:41.992715Z","caller":"traceutil/trace.go:171","msg":"trace[1571312003] linearizableReadLoop","detail":"{readStateIndex:1212; appliedIndex:1210; }","duration":"1.899294054s","start":"2026-04-28T13:54:40.093381Z","end":"2026-04-28T13:54:41.992675Z","steps":["trace[1571312003] 'read index received' (duration: 822.679674ms)","trace[1571312003] 'applied index is now lower than readState.Index' (duration: 1.076610919s)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:54:41.992947Z","caller":"traceutil/trace.go:171","msg":"trace[111758461] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"1.484337372s","start":"2026-04-28T13:54:40.508584Z","end":"2026-04-28T13:54:41.992921Z","steps":["trace[111758461] 'process raft request' (duration: 829.714958ms)","trace[111758461] 'compare' (duration: 653.441573ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:54:41.992775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:41.691769Z","time spent":"300.956683ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:54:41.993143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:40.50855Z","time spent":"1.484458085s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:54:41.993454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.899436677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:54:41.99349Z","caller":"traceutil/trace.go:171","msg":"trace[1481324510] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1164; }","duration":"1.899499008s","start":"2026-04-28T13:54:40.09398Z","end":"2026-04-28T13:54:41.993479Z","steps":["trace[1481324510] 'agreement among raft nodes before linearized reading' (duration: 1.899321534s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:41.993522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:40.093968Z","time spent":"1.899546649s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T13:54:41.99367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.900280429s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-28T13:54:41.993725Z","caller":"traceutil/trace.go:171","msg":"trace[449506151] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1164; }","duration":"1.900382071s","start":"2026-04-28T13:54:40.093327Z","end":"2026-04-28T13:54:41.993709Z","steps":["trace[449506151] 'agreement among raft nodes before linearized reading' (duration: 1.900209397s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:41.993761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.459074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:54:41.993767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:40.093305Z","time spent":"1.900452132s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-28T13:54:41.993798Z","caller":"traceutil/trace.go:171","msg":"trace[1065363562] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1164; }","duration":"596.527276ms","start":"2026-04-28T13:54:41.397259Z","end":"2026-04-28T13:54:41.993787Z","steps":["trace[1065363562] 'agreement among raft nodes before linearized reading' (duration: 596.469105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:41.993833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:41.39724Z","time spent":"596.583697ms","remote":"127.0.0.1:54244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:54:41.993999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.259259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:54:41.994029Z","caller":"traceutil/trace.go:171","msg":"trace[1972433542] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1164; }","duration":"782.333281ms","start":"2026-04-28T13:54:41.211686Z","end":"2026-04-28T13:54:41.994019Z","steps":["trace[1972433542] 'agreement among raft nodes before linearized reading' (duration: 782.28371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:41.994073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:41.211664Z","time spent":"782.396943ms","remote":"127.0.0.1:43412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:54:41.994268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"900.096658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:54:41.994305Z","caller":"traceutil/trace.go:171","msg":"trace[2054108397] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1164; }","duration":"900.192901ms","start":"2026-04-28T13:54:41.094102Z","end":"2026-04-28T13:54:41.994295Z","steps":["trace[2054108397] 'agreement among raft nodes before linearized reading' (duration: 900.131149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:41.994337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:41.094085Z","time spent":"900.243821ms","remote":"127.0.0.1:43240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:54:41.994581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.899859827s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-28T13:54:41.994749Z","caller":"traceutil/trace.go:171","msg":"trace[1885405284] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1164; }","duration":"1.900088614s","start":"2026-04-28T13:54:40.094624Z","end":"2026-04-28T13:54:41.994712Z","steps":["trace[1885405284] 'agreement among raft nodes before linearized reading' (duration: 1.899707033s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:41.994804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:40.094599Z","time spent":"1.900194948s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T13:54:41.994804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.580837203s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:54:41.994848Z","caller":"traceutil/trace.go:171","msg":"trace[468227491] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1164; }","duration":"1.580937805s","start":"2026-04-28T13:54:40.413899Z","end":"2026-04-28T13:54:41.994836Z","steps":["trace[468227491] 'agreement among raft nodes before linearized reading' (duration: 1.580869703s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:41.994884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:40.413867Z","time spent":"1.581008297s","remote":"127.0.0.1:43274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:54:41.994895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.897440094s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T13:54:41.994954Z","caller":"traceutil/trace.go:171","msg":"trace[804117161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1164; }","duration":"1.897526826s","start":"2026-04-28T13:54:40.097412Z","end":"2026-04-28T13:54:41.994939Z","steps":["trace[804117161] 'agreement among raft nodes before linearized reading' (duration: 1.897367212s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:41.995005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:40.097393Z","time spent":"1.8975958s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T13:54:41.995052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.222358047s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:54:41.995088Z","caller":"traceutil/trace.go:171","msg":"trace[469744228] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1164; }","duration":"1.222445299s","start":"2026-04-28T13:54:40.772631Z","end":"2026-04-28T13:54:41.995076Z","steps":["trace[469744228] 'agreement among raft nodes before linearized reading' (duration: 1.222391127s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:41.995118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:54:40.772606Z","time spent":"1.222503761s","remote":"127.0.0.1:54388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"info","ts":"2026-04-28T13:54:56.16551Z","caller":"traceutil/trace.go:171","msg":"trace[1072319738] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"106.805971ms","start":"2026-04-28T13:54:56.058657Z","end":"2026-04-28T13:54:56.165463Z","steps":["trace[1072319738] 'process raft request' (duration: 106.114722ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:58.465968Z","caller":"traceutil/trace.go:171","msg":"trace[822534826] linearizableReadLoop","detail":"{readStateIndex:1268; appliedIndex:1267; }","duration":"284.715659ms","start":"2026-04-28T13:54:58.181223Z","end":"2026-04-28T13:54:58.465938Z","steps":["trace[822534826] 'read index received' (duration: 284.519943ms)","trace[822534826] 'applied index is now lower than readState.Index' (duration: 194.556µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:54:58.466404Z","caller":"traceutil/trace.go:171","msg":"trace[1153894934] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"294.737831ms","start":"2026-04-28T13:54:58.171655Z","end":"2026-04-28T13:54:58.466393Z","steps":["trace[1153894934] 'process raft request' (duration: 294.087634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:58.466709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.478129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:54:58.466753Z","caller":"traceutil/trace.go:171","msg":"trace[1960100243] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1216; }","duration":"285.598122ms","start":"2026-04-28T13:54:58.181146Z","end":"2026-04-28T13:54:58.466744Z","steps":["trace[1960100243] 'agreement among raft nodes before linearized reading' (duration: 285.434438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:58.466939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.731605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T13:54:58.466977Z","caller":"traceutil/trace.go:171","msg":"trace[236034400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1216; }","duration":"285.802187ms","start":"2026-04-28T13:54:58.181163Z","end":"2026-04-28T13:54:58.466965Z","steps":["trace[236034400] 'agreement among raft nodes before linearized reading' (duration: 285.717375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:58.467382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.934401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-28T13:54:58.467509Z","caller":"traceutil/trace.go:171","msg":"trace[212126265] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1216; }","duration":"286.136826ms","start":"2026-04-28T13:54:58.181343Z","end":"2026-04-28T13:54:58.467479Z","steps":["trace[212126265] 'agreement among raft nodes before linearized reading' (duration: 285.685034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:58.467697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.77143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.207\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-28T13:54:58.467737Z","caller":"traceutil/trace.go:171","msg":"trace[1861158730] range","detail":"{range_begin:/registry/masterleases/199.19.213.207; range_end:; response_count:1; response_revision:1216; }","duration":"222.843232ms","start":"2026-04-28T13:54:58.244885Z","end":"2026-04-28T13:54:58.467728Z","steps":["trace[1861158730] 'agreement among raft nodes before linearized reading' (duration: 222.75207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:54:58.467899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.432506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-28T13:54:58.467988Z","caller":"traceutil/trace.go:171","msg":"trace[982324039] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1216; }","duration":"285.571151ms","start":"2026-04-28T13:54:58.182398Z","end":"2026-04-28T13:54:58.467969Z","steps":["trace[982324039] 'agreement among raft nodes before linearized reading' (duration: 285.332984ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:58.668956Z","caller":"traceutil/trace.go:171","msg":"trace[476961411] linearizableReadLoop","detail":"{readStateIndex:1269; appliedIndex:1268; }","duration":"198.378933ms","start":"2026-04-28T13:54:58.47054Z","end":"2026-04-28T13:54:58.668919Z","steps":["trace[476961411] 'read index received' (duration: 159.61477ms)","trace[476961411] 'applied index is now lower than readState.Index' (duration: 38.761783ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:54:58.669132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.561028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:54:58.669178Z","caller":"traceutil/trace.go:171","msg":"trace[734826726] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1216; }","duration":"198.65805ms","start":"2026-04-28T13:54:58.470507Z","end":"2026-04-28T13:54:58.669165Z","steps":["trace[734826726] 'agreement among raft nodes before linearized reading' (duration: 198.533227ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:58.757109Z","caller":"traceutil/trace.go:171","msg":"trace[961937170] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"284.715228ms","start":"2026-04-28T13:54:58.472358Z","end":"2026-04-28T13:54:58.757073Z","steps":["trace[961937170] 'process raft request' (duration: 284.653136ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:58.757334Z","caller":"traceutil/trace.go:171","msg":"trace[1992966440] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"285.220242ms","start":"2026-04-28T13:54:58.472106Z","end":"2026-04-28T13:54:58.757326Z","steps":["trace[1992966440] 'process raft request' (duration: 284.720418ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:58.757469Z","caller":"traceutil/trace.go:171","msg":"trace[961929370] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"284.952705ms","start":"2026-04-28T13:54:58.472502Z","end":"2026-04-28T13:54:58.757455Z","steps":["trace[961929370] 'process raft request' (duration: 284.539575ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:58.757782Z","caller":"traceutil/trace.go:171","msg":"trace[379118014] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"284.537864ms","start":"2026-04-28T13:54:58.473213Z","end":"2026-04-28T13:54:58.757751Z","steps":["trace[379118014] 'process raft request' (duration: 284.198745ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:54:58.829064Z","caller":"traceutil/trace.go:171","msg":"trace[1662279476] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"158.789718ms","start":"2026-04-28T13:54:58.670245Z","end":"2026-04-28T13:54:58.829035Z","steps":["trace[1662279476] 'process raft request' (duration: 117.470008ms)","trace[1662279476] 'compare' (duration: 41.200187ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:54:59.568741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.047476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:54:59.56882Z","caller":"traceutil/trace.go:171","msg":"trace[1643862984] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1223; }","duration":"169.464728ms","start":"2026-04-28T13:54:59.399337Z","end":"2026-04-28T13:54:59.568802Z","steps":["trace[1643862984] 'range keys from in-memory index tree' (duration: 168.976144ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:55:00.646837Z","caller":"traceutil/trace.go:171","msg":"trace[973301163] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"173.908514ms","start":"2026-04-28T13:55:00.472909Z","end":"2026-04-28T13:55:00.646817Z","steps":["trace[973301163] 'process raft request' (duration: 173.791851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:01.600779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.736289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"info","ts":"2026-04-28T13:55:01.600855Z","caller":"traceutil/trace.go:171","msg":"trace[1641892370] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1230; }","duration":"258.879104ms","start":"2026-04-28T13:55:01.34196Z","end":"2026-04-28T13:55:01.600839Z","steps":["trace[1641892370] 'range keys from in-memory index tree' (duration: 258.586386ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:55:01.600913Z","caller":"traceutil/trace.go:171","msg":"trace[2090050640] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"123.699412ms","start":"2026-04-28T13:55:01.477157Z","end":"2026-04-28T13:55:01.600857Z","steps":["trace[2090050640] 'process raft request' (duration: 115.619411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:01.600945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.230476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:55:01.601011Z","caller":"traceutil/trace.go:171","msg":"trace[470926407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1230; }","duration":"204.408341ms","start":"2026-04-28T13:55:01.396586Z","end":"2026-04-28T13:55:01.600994Z","steps":["trace[470926407] 'range keys from in-memory index tree' (duration: 204.135673ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:55:02.000432Z","caller":"traceutil/trace.go:171","msg":"trace[834899414] linearizableReadLoop","detail":"{readStateIndex:1285; appliedIndex:1284; }","duration":"333.78186ms","start":"2026-04-28T13:55:01.666622Z","end":"2026-04-28T13:55:02.000404Z","steps":["trace[834899414] 'read index received' (duration: 297.966135ms)","trace[834899414] 'applied index is now lower than readState.Index' (duration: 35.813125ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:55:02.000554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.913683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:55:02.000543Z","caller":"traceutil/trace.go:171","msg":"trace[1572822578] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"388.850289ms","start":"2026-04-28T13:55:01.611652Z","end":"2026-04-28T13:55:02.000502Z","steps":["trace[1572822578] 'process raft request' (duration: 353.058314ms)","trace[1572822578] 'compare' (duration: 35.532788ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:55:02.000578Z","caller":"traceutil/trace.go:171","msg":"trace[1592642038] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1232; }","duration":"333.978486ms","start":"2026-04-28T13:55:01.666593Z","end":"2026-04-28T13:55:02.000571Z","steps":["trace[1592642038] 'agreement among raft nodes before linearized reading' (duration: 333.897073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:02.00061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:01.666579Z","time spent":"334.025748ms","remote":"127.0.0.1:54588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":27,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" "} {"level":"warn","ts":"2026-04-28T13:55:02.000662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:01.611631Z","time spent":"388.971393ms","remote":"127.0.0.1:54320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":822,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:55:06.106985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.066407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:55:06.107077Z","caller":"traceutil/trace.go:171","msg":"trace[1096903220] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1271; }","duration":"199.161269ms","start":"2026-04-28T13:55:05.907888Z","end":"2026-04-28T13:55:06.107049Z","steps":["trace[1096903220] 'range keys from in-memory index tree' (duration: 198.890793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:06.106727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.588315ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:55:06.107475Z","caller":"traceutil/trace.go:171","msg":"trace[1115765948] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1271; }","duration":"132.360865ms","start":"2026-04-28T13:55:05.975092Z","end":"2026-04-28T13:55:06.107453Z","steps":["trace[1115765948] 'range keys from in-memory index tree' (duration: 131.560705ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:55:14.793777Z","caller":"traceutil/trace.go:171","msg":"trace[1914134731] linearizableReadLoop","detail":"{readStateIndex:1390; appliedIndex:1389; }","duration":"105.371635ms","start":"2026-04-28T13:55:14.68837Z","end":"2026-04-28T13:55:14.793741Z","steps":["trace[1914134731] 'read index received' (duration: 105.131409ms)","trace[1914134731] 'applied index is now lower than readState.Index' (duration: 238.696µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:55:14.794288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.89861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-04-28T13:55:14.79436Z","caller":"traceutil/trace.go:171","msg":"trace[1105801393] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1334; }","duration":"106.044953ms","start":"2026-04-28T13:55:14.688302Z","end":"2026-04-28T13:55:14.794347Z","steps":["trace[1105801393] 'agreement among raft nodes before linearized reading' (duration: 105.57019ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:55:14.793823Z","caller":"traceutil/trace.go:171","msg":"trace[777762389] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"369.912841ms","start":"2026-04-28T13:55:14.42388Z","end":"2026-04-28T13:55:14.793793Z","steps":["trace[777762389] 'process raft request' (duration: 369.616464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:14.79556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:14.423846Z","time spent":"371.625775ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:55:15.385459Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721272727527667278,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T13:55:15.886599Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721272727527667278,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T13:55:16.173466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.365553ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:55:16.173636Z","caller":"traceutil/trace.go:171","msg":"trace[1386354853] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1334; }","duration":"197.546097ms","start":"2026-04-28T13:55:15.976074Z","end":"2026-04-28T13:55:16.17362Z","steps":["trace[1386354853] 'range keys from in-memory index tree' (duration: 197.353013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.174113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.329378595s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:55:16.174174Z","caller":"traceutil/trace.go:171","msg":"trace[1117442783] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"1.473309571s","start":"2026-04-28T13:55:14.70085Z","end":"2026-04-28T13:55:16.17416Z","steps":["trace[1117442783] 'process raft request' (duration: 143.796912ms)","trace[1117442783] 'compare' (duration: 1.328944324s)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:55:16.174217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:14.700818Z","time spent":"1.473379073s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:55:16.387322Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721272727527667278,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T13:55:16.38842Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.543848512s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T13:55:16.389666Z","caller":"traceutil/trace.go:171","msg":"trace[194593264] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"1.590293218s","start":"2026-04-28T13:55:14.79934Z","end":"2026-04-28T13:55:16.389633Z","steps":["trace[194593264] 'process raft request' (duration: 1.589462015s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.389827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:14.799309Z","time spent":"1.590418231s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:55:16.39085Z","caller":"traceutil/trace.go:171","msg":"trace[1199466350] linearizableReadLoop","detail":"{readStateIndex:1393; appliedIndex:1391; }","duration":"1.505501386s","start":"2026-04-28T13:55:14.885332Z","end":"2026-04-28T13:55:16.390834Z","steps":["trace[1199466350] 'read index received' (duration: 1.50368012s)","trace[1199466350] 'applied index is now lower than readState.Index' (duration: 1.820296ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:55:16.391073Z","caller":"traceutil/trace.go:171","msg":"trace[1385730772] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"1.463711512s","start":"2026-04-28T13:55:14.92735Z","end":"2026-04-28T13:55:16.391062Z","steps":["trace[1385730772] 'process raft request' (duration: 1.463340412s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.391147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:14.927313Z","time spent":"1.463795474s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:55:16.391844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.47634713s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-28T13:55:16.391941Z","caller":"traceutil/trace.go:171","msg":"trace[1783668465] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1337; }","duration":"1.476490174s","start":"2026-04-28T13:55:14.915432Z","end":"2026-04-28T13:55:16.391923Z","steps":["trace[1783668465] 'agreement among raft nodes before linearized reading' (duration: 1.476255737s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.392222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:14.91541Z","time spent":"1.47677599s","remote":"127.0.0.1:54486","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-04-28T13:55:16.392302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"913.630125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:55:16.392353Z","caller":"traceutil/trace.go:171","msg":"trace[177709594] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1337; }","duration":"913.708426ms","start":"2026-04-28T13:55:15.478627Z","end":"2026-04-28T13:55:16.392335Z","steps":["trace[177709594] 'agreement among raft nodes before linearized reading' (duration: 913.635704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.392189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.130221956s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-28T13:55:16.39244Z","caller":"traceutil/trace.go:171","msg":"trace[1852403982] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1337; }","duration":"1.130512863s","start":"2026-04-28T13:55:15.261918Z","end":"2026-04-28T13:55:16.392431Z","steps":["trace[1852403982] 'agreement among raft nodes before linearized reading' (duration: 1.130153013s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.392451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.332913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:55:16.392493Z","caller":"traceutil/trace.go:171","msg":"trace[1458353957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1337; }","duration":"993.413185ms","start":"2026-04-28T13:55:15.399068Z","end":"2026-04-28T13:55:16.392481Z","steps":["trace[1458353957] 'agreement among raft nodes before linearized reading' (duration: 993.357214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.392507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:15.261896Z","time spent":"1.130577885s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-28T13:55:16.39253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:15.399041Z","time spent":"993.480346ms","remote":"127.0.0.1:54244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:55:16.392318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.291031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"warn","ts":"2026-04-28T13:55:16.392399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:15.47861Z","time spent":"913.777028ms","remote":"127.0.0.1:57944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"info","ts":"2026-04-28T13:55:16.392771Z","caller":"traceutil/trace.go:171","msg":"trace[1375258650] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1337; }","duration":"553.731342ms","start":"2026-04-28T13:55:15.838952Z","end":"2026-04-28T13:55:16.392684Z","steps":["trace[1375258650] 'agreement among raft nodes before linearized reading' (duration: 553.26199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.392935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:15.838922Z","time spent":"554.001429ms","remote":"127.0.0.1:54318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":140,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-04-28T13:55:16.393264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.471903564s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-28T13:55:16.393328Z","caller":"traceutil/trace.go:171","msg":"trace[40276142] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1337; }","duration":"1.471986327s","start":"2026-04-28T13:55:14.921332Z","end":"2026-04-28T13:55:16.393319Z","steps":["trace[40276142] 'agreement among raft nodes before linearized reading' (duration: 1.471869774s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.393368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:14.921321Z","time spent":"1.472040148s","remote":"127.0.0.1:54486","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-04-28T13:55:16.393479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.110592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-04-28T13:55:16.393509Z","caller":"traceutil/trace.go:171","msg":"trace[60834284] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1337; }","duration":"223.169552ms","start":"2026-04-28T13:55:16.170331Z","end":"2026-04-28T13:55:16.393501Z","steps":["trace[60834284] 'agreement among raft nodes before linearized reading' (duration: 222.889646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.393517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.789294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:100975"} {"level":"warn","ts":"2026-04-28T13:55:16.393516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.581056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-28T13:55:16.393593Z","caller":"traceutil/trace.go:171","msg":"trace[233118176] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1337; }","duration":"838.693049ms","start":"2026-04-28T13:55:15.554881Z","end":"2026-04-28T13:55:16.393574Z","steps":["trace[233118176] 'agreement among raft nodes before linearized reading' (duration: 836.82047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.393618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.472702454s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:55:16.393643Z","caller":"traceutil/trace.go:171","msg":"trace[2066883924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1337; }","duration":"1.472760076s","start":"2026-04-28T13:55:14.920875Z","end":"2026-04-28T13:55:16.393636Z","steps":["trace[2066883924] 'agreement among raft nodes before linearized reading' (duration: 1.472693814s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.393644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:15.554857Z","time spent":"838.776021ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-28T13:55:16.393664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:14.920859Z","time spent":"1.472800256s","remote":"127.0.0.1:54486","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-04-28T13:55:16.393742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.330033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T13:55:16.393768Z","caller":"traceutil/trace.go:171","msg":"trace[632333071] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1337; }","duration":"612.393835ms","start":"2026-04-28T13:55:15.781367Z","end":"2026-04-28T13:55:16.393761Z","steps":["trace[632333071] 'agreement among raft nodes before linearized reading' (duration: 612.352134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.393913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.791117ms","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-04-28T13:55:16.393947Z","caller":"traceutil/trace.go:171","msg":"trace[1875226951] 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:1337; }","duration":"362.863729ms","start":"2026-04-28T13:55:16.031075Z","end":"2026-04-28T13:55:16.393938Z","steps":["trace[1875226951] 'agreement among raft nodes before linearized reading' (duration: 362.806188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.393994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:16.031055Z","time spent":"362.92993ms","remote":"127.0.0.1:43228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-04-28T13:55:16.393547Z","caller":"traceutil/trace.go:171","msg":"trace[610514821] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1337; }","duration":"558.864905ms","start":"2026-04-28T13:55:15.834673Z","end":"2026-04-28T13:55:16.393538Z","steps":["trace[610514821] 'agreement among raft nodes before linearized reading' (duration: 558.752833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.394186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:15.834651Z","time spent":"559.511193ms","remote":"127.0.0.1:54302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":100997,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-04-28T13:55:16.393791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:15.781339Z","time spent":"612.443435ms","remote":"127.0.0.1:54590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":29,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:55:16.396303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.510965178s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:55:16.396381Z","caller":"traceutil/trace.go:171","msg":"trace[1616636827] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1337; }","duration":"1.511093001s","start":"2026-04-28T13:55:14.885269Z","end":"2026-04-28T13:55:16.396362Z","steps":["trace[1616636827] 'agreement among raft nodes before linearized reading' (duration: 1.506005659s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:16.396433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:55:14.885242Z","time spent":"1.511179423s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-28T13:55:42.654285Z","caller":"traceutil/trace.go:171","msg":"trace[1741988227] linearizableReadLoop","detail":"{readStateIndex:1519; appliedIndex:1518; }","duration":"110.220321ms","start":"2026-04-28T13:55:42.544038Z","end":"2026-04-28T13:55:42.654258Z","steps":["trace[1741988227] 'read index received' (duration: 109.996465ms)","trace[1741988227] 'applied index is now lower than readState.Index' (duration: 222.786µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:55:42.654407Z","caller":"traceutil/trace.go:171","msg":"trace[1568640941] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"111.944726ms","start":"2026-04-28T13:55:42.542442Z","end":"2026-04-28T13:55:42.654387Z","steps":["trace[1568640941] 'process raft request' (duration: 111.668338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:42.654531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.475028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:55:42.654569Z","caller":"traceutil/trace.go:171","msg":"trace[1489623085] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1458; }","duration":"110.557ms","start":"2026-04-28T13:55:42.544003Z","end":"2026-04-28T13:55:42.65456Z","steps":["trace[1489623085] 'agreement among raft nodes before linearized reading' (duration: 110.395476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:42.654566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.497073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-28T13:55:42.654604Z","caller":"traceutil/trace.go:171","msg":"trace[1530264920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1458; }","duration":"109.548904ms","start":"2026-04-28T13:55:42.545042Z","end":"2026-04-28T13:55:42.654591Z","steps":["trace[1530264920] 'agreement among raft nodes before linearized reading' (duration: 109.438451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:42.65467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.575275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-28T13:55:42.654705Z","caller":"traceutil/trace.go:171","msg":"trace[349583162] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1458; }","duration":"109.622576ms","start":"2026-04-28T13:55:42.545072Z","end":"2026-04-28T13:55:42.654695Z","steps":["trace[349583162] 'agreement among raft nodes before linearized reading' (duration: 109.522614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:42.654714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.794478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-28T13:55:42.654854Z","caller":"traceutil/trace.go:171","msg":"trace[23632056] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1458; }","duration":"107.955893ms","start":"2026-04-28T13:55:42.546868Z","end":"2026-04-28T13:55:42.654824Z","steps":["trace[23632056] 'agreement among raft nodes before linearized reading' (duration: 107.676716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:55:42.655172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.844864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:55:42.65522Z","caller":"traceutil/trace.go:171","msg":"trace[1278916163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1458; }","duration":"107.118241ms","start":"2026-04-28T13:55:42.54809Z","end":"2026-04-28T13:55:42.655208Z","steps":["trace[1278916163] 'agreement among raft nodes before linearized reading' (duration: 106.411343ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:56:31.138209Z","caller":"traceutil/trace.go:171","msg":"trace[314714627] linearizableReadLoop","detail":"{readStateIndex:1750; appliedIndex:1749; }","duration":"130.409547ms","start":"2026-04-28T13:56:31.007774Z","end":"2026-04-28T13:56:31.138184Z","steps":["trace[314714627] 'read index received' (duration: 130.125809ms)","trace[314714627] 'applied index is now lower than readState.Index' (duration: 282.888µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:56:31.138312Z","caller":"traceutil/trace.go:171","msg":"trace[1685236393] transaction","detail":"{read_only:false; response_revision:1679; number_of_response:1; }","duration":"130.744547ms","start":"2026-04-28T13:56:31.007529Z","end":"2026-04-28T13:56:31.138274Z","steps":["trace[1685236393] 'process raft request' (duration: 130.498921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:56:31.13847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.520511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:56:31.138802Z","caller":"traceutil/trace.go:171","msg":"trace[473372525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1679; }","duration":"130.88858ms","start":"2026-04-28T13:56:31.007888Z","end":"2026-04-28T13:56:31.138777Z","steps":["trace[473372525] 'agreement among raft nodes before linearized reading' (duration: 130.473909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:56:31.138489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.692494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:56:31.138897Z","caller":"traceutil/trace.go:171","msg":"trace[1162019462] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1679; }","duration":"131.123057ms","start":"2026-04-28T13:56:31.007743Z","end":"2026-04-28T13:56:31.138866Z","steps":["trace[1162019462] 'agreement among raft nodes before linearized reading' (duration: 130.593703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:56:31.138563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.894011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-28T13:56:31.138954Z","caller":"traceutil/trace.go:171","msg":"trace[162344673] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1679; }","duration":"126.317792ms","start":"2026-04-28T13:56:31.012624Z","end":"2026-04-28T13:56:31.138942Z","steps":["trace[162344673] 'agreement among raft nodes before linearized reading' (duration: 125.87839ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:56:31.138608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.170977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:56:31.139021Z","caller":"traceutil/trace.go:171","msg":"trace[490356313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1679; }","duration":"126.595329ms","start":"2026-04-28T13:56:31.012415Z","end":"2026-04-28T13:56:31.13901Z","steps":["trace[490356313] 'agreement among raft nodes before linearized reading' (duration: 126.141707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:56:31.138628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.447977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-04-28T13:56:31.139114Z","caller":"traceutil/trace.go:171","msg":"trace[1268424791] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1679; }","duration":"120.931941ms","start":"2026-04-28T13:56:31.018152Z","end":"2026-04-28T13:56:31.139084Z","steps":["trace[1268424791] 'agreement among raft nodes before linearized reading' (duration: 120.440468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:57:05.53522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.348248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-28T13:57:05.535273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.707621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-28T13:57:05.535349Z","caller":"traceutil/trace.go:171","msg":"trace[756122405] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1834; }","duration":"209.822384ms","start":"2026-04-28T13:57:05.325509Z","end":"2026-04-28T13:57:05.535332Z","steps":["trace[756122405] 'range keys from in-memory index tree' (duration: 209.551397ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:57:05.535344Z","caller":"traceutil/trace.go:171","msg":"trace[1376002242] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1834; }","duration":"210.525632ms","start":"2026-04-28T13:57:05.324797Z","end":"2026-04-28T13:57:05.535322Z","steps":["trace[1376002242] 'range keys from in-memory index tree' (duration: 210.145082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:57:05.535485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.107117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:57:05.535505Z","caller":"traceutil/trace.go:171","msg":"trace[512278266] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1834; }","duration":"136.165548ms","start":"2026-04-28T13:57:05.39933Z","end":"2026-04-28T13:57:05.535495Z","steps":["trace[512278266] 'range keys from in-memory index tree' (duration: 136.046525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:57:05.535527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.726657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-28T13:57:05.535598Z","caller":"traceutil/trace.go:171","msg":"trace[772403988] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1834; }","duration":"202.8178ms","start":"2026-04-28T13:57:05.33276Z","end":"2026-04-28T13:57:05.535578Z","steps":["trace[772403988] 'range keys from in-memory index tree' (duration: 202.600954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:57:05.535721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.801258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-28T13:57:05.535734Z","caller":"traceutil/trace.go:171","msg":"trace[466104964] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1834; }","duration":"205.83585ms","start":"2026-04-28T13:57:05.329893Z","end":"2026-04-28T13:57:05.535729Z","steps":["trace[466104964] 'range keys from in-memory index tree' (duration: 205.739456ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:57:05.535795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.551126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-28T13:57:05.535813Z","caller":"traceutil/trace.go:171","msg":"trace[1631356716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1834; }","duration":"204.583388ms","start":"2026-04-28T13:57:05.331223Z","end":"2026-04-28T13:57:05.535807Z","steps":["trace[1631356716] 'range keys from in-memory index tree' (duration: 204.465324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:57:05.535878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.999885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-28T13:57:05.535898Z","caller":"traceutil/trace.go:171","msg":"trace[84333933] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1834; }","duration":"216.065837ms","start":"2026-04-28T13:57:05.319827Z","end":"2026-04-28T13:57:05.535893Z","steps":["trace[84333933] 'range keys from in-memory index tree' (duration: 215.905533ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:57:05.723894Z","caller":"traceutil/trace.go:171","msg":"trace[1788589653] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"183.588887ms","start":"2026-04-28T13:57:05.540272Z","end":"2026-04-28T13:57:05.723861Z","steps":["trace[1788589653] 'process raft request' (duration: 168.640497ms)","trace[1788589653] 'compare' (duration: 14.756816ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:57:05.724126Z","caller":"traceutil/trace.go:171","msg":"trace[1320777717] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"183.834434ms","start":"2026-04-28T13:57:05.540272Z","end":"2026-04-28T13:57:05.724107Z","steps":["trace[1320777717] 'process raft request' (duration: 183.550776ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:57:05.72415Z","caller":"traceutil/trace.go:171","msg":"trace[1176353046] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"180.902148ms","start":"2026-04-28T13:57:05.543216Z","end":"2026-04-28T13:57:05.724118Z","steps":["trace[1176353046] 'process raft request' (duration: 180.871997ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:57:05.724298Z","caller":"traceutil/trace.go:171","msg":"trace[938709140] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"183.329761ms","start":"2026-04-28T13:57:05.540963Z","end":"2026-04-28T13:57:05.724293Z","steps":["trace[938709140] 'process raft request' (duration: 183.035193ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:57:05.724342Z","caller":"traceutil/trace.go:171","msg":"trace[2145368938] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"181.830542ms","start":"2026-04-28T13:57:05.542508Z","end":"2026-04-28T13:57:05.724339Z","steps":["trace[2145368938] 'process raft request' (duration: 181.557805ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:57:05.823258Z","caller":"traceutil/trace.go:171","msg":"trace[238332636] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"195.358135ms","start":"2026-04-28T13:57:05.627853Z","end":"2026-04-28T13:57:05.823211Z","steps":["trace[238332636] 'process raft request' (duration: 195.101689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:57:41.963903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.900473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-28T13:57:41.964015Z","caller":"traceutil/trace.go:171","msg":"trace[1094099504] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2003; }","duration":"128.108938ms","start":"2026-04-28T13:57:41.835884Z","end":"2026-04-28T13:57:41.963993Z","steps":["trace[1094099504] 'range keys from in-memory index tree' (duration: 127.655946ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:58:18.395085Z","caller":"traceutil/trace.go:171","msg":"trace[1738961128] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"163.446457ms","start":"2026-04-28T13:58:18.231616Z","end":"2026-04-28T13:58:18.395063Z","steps":["trace[1738961128] 'process raft request' (duration: 163.316364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:18.39542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.801597ms","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-04-28T13:58:18.395429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.45683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.207\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-28T13:58:18.395484Z","caller":"traceutil/trace.go:171","msg":"trace[1211857230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2169; }","duration":"158.89852ms","start":"2026-04-28T13:58:18.236573Z","end":"2026-04-28T13:58:18.395471Z","steps":["trace[1211857230] 'agreement among raft nodes before linearized reading' (duration: 158.681285ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:58:18.395508Z","caller":"traceutil/trace.go:171","msg":"trace[1523073143] range","detail":"{range_begin:/registry/masterleases/199.19.213.207; range_end:; response_count:1; response_revision:2169; }","duration":"140.578553ms","start":"2026-04-28T13:58:18.254911Z","end":"2026-04-28T13:58:18.39549Z","steps":["trace[1523073143] 'agreement among raft nodes before linearized reading' (duration: 140.379218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:18.395444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.543566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:58:18.395629Z","caller":"traceutil/trace.go:171","msg":"trace[475781858] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2169; }","duration":"159.752911ms","start":"2026-04-28T13:58:18.235855Z","end":"2026-04-28T13:58:18.395608Z","steps":["trace[475781858] 'agreement among raft nodes before linearized reading' (duration: 159.412073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:18.395625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.755752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-04-28T13:58:18.395896Z","caller":"traceutil/trace.go:171","msg":"trace[1592625647] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2169; }","duration":"160.058769ms","start":"2026-04-28T13:58:18.235822Z","end":"2026-04-28T13:58:18.395881Z","steps":["trace[1592625647] 'agreement among raft nodes before linearized reading' (duration: 159.622538ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:58:18.423158Z","caller":"traceutil/trace.go:171","msg":"trace[1849883797] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"115.267485ms","start":"2026-04-28T13:58:18.307844Z","end":"2026-04-28T13:58:18.423111Z","steps":["trace[1849883797] 'process raft request' (duration: 115.07375ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:58:18.625314Z","caller":"traceutil/trace.go:171","msg":"trace[14295963] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"176.628389ms","start":"2026-04-28T13:58:18.44866Z","end":"2026-04-28T13:58:18.625289Z","steps":["trace[14295963] 'process raft request' (duration: 176.422504ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:58:23.998861Z","caller":"traceutil/trace.go:171","msg":"trace[865251457] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"139.876195ms","start":"2026-04-28T13:58:23.858968Z","end":"2026-04-28T13:58:23.998845Z","steps":["trace[865251457] 'process raft request' (duration: 139.414113ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:58:24.566893Z","caller":"traceutil/trace.go:171","msg":"trace[1036206140] transaction","detail":"{read_only:false; response_revision:2218; number_of_response:1; }","duration":"111.738425ms","start":"2026-04-28T13:58:24.455128Z","end":"2026-04-28T13:58:24.566867Z","steps":["trace[1036206140] 'process raft request' (duration: 61.12296ms)","trace[1036206140] 'compare' (duration: 50.4359ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:58:37.345091Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721272727527669603,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T13:58:37.846237Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721272727527669603,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T13:58:38.115203Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.271394722s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T13:58:38.115568Z","caller":"traceutil/trace.go:171","msg":"trace[1633196377] transaction","detail":"{read_only:false; response_revision:2287; number_of_response:1; }","duration":"1.271868874s","start":"2026-04-28T13:58:36.843678Z","end":"2026-04-28T13:58:38.115547Z","steps":["trace[1633196377] 'process raft request' (duration: 1.271694869s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:38.115758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:58:36.843651Z","time spent":"1.271999798s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:58:38.142816Z","caller":"traceutil/trace.go:171","msg":"trace[1320968247] linearizableReadLoop","detail":"{readStateIndex:2385; appliedIndex:2384; }","duration":"1.298560157s","start":"2026-04-28T13:58:36.844239Z","end":"2026-04-28T13:58:38.142799Z","steps":["trace[1320968247] 'read index received' (duration: 1.271899094s)","trace[1320968247] 'applied index is now lower than readState.Index' (duration: 26.660553ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:58:38.142987Z","caller":"traceutil/trace.go:171","msg":"trace[695416834] transaction","detail":"{read_only:false; response_revision:2288; number_of_response:1; }","duration":"1.198511688s","start":"2026-04-28T13:58:36.944468Z","end":"2026-04-28T13:58:38.14298Z","steps":["trace[695416834] 'process raft request' (duration: 1.19824678s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:38.143057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:58:36.94445Z","time spent":"1.198556569s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:58:38.143207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.298958237s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-04-28T13:58:38.143226Z","caller":"traceutil/trace.go:171","msg":"trace[1063535355] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2288; }","duration":"1.29903693s","start":"2026-04-28T13:58:36.844185Z","end":"2026-04-28T13:58:38.143222Z","steps":["trace[1063535355] 'agreement among raft nodes before linearized reading' (duration: 1.298962038s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:38.14324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:58:36.844173Z","time spent":"1.29906425s","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-28T13:58:38.143309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.064243148s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:58:38.143325Z","caller":"traceutil/trace.go:171","msg":"trace[1726316029] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2288; }","duration":"1.064259148s","start":"2026-04-28T13:58:37.079062Z","end":"2026-04-28T13:58:38.143322Z","steps":["trace[1726316029] 'agreement among raft nodes before linearized reading' (duration: 1.064235678s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:38.143336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:58:37.079019Z","time spent":"1.06431543s","remote":"127.0.0.1:54244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:58:38.143417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.069553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T13:58:38.143439Z","caller":"traceutil/trace.go:171","msg":"trace[1789995182] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2288; }","duration":"613.121793ms","start":"2026-04-28T13:58:37.530311Z","end":"2026-04-28T13:58:38.143433Z","steps":["trace[1789995182] 'agreement among raft nodes before linearized reading' (duration: 613.089292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:38.143458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:58:37.530293Z","time spent":"613.159915ms","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":5,"response size":29,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:58:38.143527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.923865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T13:58:38.143586Z","caller":"traceutil/trace.go:171","msg":"trace[741622319] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:2288; }","duration":"771.027919ms","start":"2026-04-28T13:58:37.372544Z","end":"2026-04-28T13:58:38.143572Z","steps":["trace[741622319] 'agreement among raft nodes before linearized reading' (duration: 770.917605ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:38.143593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.782626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:58:38.143687Z","caller":"traceutil/trace.go:171","msg":"trace[1894321987] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2288; }","duration":"744.915839ms","start":"2026-04-28T13:58:37.398727Z","end":"2026-04-28T13:58:38.143643Z","steps":["trace[1894321987] 'agreement among raft nodes before linearized reading' (duration: 744.749354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:38.143614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:58:37.372524Z","time spent":"771.08213ms","remote":"127.0.0.1:54638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":29,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:58:38.143737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:58:37.398711Z","time spent":"745.015432ms","remote":"127.0.0.1:54230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:58:42.938363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.736323ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:58:42.938476Z","caller":"traceutil/trace.go:171","msg":"trace[792694899] transaction","detail":"{read_only:false; response_revision:2316; number_of_response:1; }","duration":"152.624628ms","start":"2026-04-28T13:58:42.785833Z","end":"2026-04-28T13:58:42.938457Z","steps":["trace[792694899] 'process raft request' (duration: 40.710359ms)","trace[792694899] 'compare' (duration: 111.60567ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:58:42.941823Z","caller":"traceutil/trace.go:171","msg":"trace[1412855237] linearizableReadLoop","detail":"{readStateIndex:2417; appliedIndex:2415; }","duration":"100.801569ms","start":"2026-04-28T13:58:42.841005Z","end":"2026-04-28T13:58:42.941806Z","steps":["trace[1412855237] 'read index received' (duration: 100.671966ms)","trace[1412855237] 'applied index is now lower than readState.Index' (duration: 128.583µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:58:42.941854Z","caller":"traceutil/trace.go:171","msg":"trace[159389889] transaction","detail":"{read_only:false; response_revision:2317; number_of_response:1; }","duration":"155.622684ms","start":"2026-04-28T13:58:42.786206Z","end":"2026-04-28T13:58:42.941829Z","steps":["trace[159389889] 'process raft request' (duration: 155.4806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:42.942099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.084497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:6 size:363686"} {"level":"info","ts":"2026-04-28T13:58:42.942141Z","caller":"traceutil/trace.go:171","msg":"trace[523533533] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:2318; }","duration":"101.129078ms","start":"2026-04-28T13:58:42.840998Z","end":"2026-04-28T13:58:42.942127Z","steps":["trace[523533533] 'agreement among raft nodes before linearized reading' (duration: 100.873251ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:58:42.942175Z","caller":"traceutil/trace.go:171","msg":"trace[819601979] transaction","detail":"{read_only:false; response_revision:2318; number_of_response:1; }","duration":"155.83478ms","start":"2026-04-28T13:58:42.786332Z","end":"2026-04-28T13:58:42.942167Z","steps":["trace[819601979] 'process raft request' (duration: 155.433969ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:43.400856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.505762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"warn","ts":"2026-04-28T13:58:43.400628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.107822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-28T13:58:43.401006Z","caller":"traceutil/trace.go:171","msg":"trace[264862985] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2318; }","duration":"277.526902ms","start":"2026-04-28T13:58:43.123447Z","end":"2026-04-28T13:58:43.400974Z","steps":["trace[264862985] 'range keys from in-memory index tree' (duration: 276.890796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:43.401025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.144719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:6 size:363686"} {"level":"info","ts":"2026-04-28T13:58:43.401152Z","caller":"traceutil/trace.go:171","msg":"trace[1711648695] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:2318; }","duration":"338.334713ms","start":"2026-04-28T13:58:43.06279Z","end":"2026-04-28T13:58:43.401124Z","steps":["trace[1711648695] 'range keys from in-memory index tree' (duration: 337.611606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:43.401211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:58:43.062765Z","time spent":"338.433765ms","remote":"127.0.0.1:54338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":6,"response size":363708,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"info","ts":"2026-04-28T13:58:43.400935Z","caller":"traceutil/trace.go:171","msg":"trace[1417472687] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2318; }","duration":"232.643206ms","start":"2026-04-28T13:58:43.168275Z","end":"2026-04-28T13:58:43.400918Z","steps":["trace[1417472687] 'range keys from in-memory index tree' (duration: 232.306648ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:58:43.790074Z","caller":"traceutil/trace.go:171","msg":"trace[789904728] linearizableReadLoop","detail":"{readStateIndex:2420; appliedIndex:2419; }","duration":"266.764883ms","start":"2026-04-28T13:58:43.523274Z","end":"2026-04-28T13:58:43.790039Z","steps":["trace[789904728] 'read index received' (duration: 241.932097ms)","trace[789904728] 'applied index is now lower than readState.Index' (duration: 24.831036ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:58:43.79031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.130164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-28T13:58:43.790311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.011339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-04-28T13:58:43.790352Z","caller":"traceutil/trace.go:171","msg":"trace[702474799] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:2320; }","duration":"234.196936ms","start":"2026-04-28T13:58:43.55614Z","end":"2026-04-28T13:58:43.790337Z","steps":["trace[702474799] 'agreement among raft nodes before linearized reading' (duration: 234.085094ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:58:43.790356Z","caller":"traceutil/trace.go:171","msg":"trace[2063506624] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2320; }","duration":"267.146133ms","start":"2026-04-28T13:58:43.523197Z","end":"2026-04-28T13:58:43.790343Z","steps":["trace[2063506624] 'agreement among raft nodes before linearized reading' (duration: 266.929267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:58:43.790711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.675511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:6 size:363686"} {"level":"info","ts":"2026-04-28T13:58:43.790809Z","caller":"traceutil/trace.go:171","msg":"trace[679310262] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:2320; }","duration":"196.797264ms","start":"2026-04-28T13:58:43.593987Z","end":"2026-04-28T13:58:43.790785Z","steps":["trace[679310262] 'agreement among raft nodes before linearized reading' (duration: 196.357943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:59:06.511832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.721118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system:controller:cloud-provider\" ","response":"range_response_count:1 size:733"} {"level":"info","ts":"2026-04-28T13:59:06.511953Z","caller":"traceutil/trace.go:171","msg":"trace[707786632] range","detail":"{range_begin:/registry/rolebindings/kube-system/system:controller:cloud-provider; range_end:; response_count:1; response_revision:2426; }","duration":"105.896732ms","start":"2026-04-28T13:59:06.406029Z","end":"2026-04-28T13:59:06.511926Z","steps":["trace[707786632] 'range keys from in-memory index tree' (duration: 105.614965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:59:06.511843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.560237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:59:06.512334Z","caller":"traceutil/trace.go:171","msg":"trace[1109138497] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2426; }","duration":"115.096032ms","start":"2026-04-28T13:59:06.397209Z","end":"2026-04-28T13:59:06.512305Z","steps":["trace[1109138497] 'range keys from in-memory index tree' (duration: 114.432334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:59:06.511771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.862623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:741"} {"level":"info","ts":"2026-04-28T13:59:06.512453Z","caller":"traceutil/trace.go:171","msg":"trace[769565648] range","detail":"{range_begin:/registry/rolebindings/kube-system/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:2426; }","duration":"138.583501ms","start":"2026-04-28T13:59:06.373839Z","end":"2026-04-28T13:59:06.512423Z","steps":["trace[769565648] 'range keys from in-memory index tree' (duration: 137.706129ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:59:07.060583Z","caller":"traceutil/trace.go:171","msg":"trace[1395987028] transaction","detail":"{read_only:false; response_revision:2429; number_of_response:1; }","duration":"101.427046ms","start":"2026-04-28T13:59:06.959142Z","end":"2026-04-28T13:59:07.06057Z","steps":["trace[1395987028] 'process raft request' (duration: 101.238211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:59:07.303943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.61757ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:59:07.304115Z","caller":"traceutil/trace.go:171","msg":"trace[345444497] transaction","detail":"{read_only:false; response_revision:2430; number_of_response:1; }","duration":"239.633178ms","start":"2026-04-28T13:59:07.06445Z","end":"2026-04-28T13:59:07.304083Z","steps":["trace[345444497] 'process raft request' (duration: 97.74249ms)","trace[345444497] 'compare' (duration: 141.499947ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:59:07.339451Z","caller":"traceutil/trace.go:171","msg":"trace[727262028] transaction","detail":"{read_only:false; response_revision:2431; number_of_response:1; }","duration":"274.120604ms","start":"2026-04-28T13:59:07.065302Z","end":"2026-04-28T13:59:07.339423Z","steps":["trace[727262028] 'process raft request' (duration: 273.948689ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:59:07.339634Z","caller":"traceutil/trace.go:171","msg":"trace[1188027582] linearizableReadLoop","detail":"{readStateIndex:2536; appliedIndex:2533; }","duration":"206.084536ms","start":"2026-04-28T13:59:07.13351Z","end":"2026-04-28T13:59:07.339595Z","steps":["trace[1188027582] 'read index received' (duration: 28.666955ms)","trace[1188027582] 'applied index is now lower than readState.Index' (duration: 177.415431ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:59:07.339696Z","caller":"traceutil/trace.go:171","msg":"trace[1932956349] transaction","detail":"{read_only:false; response_revision:2432; number_of_response:1; }","duration":"272.457851ms","start":"2026-04-28T13:59:07.067221Z","end":"2026-04-28T13:59:07.339679Z","steps":["trace[1932956349] 'process raft request' (duration: 272.152472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:59:07.33985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.313792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/kubeadm:kubeadm-certs\" ","response":"range_response_count:1 size:339"} {"level":"info","ts":"2026-04-28T13:59:07.339897Z","caller":"traceutil/trace.go:171","msg":"trace[818829670] range","detail":"{range_begin:/registry/roles/kube-system/kubeadm:kubeadm-certs; range_end:; response_count:1; response_revision:2432; }","duration":"206.411934ms","start":"2026-04-28T13:59:07.133473Z","end":"2026-04-28T13:59:07.339885Z","steps":["trace[818829670] 'agreement among raft nodes before linearized reading' (duration: 206.290891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:59:07.339917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.595943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/kube-proxy\" ","response":"range_response_count:1 size:317"} {"level":"info","ts":"2026-04-28T13:59:07.339995Z","caller":"traceutil/trace.go:171","msg":"trace[740803430] range","detail":"{range_begin:/registry/roles/kube-system/kube-proxy; range_end:; response_count:1; response_revision:2432; }","duration":"205.711606ms","start":"2026-04-28T13:59:07.134266Z","end":"2026-04-28T13:59:07.339977Z","steps":["trace[740803430] 'agreement among raft nodes before linearized reading' (duration: 205.583273ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:59:08.400403Z","caller":"traceutil/trace.go:171","msg":"trace[230160028] linearizableReadLoop","detail":"{readStateIndex:2537; appliedIndex:2536; }","duration":"138.031957ms","start":"2026-04-28T13:59:08.262346Z","end":"2026-04-28T13:59:08.400378Z","steps":["trace[230160028] 'read index received' (duration: 137.841113ms)","trace[230160028] 'applied index is now lower than readState.Index' (duration: 189.414µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:59:08.401666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.296201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:115 size:88927"} {"level":"warn","ts":"2026-04-28T13:59:08.401709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.237975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-28T13:59:08.401762Z","caller":"traceutil/trace.go:171","msg":"trace[1549925261] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:2433; }","duration":"110.331808ms","start":"2026-04-28T13:59:08.291418Z","end":"2026-04-28T13:59:08.40175Z","steps":["trace[1549925261] 'agreement among raft nodes before linearized reading' (duration: 110.204245ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:59:08.40182Z","caller":"traceutil/trace.go:171","msg":"trace[273003972] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:115; response_revision:2432; }","duration":"139.435364ms","start":"2026-04-28T13:59:08.262283Z","end":"2026-04-28T13:59:08.401718Z","steps":["trace[273003972] 'agreement among raft nodes before linearized reading' (duration: 138.233653ms)"],"step_count":1}