{"level":"warn","ts":"2026-07-23T23:49:05.683993Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-23T23:49:05.684108Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57: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-07-23T23:49:05.684183Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-23T23:49:05.684191Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-07-23T23:49:05.68421Z","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-07-23T23:49:05.684862Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-07-23T23:49:05.684946Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57: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-07-23T23:49:05.688826Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.654458ms"} {"level":"info","ts":"2026-07-23T23:49:05.70591Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-07-23T23:49:05.706024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-07-23T23:49:05.706052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-07-23T23:49:05.706062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-23T23:49:05.706073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-07-23T23:49:05.706145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-07-23T23:49:05.71598Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-23T23:49:05.71717Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-23T23:49:05.719338Z","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-07-23T23:49:05.72149Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-23T23:49:05.721756Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-23T23:49:05.722156Z","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-07-23T23:49:05.724727Z","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-07-23T23:49:05.724868Z","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-07-23T23:49:05.726292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-07-23T23:49:05.726622Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-07-23T23:49:05.728289Z","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-07-23T23:49:05.72847Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-07-23T23:49:05.728504Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-07-23T23:49:05.728558Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-23T23:49:05.728586Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-23T23:49:06.507619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-07-23T23:49:06.507736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-23T23:49:06.507809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-07-23T23:49:06.507857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-07-23T23:49:06.507903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-07-23T23:49:06.507953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-07-23T23:49:06.50798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-07-23T23:49:06.50872Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:49:06.509496Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-07-23T23:49:06.509512Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-23T23:49:06.509543Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-23T23:49:06.510003Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:49:06.510178Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:49:06.510239Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:49:06.512504Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"info","ts":"2026-07-23T23:49:06.512602Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-23T23:49:06.512666Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-23T23:49:06.512865Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-23T23:49:08.69329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.034085ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-23T23:49:08.69354Z","caller":"traceutil/trace.go:171","msg":"trace[1812901874] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"595.64669ms","start":"2026-07-23T23:49:08.09784Z","end":"2026-07-23T23:49:08.693487Z","steps":["trace[1812901874] 'process raft request' (duration: 150.842184ms)","trace[1812901874] 'compare' (duration: 443.82512ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:49:08.693688Z","caller":"traceutil/trace.go:171","msg":"trace[306960237] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"524.614626ms","start":"2026-07-23T23:49:08.169036Z","end":"2026-07-23T23:49:08.69365Z","steps":["trace[306960237] 'read index received' (duration: 79.705938ms)","trace[306960237] 'applied index is now lower than readState.Index' (duration: 444.905198ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:49:08.693728Z","caller":"traceutil/trace.go:171","msg":"trace[495720167] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"504.090363ms","start":"2026-07-23T23:49:08.189616Z","end":"2026-07-23T23:49:08.693706Z","steps":["trace[495720167] 'process raft request' (duration: 504.040381ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:08.693809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.097812Z","time spent":"595.868596ms","remote":"127.0.0.1:42376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:08.693946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.189603Z","time spent":"504.287368ms","remote":"127.0.0.1:42268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:08.69415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.02602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:49:08.694214Z","caller":"traceutil/trace.go:171","msg":"trace[277057183] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"547.204465ms","start":"2026-07-23T23:49:08.146996Z","end":"2026-07-23T23:49:08.6942Z","steps":["trace[277057183] 'agreement among raft nodes before linearized reading' (duration: 546.958859ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:08.694255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.146978Z","time spent":"547.266196ms","remote":"127.0.0.1:42188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-23T23:49:08.694253Z","caller":"traceutil/trace.go:171","msg":"trace[1720727633] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"519.766175ms","start":"2026-07-23T23:49:08.174474Z","end":"2026-07-23T23:49:08.69424Z","steps":["trace[1720727633] 'process raft request' (duration: 518.981364ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:08.694314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.17445Z","time spent":"519.841038ms","remote":"127.0.0.1:42574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:08.694492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.130467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-23T23:49:08.694489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.314055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-07-23T23:49:08.694522Z","caller":"traceutil/trace.go:171","msg":"trace[293963037] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:0; response_revision:10; }","duration":"523.181308ms","start":"2026-07-23T23:49:08.171331Z","end":"2026-07-23T23:49:08.694512Z","steps":["trace[293963037] 'agreement among raft nodes before linearized reading' (duration: 523.132946ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:08.694544Z","caller":"traceutil/trace.go:171","msg":"trace[890589048] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"600.382528ms","start":"2026-07-23T23:49:08.094139Z","end":"2026-07-23T23:49:08.694521Z","steps":["trace[890589048] 'agreement among raft nodes before linearized reading' (duration: 600.266935ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:08.694558Z","caller":"traceutil/trace.go:171","msg":"trace[1619282411] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"514.637997ms","start":"2026-07-23T23:49:08.179908Z","end":"2026-07-23T23:49:08.694546Z","steps":["trace[1619282411] 'process raft request' (duration: 513.61345ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:08.694579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.094134Z","time spent":"600.439069ms","remote":"127.0.0.1:42268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-07-23T23:49:08.694623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.179895Z","time spent":"514.705349ms","remote":"127.0.0.1:42672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:08.694687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.460433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:49:08.694718Z","caller":"traceutil/trace.go:171","msg":"trace[407578868] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"468.511945ms","start":"2026-07-23T23:49:08.226198Z","end":"2026-07-23T23:49:08.694709Z","steps":["trace[407578868] 'agreement among raft nodes before linearized reading' (duration: 468.467914ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:08.694736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.665241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:49:08.694746Z","caller":"traceutil/trace.go:171","msg":"trace[2073488576] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"514.800572ms","start":"2026-07-23T23:49:08.179936Z","end":"2026-07-23T23:49:08.694737Z","steps":["trace[2073488576] 'process raft request' (duration: 513.61326ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:08.69477Z","caller":"traceutil/trace.go:171","msg":"trace[865695495] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:10; }","duration":"598.736883ms","start":"2026-07-23T23:49:08.096021Z","end":"2026-07-23T23:49:08.694758Z","steps":["trace[865695495] 'agreement among raft nodes before linearized reading' (duration: 598.690222ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:08.694796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.113425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-23T23:49:08.694807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.095998Z","time spent":"598.803165ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-07-23T23:49:08.694825Z","caller":"traceutil/trace.go:171","msg":"trace[1998180964] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"520.158477ms","start":"2026-07-23T23:49:08.174657Z","end":"2026-07-23T23:49:08.694816Z","steps":["trace[1998180964] 'agreement among raft nodes before linearized reading' (duration: 520.112055ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:08.694838Z","caller":"traceutil/trace.go:171","msg":"trace[2084284794] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"514.883744ms","start":"2026-07-23T23:49:08.179947Z","end":"2026-07-23T23:49:08.69483Z","steps":["trace[2084284794] 'process raft request' (duration: 513.63063ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:08.694854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.174645Z","time spent":"520.202238ms","remote":"127.0.0.1:42164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-07-23T23:49:08.694893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.17991Z","time spent":"514.959336ms","remote":"127.0.0.1:42672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:08.694961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.986659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-23T23:49:08.695011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.688218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:49:08.69502Z","caller":"traceutil/trace.go:171","msg":"trace[133234591] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"514.996287ms","start":"2026-07-23T23:49:08.180015Z","end":"2026-07-23T23:49:08.695011Z","steps":["trace[133234591] 'process raft request' (duration: 513.586439ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:08.69505Z","caller":"traceutil/trace.go:171","msg":"trace[1984732417] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"521.806191ms","start":"2026-07-23T23:49:08.173235Z","end":"2026-07-23T23:49:08.695041Z","steps":["trace[1984732417] 'agreement among raft nodes before linearized reading' (duration: 521.754839ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:08.695058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.905385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-23T23:49:08.695078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.173177Z","time spent":"521.894663ms","remote":"127.0.0.1:42188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-23T23:49:08.695094Z","caller":"traceutil/trace.go:171","msg":"trace[406287563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:10; }","duration":"599.942786ms","start":"2026-07-23T23:49:08.095143Z","end":"2026-07-23T23:49:08.695086Z","steps":["trace[406287563] 'agreement among raft nodes before linearized reading' (duration: 599.890085ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:08.695122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.095126Z","time spent":"599.990697ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-23T23:49:08.695154Z","caller":"traceutil/trace.go:171","msg":"trace[1727583338] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"515.037019ms","start":"2026-07-23T23:49:08.180109Z","end":"2026-07-23T23:49:08.695146Z","steps":["trace[1727583338] 'process raft request' (duration: 513.520348ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:08.695201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.180099Z","time spent":"515.0806ms","remote":"127.0.0.1:42672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:08.695254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.362665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-07-23T23:49:08.695304Z","caller":"traceutil/trace.go:171","msg":"trace[1974303901] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"522.464249ms","start":"2026-07-23T23:49:08.17283Z","end":"2026-07-23T23:49:08.695294Z","steps":["trace[1974303901] 'agreement among raft nodes before linearized reading' (duration: 522.378916ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:08.695339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.172803Z","time spent":"522.52979ms","remote":"127.0.0.1:42268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-07-23T23:49:08.694752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.226185Z","time spent":"468.560646ms","remote":"127.0.0.1:42188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-23T23:49:08.694804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.179919Z","time spent":"514.865344ms","remote":"127.0.0.1:42672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:08.694549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.17132Z","time spent":"523.223448ms","remote":"127.0.0.1:42096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"info","ts":"2026-07-23T23:49:08.69501Z","caller":"traceutil/trace.go:171","msg":"trace[1297253003] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:10; }","duration":"599.046702ms","start":"2026-07-23T23:49:08.095951Z","end":"2026-07-23T23:49:08.694998Z","steps":["trace[1297253003] 'agreement among raft nodes before linearized reading' (duration: 598.98764ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:08.695926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.095944Z","time spent":"599.967966ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-23T23:49:08.695114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.180008Z","time spent":"515.038488ms","remote":"127.0.0.1:42672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:09.730078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.460738ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-23T23:49:09.730352Z","caller":"traceutil/trace.go:171","msg":"trace[1166353467] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"1.030095316s","start":"2026-07-23T23:49:08.700198Z","end":"2026-07-23T23:49:09.730293Z","steps":["trace[1166353467] 'process raft request' (duration: 782.262108ms)","trace[1166353467] 'compare' (duration: 247.278813ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:49:09.730426Z","caller":"traceutil/trace.go:171","msg":"trace[427756896] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"1.029911142s","start":"2026-07-23T23:49:08.700475Z","end":"2026-07-23T23:49:09.730386Z","steps":["trace[427756896] 'process raft request' (duration: 1.029741937s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.730608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.700175Z","time spent":"1.030307292s","remote":"127.0.0.1:42574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:49:09.730636Z","caller":"traceutil/trace.go:171","msg":"trace[1828241484] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"1.028756371s","start":"2026-07-23T23:49:08.701813Z","end":"2026-07-23T23:49:09.73057Z","steps":["trace[1828241484] 'process raft request' (duration: 1.028485803s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.730865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.701794Z","time spent":"1.028965816s","remote":"127.0.0.1:42672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:49:09.730935Z","caller":"traceutil/trace.go:171","msg":"trace[1526870645] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:13; }","duration":"1.030651301s","start":"2026-07-23T23:49:08.700233Z","end":"2026-07-23T23:49:09.730885Z","steps":["trace[1526870645] 'read index received' (duration: 13.206645ms)","trace[1526870645] 'applied index is now lower than readState.Index' (duration: 1.017443456s)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:49:09.731208Z","caller":"traceutil/trace.go:171","msg":"trace[1416315773] transaction","detail":"{read_only:false; number_of_response:0; response_revision:17; }","duration":"1.028312478s","start":"2026-07-23T23:49:08.70269Z","end":"2026-07-23T23:49:09.731003Z","steps":["trace[1416315773] 'process raft request' (duration: 1.027795835s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:09.73125Z","caller":"traceutil/trace.go:171","msg":"trace[94515818] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"1.030085367s","start":"2026-07-23T23:49:08.701149Z","end":"2026-07-23T23:49:09.731234Z","steps":["trace[94515818] 'process raft request' (duration: 1.029114421s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:09.731248Z","caller":"traceutil/trace.go:171","msg":"trace[166720313] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"1.026797698s","start":"2026-07-23T23:49:08.704436Z","end":"2026-07-23T23:49:09.731233Z","steps":["trace[166720313] 'process raft request' (duration: 1.026172991s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.73066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.700464Z","time spent":"1.030087646s","remote":"127.0.0.1:42188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:09.731332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.70114Z","time spent":"1.030159178s","remote":"127.0.0.1:42672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:09.731338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.704424Z","time spent":"1.02688434s","remote":"127.0.0.1:42672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:09.731441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.702662Z","time spent":"1.028667168s","remote":"127.0.0.1:42188","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:49:09.731532Z","caller":"traceutil/trace.go:171","msg":"trace[906200457] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"1.028590626s","start":"2026-07-23T23:49:08.702927Z","end":"2026-07-23T23:49:09.731518Z","steps":["trace[906200457] 'process raft request' (duration: 1.027582909s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.731614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.702904Z","time spent":"1.028686088s","remote":"127.0.0.1:42672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:49:09.731648Z","caller":"traceutil/trace.go:171","msg":"trace[1945924188] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"1.021614878s","start":"2026-07-23T23:49:08.710011Z","end":"2026-07-23T23:49:09.731626Z","steps":["trace[1945924188] 'process raft request' (duration: 1.020719244s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:09.731906Z","caller":"traceutil/trace.go:171","msg":"trace[181639326] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"1.029277004s","start":"2026-07-23T23:49:08.702617Z","end":"2026-07-23T23:49:09.731894Z","steps":["trace[181639326] 'process raft request' (duration: 1.027799325s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.731968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.702604Z","time spent":"1.029339836s","remote":"127.0.0.1:42672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:09.731954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.031653469s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:49:09.732072Z","caller":"traceutil/trace.go:171","msg":"trace[197749039] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"1.031770762s","start":"2026-07-23T23:49:08.700242Z","end":"2026-07-23T23:49:09.732013Z","steps":["trace[197749039] 'agreement among raft nodes before linearized reading' (duration: 1.031652278s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.732144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.700223Z","time spent":"1.031887905s","remote":"127.0.0.1:42072","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-07-23T23:49:09.73219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"978.441635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:49:09.732238Z","caller":"traceutil/trace.go:171","msg":"trace[1855002734] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:0; response_revision:20; }","duration":"978.540427ms","start":"2026-07-23T23:49:08.753686Z","end":"2026-07-23T23:49:09.732227Z","steps":["trace[1855002734] 'agreement among raft nodes before linearized reading' (duration: 978.453635ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.732277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.753661Z","time spent":"978.60866ms","remote":"127.0.0.1:42188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-node-lease\" "} {"level":"warn","ts":"2026-07-23T23:49:09.732293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.007848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-07-23T23:49:09.732332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.174512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:49:09.732367Z","caller":"traceutil/trace.go:171","msg":"trace[1712380915] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"980.135811ms","start":"2026-07-23T23:49:08.752214Z","end":"2026-07-23T23:49:09.73235Z","steps":["trace[1712380915] 'agreement among raft nodes before linearized reading' (duration: 979.995757ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:09.732428Z","caller":"traceutil/trace.go:171","msg":"trace[662167228] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"505.272425ms","start":"2026-07-23T23:49:09.227119Z","end":"2026-07-23T23:49:09.732391Z","steps":["trace[662167228] 'agreement among raft nodes before linearized reading' (duration: 505.176292ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.73247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:09.227094Z","time spent":"505.370658ms","remote":"127.0.0.1:42070","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-07-23T23:49:09.732485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.173051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-23T23:49:09.732537Z","caller":"traceutil/trace.go:171","msg":"trace[22466093] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"980.237943ms","start":"2026-07-23T23:49:08.752287Z","end":"2026-07-23T23:49:09.732524Z","steps":["trace[22466093] 'agreement among raft nodes before linearized reading' (duration: 980.167582ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.732216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.031982247s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-rdsnr\" ","response":"range_response_count:1 size:861"} {"level":"warn","ts":"2026-07-23T23:49:09.732579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.866004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-23T23:49:09.732592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.752275Z","time spent":"980.295675ms","remote":"127.0.0.1:42188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-23T23:49:09.732619Z","caller":"traceutil/trace.go:171","msg":"trace[639919226] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:20; }","duration":"658.957176ms","start":"2026-07-23T23:49:09.073653Z","end":"2026-07-23T23:49:09.73261Z","steps":["trace[639919226] 'agreement among raft nodes before linearized reading' (duration: 658.892334ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.732641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.115938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-23T23:49:09.732662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:09.073624Z","time spent":"659.029048ms","remote":"127.0.0.1:42472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"info","ts":"2026-07-23T23:49:09.732621Z","caller":"traceutil/trace.go:171","msg":"trace[563000647] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-rdsnr; range_end:; response_count:1; response_revision:20; }","duration":"1.032401629s","start":"2026-07-23T23:49:08.700204Z","end":"2026-07-23T23:49:09.732606Z","steps":["trace[563000647] 'agreement among raft nodes before linearized reading' (duration: 1.031986467s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.732709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.700191Z","time spent":"1.032505791s","remote":"127.0.0.1:42376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-rdsnr\" "} {"level":"info","ts":"2026-07-23T23:49:09.732688Z","caller":"traceutil/trace.go:171","msg":"trace[906684776] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:20; }","duration":"660.221831ms","start":"2026-07-23T23:49:09.072454Z","end":"2026-07-23T23:49:09.732676Z","steps":["trace[906684776] 'agreement among raft nodes before linearized reading' (duration: 660.107197ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.73281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:09.072433Z","time spent":"660.367194ms","remote":"127.0.0.1:42488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-07-23T23:49:09.732416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.710003Z","time spent":"1.021794033s","remote":"127.0.0.1:42268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:49:09.732146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.623621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:49:09.732903Z","caller":"traceutil/trace.go:171","msg":"trace[1385884613] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:20; }","duration":"828.450203ms","start":"2026-07-23T23:49:08.904441Z","end":"2026-07-23T23:49:09.732891Z","steps":["trace[1385884613] 'agreement among raft nodes before linearized reading' (duration: 827.630261ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.732948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.904427Z","time spent":"828.511255ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-07-23T23:49:09.732427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"972.508475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-23T23:49:09.733117Z","caller":"traceutil/trace.go:171","msg":"trace[121367090] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"973.217984ms","start":"2026-07-23T23:49:08.759889Z","end":"2026-07-23T23:49:09.733107Z","steps":["trace[121367090] 'agreement among raft nodes before linearized reading' (duration: 972.493605ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.733171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.759873Z","time spent":"973.287586ms","remote":"127.0.0.1:42188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-23T23:49:09.732426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.75219Z","time spent":"980.225814ms","remote":"127.0.0.1:42188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-23T23:49:09.731746Z","caller":"traceutil/trace.go:171","msg":"trace[293592551] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"1.029530421s","start":"2026-07-23T23:49:08.702198Z","end":"2026-07-23T23:49:09.731728Z","steps":["trace[293592551] 'process raft request' (duration: 1.028129133s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:09.733506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:08.702188Z","time spent":"1.031153155s","remote":"127.0.0.1:42528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:17.178242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.691429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-07-23T23:49:17.1784Z","caller":"traceutil/trace.go:171","msg":"trace[1624270407] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7c96b6546b; range_end:; response_count:1; response_revision:349; }","duration":"108.880964ms","start":"2026-07-23T23:49:17.069491Z","end":"2026-07-23T23:49:17.178372Z","steps":["trace[1624270407] 'range keys from in-memory index tree' (duration: 108.492353ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:17.385977Z","caller":"traceutil/trace.go:171","msg":"trace[2100447322] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"139.340974ms","start":"2026-07-23T23:49:17.246604Z","end":"2026-07-23T23:49:17.385945Z","steps":["trace[2100447322] 'process raft request' (duration: 94.986619ms)","trace[2100447322] 'compare' (duration: 43.729238ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:49:18.051129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.163416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-23T23:49:18.051154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.598015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:49:18.051196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.260618ms","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-07-23T23:49:18.051254Z","caller":"traceutil/trace.go:171","msg":"trace[332445925] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:351; }","duration":"390.77048ms","start":"2026-07-23T23:49:17.660457Z","end":"2026-07-23T23:49:18.051228Z","steps":["trace[332445925] 'range keys from in-memory index tree' (duration: 390.462171ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:18.052024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:17.660426Z","time spent":"391.562371ms","remote":"127.0.0.1:42072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-23T23:49:18.051258Z","caller":"traceutil/trace.go:171","msg":"trace[1140575160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:351; }","duration":"245.362171ms","start":"2026-07-23T23:49:17.805877Z","end":"2026-07-23T23:49:18.051239Z","steps":["trace[1140575160] 'range keys from in-memory index tree' (duration: 245.134655ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:18.051252Z","caller":"traceutil/trace.go:171","msg":"trace[2055832929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:351; }","duration":"245.298529ms","start":"2026-07-23T23:49:17.80592Z","end":"2026-07-23T23:49:18.051219Z","steps":["trace[2055832929] 'range keys from in-memory index tree' (duration: 245.015521ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:18.729914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.842362ms","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-07-23T23:49:18.730026Z","caller":"traceutil/trace.go:171","msg":"trace[1795967318] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:353; }","duration":"273.037027ms","start":"2026-07-23T23:49:18.456963Z","end":"2026-07-23T23:49:18.73Z","steps":["trace[1795967318] 'range keys from in-memory index tree' (duration: 272.664916ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:19.16387Z","caller":"traceutil/trace.go:171","msg":"trace[744733730] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"216.219217ms","start":"2026-07-23T23:49:18.94761Z","end":"2026-07-23T23:49:19.163829Z","steps":["trace[744733730] 'process raft request' (duration: 215.939589ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:20.341192Z","caller":"traceutil/trace.go:171","msg":"trace[1464656195] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"178.860869ms","start":"2026-07-23T23:49:20.162298Z","end":"2026-07-23T23:49:20.341159Z","steps":["trace[1464656195] 'process raft request' (duration: 178.613823ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:20.418799Z","caller":"traceutil/trace.go:171","msg":"trace[1656248070] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"254.97028ms","start":"2026-07-23T23:49:20.163792Z","end":"2026-07-23T23:49:20.418762Z","steps":["trace[1656248070] 'process raft request' (duration: 225.756953ms)","trace[1656248070] 'compare' (duration: 29.025722ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:49:20.66735Z","caller":"traceutil/trace.go:171","msg":"trace[186448221] linearizableReadLoop","detail":"{readStateIndex:376; appliedIndex:375; }","duration":"124.569386ms","start":"2026-07-23T23:49:20.542749Z","end":"2026-07-23T23:49:20.667319Z","steps":["trace[186448221] 'read index received' (duration: 124.325329ms)","trace[186448221] 'applied index is now lower than readState.Index' (duration: 243.117µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:49:20.667482Z","caller":"traceutil/trace.go:171","msg":"trace[1791145785] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"161.363618ms","start":"2026-07-23T23:49:20.50611Z","end":"2026-07-23T23:49:20.667473Z","steps":["trace[1791145785] 'process raft request' (duration: 161.04356ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:20.667759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.979048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-23T23:49:20.667807Z","caller":"traceutil/trace.go:171","msg":"trace[401065953] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:364; }","duration":"125.127982ms","start":"2026-07-23T23:49:20.54267Z","end":"2026-07-23T23:49:20.667798Z","steps":["trace[401065953] 'agreement among raft nodes before linearized reading' (duration: 124.973738ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:20.980495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.772039ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:49:20.980638Z","caller":"traceutil/trace.go:171","msg":"trace[219950468] linearizableReadLoop","detail":"{readStateIndex:378; appliedIndex:377; }","duration":"205.487717ms","start":"2026-07-23T23:49:20.775128Z","end":"2026-07-23T23:49:20.980616Z","steps":["trace[219950468] 'read index received' (duration: 32.391µs)","trace[219950468] 'applied index is now lower than readState.Index' (duration: 205.453696ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:49:20.980676Z","caller":"traceutil/trace.go:171","msg":"trace[463759926] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"226.180155ms","start":"2026-07-23T23:49:20.754461Z","end":"2026-07-23T23:49:20.980641Z","steps":["trace[463759926] 'process raft request' (duration: 18.133959ms)","trace[463759926] 'compare' (duration: 207.522881ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:49:20.980997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.839447ms","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-07-23T23:49:20.981156Z","caller":"traceutil/trace.go:171","msg":"trace[1037176971] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:365; }","duration":"206.052593ms","start":"2026-07-23T23:49:20.775075Z","end":"2026-07-23T23:49:20.981128Z","steps":["trace[1037176971] 'agreement among raft nodes before linearized reading' (duration: 205.661132ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:32.583338Z","caller":"traceutil/trace.go:171","msg":"trace[552676605] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"111.167476ms","start":"2026-07-23T23:49:32.472121Z","end":"2026-07-23T23:49:32.583288Z","steps":["trace[552676605] 'process raft request' (duration: 64.149539ms)","trace[552676605] 'compare' (duration: 46.703478ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:49:46.842905Z","caller":"traceutil/trace.go:171","msg":"trace[1455402264] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"264.888337ms","start":"2026-07-23T23:49:46.577962Z","end":"2026-07-23T23:49:46.842851Z","steps":["trace[1455402264] 'process raft request' (duration: 264.541548ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:46.84302Z","caller":"traceutil/trace.go:171","msg":"trace[1214500516] linearizableReadLoop","detail":"{readStateIndex:476; appliedIndex:475; }","duration":"186.154106ms","start":"2026-07-23T23:49:46.656598Z","end":"2026-07-23T23:49:46.842753Z","steps":["trace[1214500516] 'read index received' (duration: 185.800777ms)","trace[1214500516] 'applied index is now lower than readState.Index' (duration: 351.879µs)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:49:46.843112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.461684ms","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-07-23T23:49:46.843262Z","caller":"traceutil/trace.go:171","msg":"trace[664746193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:458; }","duration":"186.67081ms","start":"2026-07-23T23:49:46.656557Z","end":"2026-07-23T23:49:46.843228Z","steps":["trace[664746193] 'agreement among raft nodes before linearized reading' (duration: 186.379052ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:46.843405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.775795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:49:46.843471Z","caller":"traceutil/trace.go:171","msg":"trace[271457562] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:458; }","duration":"186.014672ms","start":"2026-07-23T23:49:46.657437Z","end":"2026-07-23T23:49:46.843451Z","steps":["trace[271457562] 'agreement among raft nodes before linearized reading' (duration: 185.800196ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:50.560705Z","caller":"traceutil/trace.go:171","msg":"trace[806463089] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"249.032206ms","start":"2026-07-23T23:49:50.311634Z","end":"2026-07-23T23:49:50.560666Z","steps":["trace[806463089] 'process raft request' (duration: 248.8244ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:51.22874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.291175ms","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-07-23T23:49:51.228946Z","caller":"traceutil/trace.go:171","msg":"trace[665918474] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:501; }","duration":"526.515332ms","start":"2026-07-23T23:49:50.702399Z","end":"2026-07-23T23:49:51.228914Z","steps":["trace[665918474] 'range keys from in-memory index tree' (duration: 526.262465ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:51.239251Z","caller":"traceutil/trace.go:171","msg":"trace[186092271] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"925.681608ms","start":"2026-07-23T23:49:50.313526Z","end":"2026-07-23T23:49:51.239208Z","steps":["trace[186092271] 'process raft request' (duration: 925.406991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:51.239446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.313497Z","time spent":"925.849872ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:49:51.239621Z","caller":"traceutil/trace.go:171","msg":"trace[1213807553] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"917.188808ms","start":"2026-07-23T23:49:50.32242Z","end":"2026-07-23T23:49:51.239609Z","steps":["trace[1213807553] 'process raft request' (duration: 916.809268ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:51.239677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.322395Z","time spent":"917.25662ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:49:51.239834Z","caller":"traceutil/trace.go:171","msg":"trace[1814706827] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"926.192782ms","start":"2026-07-23T23:49:50.313605Z","end":"2026-07-23T23:49:51.239798Z","steps":["trace[1814706827] 'process raft request' (duration: 925.490063ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:51.239881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.313598Z","time spent":"926.259754ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:49:51.239945Z","caller":"traceutil/trace.go:171","msg":"trace[1911935666] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"910.951209ms","start":"2026-07-23T23:49:50.328967Z","end":"2026-07-23T23:49:51.239918Z","steps":["trace[1911935666] 'process raft request' (duration: 910.473246ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:51.240541Z","caller":"traceutil/trace.go:171","msg":"trace[708229714] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"905.515523ms","start":"2026-07-23T23:49:50.334965Z","end":"2026-07-23T23:49:51.240481Z","steps":["trace[708229714] 'process raft request' (duration: 904.68414ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:51.240715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.328957Z","time spent":"911.69479ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:49:51.240722Z","caller":"traceutil/trace.go:171","msg":"trace[644689257] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"916.600902ms","start":"2026-07-23T23:49:50.32345Z","end":"2026-07-23T23:49:51.240051Z","steps":["trace[644689257] 'process raft request' (duration: 915.876902ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:51.240008Z","caller":"traceutil/trace.go:171","msg":"trace[2014269775] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"908.910184ms","start":"2026-07-23T23:49:50.331087Z","end":"2026-07-23T23:49:51.239997Z","steps":["trace[2014269775] 'process raft request' (duration: 908.400041ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:51.240952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.331078Z","time spent":"909.828519ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:51.240955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.323422Z","time spent":"917.398694ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:51.241248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.334955Z","time spent":"905.688557ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:49:51.241619Z","caller":"traceutil/trace.go:171","msg":"trace[772637216] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"875.999634ms","start":"2026-07-23T23:49:50.365386Z","end":"2026-07-23T23:49:51.241385Z","steps":["trace[772637216] 'process raft request' (duration: 874.533244ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:51.241628Z","caller":"traceutil/trace.go:171","msg":"trace[1255409786] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"907.235459ms","start":"2026-07-23T23:49:50.333961Z","end":"2026-07-23T23:49:51.241197Z","steps":["trace[1255409786] 'process raft request' (duration: 905.599785ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:51.2417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.365376Z","time spent":"876.281601ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:51.241896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.33393Z","time spent":"907.857476ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:49:51.245279Z","caller":"traceutil/trace.go:171","msg":"trace[1072913228] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"851.79924ms","start":"2026-07-23T23:49:50.393455Z","end":"2026-07-23T23:49:51.245254Z","steps":["trace[1072913228] 'process raft request' (duration: 847.086282ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:51.245401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.393427Z","time spent":"851.928003ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:49:51.246677Z","caller":"traceutil/trace.go:171","msg":"trace[726751577] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:518; }","duration":"703.20348ms","start":"2026-07-23T23:49:50.543422Z","end":"2026-07-23T23:49:51.246625Z","steps":["trace[726751577] 'read index received' (duration: 17.081512ms)","trace[726751577] 'applied index is now lower than readState.Index' (duration: 686.119498ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:49:51.246707Z","caller":"traceutil/trace.go:171","msg":"trace[1807542220] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"732.654137ms","start":"2026-07-23T23:49:50.513965Z","end":"2026-07-23T23:49:51.246619Z","steps":["trace[1807542220] 'process raft request' (duration: 732.213175ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:51.24684Z","caller":"traceutil/trace.go:171","msg":"trace[833343433] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"411.658505ms","start":"2026-07-23T23:49:50.835158Z","end":"2026-07-23T23:49:51.246816Z","steps":["trace[833343433] 'process raft request' (duration: 411.582823ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:51.246857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.51394Z","time spent":"732.835562ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:49:51.246931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.835125Z","time spent":"411.752158ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:49:51.246936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.513509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-23T23:49:51.247116Z","caller":"traceutil/trace.go:171","msg":"trace[1140454461] transaction","detail":"{read_only:false; number_of_response:1; response_revision:514; }","duration":"676.611451ms","start":"2026-07-23T23:49:50.570489Z","end":"2026-07-23T23:49:51.247101Z","steps":["trace[1140454461] 'process raft request' (duration: 676.21223ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:51.247139Z","caller":"traceutil/trace.go:171","msg":"trace[177439527] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"677.466004ms","start":"2026-07-23T23:49:50.569617Z","end":"2026-07-23T23:49:51.247083Z","steps":["trace[177439527] 'process raft request' (duration: 677.012032ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:51.247175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.570458Z","time spent":"676.680973ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:49:51.247272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.569609Z","time spent":"677.564537ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:49:51.247455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.45255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:49:51.247492Z","caller":"traceutil/trace.go:171","msg":"trace[1015730941] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"679.93067ms","start":"2026-07-23T23:49:50.567531Z","end":"2026-07-23T23:49:51.247461Z","steps":["trace[1015730941] 'process raft request' (duration: 679.043096ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:51.247522Z","caller":"traceutil/trace.go:171","msg":"trace[253207142] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"587.553323ms","start":"2026-07-23T23:49:50.659938Z","end":"2026-07-23T23:49:51.247491Z","steps":["trace[253207142] 'agreement among raft nodes before linearized reading' (duration: 587.474811ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:51.247553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.206847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-23T23:49:51.247559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.567507Z","time spent":"680.015063ms","remote":"127.0.0.1:42672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:49:51.247607Z","caller":"traceutil/trace.go:171","msg":"trace[1476304381] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"386.31014ms","start":"2026-07-23T23:49:50.861287Z","end":"2026-07-23T23:49:51.247597Z","steps":["trace[1476304381] 'agreement among raft nodes before linearized reading' (duration: 386.157066ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:51.247632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.86126Z","time spent":"386.364971ms","remote":"127.0.0.1:42386","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-07-23T23:49:51.247659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.659914Z","time spent":"587.724587ms","remote":"127.0.0.1:42070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-23T23:49:51.248184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.922571ms","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-07-23T23:49:51.248239Z","caller":"traceutil/trace.go:171","msg":"trace[1460175009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"389.003873ms","start":"2026-07-23T23:49:50.859207Z","end":"2026-07-23T23:49:51.248211Z","steps":["trace[1460175009] 'agreement among raft nodes before linearized reading' (duration: 388.853489ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:51.248277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.859189Z","time spent":"389.077594ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-23T23:49:51.246986Z","caller":"traceutil/trace.go:171","msg":"trace[560149022] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:515; }","duration":"703.609841ms","start":"2026-07-23T23:49:50.543364Z","end":"2026-07-23T23:49:51.246973Z","steps":["trace[560149022] 'agreement among raft nodes before linearized reading' (duration: 703.428996ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:51.248354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:50.54335Z","time spent":"704.981878ms","remote":"127.0.0.1:42096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"info","ts":"2026-07-23T23:49:58.372207Z","caller":"traceutil/trace.go:171","msg":"trace[1145406322] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"394.058339ms","start":"2026-07-23T23:49:57.978113Z","end":"2026-07-23T23:49:58.372171Z","steps":["trace[1145406322] 'process raft request' (duration: 393.453983ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:58.372383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:57.97807Z","time spent":"394.222973ms","remote":"127.0.0.1:42166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:49:59.161256Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104619501629218,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T23:49:59.472688Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.039874848s","expected-duration":"1s"} {"level":"info","ts":"2026-07-23T23:49:59.473087Z","caller":"traceutil/trace.go:171","msg":"trace[240487825] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"811.87546ms","start":"2026-07-23T23:49:58.661189Z","end":"2026-07-23T23:49:59.473064Z","steps":["trace[240487825] 'read index received' (duration: 811.635314ms)","trace[240487825] 'applied index is now lower than readState.Index' (duration: 238.976µs)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:49:59.473364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.158128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:49:59.473445Z","caller":"traceutil/trace.go:171","msg":"trace[310758867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"812.298362ms","start":"2026-07-23T23:49:58.661122Z","end":"2026-07-23T23:49:59.473421Z","steps":["trace[310758867] 'agreement among raft nodes before linearized reading' (duration: 812.071836ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:59.473463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.212499ms","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-07-23T23:49:59.473425Z","caller":"traceutil/trace.go:171","msg":"trace[187094344] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"1.04070429s","start":"2026-07-23T23:49:58.432681Z","end":"2026-07-23T23:49:59.473385Z","steps":["trace[187094344] 'process raft request' (duration: 1.040229557s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:59.473491Z","caller":"traceutil/trace.go:171","msg":"trace[577695148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"148.24923ms","start":"2026-07-23T23:49:59.325231Z","end":"2026-07-23T23:49:59.47348Z","steps":["trace[577695148] 'agreement among raft nodes before linearized reading' (duration: 148.125357ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:59.473489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:58.661095Z","time spent":"812.384644ms","remote":"127.0.0.1:42070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-23T23:49:59.47353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.941745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-23T23:49:59.473589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:58.432653Z","time spent":"1.040868074s","remote":"127.0.0.1:42350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:49:59.4736Z","caller":"traceutil/trace.go:171","msg":"trace[1509436289] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"150.069669ms","start":"2026-07-23T23:49:59.323508Z","end":"2026-07-23T23:49:59.473578Z","steps":["trace[1509436289] 'agreement among raft nodes before linearized reading' (duration: 149.72654ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:49:59.473591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.985956ms","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-07-23T23:49:59.473714Z","caller":"traceutil/trace.go:171","msg":"trace[856596424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"147.126029ms","start":"2026-07-23T23:49:59.326546Z","end":"2026-07-23T23:49:59.473672Z","steps":["trace[856596424] 'agreement among raft nodes before linearized reading' (duration: 146.804081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:00.77196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.249827067s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:50:00.772296Z","caller":"traceutil/trace.go:171","msg":"trace[75281259] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:640; }","duration":"1.291778521s","start":"2026-07-23T23:49:59.480461Z","end":"2026-07-23T23:50:00.77224Z","steps":["trace[75281259] 'read index received' (duration: 41.489022ms)","trace[75281259] 'applied index is now lower than readState.Index' (duration: 1.250288429s)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:50:00.772271Z","caller":"traceutil/trace.go:171","msg":"trace[1460236187] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"1.293523488s","start":"2026-07-23T23:49:59.478714Z","end":"2026-07-23T23:50:00.772238Z","steps":["trace[1460236187] 'process raft request' (duration: 43.28074ms)","trace[1460236187] 'compare' (duration: 1.249173259s)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:50:00.772398Z","caller":"traceutil/trace.go:171","msg":"trace[1803676139] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"1.293455176s","start":"2026-07-23T23:49:59.478932Z","end":"2026-07-23T23:50:00.772387Z","steps":["trace[1803676139] 'process raft request' (duration: 1.293170999s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:00.772448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:59.478918Z","time spent":"1.293505548s","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:50:00.772465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:59.478679Z","time spent":"1.293670632s","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:50:00.772558Z","caller":"traceutil/trace.go:171","msg":"trace[465715267] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"1.29319333s","start":"2026-07-23T23:49:59.479334Z","end":"2026-07-23T23:50:00.772527Z","steps":["trace[465715267] 'process raft request' (duration: 1.292868481s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:00.772591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.29210403s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-07-23T23:50:00.772646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.165204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:00.772692Z","caller":"traceutil/trace.go:171","msg":"trace[338319521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"112.217385ms","start":"2026-07-23T23:50:00.66046Z","end":"2026-07-23T23:50:00.772677Z","steps":["trace[338319521] 'agreement among raft nodes before linearized reading' (duration: 112.139903ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:00.772697Z","caller":"traceutil/trace.go:171","msg":"trace[1723334284] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:619; }","duration":"1.292218603s","start":"2026-07-23T23:49:59.480448Z","end":"2026-07-23T23:50:00.772667Z","steps":["trace[1723334284] 'agreement among raft nodes before linearized reading' (duration: 1.292058669s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:00.772714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.217962735s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-23T23:50:00.772726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:59.479324Z","time spent":"1.293298303s","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:50:00.772744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:59.480439Z","time spent":"1.292296436s","remote":"127.0.0.1:42308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"info","ts":"2026-07-23T23:50:00.772775Z","caller":"traceutil/trace.go:171","msg":"trace[597137451] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:619; }","duration":"1.218060547s","start":"2026-07-23T23:49:59.554693Z","end":"2026-07-23T23:50:00.772754Z","steps":["trace[597137451] 'agreement among raft nodes before linearized reading' (duration: 1.217830961s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:00.772814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:49:59.554669Z","time spent":"1.21813691s","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-23T23:50:00.772918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.725846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-23T23:50:00.77295Z","caller":"traceutil/trace.go:171","msg":"trace[1886840818] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:619; }","duration":"228.755427ms","start":"2026-07-23T23:50:00.544182Z","end":"2026-07-23T23:50:00.772937Z","steps":["trace[1886840818] 'agreement among raft nodes before linearized reading' (duration: 228.604353ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:01.392269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.057458ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-07-23T23:50:01.392575Z","caller":"traceutil/trace.go:171","msg":"trace[2113760005] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:643; }","duration":"610.890483ms","start":"2026-07-23T23:50:00.781662Z","end":"2026-07-23T23:50:01.392553Z","steps":["trace[2113760005] 'read index received' (duration: 409.514847ms)","trace[2113760005] 'applied index is now lower than readState.Index' (duration: 201.374426ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:50:01.392679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.005156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:01.39271Z","caller":"traceutil/trace.go:171","msg":"trace[1217039300] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:620; }","duration":"611.069778ms","start":"2026-07-23T23:50:00.781628Z","end":"2026-07-23T23:50:01.392698Z","steps":["trace[1217039300] 'agreement among raft nodes before linearized reading' (duration: 610.988416ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:01.392746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:00.781618Z","time spent":"611.118169ms","remote":"127.0.0.1:42216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"info","ts":"2026-07-23T23:50:01.392815Z","caller":"traceutil/trace.go:171","msg":"trace[1199301968] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"615.610371ms","start":"2026-07-23T23:50:00.777154Z","end":"2026-07-23T23:50:01.392765Z","steps":["trace[1199301968] 'process raft request' (duration: 615.260921ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:01.392902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:00.774643Z","time spent":"618.248162ms","remote":"127.0.0.1:42096","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-23T23:50:01.393047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:00.77713Z","time spent":"615.774475ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:50:03.186012Z","caller":"traceutil/trace.go:171","msg":"trace[544031317] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"447.249267ms","start":"2026-07-23T23:50:02.738728Z","end":"2026-07-23T23:50:03.185977Z","steps":["trace[544031317] 'read index received' (duration: 447.210356ms)","trace[544031317] 'applied index is now lower than readState.Index' (duration: 37.481µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:50:03.186092Z","caller":"traceutil/trace.go:171","msg":"trace[1297336419] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"448.754328ms","start":"2026-07-23T23:50:02.737303Z","end":"2026-07-23T23:50:03.186057Z","steps":["trace[1297336419] 'process raft request' (duration: 448.499802ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:03.186438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.67342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:03.186531Z","caller":"traceutil/trace.go:171","msg":"trace[631303945] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:640; }","duration":"447.814263ms","start":"2026-07-23T23:50:02.738697Z","end":"2026-07-23T23:50:03.186511Z","steps":["trace[631303945] 'agreement among raft nodes before linearized reading' (duration: 447.632138ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:03.186573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:02.738687Z","time spent":"447.878725ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"warn","ts":"2026-07-23T23:50:03.186917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:02.737289Z","time spent":"449.522509ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:50:03.193223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.469008ms","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-07-23T23:50:03.194311Z","caller":"traceutil/trace.go:171","msg":"trace[2006432026] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:643; }","duration":"416.592828ms","start":"2026-07-23T23:50:02.777699Z","end":"2026-07-23T23:50:03.194292Z","steps":["trace[2006432026] 'agreement among raft nodes before linearized reading' (duration: 415.346205ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:03.19495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:02.777688Z","time spent":"416.761414ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-23T23:50:03.193429Z","caller":"traceutil/trace.go:171","msg":"trace[756677335] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"251.282076ms","start":"2026-07-23T23:50:02.942127Z","end":"2026-07-23T23:50:03.193409Z","steps":["trace[756677335] 'process raft request' (duration: 250.811844ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:03.1936Z","caller":"traceutil/trace.go:171","msg":"trace[2097825952] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"452.617053ms","start":"2026-07-23T23:50:02.740973Z","end":"2026-07-23T23:50:03.19359Z","steps":["trace[2097825952] 'process raft request' (duration: 451.816682ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:03.195473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:02.74096Z","time spent":"454.441662ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:50:03.193926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.957741ms","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-07-23T23:50:03.195595Z","caller":"traceutil/trace.go:171","msg":"trace[1558237786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:643; }","duration":"417.674388ms","start":"2026-07-23T23:50:02.777903Z","end":"2026-07-23T23:50:03.195577Z","steps":["trace[1558237786] 'agreement among raft nodes before linearized reading' (duration: 415.89172ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:03.195632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:02.777877Z","time spent":"417.74421ms","remote":"127.0.0.1:42386","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-07-23T23:50:03.194206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.303951ms","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-07-23T23:50:03.199288Z","caller":"traceutil/trace.go:171","msg":"trace[531614079] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:643; }","duration":"421.417839ms","start":"2026-07-23T23:50:02.777847Z","end":"2026-07-23T23:50:03.199264Z","steps":["trace[531614079] 'agreement among raft nodes before linearized reading' (duration: 416.28395ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:03.199341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:02.777818Z","time spent":"421.511342ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-23T23:50:13.584083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.196977ms","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-07-23T23:50:13.584196Z","caller":"traceutil/trace.go:171","msg":"trace[1410162370] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:762; }","duration":"135.389683ms","start":"2026-07-23T23:50:13.448783Z","end":"2026-07-23T23:50:13.584173Z","steps":["trace[1410162370] 'range keys from in-memory index tree' (duration: 134.963711ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:13.590167Z","caller":"traceutil/trace.go:171","msg":"trace[303279008] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"120.655044ms","start":"2026-07-23T23:50:13.469482Z","end":"2026-07-23T23:50:13.590137Z","steps":["trace[303279008] 'process raft request' (duration: 120.477349ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.175122Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104619501629531,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T23:50:16.637398Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.03299834s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-23T23:50:16.89688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.594554ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:50:16.897072Z","caller":"traceutil/trace.go:171","msg":"trace[272145948] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"1.292802788s","start":"2026-07-23T23:50:15.604234Z","end":"2026-07-23T23:50:16.897037Z","steps":["trace[272145948] 'process raft request' (duration: 1.033937556s)","trace[272145948] 'compare' (duration: 258.477921ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:50:16.897153Z","caller":"traceutil/trace.go:171","msg":"trace[1612303743] linearizableReadLoop","detail":"{readStateIndex:808; appliedIndex:807; }","duration":"1.222647201s","start":"2026-07-23T23:50:15.674467Z","end":"2026-07-23T23:50:16.897114Z","steps":["trace[1612303743] 'read index received' (duration: 963.421309ms)","trace[1612303743] 'applied index is now lower than readState.Index' (duration: 259.222442ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:50:16.897637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:15.604194Z","time spent":"1.293089665s","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:50:16.904025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.084101ms","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-07-23T23:50:16.904124Z","caller":"traceutil/trace.go:171","msg":"trace[801860789] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:778; }","duration":"112.273627ms","start":"2026-07-23T23:50:16.791802Z","end":"2026-07-23T23:50:16.904076Z","steps":["trace[801860789] 'agreement among raft nodes before linearized reading' (duration: 112.140634ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.904091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.805019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:16.904219Z","caller":"traceutil/trace.go:171","msg":"trace[1613079798] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:778; }","duration":"385.026894ms","start":"2026-07-23T23:50:16.519171Z","end":"2026-07-23T23:50:16.904198Z","steps":["trace[1613079798] 'agreement among raft nodes before linearized reading' (duration: 384.748967ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.904108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.522866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:50:16.904627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.200189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:50:16.904701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.665482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:50:16.904757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.142193ms","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-07-23T23:50:16.904787Z","caller":"traceutil/trace.go:171","msg":"trace[71047729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:778; }","duration":"246.750964ms","start":"2026-07-23T23:50:16.658024Z","end":"2026-07-23T23:50:16.904775Z","steps":["trace[71047729] 'agreement among raft nodes before linearized reading' (duration: 246.59943ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:16.904838Z","caller":"traceutil/trace.go:171","msg":"trace[13558625] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:778; }","duration":"112.237156ms","start":"2026-07-23T23:50:16.792575Z","end":"2026-07-23T23:50:16.904786Z","steps":["trace[13558625] 'agreement among raft nodes before linearized reading' (duration: 112.124793ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.904831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.017067ms","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-07-23T23:50:16.904903Z","caller":"traceutil/trace.go:171","msg":"trace[225002468] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:778; }","duration":"865.10042ms","start":"2026-07-23T23:50:16.039791Z","end":"2026-07-23T23:50:16.904891Z","steps":["trace[225002468] 'agreement among raft nodes before linearized reading' (duration: 865.014448ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.905003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.034647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:50:16.905033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.041832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:50:16.904965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.195719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:16.90505Z","caller":"traceutil/trace.go:171","msg":"trace[1579217339] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:778; }","duration":"113.099289ms","start":"2026-07-23T23:50:16.791943Z","end":"2026-07-23T23:50:16.905043Z","steps":["trace[1579217339] 'agreement among raft nodes before linearized reading' (duration: 113.036618ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:16.905085Z","caller":"traceutil/trace.go:171","msg":"trace[350951096] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:778; }","duration":"419.393394ms","start":"2026-07-23T23:50:16.48568Z","end":"2026-07-23T23:50:16.905073Z","steps":["trace[350951096] 'agreement among raft nodes before linearized reading' (duration: 418.922821ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:16.905092Z","caller":"traceutil/trace.go:171","msg":"trace[379055844] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:778; }","duration":"420.153235ms","start":"2026-07-23T23:50:16.484912Z","end":"2026-07-23T23:50:16.905065Z","steps":["trace[379055844] 'agreement among raft nodes before linearized reading' (duration: 420.090993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.905127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.485623Z","time spent":"419.492816ms","remote":"127.0.0.1:44498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-23T23:50:16.905146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.484885Z","time spent":"420.250547ms","remote":"127.0.0.1:44498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:50:16.903895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.069673703s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:16.905211Z","caller":"traceutil/trace.go:171","msg":"trace[998841136] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:778; }","duration":"1.071077022s","start":"2026-07-23T23:50:15.834126Z","end":"2026-07-23T23:50:16.905203Z","steps":["trace[998841136] 'agreement among raft nodes before linearized reading' (duration: 1.069674324s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.904296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.519146Z","time spent":"385.138618ms","remote":"127.0.0.1:44502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:50:16.905304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.268424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:16.905344Z","caller":"traceutil/trace.go:171","msg":"trace[1041165963] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:778; }","duration":"479.318975ms","start":"2026-07-23T23:50:16.426013Z","end":"2026-07-23T23:50:16.905332Z","steps":["trace[1041165963] 'agreement among raft nodes before linearized reading' (duration: 479.269834ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.905382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.426009Z","time spent":"479.365116ms","remote":"127.0.0.1:44480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-07-23T23:50:16.905427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.116868ms","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-07-23T23:50:16.905467Z","caller":"traceutil/trace.go:171","msg":"trace[1366719860] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:778; }","duration":"866.169619ms","start":"2026-07-23T23:50:16.039287Z","end":"2026-07-23T23:50:16.905457Z","steps":["trace[1366719860] 'agreement among raft nodes before linearized reading' (duration: 866.115027ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.905507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.039278Z","time spent":"866.220251ms","remote":"127.0.0.1:44452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:50:16.905552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.740811ms","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":"warn","ts":"2026-07-23T23:50:16.905577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.639374ms","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-07-23T23:50:16.905593Z","caller":"traceutil/trace.go:171","msg":"trace[430212940] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:778; }","duration":"891.783132ms","start":"2026-07-23T23:50:16.013795Z","end":"2026-07-23T23:50:16.905578Z","steps":["trace[430212940] 'agreement among raft nodes before linearized reading' (duration: 891.739521ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.905618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.013789Z","time spent":"891.822713ms","remote":"127.0.0.1:44436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:50:16.905678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.876174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:50:16.90569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.070783434s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:50:16.905686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.048954193s","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":"info","ts":"2026-07-23T23:50:16.905726Z","caller":"traceutil/trace.go:171","msg":"trace[1614510025] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:778; }","duration":"1.070875276s","start":"2026-07-23T23:50:15.834841Z","end":"2026-07-23T23:50:16.905716Z","steps":["trace[1614510025] 'agreement among raft nodes before linearized reading' (duration: 1.070818254s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:16.905734Z","caller":"traceutil/trace.go:171","msg":"trace[643111801] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:778; }","duration":"891.943566ms","start":"2026-07-23T23:50:16.013761Z","end":"2026-07-23T23:50:16.905704Z","steps":["trace[643111801] 'agreement among raft nodes before linearized reading' (duration: 891.871404ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.905743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.828259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:16.905756Z","caller":"traceutil/trace.go:171","msg":"trace[1893854067] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:778; }","duration":"1.049033435s","start":"2026-07-23T23:50:15.856699Z","end":"2026-07-23T23:50:16.905733Z","steps":["trace[1893854067] 'agreement among raft nodes before linearized reading' (duration: 1.048900761s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.905768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.013753Z","time spent":"892.008208ms","remote":"127.0.0.1:44436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-07-23T23:50:16.905764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.049669953s","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-07-23T23:50:16.905787Z","caller":"traceutil/trace.go:171","msg":"trace[161539348] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:778; }","duration":"479.913211ms","start":"2026-07-23T23:50:16.425864Z","end":"2026-07-23T23:50:16.905777Z","steps":["trace[161539348] 'agreement among raft nodes before linearized reading' (duration: 479.85153ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:16.905808Z","caller":"traceutil/trace.go:171","msg":"trace[1504246350] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:778; }","duration":"1.049737334s","start":"2026-07-23T23:50:15.856059Z","end":"2026-07-23T23:50:16.905796Z","steps":["trace[1504246350] 'agreement among raft nodes before linearized reading' (duration: 1.049681892s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.905804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:15.856691Z","time spent":"1.049101407s","remote":"127.0.0.1:44430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-23T23:50:16.905821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.071090832s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:50:16.905832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.425839Z","time spent":"479.981573ms","remote":"127.0.0.1:44496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-07-23T23:50:16.90586Z","caller":"traceutil/trace.go:171","msg":"trace[1820656577] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:778; }","duration":"1.071133623s","start":"2026-07-23T23:50:15.834717Z","end":"2026-07-23T23:50:16.905851Z","steps":["trace[1820656577] 'agreement among raft nodes before linearized reading' (duration: 1.071076502s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.904785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.266805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:50:16.905897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:15.834696Z","time spent":"1.071192374s","remote":"127.0.0.1:44424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-07-23T23:50:16.905938Z","caller":"traceutil/trace.go:171","msg":"trace[40346149] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:778; }","duration":"808.396635ms","start":"2026-07-23T23:50:16.097502Z","end":"2026-07-23T23:50:16.905899Z","steps":["trace[40346149] 'agreement among raft nodes before linearized reading' (duration: 807.245804ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.905467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.049456856s","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-07-23T23:50:16.905519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.795495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:50:16.906039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.097429Z","time spent":"808.595941ms","remote":"127.0.0.1:44466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-07-23T23:50:16.904715Z","caller":"traceutil/trace.go:171","msg":"trace[192097149] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:778; }","duration":"385.295862ms","start":"2026-07-23T23:50:16.519404Z","end":"2026-07-23T23:50:16.9047Z","steps":["trace[192097149] 'agreement among raft nodes before linearized reading' (duration: 385.20546ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.906066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.65296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:16.906036Z","caller":"traceutil/trace.go:171","msg":"trace[2071420256] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:778; }","duration":"1.050026702s","start":"2026-07-23T23:50:15.855996Z","end":"2026-07-23T23:50:16.906023Z","steps":["trace[2071420256] 'agreement among raft nodes before linearized reading' (duration: 1.049438086s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.906117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:15.855986Z","time spent":"1.050123654s","remote":"127.0.0.1:44430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"info","ts":"2026-07-23T23:50:16.90612Z","caller":"traceutil/trace.go:171","msg":"trace[1831988832] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:778; }","duration":"616.740002ms","start":"2026-07-23T23:50:16.289366Z","end":"2026-07-23T23:50:16.906106Z","steps":["trace[1831988832] 'agreement among raft nodes before linearized reading' (duration: 616.66659ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.906165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.289318Z","time spent":"616.830034ms","remote":"127.0.0.1:44480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-07-23T23:50:16.904399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.140145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:16.90631Z","caller":"traceutil/trace.go:171","msg":"trace[740897491] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:778; }","duration":"808.405856ms","start":"2026-07-23T23:50:16.097892Z","end":"2026-07-23T23:50:16.906298Z","steps":["trace[740897491] 'agreement among raft nodes before linearized reading' (duration: 806.113874ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.90538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.961943ms","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":"warn","ts":"2026-07-23T23:50:16.906339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.975728ms","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-07-23T23:50:16.905615Z","caller":"traceutil/trace.go:171","msg":"trace[1202602616] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:778; }","duration":"479.684555ms","start":"2026-07-23T23:50:16.425921Z","end":"2026-07-23T23:50:16.905606Z","steps":["trace[1202602616] 'agreement among raft nodes before linearized reading' (duration: 479.631123ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:16.906383Z","caller":"traceutil/trace.go:171","msg":"trace[70647855] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:778; }","duration":"617.070341ms","start":"2026-07-23T23:50:16.289302Z","end":"2026-07-23T23:50:16.906373Z","steps":["trace[70647855] 'agreement among raft nodes before linearized reading' (duration: 617.00775ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:16.906395Z","caller":"traceutil/trace.go:171","msg":"trace[1975195125] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:778; }","duration":"867.017322ms","start":"2026-07-23T23:50:16.039363Z","end":"2026-07-23T23:50:16.906381Z","steps":["trace[1975195125] 'agreement among raft nodes before linearized reading' (duration: 865.986774ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.906417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.425918Z","time spent":"480.480936ms","remote":"127.0.0.1:44496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:50:16.906486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.039336Z","time spent":"867.135015ms","remote":"127.0.0.1:44452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-07-23T23:50:16.904505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.679851ms","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":"warn","ts":"2026-07-23T23:50:16.906429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.289271Z","time spent":"617.146624ms","remote":"127.0.0.1:44480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:50:16.905831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:15.856044Z","time spent":"1.049779935s","remote":"127.0.0.1:44430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-07-23T23:50:16.906615Z","caller":"traceutil/trace.go:171","msg":"trace[137665436] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:778; }","duration":"367.766577ms","start":"2026-07-23T23:50:16.538818Z","end":"2026-07-23T23:50:16.906584Z","steps":["trace[137665436] 'agreement among raft nodes before linearized reading' (duration: 365.64405ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.906719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.822157ms","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":"warn","ts":"2026-07-23T23:50:16.906727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.538796Z","time spent":"367.918252ms","remote":"127.0.0.1:44512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"info","ts":"2026-07-23T23:50:16.906791Z","caller":"traceutil/trace.go:171","msg":"trace[602524862] 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:778; }","duration":"774.91173ms","start":"2026-07-23T23:50:16.131829Z","end":"2026-07-23T23:50:16.90674Z","steps":["trace[602524862] 'agreement among raft nodes before linearized reading' (duration: 774.867849ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.904512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.415444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:50:16.904492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.230028191s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-88z5b\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-07-23T23:50:16.906352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.097866Z","time spent":"808.474028ms","remote":"127.0.0.1:44466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-07-23T23:50:16.906894Z","caller":"traceutil/trace.go:171","msg":"trace[387080655] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-88z5b; range_end:; response_count:1; response_revision:778; }","duration":"1.232447347s","start":"2026-07-23T23:50:15.674426Z","end":"2026-07-23T23:50:16.906874Z","steps":["trace[387080655] 'agreement among raft nodes before linearized reading' (duration: 1.222772485s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.906917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.62338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:16.906969Z","caller":"traceutil/trace.go:171","msg":"trace[1179813497] 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:778; }","duration":"775.703492ms","start":"2026-07-23T23:50:16.131253Z","end":"2026-07-23T23:50:16.906956Z","steps":["trace[1179813497] 'agreement among raft nodes before linearized reading' (duration: 775.62455ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.906944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:15.674409Z","time spent":"1.232522898s","remote":"127.0.0.1:42280","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-88z5b\" "} {"level":"warn","ts":"2026-07-23T23:50:16.907023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.131237Z","time spent":"775.764943ms","remote":"127.0.0.1:44472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-07-23T23:50:16.906902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.1318Z","time spent":"775.015813ms","remote":"127.0.0.1:44472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:50:16.905771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:15.834808Z","time spent":"1.070951218s","remote":"127.0.0.1:44424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-23T23:50:16.905031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.039781Z","time spent":"865.234704ms","remote":"127.0.0.1:44452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-07-23T23:50:16.90454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.218886ms","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-07-23T23:50:16.907324Z","caller":"traceutil/trace.go:171","msg":"trace[337391637] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:778; }","duration":"369.033432ms","start":"2026-07-23T23:50:16.538275Z","end":"2026-07-23T23:50:16.907308Z","steps":["trace[337391637] 'agreement among raft nodes before linearized reading' (duration: 366.246916ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.907374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.538251Z","time spent":"369.108414ms","remote":"127.0.0.1:44512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-07-23T23:50:16.906077Z","caller":"traceutil/trace.go:171","msg":"trace[372569175] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:778; }","duration":"891.372821ms","start":"2026-07-23T23:50:16.014685Z","end":"2026-07-23T23:50:16.906058Z","steps":["trace[372569175] 'agreement among raft nodes before linearized reading' (duration: 890.809676ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.904595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.298998ms","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":"warn","ts":"2026-07-23T23:50:16.907569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.014674Z","time spent":"892.83214ms","remote":"127.0.0.1:44436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-07-23T23:50:16.904509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.302902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:16.907809Z","caller":"traceutil/trace.go:171","msg":"trace[669338111] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:778; }","duration":"388.626442ms","start":"2026-07-23T23:50:16.51917Z","end":"2026-07-23T23:50:16.907796Z","steps":["trace[669338111] 'agreement among raft nodes before linearized reading' (duration: 385.301432ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.907851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.519153Z","time spent":"388.687013ms","remote":"127.0.0.1:44502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"info","ts":"2026-07-23T23:50:16.904713Z","caller":"traceutil/trace.go:171","msg":"trace[2022999203] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:778; }","duration":"807.126922ms","start":"2026-07-23T23:50:16.097568Z","end":"2026-07-23T23:50:16.904695Z","steps":["trace[2022999203] 'agreement among raft nodes before linearized reading' (duration: 806.495195ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.907986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.097487Z","time spent":"810.480102ms","remote":"127.0.0.1:44466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:50:16.904376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.736084ms","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-07-23T23:50:16.908036Z","caller":"traceutil/trace.go:171","msg":"trace[907107809] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:778; }","duration":"301.440043ms","start":"2026-07-23T23:50:16.606587Z","end":"2026-07-23T23:50:16.908027Z","steps":["trace[907107809] 'agreement among raft nodes before linearized reading' (duration: 297.752753ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.908069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.606561Z","time spent":"301.498355ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-07-23T23:50:16.907592Z","caller":"traceutil/trace.go:171","msg":"trace[1514431593] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:778; }","duration":"369.311309ms","start":"2026-07-23T23:50:16.538269Z","end":"2026-07-23T23:50:16.907581Z","steps":["trace[1514431593] 'agreement among raft nodes before linearized reading' (duration: 366.306358ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.908205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.538253Z","time spent":"369.901916ms","remote":"127.0.0.1:44512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-07-23T23:50:16.904421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.062568ms","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-07-23T23:50:16.908276Z","caller":"traceutil/trace.go:171","msg":"trace[1997079538] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:778; }","duration":"143.923783ms","start":"2026-07-23T23:50:16.76434Z","end":"2026-07-23T23:50:16.908264Z","steps":["trace[1997079538] 'agreement among raft nodes before linearized reading' (duration: 140.057459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.905261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.473913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:16.908473Z","caller":"traceutil/trace.go:171","msg":"trace[1426650500] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:778; }","duration":"423.691191ms","start":"2026-07-23T23:50:16.484728Z","end":"2026-07-23T23:50:16.908419Z","steps":["trace[1426650500] 'agreement among raft nodes before linearized reading' (duration: 420.505384ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.90856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.484697Z","time spent":"423.850224ms","remote":"127.0.0.1:44498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-23T23:50:16.906084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.519395Z","time spent":"386.675979ms","remote":"127.0.0.1:44502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-07-23T23:50:16.904441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.919529ms","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":"warn","ts":"2026-07-23T23:50:16.90668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.744996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:16.908783Z","caller":"traceutil/trace.go:171","msg":"trace[1960709141] 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:778; }","duration":"776.868153ms","start":"2026-07-23T23:50:16.131905Z","end":"2026-07-23T23:50:16.908773Z","steps":["trace[1960709141] 'agreement among raft nodes before linearized reading' (duration: 774.723065ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.908823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.131887Z","time spent":"776.924685ms","remote":"127.0.0.1:44472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"info","ts":"2026-07-23T23:50:16.908763Z","caller":"traceutil/trace.go:171","msg":"trace[1092833658] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:778; }","duration":"302.267636ms","start":"2026-07-23T23:50:16.606486Z","end":"2026-07-23T23:50:16.908753Z","steps":["trace[1092833658] 'agreement among raft nodes before linearized reading' (duration: 297.927828ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.904548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.01786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:16.908967Z","caller":"traceutil/trace.go:171","msg":"trace[800153595] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:778; }","duration":"177.46024ms","start":"2026-07-23T23:50:16.731497Z","end":"2026-07-23T23:50:16.908957Z","steps":["trace[800153595] 'agreement among raft nodes before linearized reading' (duration: 173.02975ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.90908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.606469Z","time spent":"302.465792ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-07-23T23:50:16.904481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.203553ms","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":"warn","ts":"2026-07-23T23:50:16.904605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.130043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:16.906838Z","caller":"traceutil/trace.go:171","msg":"trace[176259325] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:778; }","duration":"174.755926ms","start":"2026-07-23T23:50:16.732067Z","end":"2026-07-23T23:50:16.906823Z","steps":["trace[176259325] 'agreement among raft nodes before linearized reading' (duration: 172.427923ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:16.909901Z","caller":"traceutil/trace.go:171","msg":"trace[1425522779] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:778; }","duration":"178.419086ms","start":"2026-07-23T23:50:16.731467Z","end":"2026-07-23T23:50:16.909886Z","steps":["trace[1425522779] 'agreement among raft nodes before linearized reading' (duration: 173.096392ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:16.909692Z","caller":"traceutil/trace.go:171","msg":"trace[141439788] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:778; }","duration":"145.423574ms","start":"2026-07-23T23:50:16.764258Z","end":"2026-07-23T23:50:16.909682Z","steps":["trace[141439788] 'agreement among raft nodes before linearized reading' (duration: 140.202283ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.905247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:15.834097Z","time spent":"1.071136682s","remote":"127.0.0.1:44424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-23T23:50:16.904345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.106686ms","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-07-23T23:50:16.910285Z","caller":"traceutil/trace.go:171","msg":"trace[1723373449] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:778; }","duration":"303.100589ms","start":"2026-07-23T23:50:16.607176Z","end":"2026-07-23T23:50:16.910276Z","steps":["trace[1723373449] 'agreement among raft nodes before linearized reading' (duration: 297.078176ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:16.910951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:16.60715Z","time spent":"303.744676ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"info","ts":"2026-07-23T23:50:52.055722Z","caller":"traceutil/trace.go:171","msg":"trace[1150451932] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"105.129394ms","start":"2026-07-23T23:50:51.950553Z","end":"2026-07-23T23:50:52.055683Z","steps":["trace[1150451932] 'process raft request' (duration: 104.972449ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:52.86806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.419749ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:50:52.868178Z","caller":"traceutil/trace.go:171","msg":"trace[777061460] linearizableReadLoop","detail":"{readStateIndex:1035; appliedIndex:1034; }","duration":"209.314422ms","start":"2026-07-23T23:50:52.658847Z","end":"2026-07-23T23:50:52.868161Z","steps":["trace[777061460] 'read index received' (duration: 64.372µs)","trace[777061460] 'applied index is now lower than readState.Index' (duration: 209.24886ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:50:52.868277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.443995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:50:52.868298Z","caller":"traceutil/trace.go:171","msg":"trace[1173171656] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:995; }","duration":"209.515028ms","start":"2026-07-23T23:50:52.658774Z","end":"2026-07-23T23:50:52.868289Z","steps":["trace[1173171656] 'agreement among raft nodes before linearized reading' (duration: 209.428416ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:52.868308Z","caller":"traceutil/trace.go:171","msg":"trace[1549356407] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"604.517472ms","start":"2026-07-23T23:50:52.263745Z","end":"2026-07-23T23:50:52.868262Z","steps":["trace[1549356407] 'process raft request' (duration: 77.792835ms)","trace[1549356407] 'compare' (duration: 525.507554ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:50:52.868771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:52.263683Z","time spent":"604.706077ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:51:18.40269Z","caller":"traceutil/trace.go:171","msg":"trace[1646493297] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"245.342347ms","start":"2026-07-23T23:51:18.15732Z","end":"2026-07-23T23:51:18.402662Z","steps":["trace[1646493297] 'process raft request' (duration: 245.144342ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:25.645908Z","caller":"traceutil/trace.go:171","msg":"trace[1705525192] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"286.851291ms","start":"2026-07-23T23:51:25.359023Z","end":"2026-07-23T23:51:25.645874Z","steps":["trace[1705525192] 'process raft request' (duration: 286.632846ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:26.055636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.462006ms","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-07-23T23:51:26.055801Z","caller":"traceutil/trace.go:171","msg":"trace[1568031021] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1102; }","duration":"250.677232ms","start":"2026-07-23T23:51:25.805098Z","end":"2026-07-23T23:51:26.055775Z","steps":["trace[1568031021] 'range keys from in-memory index tree' (duration: 250.26055ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:26.056208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.482841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-23T23:51:26.056184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.497323ms","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-07-23T23:51:26.056256Z","caller":"traceutil/trace.go:171","msg":"trace[1060954104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1102; }","duration":"252.607164ms","start":"2026-07-23T23:51:25.803636Z","end":"2026-07-23T23:51:26.056243Z","steps":["trace[1060954104] 'range keys from in-memory index tree' (duration: 252.345387ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:26.056289Z","caller":"traceutil/trace.go:171","msg":"trace[891704379] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1102; }","duration":"351.662177ms","start":"2026-07-23T23:51:25.704598Z","end":"2026-07-23T23:51:26.056261Z","steps":["trace[891704379] 'range keys from in-memory index tree' (duration: 351.278647ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:26.056422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.601546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:51:26.056463Z","caller":"traceutil/trace.go:171","msg":"trace[320129679] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1102; }","duration":"251.670759ms","start":"2026-07-23T23:51:25.804782Z","end":"2026-07-23T23:51:26.056453Z","steps":["trace[320129679] 'count revisions from in-memory index tree' (duration: 251.521704ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:26.056369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.358243ms","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-07-23T23:51:26.056624Z","caller":"traceutil/trace.go:171","msg":"trace[776818363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1102; }","duration":"281.753694ms","start":"2026-07-23T23:51:25.774786Z","end":"2026-07-23T23:51:26.056539Z","steps":["trace[776818363] 'range keys from in-memory index tree' (duration: 280.996454ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:26.056362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:25.704572Z","time spent":"351.772511ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-23T23:51:26.245109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.455466ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-23T23:51:26.261475Z","caller":"traceutil/trace.go:171","msg":"trace[91421368] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"200.03489ms","start":"2026-07-23T23:51:26.061401Z","end":"2026-07-23T23:51:26.261436Z","steps":["trace[91421368] 'process raft request' (duration: 199.67257ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:26.26152Z","caller":"traceutil/trace.go:171","msg":"trace[595190858] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"199.617368ms","start":"2026-07-23T23:51:26.061872Z","end":"2026-07-23T23:51:26.261489Z","steps":["trace[595190858] 'process raft request' (duration: 199.440693ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:26.261529Z","caller":"traceutil/trace.go:171","msg":"trace[1376811463] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"199.179877ms","start":"2026-07-23T23:51:26.062305Z","end":"2026-07-23T23:51:26.261485Z","steps":["trace[1376811463] 'process raft request' (duration: 199.117955ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:26.261546Z","caller":"traceutil/trace.go:171","msg":"trace[1500342859] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"199.262829ms","start":"2026-07-23T23:51:26.062259Z","end":"2026-07-23T23:51:26.261522Z","steps":["trace[1500342859] 'process raft request' (duration: 199.114115ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:28.495147Z","caller":"traceutil/trace.go:171","msg":"trace[90467666] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"222.875679ms","start":"2026-07-23T23:51:28.272224Z","end":"2026-07-23T23:51:28.4951Z","steps":["trace[90467666] 'process raft request' (duration: 222.609122ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:28.895125Z","caller":"traceutil/trace.go:171","msg":"trace[1458636284] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"622.599519ms","start":"2026-07-23T23:51:28.272478Z","end":"2026-07-23T23:51:28.895078Z","steps":["trace[1458636284] 'process raft request' (duration: 622.309861ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:28.89514Z","caller":"traceutil/trace.go:171","msg":"trace[2128997861] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"621.614172ms","start":"2026-07-23T23:51:28.273491Z","end":"2026-07-23T23:51:28.895106Z","steps":["trace[2128997861] 'process raft request' (duration: 621.489488ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:28.895192Z","caller":"traceutil/trace.go:171","msg":"trace[234840401] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"621.998913ms","start":"2026-07-23T23:51:28.273142Z","end":"2026-07-23T23:51:28.895141Z","steps":["trace[234840401] 'process raft request' (duration: 621.799907ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:28.895366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:28.273482Z","time spent":"621.750776ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:51:28.89542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:28.273128Z","time spent":"622.171577ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:51:28.895562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:28.272467Z","time spent":"622.757053ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:51:28.926453Z","caller":"traceutil/trace.go:171","msg":"trace[1219324849] linearizableReadLoop","detail":"{readStateIndex:1160; appliedIndex:1156; }","duration":"266.688875ms","start":"2026-07-23T23:51:28.659744Z","end":"2026-07-23T23:51:28.926433Z","steps":["trace[1219324849] 'read index received' (duration: 235.053598ms)","trace[1219324849] 'applied index is now lower than readState.Index' (duration: 31.633577ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:51:28.926616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.879121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:51:28.926705Z","caller":"traceutil/trace.go:171","msg":"trace[527019823] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1113; }","duration":"267.050185ms","start":"2026-07-23T23:51:28.659641Z","end":"2026-07-23T23:51:28.926692Z","steps":["trace[527019823] 'agreement among raft nodes before linearized reading' (duration: 266.86045ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:28.926856Z","caller":"traceutil/trace.go:171","msg":"trace[1482763290] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"408.885179ms","start":"2026-07-23T23:51:28.517785Z","end":"2026-07-23T23:51:28.92667Z","steps":["trace[1482763290] 'process raft request' (duration: 408.469658ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:28.927378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:28.517754Z","time spent":"409.397783ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:51:43.651903Z","caller":"traceutil/trace.go:171","msg":"trace[492485084] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"100.826882ms","start":"2026-07-23T23:51:43.551049Z","end":"2026-07-23T23:51:43.651876Z","steps":["trace[492485084] 'process raft request' (duration: 100.626207ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:45.089152Z","caller":"traceutil/trace.go:171","msg":"trace[1052805523] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"489.902524ms","start":"2026-07-23T23:51:44.599226Z","end":"2026-07-23T23:51:45.089128Z","steps":["trace[1052805523] 'process raft request' (duration: 489.73537ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:45.089318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:44.599206Z","time spent":"490.025358ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:51:46.004445Z","caller":"traceutil/trace.go:171","msg":"trace[1523877247] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"939.69485ms","start":"2026-07-23T23:51:45.064691Z","end":"2026-07-23T23:51:46.004386Z","steps":["trace[1523877247] 'process raft request' (duration: 939.397602ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:46.004635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:45.064664Z","time spent":"939.867215ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:51:46.004689Z","caller":"traceutil/trace.go:171","msg":"trace[1928870136] linearizableReadLoop","detail":"{readStateIndex:1266; appliedIndex:1264; }","duration":"933.931474ms","start":"2026-07-23T23:51:45.070709Z","end":"2026-07-23T23:51:46.00464Z","steps":["trace[1928870136] 'read index received' (duration: 18.340737ms)","trace[1928870136] 'applied index is now lower than readState.Index' (duration: 915.588207ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:51:46.004782Z","caller":"traceutil/trace.go:171","msg":"trace[2063596754] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"928.040784ms","start":"2026-07-23T23:51:45.07668Z","end":"2026-07-23T23:51:46.004721Z","steps":["trace[2063596754] 'process raft request' (duration: 927.616653ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:46.00489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"934.1759ms","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-07-23T23:51:46.004958Z","caller":"traceutil/trace.go:171","msg":"trace[1689009704] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1215; }","duration":"934.258743ms","start":"2026-07-23T23:51:45.070667Z","end":"2026-07-23T23:51:46.004925Z","steps":["trace[1689009704] 'agreement among raft nodes before linearized reading' (duration: 934.093918ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:46.004987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:45.070638Z","time spent":"934.342775ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-23T23:51:46.004959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.267068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:51:46.00505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:45.076649Z","time spent":"928.26756ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:51:46.005071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"930.634565ms","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-07-23T23:51:46.00508Z","caller":"traceutil/trace.go:171","msg":"trace[992730995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1215; }","duration":"344.455543ms","start":"2026-07-23T23:51:45.660593Z","end":"2026-07-23T23:51:46.005049Z","steps":["trace[992730995] 'agreement among raft nodes before linearized reading' (duration: 344.260678ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:46.005122Z","caller":"traceutil/trace.go:171","msg":"trace[2097427540] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1215; }","duration":"930.736118ms","start":"2026-07-23T23:51:45.074373Z","end":"2026-07-23T23:51:46.005109Z","steps":["trace[2097427540] 'agreement among raft nodes before linearized reading' (duration: 930.46947ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:46.005152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:45.660567Z","time spent":"344.571047ms","remote":"127.0.0.1:42070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-23T23:51:46.005182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:45.074362Z","time spent":"930.792629ms","remote":"127.0.0.1:42386","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-07-23T23:51:46.00519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.540067ms","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-07-23T23:51:46.005293Z","caller":"traceutil/trace.go:171","msg":"trace[183793458] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1215; }","duration":"209.695472ms","start":"2026-07-23T23:51:45.79557Z","end":"2026-07-23T23:51:46.005265Z","steps":["trace[183793458] 'agreement among raft nodes before linearized reading' (duration: 209.402964ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:46.005319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.715488ms","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-07-23T23:51:46.005415Z","caller":"traceutil/trace.go:171","msg":"trace[677683465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1215; }","duration":"926.876172ms","start":"2026-07-23T23:51:45.078514Z","end":"2026-07-23T23:51:46.00539Z","steps":["trace[677683465] 'agreement among raft nodes before linearized reading' (duration: 926.557424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:46.005478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:45.078487Z","time spent":"926.981835ms","remote":"127.0.0.1:42386","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-07-23T23:51:46.005702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"767.985169ms","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-07-23T23:51:46.005785Z","caller":"traceutil/trace.go:171","msg":"trace[786349708] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1215; }","duration":"768.116773ms","start":"2026-07-23T23:51:45.237654Z","end":"2026-07-23T23:51:46.005771Z","steps":["trace[786349708] 'agreement among raft nodes before linearized reading' (duration: 767.954348ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:46.005857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:45.237629Z","time spent":"768.218425ms","remote":"127.0.0.1:44942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:51:58.565129Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104619501630654,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-23T23:51:59.005508Z","caller":"traceutil/trace.go:171","msg":"trace[997231436] linearizableReadLoop","detail":"{readStateIndex:1309; appliedIndex:1308; }","duration":"940.877859ms","start":"2026-07-23T23:51:58.064601Z","end":"2026-07-23T23:51:59.005478Z","steps":["trace[997231436] 'read index received' (duration: 940.539609ms)","trace[997231436] 'applied index is now lower than readState.Index' (duration: 336.89µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:51:59.005611Z","caller":"traceutil/trace.go:171","msg":"trace[1309793138] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"958.439874ms","start":"2026-07-23T23:51:58.047126Z","end":"2026-07-23T23:51:59.005566Z","steps":["trace[1309793138] 'process raft request' (duration: 958.103335ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:59.005782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.143075ms","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-07-23T23:51:59.005896Z","caller":"traceutil/trace.go:171","msg":"trace[335446066] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1254; }","duration":"941.32429ms","start":"2026-07-23T23:51:58.064547Z","end":"2026-07-23T23:51:59.005872Z","steps":["trace[335446066] 'agreement among raft nodes before linearized reading' (duration: 941.098474ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:59.005959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:58.064537Z","time spent":"941.409643ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:51:59.005968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.118273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-23T23:51:59.006022Z","caller":"traceutil/trace.go:171","msg":"trace[239103644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1254; }","duration":"928.183355ms","start":"2026-07-23T23:51:58.077824Z","end":"2026-07-23T23:51:59.006007Z","steps":["trace[239103644] 'agreement among raft nodes before linearized reading' (duration: 927.98634ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:59.006085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:58.077806Z","time spent":"928.258747ms","remote":"127.0.0.1:42386","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-07-23T23:51:59.006349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.113587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:51:59.00639Z","caller":"traceutil/trace.go:171","msg":"trace[1752230058] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1254; }","duration":"346.19373ms","start":"2026-07-23T23:51:58.660184Z","end":"2026-07-23T23:51:59.006377Z","steps":["trace[1752230058] 'agreement among raft nodes before linearized reading' (duration: 346.135609ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:59.006419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:58.660159Z","time spent":"346.252661ms","remote":"127.0.0.1:42070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-23T23:51:59.006086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:58.047098Z","time spent":"958.746613ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:51:59.006537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.714044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-23T23:51:59.00653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.204464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-23T23:51:59.006582Z","caller":"traceutil/trace.go:171","msg":"trace[2009673065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1254; }","duration":"923.797716ms","start":"2026-07-23T23:51:58.082769Z","end":"2026-07-23T23:51:59.006567Z","steps":["trace[2009673065] 'agreement among raft nodes before linearized reading' (duration: 923.614161ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:59.006652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:58.082737Z","time spent":"923.903539ms","remote":"127.0.0.1:42386","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-07-23T23:51:59.006673Z","caller":"traceutil/trace.go:171","msg":"trace[398298192] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1254; }","duration":"846.357778ms","start":"2026-07-23T23:51:58.160268Z","end":"2026-07-23T23:51:59.006626Z","steps":["trace[398298192] 'agreement among raft nodes before linearized reading' (duration: 846.203674ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:59.006785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:58.160248Z","time spent":"846.521453ms","remote":"127.0.0.1:44970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:51:59.006777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.665019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-07-23T23:51:59.006809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"925.940005ms","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-07-23T23:51:59.006892Z","caller":"traceutil/trace.go:171","msg":"trace[1909617902] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1254; }","duration":"921.816573ms","start":"2026-07-23T23:51:58.085052Z","end":"2026-07-23T23:51:59.006868Z","steps":["trace[1909617902] 'agreement among raft nodes before linearized reading' (duration: 921.447503ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:59.00691Z","caller":"traceutil/trace.go:171","msg":"trace[772563980] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1254; }","duration":"926.049447ms","start":"2026-07-23T23:51:58.080827Z","end":"2026-07-23T23:51:59.006876Z","steps":["trace[772563980] 'agreement among raft nodes before linearized reading' (duration: 925.916943ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:59.006945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:58.080822Z","time spent":"926.11517ms","remote":"127.0.0.1:42386","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-07-23T23:51:59.00696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:58.085045Z","time spent":"921.899155ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-23T23:51:59.302514Z","caller":"traceutil/trace.go:171","msg":"trace[316969642] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"288.590234ms","start":"2026-07-23T23:51:59.013889Z","end":"2026-07-23T23:51:59.302479Z","steps":["trace[316969642] 'process raft request' (duration: 284.905033ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:59.302858Z","caller":"traceutil/trace.go:171","msg":"trace[1276622320] linearizableReadLoop","detail":"{readStateIndex:1313; appliedIndex:1309; }","duration":"112.472397ms","start":"2026-07-23T23:51:59.190355Z","end":"2026-07-23T23:51:59.302828Z","steps":["trace[1276622320] 'read index received' (duration: 108.58044ms)","trace[1276622320] 'applied index is now lower than readState.Index' (duration: 3.890576ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:51:59.302977Z","caller":"traceutil/trace.go:171","msg":"trace[26688976] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"288.887153ms","start":"2026-07-23T23:51:59.014062Z","end":"2026-07-23T23:51:59.30295Z","steps":["trace[26688976] 'process raft request' (duration: 288.661827ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:59.303096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.728454ms","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-07-23T23:51:59.303136Z","caller":"traceutil/trace.go:171","msg":"trace[1064771059] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1258; }","duration":"112.830227ms","start":"2026-07-23T23:51:59.190293Z","end":"2026-07-23T23:51:59.303123Z","steps":["trace[1064771059] 'agreement among raft nodes before linearized reading' (duration: 112.644332ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:59.303157Z","caller":"traceutil/trace.go:171","msg":"trace[237797410] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"289.189071ms","start":"2026-07-23T23:51:59.013955Z","end":"2026-07-23T23:51:59.303144Z","steps":["trace[237797410] 'process raft request' (duration: 288.42383ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:59.303228Z","caller":"traceutil/trace.go:171","msg":"trace[1068779473] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"289.096788ms","start":"2026-07-23T23:51:59.014111Z","end":"2026-07-23T23:51:59.303208Z","steps":["trace[1068779473] 'process raft request' (duration: 288.673126ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:00.687643Z","caller":"traceutil/trace.go:171","msg":"trace[1678545264] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"111.468679ms","start":"2026-07-23T23:52:00.576143Z","end":"2026-07-23T23:52:00.687612Z","steps":["trace[1678545264] 'process raft request' (duration: 111.071199ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:01.864828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.501301ms","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-07-23T23:52:01.864859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.404392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-23T23:52:01.864881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.155626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-23T23:52:01.864931Z","caller":"traceutil/trace.go:171","msg":"trace[2062453008] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1262; }","duration":"549.673056ms","start":"2026-07-23T23:52:01.315233Z","end":"2026-07-23T23:52:01.864906Z","steps":["trace[2062453008] 'range keys from in-memory index tree' (duration: 549.209833ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:01.864955Z","caller":"traceutil/trace.go:171","msg":"trace[575090672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1262; }","duration":"555.574138ms","start":"2026-07-23T23:52:01.309358Z","end":"2026-07-23T23:52:01.864932Z","steps":["trace[575090672] 'range keys from in-memory index tree' (duration: 555.122395ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:01.864974Z","caller":"traceutil/trace.go:171","msg":"trace[1865345616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1262; }","duration":"555.32268ms","start":"2026-07-23T23:52:01.309631Z","end":"2026-07-23T23:52:01.864954Z","steps":["trace[1865345616] 'range keys from in-memory index tree' (duration: 554.961051ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:01.864991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:01.315206Z","time spent":"549.775659ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-23T23:52:01.864967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.533389ms","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-07-23T23:52:01.865022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:01.309605Z","time spent":"555.408453ms","remote":"127.0.0.1:42386","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-07-23T23:52:01.865019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:01.309338Z","time spent":"555.66718ms","remote":"127.0.0.1:42386","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-07-23T23:52:01.865071Z","caller":"traceutil/trace.go:171","msg":"trace[1593062425] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1262; }","duration":"554.675433ms","start":"2026-07-23T23:52:01.310371Z","end":"2026-07-23T23:52:01.865047Z","steps":["trace[1593062425] 'range keys from in-memory index tree' (duration: 554.320153ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:01.8651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.106459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-07-23T23:52:01.865139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:01.310357Z","time spent":"554.764775ms","remote":"127.0.0.1:42386","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-07-23T23:52:01.865149Z","caller":"traceutil/trace.go:171","msg":"trace[1033489163] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1262; }","duration":"557.212372ms","start":"2026-07-23T23:52:01.307924Z","end":"2026-07-23T23:52:01.865136Z","steps":["trace[1033489163] 'range keys from in-memory index tree' (duration: 556.941145ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:01.865181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:01.30789Z","time spent":"557.283244ms","remote":"127.0.0.1:42386","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-07-23T23:52:01.86531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.788299ms","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-07-23T23:52:01.86534Z","caller":"traceutil/trace.go:171","msg":"trace[201894395] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1262; }","duration":"171.880371ms","start":"2026-07-23T23:52:01.693448Z","end":"2026-07-23T23:52:01.865328Z","steps":["trace[201894395] 'count revisions from in-memory index tree' (duration: 171.649935ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:02.018109Z","caller":"traceutil/trace.go:171","msg":"trace[1026322170] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"147.014852ms","start":"2026-07-23T23:52:01.87106Z","end":"2026-07-23T23:52:02.018075Z","steps":["trace[1026322170] 'process raft request' (duration: 146.417655ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:02.551922Z","caller":"traceutil/trace.go:171","msg":"trace[1518070204] linearizableReadLoop","detail":"{readStateIndex:1323; appliedIndex:1319; }","duration":"169.233579ms","start":"2026-07-23T23:52:02.382658Z","end":"2026-07-23T23:52:02.551891Z","steps":["trace[1518070204] 'read index received' (duration: 165.309752ms)","trace[1518070204] 'applied index is now lower than readState.Index' (duration: 3.922787ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:52:02.551979Z","caller":"traceutil/trace.go:171","msg":"trace[807065241] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"680.883026ms","start":"2026-07-23T23:52:01.871071Z","end":"2026-07-23T23:52:02.551954Z","steps":["trace[807065241] 'process raft request' (duration: 676.906297ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:02.552073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.379803ms","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":"warn","ts":"2026-07-23T23:52:02.552111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:01.871055Z","time spent":"680.980398ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:52:02.552129Z","caller":"traceutil/trace.go:171","msg":"trace[1799240870] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1267; }","duration":"169.498687ms","start":"2026-07-23T23:52:02.382608Z","end":"2026-07-23T23:52:02.552107Z","steps":["trace[1799240870] 'agreement among raft nodes before linearized reading' (duration: 169.395554ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:02.552396Z","caller":"traceutil/trace.go:171","msg":"trace[49028466] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"680.504095ms","start":"2026-07-23T23:52:01.871878Z","end":"2026-07-23T23:52:02.552382Z","steps":["trace[49028466] 'process raft request' (duration: 679.776655ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:02.552661Z","caller":"traceutil/trace.go:171","msg":"trace[1400837707] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"679.2377ms","start":"2026-07-23T23:52:01.873414Z","end":"2026-07-23T23:52:02.552652Z","steps":["trace[1400837707] 'process raft request' (duration: 678.432678ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:02.552717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:01.873405Z","time spent":"679.283612ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:52:02.552819Z","caller":"traceutil/trace.go:171","msg":"trace[1977158152] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"679.508278ms","start":"2026-07-23T23:52:01.873272Z","end":"2026-07-23T23:52:02.552781Z","steps":["trace[1977158152] 'process raft request' (duration: 678.537121ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:02.553043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:01.873259Z","time spent":"679.661502ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:52:02.554004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:01.871863Z","time spent":"680.571407ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:52:03.149314Z","caller":"traceutil/trace.go:171","msg":"trace[1316253659] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"110.708908ms","start":"2026-07-23T23:52:03.038544Z","end":"2026-07-23T23:52:03.149253Z","steps":["trace[1316253659] 'process raft request' (duration: 24.044117ms)","trace[1316253659] 'compare' (duration: 86.27039ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:52:03.715762Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104619501630695,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T23:52:04.556588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.236213ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:52:04.556715Z","caller":"traceutil/trace.go:171","msg":"trace[987742218] linearizableReadLoop","detail":"{readStateIndex:1326; appliedIndex:1325; }","duration":"1.341907318s","start":"2026-07-23T23:52:03.214783Z","end":"2026-07-23T23:52:04.55669Z","steps":["trace[987742218] 'read index received' (duration: 523.452849ms)","trace[987742218] 'applied index is now lower than readState.Index' (duration: 818.452479ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:52:04.556803Z","caller":"traceutil/trace.go:171","msg":"trace[826165182] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"1.395006179s","start":"2026-07-23T23:52:03.161783Z","end":"2026-07-23T23:52:04.556789Z","steps":["trace[826165182] 'process raft request' (duration: 576.484719ms)","trace[826165182] 'compare' (duration: 817.39485ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:52:04.556866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:03.161722Z","time spent":"1.395116973s","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:52:04.557237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.342437412s","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-07-23T23:52:04.557316Z","caller":"traceutil/trace.go:171","msg":"trace[1698452305] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1270; }","duration":"1.342588776s","start":"2026-07-23T23:52:03.214708Z","end":"2026-07-23T23:52:04.557297Z","steps":["trace[1698452305] 'agreement among raft nodes before linearized reading' (duration: 1.342437482s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:04.557358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:03.214666Z","time spent":"1.342683699s","remote":"127.0.0.1:42518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" "} {"level":"info","ts":"2026-07-23T23:52:04.801132Z","caller":"traceutil/trace.go:171","msg":"trace[944347576] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"583.481521ms","start":"2026-07-23T23:52:04.217626Z","end":"2026-07-23T23:52:04.801107Z","steps":["trace[944347576] 'process raft request' (duration: 583.263535ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:04.801871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:04.217591Z","time spent":"584.128738ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:52:04.802148Z","caller":"traceutil/trace.go:171","msg":"trace[1182538431] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1327; }","duration":"245.356412ms","start":"2026-07-23T23:52:04.556745Z","end":"2026-07-23T23:52:04.802101Z","steps":["trace[1182538431] 'read index received' (duration: 245.337911ms)","trace[1182538431] 'applied index is now lower than readState.Index' (duration: 15.121µs)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:52:04.802387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.03955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-23T23:52:04.80239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.123004499s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-23T23:52:04.802438Z","caller":"traceutil/trace.go:171","msg":"trace[1515535453] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1271; }","duration":"779.136373ms","start":"2026-07-23T23:52:04.02329Z","end":"2026-07-23T23:52:04.802426Z","steps":["trace[1515535453] 'agreement among raft nodes before linearized reading' (duration: 778.972248ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:04.802449Z","caller":"traceutil/trace.go:171","msg":"trace[571777510] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1271; }","duration":"1.123144693s","start":"2026-07-23T23:52:03.679289Z","end":"2026-07-23T23:52:04.802433Z","steps":["trace[571777510] 'agreement among raft nodes before linearized reading' (duration: 1.122987139s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:04.802475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:04.023264Z","time spent":"779.202905ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-23T23:52:04.8025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:03.679259Z","time spent":"1.123229875s","remote":"127.0.0.1:44644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:52:04.80252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.997031ms","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-07-23T23:52:04.802632Z","caller":"traceutil/trace.go:171","msg":"trace[423229155] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1271; }","duration":"684.156705ms","start":"2026-07-23T23:52:04.118443Z","end":"2026-07-23T23:52:04.802599Z","steps":["trace[423229155] 'agreement among raft nodes before linearized reading' (duration: 683.935389ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:04.802688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:04.118428Z","time spent":"684.247597ms","remote":"127.0.0.1:44622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-07-23T23:52:04.864362Z","caller":"traceutil/trace.go:171","msg":"trace[385592841] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"301.508997ms","start":"2026-07-23T23:52:04.562828Z","end":"2026-07-23T23:52:04.864337Z","steps":["trace[385592841] 'process raft request' (duration: 301.315542ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:04.864489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:04.562781Z","time spent":"301.643161ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":822,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:52:04.864625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.647496ms","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-07-23T23:52:04.864709Z","caller":"traceutil/trace.go:171","msg":"trace[383184804] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1272; }","duration":"303.815811ms","start":"2026-07-23T23:52:04.560875Z","end":"2026-07-23T23:52:04.864691Z","steps":["trace[383184804] 'agreement among raft nodes before linearized reading' (duration: 303.443981ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:04.864759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:04.560855Z","time spent":"303.895013ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-23T23:52:04.864961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.97939ms","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-07-23T23:52:04.864993Z","caller":"traceutil/trace.go:171","msg":"trace[1455355226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1272; }","duration":"306.066873ms","start":"2026-07-23T23:52:04.55892Z","end":"2026-07-23T23:52:04.864987Z","steps":["trace[1455355226] 'agreement among raft nodes before linearized reading' (duration: 305.95381ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:04.86501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:04.558909Z","time spent":"306.098123ms","remote":"127.0.0.1:42386","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-07-23T23:52:04.865026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.736128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:52:04.865057Z","caller":"traceutil/trace.go:171","msg":"trace[492998397] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1272; }","duration":"205.8068ms","start":"2026-07-23T23:52:04.65924Z","end":"2026-07-23T23:52:04.865047Z","steps":["trace[492998397] 'agreement among raft nodes before linearized reading' (duration: 205.754988ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:04.865133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.134372ms","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-07-23T23:52:04.865149Z","caller":"traceutil/trace.go:171","msg":"trace[204808083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1272; }","duration":"307.206013ms","start":"2026-07-23T23:52:04.557938Z","end":"2026-07-23T23:52:04.865144Z","steps":["trace[204808083] 'agreement among raft nodes before linearized reading' (duration: 307.156552ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:04.865162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:04.557904Z","time spent":"307.255535ms","remote":"127.0.0.1:42386","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-07-23T23:52:04.865407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.597221ms","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-07-23T23:52:04.865428Z","caller":"traceutil/trace.go:171","msg":"trace[1070730708] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1272; }","duration":"308.665024ms","start":"2026-07-23T23:52:04.556757Z","end":"2026-07-23T23:52:04.865422Z","steps":["trace[1070730708] 'agreement among raft nodes before linearized reading' (duration: 307.540073ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:04.865442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:04.556735Z","time spent":"308.703494ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-23T23:52:04.928413Z","caller":"traceutil/trace.go:171","msg":"trace[1612183026] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"120.880187ms","start":"2026-07-23T23:52:04.807487Z","end":"2026-07-23T23:52:04.928367Z","steps":["trace[1612183026] 'process raft request' (duration: 85.709705ms)","trace[1612183026] 'compare' (duration: 34.881684ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:52:05.155274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.170349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-23T23:52:05.155365Z","caller":"traceutil/trace.go:171","msg":"trace[773138463] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1277; }","duration":"112.328283ms","start":"2026-07-23T23:52:05.043015Z","end":"2026-07-23T23:52:05.155343Z","steps":["trace[773138463] 'count revisions from in-memory index tree' (duration: 112.068545ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:05.225882Z","caller":"traceutil/trace.go:171","msg":"trace[1391554104] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"124.387162ms","start":"2026-07-23T23:52:05.101475Z","end":"2026-07-23T23:52:05.225862Z","steps":["trace[1391554104] 'process raft request' (duration: 124.160946ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:05.360922Z","caller":"traceutil/trace.go:171","msg":"trace[6075891] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"204.770701ms","start":"2026-07-23T23:52:05.156113Z","end":"2026-07-23T23:52:05.360883Z","steps":["trace[6075891] 'process raft request' (duration: 122.088349ms)","trace[6075891] 'compare' (duration: 82.526218ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:52:06.270802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.826179ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-23T23:52:06.271084Z","caller":"traceutil/trace.go:171","msg":"trace[1558834673] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"100.363636ms","start":"2026-07-23T23:52:06.170702Z","end":"2026-07-23T23:52:06.271066Z","steps":["trace[1558834673] 'process raft request' (duration: 100.227122ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:16.895931Z","caller":"traceutil/trace.go:171","msg":"trace[1581855734] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"365.191979ms","start":"2026-07-23T23:52:16.530706Z","end":"2026-07-23T23:52:16.895898Z","steps":["trace[1581855734] 'process raft request' (duration: 364.939732ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:16.896211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:16.530679Z","time spent":"365.366734ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:52:16.89741Z","caller":"traceutil/trace.go:171","msg":"trace[1762851321] linearizableReadLoop","detail":"{readStateIndex:1432; appliedIndex:1430; }","duration":"239.526853ms","start":"2026-07-23T23:52:16.657805Z","end":"2026-07-23T23:52:16.897331Z","steps":["trace[1762851321] 'read index received' (duration: 237.954539ms)","trace[1762851321] 'applied index is now lower than readState.Index' (duration: 1.571084ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:52:16.897597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.775289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:52:16.89764Z","caller":"traceutil/trace.go:171","msg":"trace[522994033] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1373; }","duration":"239.897163ms","start":"2026-07-23T23:52:16.657732Z","end":"2026-07-23T23:52:16.89763Z","steps":["trace[522994033] 'agreement among raft nodes before linearized reading' (duration: 239.762139ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:16.898026Z","caller":"traceutil/trace.go:171","msg":"trace[1536175562] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"282.419755ms","start":"2026-07-23T23:52:16.615592Z","end":"2026-07-23T23:52:16.898012Z","steps":["trace[1536175562] 'process raft request' (duration: 281.568632ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:17.197441Z","caller":"traceutil/trace.go:171","msg":"trace[2034143229] linearizableReadLoop","detail":"{readStateIndex:1433; appliedIndex:1432; }","duration":"138.670173ms","start":"2026-07-23T23:52:17.058748Z","end":"2026-07-23T23:52:17.197418Z","steps":["trace[2034143229] 'read index received' (duration: 138.487268ms)","trace[2034143229] 'applied index is now lower than readState.Index' (duration: 181.995µs)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:52:17.197831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.043113ms","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-07-23T23:52:17.197973Z","caller":"traceutil/trace.go:171","msg":"trace[349836226] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1374; }","duration":"139.241499ms","start":"2026-07-23T23:52:17.058708Z","end":"2026-07-23T23:52:17.19795Z","steps":["trace[349836226] 'agreement among raft nodes before linearized reading' (duration: 138.832308ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:17.198201Z","caller":"traceutil/trace.go:171","msg":"trace[1200472193] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"140.607646ms","start":"2026-07-23T23:52:17.057544Z","end":"2026-07-23T23:52:17.198152Z","steps":["trace[1200472193] 'process raft request' (duration: 139.664191ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:17.24873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.969499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-23T23:52:17.248739Z","caller":"traceutil/trace.go:171","msg":"trace[632792997] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"186.965714ms","start":"2026-07-23T23:52:17.061734Z","end":"2026-07-23T23:52:17.2487Z","steps":["trace[632792997] 'process raft request' (duration: 186.726728ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:17.248801Z","caller":"traceutil/trace.go:171","msg":"trace[1449024311] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1375; }","duration":"189.116803ms","start":"2026-07-23T23:52:17.059668Z","end":"2026-07-23T23:52:17.248784Z","steps":["trace[1449024311] 'agreement among raft nodes before linearized reading' (duration: 188.896737ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:17.248875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.765554ms","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:530"} {"level":"info","ts":"2026-07-23T23:52:17.248957Z","caller":"traceutil/trace.go:171","msg":"trace[1461473760] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1375; }","duration":"116.860146ms","start":"2026-07-23T23:52:17.132072Z","end":"2026-07-23T23:52:17.248932Z","steps":["trace[1461473760] 'agreement among raft nodes before linearized reading' (duration: 116.529627ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:17.248966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.200458ms","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-07-23T23:52:17.249784Z","caller":"traceutil/trace.go:171","msg":"trace[1917382852] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1375; }","duration":"189.082112ms","start":"2026-07-23T23:52:17.060677Z","end":"2026-07-23T23:52:17.249759Z","steps":["trace[1917382852] 'agreement among raft nodes before linearized reading' (duration: 187.960851ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:18.024381Z","caller":"traceutil/trace.go:171","msg":"trace[494423648] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"821.525992ms","start":"2026-07-23T23:52:17.202828Z","end":"2026-07-23T23:52:18.024354Z","steps":["trace[494423648] 'process raft request' (duration: 821.368297ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:18.02463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:17.202803Z","time spent":"821.655604ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:52:18.025372Z","caller":"traceutil/trace.go:171","msg":"trace[545547673] linearizableReadLoop","detail":"{readStateIndex:1439; appliedIndex:1434; }","duration":"364.857951ms","start":"2026-07-23T23:52:17.660492Z","end":"2026-07-23T23:52:18.02535Z","steps":["trace[545547673] 'read index received' (duration: 363.778981ms)","trace[545547673] 'applied index is now lower than readState.Index' (duration: 1.07744ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:52:18.025387Z","caller":"traceutil/trace.go:171","msg":"trace[788134832] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"770.736261ms","start":"2026-07-23T23:52:17.2546Z","end":"2026-07-23T23:52:18.025336Z","steps":["trace[788134832] 'process raft request' (duration: 770.480124ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:18.025394Z","caller":"traceutil/trace.go:171","msg":"trace[757894588] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"770.609009ms","start":"2026-07-23T23:52:17.254742Z","end":"2026-07-23T23:52:18.025351Z","steps":["trace[757894588] 'process raft request' (duration: 770.469825ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:18.025441Z","caller":"traceutil/trace.go:171","msg":"trace[36243058] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"768.09866ms","start":"2026-07-23T23:52:17.257287Z","end":"2026-07-23T23:52:18.025386Z","steps":["trace[36243058] 'process raft request' (duration: 767.980537ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:18.025643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:17.254558Z","time spent":"770.941488ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:52:18.025728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.20161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:52:18.025595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:17.254733Z","time spent":"770.813144ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:52:18.025809Z","caller":"traceutil/trace.go:171","msg":"trace[1244171716] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1380; }","duration":"365.360424ms","start":"2026-07-23T23:52:17.660432Z","end":"2026-07-23T23:52:18.025793Z","steps":["trace[1244171716] 'agreement among raft nodes before linearized reading' (duration: 365.167629ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:18.025944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:17.660403Z","time spent":"365.466187ms","remote":"127.0.0.1:42070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-23T23:52:18.025501Z","caller":"traceutil/trace.go:171","msg":"trace[1949665950] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"615.24497ms","start":"2026-07-23T23:52:17.410243Z","end":"2026-07-23T23:52:18.025488Z","steps":["trace[1949665950] 'process raft request' (duration: 615.068285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:18.026211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:17.410201Z","time spent":"615.882847ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:52:18.026772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:17.257278Z","time spent":"768.344006ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:52:19.401143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.386012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-23T23:52:19.401262Z","caller":"traceutil/trace.go:171","msg":"trace[473924438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1383; }","duration":"147.566527ms","start":"2026-07-23T23:52:19.253671Z","end":"2026-07-23T23:52:19.401237Z","steps":["trace[473924438] 'range keys from in-memory index tree' (duration: 147.123144ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:58.308755Z","caller":"traceutil/trace.go:171","msg":"trace[499381006] transaction","detail":"{read_only:false; response_revision:1561; number_of_response:1; }","duration":"179.533241ms","start":"2026-07-23T23:52:58.129193Z","end":"2026-07-23T23:52:58.308726Z","steps":["trace[499381006] 'process raft request' (duration: 179.329106ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:58.323901Z","caller":"traceutil/trace.go:171","msg":"trace[441263566] transaction","detail":"{read_only:false; response_revision:1562; number_of_response:1; }","duration":"114.78799ms","start":"2026-07-23T23:52:58.20906Z","end":"2026-07-23T23:52:58.323848Z","steps":["trace[441263566] 'process raft request' (duration: 114.526843ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:07.904687Z","caller":"traceutil/trace.go:171","msg":"trace[511458947] transaction","detail":"{read_only:false; response_revision:1605; number_of_response:1; }","duration":"187.558813ms","start":"2026-07-23T23:53:07.717101Z","end":"2026-07-23T23:53:07.90466Z","steps":["trace[511458947] 'process raft request' (duration: 187.397909ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:18.454885Z","caller":"traceutil/trace.go:171","msg":"trace[659272242] transaction","detail":"{read_only:false; response_revision:1653; number_of_response:1; }","duration":"104.489544ms","start":"2026-07-23T23:53:18.350363Z","end":"2026-07-23T23:53:18.454852Z","steps":["trace[659272242] 'process raft request' (duration: 49.714588ms)","trace[659272242] 'compare' (duration: 54.645373ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:54:42.814511Z","caller":"traceutil/trace.go:171","msg":"trace[1035492508] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"247.064371ms","start":"2026-07-23T23:54:42.567407Z","end":"2026-07-23T23:54:42.814471Z","steps":["trace[1035492508] 'process raft request' (duration: 246.815564ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:54:43.140322Z","caller":"traceutil/trace.go:171","msg":"trace[1151577285] transaction","detail":"{read_only:false; response_revision:2042; number_of_response:1; }","duration":"120.298023ms","start":"2026-07-23T23:54:43.019993Z","end":"2026-07-23T23:54:43.140291Z","steps":["trace[1151577285] 'process raft request' (duration: 120.125658ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:54:53.104024Z","caller":"traceutil/trace.go:171","msg":"trace[393274872] transaction","detail":"{read_only:false; response_revision:2087; number_of_response:1; }","duration":"166.317369ms","start":"2026-07-23T23:54:52.937674Z","end":"2026-07-23T23:54:53.103992Z","steps":["trace[393274872] 'process raft request' (duration: 166.151374ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:54:53.978922Z","caller":"traceutil/trace.go:171","msg":"trace[2031136787] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"206.67714ms","start":"2026-07-23T23:54:53.772213Z","end":"2026-07-23T23:54:53.97889Z","steps":["trace[2031136787] 'process raft request' (duration: 206.492965ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:06.073906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.759573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-23T23:55:06.073996Z","caller":"traceutil/trace.go:171","msg":"trace[1174045785] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2142; }","duration":"736.915437ms","start":"2026-07-23T23:55:05.337058Z","end":"2026-07-23T23:55:06.073973Z","steps":["trace[1174045785] 'range keys from in-memory index tree' (duration: 736.561658ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:06.074041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:05.33703Z","time spent":"737.00151ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-23T23:55:06.074113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.18799ms","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-07-23T23:55:06.074191Z","caller":"traceutil/trace.go:171","msg":"trace[1435340689] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2142; }","duration":"632.315943ms","start":"2026-07-23T23:55:05.441861Z","end":"2026-07-23T23:55:06.074177Z","steps":["trace[1435340689] 'range keys from in-memory index tree' (duration: 631.913002ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:06.07431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:05.441835Z","time spent":"632.459137ms","remote":"127.0.0.1:42386","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-07-23T23:55:06.074393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.361204ms","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":"warn","ts":"2026-07-23T23:55:06.07445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.993843ms","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-07-23T23:55:06.074488Z","caller":"traceutil/trace.go:171","msg":"trace[158790127] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2142; }","duration":"780.070365ms","start":"2026-07-23T23:55:05.294406Z","end":"2026-07-23T23:55:06.074477Z","steps":["trace[158790127] 'range keys from in-memory index tree' (duration: 779.841538ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:06.074529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:05.294371Z","time spent":"780.150757ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-23T23:55:06.074488Z","caller":"traceutil/trace.go:171","msg":"trace[1637344291] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2142; }","duration":"511.516258ms","start":"2026-07-23T23:55:05.562949Z","end":"2026-07-23T23:55:06.074465Z","steps":["trace[1637344291] 'range keys from in-memory index tree' (duration: 511.133117ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:06.074628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:05.562924Z","time spent":"511.695793ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-23T23:55:06.074845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.889865ms","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-07-23T23:55:06.074902Z","caller":"traceutil/trace.go:171","msg":"trace[417286440] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2142; }","duration":"627.004958ms","start":"2026-07-23T23:55:05.447885Z","end":"2026-07-23T23:55:06.07489Z","steps":["trace[417286440] 'range keys from in-memory index tree' (duration: 626.733261ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:06.074956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:05.447852Z","time spent":"627.094321ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-23T23:55:36.67759Z","caller":"traceutil/trace.go:171","msg":"trace[1074446368] transaction","detail":"{read_only:false; response_revision:2285; number_of_response:1; }","duration":"149.168334ms","start":"2026-07-23T23:55:36.528393Z","end":"2026-07-23T23:55:36.677561Z","steps":["trace[1074446368] 'process raft request' (duration: 149.02925ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:44.886681Z","caller":"traceutil/trace.go:171","msg":"trace[2110875075] transaction","detail":"{read_only:false; response_revision:2324; number_of_response:1; }","duration":"126.667688ms","start":"2026-07-23T23:55:44.759987Z","end":"2026-07-23T23:55:44.886655Z","steps":["trace[2110875075] 'process raft request' (duration: 87.82767ms)","trace[2110875075] 'compare' (duration: 38.689734ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:56:45.226601Z","caller":"traceutil/trace.go:171","msg":"trace[926059899] transaction","detail":"{read_only:false; response_revision:2620; number_of_response:1; }","duration":"155.083607ms","start":"2026-07-23T23:56:45.071481Z","end":"2026-07-23T23:56:45.226564Z","steps":["trace[926059899] 'process raft request' (duration: 154.740688ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:56:45.846608Z","caller":"traceutil/trace.go:171","msg":"trace[1130277264] transaction","detail":"{read_only:false; response_revision:2623; number_of_response:1; }","duration":"171.343074ms","start":"2026-07-23T23:56:45.675235Z","end":"2026-07-23T23:56:45.846578Z","steps":["trace[1130277264] 'process raft request' (duration: 171.147299ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:56:46.068975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.684553ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-23T23:56:46.986845Z","caller":"traceutil/trace.go:171","msg":"trace[2078893510] transaction","detail":"{read_only:false; response_revision:2625; number_of_response:1; }","duration":"102.087845ms","start":"2026-07-23T23:56:46.884731Z","end":"2026-07-23T23:56:46.986819Z","steps":["trace[2078893510] 'process raft request' (duration: 101.90132ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:56:47.042426Z","caller":"traceutil/trace.go:171","msg":"trace[826687653] linearizableReadLoop","detail":"{readStateIndex:2740; appliedIndex:2738; }","duration":"126.988059ms","start":"2026-07-23T23:56:46.915402Z","end":"2026-07-23T23:56:47.04239Z","steps":["trace[826687653] 'read index received' (duration: 71.357267ms)","trace[826687653] 'applied index is now lower than readState.Index' (duration: 55.629051ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:56:47.042509Z","caller":"traceutil/trace.go:171","msg":"trace[195255822] transaction","detail":"{read_only:false; response_revision:2626; number_of_response:1; }","duration":"155.186599ms","start":"2026-07-23T23:56:46.887294Z","end":"2026-07-23T23:56:47.042481Z","steps":["trace[195255822] 'process raft request' (duration: 154.915242ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:56:47.04272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.285276ms","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-07-23T23:56:47.042801Z","caller":"traceutil/trace.go:171","msg":"trace[561377830] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2626; }","duration":"127.43234ms","start":"2026-07-23T23:56:46.915349Z","end":"2026-07-23T23:56:47.042781Z","steps":["trace[561377830] 'agreement among raft nodes before linearized reading' (duration: 127.181013ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:56:51.004264Z","caller":"traceutil/trace.go:171","msg":"trace[2062836369] linearizableReadLoop","detail":"{readStateIndex:2763; appliedIndex:2762; }","duration":"317.762718ms","start":"2026-07-23T23:56:50.686479Z","end":"2026-07-23T23:56:51.004241Z","steps":["trace[2062836369] 'read index received' (duration: 309.454384ms)","trace[2062836369] 'applied index is now lower than readState.Index' (duration: 8.306224ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:56:51.004477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.983604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:56:51.004507Z","caller":"traceutil/trace.go:171","msg":"trace[1868928758] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2648; }","duration":"318.050776ms","start":"2026-07-23T23:56:50.686448Z","end":"2026-07-23T23:56:51.004499Z","steps":["trace[1868928758] 'agreement among raft nodes before linearized reading' (duration: 317.929453ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:56:51.00453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:56:50.686439Z","time spent":"318.085767ms","remote":"127.0.0.1:42072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-23T23:56:51.004623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.055558ms","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-07-23T23:56:51.004734Z","caller":"traceutil/trace.go:171","msg":"trace[919181810] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2648; }","duration":"194.203963ms","start":"2026-07-23T23:56:50.810484Z","end":"2026-07-23T23:56:51.004688Z","steps":["trace[919181810] 'agreement among raft nodes before linearized reading' (duration: 194.053999ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:56:51.0043Z","caller":"traceutil/trace.go:171","msg":"trace[174064908] transaction","detail":"{read_only:false; response_revision:2648; number_of_response:1; }","duration":"317.870901ms","start":"2026-07-23T23:56:50.686385Z","end":"2026-07-23T23:56:51.004256Z","steps":["trace[174064908] 'process raft request' (duration: 309.516356ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:56:51.005096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:56:50.686363Z","time spent":"318.60018ms","remote":"127.0.0.1:42096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:56:53.200987Z","caller":"traceutil/trace.go:171","msg":"trace[1848211189] transaction","detail":"{read_only:false; response_revision:2665; number_of_response:1; }","duration":"118.997503ms","start":"2026-07-23T23:56:53.081947Z","end":"2026-07-23T23:56:53.200944Z","steps":["trace[1848211189] 'process raft request' (duration: 38.548301ms)","trace[1848211189] 'compare' (duration: 80.035761ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:57:19.706698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.682571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:57:19.707087Z","caller":"traceutil/trace.go:171","msg":"trace[2111126743] linearizableReadLoop","detail":"{readStateIndex:2910; appliedIndex:2908; }","duration":"169.63713ms","start":"2026-07-23T23:57:19.53742Z","end":"2026-07-23T23:57:19.707057Z","steps":["trace[2111126743] 'read index received' (duration: 39.380183ms)","trace[2111126743] 'applied index is now lower than readState.Index' (duration: 130.255347ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:57:19.707302Z","caller":"traceutil/trace.go:171","msg":"trace[1034416778] transaction","detail":"{read_only:false; response_revision:2789; number_of_response:1; }","duration":"203.72311ms","start":"2026-07-23T23:57:19.503557Z","end":"2026-07-23T23:57:19.70728Z","steps":["trace[1034416778] 'process raft request' (duration: 203.396171ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:57:19.707418Z","caller":"traceutil/trace.go:171","msg":"trace[359385881] transaction","detail":"{read_only:false; response_revision:2788; number_of_response:1; }","duration":"203.986366ms","start":"2026-07-23T23:57:19.503391Z","end":"2026-07-23T23:57:19.707377Z","steps":["trace[359385881] 'process raft request' (duration: 73.432762ms)","trace[359385881] 'compare' (duration: 129.501646ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:57:19.707768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.315018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/extension-apiserver-authentication-reader\" ","response":"range_response_count:1 size:671"} {"level":"info","ts":"2026-07-23T23:57:19.707873Z","caller":"traceutil/trace.go:171","msg":"trace[46833442] range","detail":"{range_begin:/registry/roles/kube-system/extension-apiserver-authentication-reader; range_end:; response_count:1; response_revision:2789; }","duration":"170.433091ms","start":"2026-07-23T23:57:19.537401Z","end":"2026-07-23T23:57:19.707835Z","steps":["trace[46833442] 'agreement among raft nodes before linearized reading' (duration: 170.057581ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:57:19.708315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.782398ms","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-07-23T23:57:19.708453Z","caller":"traceutil/trace.go:171","msg":"trace[103637372] range","detail":"{range_begin:/registry/roles/kube-system/kube-proxy; range_end:; response_count:1; response_revision:2789; }","duration":"124.949023ms","start":"2026-07-23T23:57:19.583479Z","end":"2026-07-23T23:57:19.708428Z","steps":["trace[103637372] 'agreement among raft nodes before linearized reading' (duration: 123.909555ms)"],"step_count":1}