{"level":"warn","ts":"2026-05-09T21:39:41.907315Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T21:39:41.90741Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.33: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.33:2380","--initial-cluster=instance=https://199.204.45.33:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.33:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.33:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-09T21:39:41.907482Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T21:39:41.907495Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-05-09T21:39:41.907559Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-09T21:39:41.908294Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"]} {"level":"info","ts":"2026-05-09T21:39:41.9084Z","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.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.33:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-09T21:39:41.916557Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.92053ms"} {"level":"info","ts":"2026-05-09T21:39:41.933455Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e5729930cf7e1f","cluster-id":"14aeb8c3ec66b749"} {"level":"info","ts":"2026-05-09T21:39:41.933832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=()"} {"level":"info","ts":"2026-05-09T21:39:41.93391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 0"} {"level":"info","ts":"2026-05-09T21:39:41.934069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e5729930cf7e1f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-09T21:39:41.934111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 1"} {"level":"info","ts":"2026-05-09T21:39:41.934406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"warn","ts":"2026-05-09T21:39:41.947882Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-09T21:39:41.949993Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-09T21:39:41.95149Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-09T21:39:41.954587Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e5729930cf7e1f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-09T21:39:41.955177Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e5729930cf7e1f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-09T21:39:41.955276Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T21:39:41.955485Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T21:39:41.95551Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T21:39:41.957376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"info","ts":"2026-05-09T21:39:41.957639Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","added-peer-id":"f1e5729930cf7e1f","added-peer-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-05-09T21:39:41.960542Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-09T21:39:41.960593Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-05-09T21:39:41.960643Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-05-09T21:39:41.962011Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e5729930cf7e1f","initial-advertise-peer-urls":["https://199.204.45.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-09T21:39:41.96206Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-09T21:39:42.235043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f is starting a new election at term 1"} {"level":"info","ts":"2026-05-09T21:39:42.235113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became pre-candidate at term 1"} {"level":"info","ts":"2026-05-09T21:39:42.235144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgPreVoteResp from f1e5729930cf7e1f at term 1"} {"level":"info","ts":"2026-05-09T21:39:42.235167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became candidate at term 2"} {"level":"info","ts":"2026-05-09T21:39:42.235181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgVoteResp from f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-05-09T21:39:42.2352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became leader at term 2"} {"level":"info","ts":"2026-05-09T21:39:42.235217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e5729930cf7e1f elected leader f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-05-09T21:39:42.249126Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:39:42.256482Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e5729930cf7e1f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.33:2379]}","request-path":"/0/members/f1e5729930cf7e1f/attributes","cluster-id":"14aeb8c3ec66b749","publish-timeout":"7s"} {"level":"info","ts":"2026-05-09T21:39:42.256533Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T21:39:42.256544Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T21:39:42.256931Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-09T21:39:42.257048Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-09T21:39:42.259725Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-09T21:39:42.27295Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.33:2379"} {"level":"info","ts":"2026-05-09T21:39:42.404656Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:39:42.404795Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:39:42.404851Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-09T21:39:42.570052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.603978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T21:39:42.570131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.514963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T21:39:42.570139Z","caller":"traceutil/trace.go:171","msg":"trace[1274826503] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"136.748828ms","start":"2026-05-09T21:39:42.433375Z","end":"2026-05-09T21:39:42.570124Z","steps":["trace[1274826503] 'count revisions from in-memory index tree' (duration: 136.552547ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:39:42.570181Z","caller":"traceutil/trace.go:171","msg":"trace[1353948291] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"123.581074ms","start":"2026-05-09T21:39:42.446582Z","end":"2026-05-09T21:39:42.570163Z","steps":["trace[1353948291] 'range keys from in-memory index tree' (duration: 123.459683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:42.570227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.492121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T21:39:42.570298Z","caller":"traceutil/trace.go:171","msg":"trace[882741049] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"110.567751ms","start":"2026-05-09T21:39:42.45969Z","end":"2026-05-09T21:39:42.570257Z","steps":["trace[882741049] 'count revisions from in-memory index tree' (duration: 110.34865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:42.57003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.249839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T21:39:42.57034Z","caller":"traceutil/trace.go:171","msg":"trace[1421274459] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"110.661501ms","start":"2026-05-09T21:39:42.459669Z","end":"2026-05-09T21:39:42.57033Z","steps":["trace[1421274459] 'range keys from in-memory index tree' (duration: 110.138979ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:42.570411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.565094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T21:39:42.570544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.782055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T21:39:42.570551Z","caller":"traceutil/trace.go:171","msg":"trace[926568594] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"123.713074ms","start":"2026-05-09T21:39:42.446786Z","end":"2026-05-09T21:39:42.570499Z","steps":["trace[926568594] 'count revisions from in-memory index tree' (duration: 123.516433ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:39:42.570637Z","caller":"traceutil/trace.go:171","msg":"trace[844014806] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"101.922286ms","start":"2026-05-09T21:39:42.468704Z","end":"2026-05-09T21:39:42.570626Z","steps":["trace[844014806] 'count revisions from in-memory index tree' (duration: 101.738995ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:42.570437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.966169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T21:39:42.570946Z","caller":"traceutil/trace.go:171","msg":"trace[2085922052] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"137.816455ms","start":"2026-05-09T21:39:42.433104Z","end":"2026-05-09T21:39:42.570921Z","steps":["trace[2085922052] 'range keys from in-memory index tree' (duration: 136.863609ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:42.570754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.964357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T21:39:42.571104Z","caller":"traceutil/trace.go:171","msg":"trace[1971539061] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"102.42578ms","start":"2026-05-09T21:39:42.468655Z","end":"2026-05-09T21:39:42.571081Z","steps":["trace[1971539061] 'range keys from in-memory index tree' (duration: 101.938987ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:39:43.78069Z","caller":"traceutil/trace.go:171","msg":"trace[587711608] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"258.809724ms","start":"2026-05-09T21:39:43.521855Z","end":"2026-05-09T21:39:43.780664Z","steps":["trace[587711608] 'process raft request' (duration: 258.510753ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:39:44.49539Z","caller":"traceutil/trace.go:171","msg":"trace[2035383754] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"899.403617ms","start":"2026-05-09T21:39:43.59596Z","end":"2026-05-09T21:39:44.495363Z","steps":["trace[2035383754] 'process raft request' (duration: 899.274137ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:39:44.495812Z","caller":"traceutil/trace.go:171","msg":"trace[1318888292] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"898.234709ms","start":"2026-05-09T21:39:43.597505Z","end":"2026-05-09T21:39:44.49574Z","steps":["trace[1318888292] 'process raft request' (duration: 897.909588ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:39:44.495809Z","caller":"traceutil/trace.go:171","msg":"trace[974465619] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"899.276437ms","start":"2026-05-09T21:39:43.596511Z","end":"2026-05-09T21:39:44.495787Z","steps":["trace[974465619] 'process raft request' (duration: 898.855594ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:44.495866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"962.523206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T21:39:44.495909Z","caller":"traceutil/trace.go:171","msg":"trace[459195902] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"899.665809ms","start":"2026-05-09T21:39:43.596233Z","end":"2026-05-09T21:39:44.495899Z","steps":["trace[459195902] 'process raft request' (duration: 899.055795ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:39:44.49593Z","caller":"traceutil/trace.go:171","msg":"trace[408637682] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"962.627716ms","start":"2026-05-09T21:39:43.533288Z","end":"2026-05-09T21:39:44.495915Z","steps":["trace[408637682] 'agreement among raft nodes before linearized reading' (duration: 962.376754ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:39:44.49597Z","caller":"traceutil/trace.go:171","msg":"trace[625863841] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"881.389624ms","start":"2026-05-09T21:39:43.614572Z","end":"2026-05-09T21:39:44.495962Z","steps":["trace[625863841] 'process raft request' (duration: 880.9354ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:44.495979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.533278Z","time spent":"962.687537ms","remote":"127.0.0.1:43788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-05-09T21:39:44.496029Z","caller":"traceutil/trace.go:171","msg":"trace[1156652159] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"873.208322ms","start":"2026-05-09T21:39:43.622813Z","end":"2026-05-09T21:39:44.496021Z","steps":["trace[1156652159] 'process raft request' (duration: 872.748568ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:39:44.495626Z","caller":"traceutil/trace.go:171","msg":"trace[1998334472] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"962.291274ms","start":"2026-05-09T21:39:43.533311Z","end":"2026-05-09T21:39:44.495602Z","steps":["trace[1998334472] 'read index received' (duration: 247.078841ms)","trace[1998334472] 'applied index is now lower than readState.Index' (duration: 715.211383ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:39:44.495596Z","caller":"traceutil/trace.go:171","msg":"trace[1421986070] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"899.207486ms","start":"2026-05-09T21:39:43.596298Z","end":"2026-05-09T21:39:44.495505Z","steps":["trace[1421986070] 'process raft request' (duration: 899.029525ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:44.496231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.595932Z","time spent":"899.893991ms","remote":"127.0.0.1:43816","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-05-09T21:39:44.496414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.596492Z","time spent":"899.377978ms","remote":"127.0.0.1:43896","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-05-09T21:39:44.496504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.096177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T21:39:44.496511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.596282Z","time spent":"900.007371ms","remote":"127.0.0.1:43896","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-05-09T21:39:44.496565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.596224Z","time spent":"899.71754ms","remote":"127.0.0.1:43896","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-05-09T21:39:44.496609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.502549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T21:39:44.496665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.614538Z","time spent":"881.463795ms","remote":"127.0.0.1:43570","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-05-09T21:39:44.496685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"902.90417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.33\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T21:39:44.496721Z","caller":"traceutil/trace.go:171","msg":"trace[1834255457] range","detail":"{range_begin:/registry/masterleases/199.204.45.33; range_end:; response_count:0; response_revision:11; }","duration":"902.97251ms","start":"2026-05-09T21:39:43.593738Z","end":"2026-05-09T21:39:44.49671Z","steps":["trace[1834255457] 'agreement among raft nodes before linearized reading' (duration: 902.908109ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:44.496812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.593705Z","time spent":"903.09534ms","remote":"127.0.0.1:43424","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.33\" "} {"level":"info","ts":"2026-05-09T21:39:44.49671Z","caller":"traceutil/trace.go:171","msg":"trace[889777500] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"877.690841ms","start":"2026-05-09T21:39:43.619001Z","end":"2026-05-09T21:39:44.496692Z","steps":["trace[889777500] 'agreement among raft nodes before linearized reading' (duration: 877.50313ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:39:44.495616Z","caller":"traceutil/trace.go:171","msg":"trace[378326474] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"973.595605ms","start":"2026-05-09T21:39:43.521988Z","end":"2026-05-09T21:39:44.495583Z","steps":["trace[378326474] 'process raft request' (duration: 973.059292ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:44.496888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.618984Z","time spent":"877.887672ms","remote":"127.0.0.1:43500","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-05-09T21:39:44.496937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.62279Z","time spent":"873.260802ms","remote":"127.0.0.1:43642","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-05-09T21:39:44.497117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.581392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T21:39:44.497174Z","caller":"traceutil/trace.go:171","msg":"trace[1198813982] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"849.747682ms","start":"2026-05-09T21:39:43.647411Z","end":"2026-05-09T21:39:44.497159Z","steps":["trace[1198813982] 'agreement among raft nodes before linearized reading' (duration: 849.648122ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:44.497208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.647399Z","time spent":"849.801493ms","remote":"127.0.0.1:43500","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-05-09T21:39:44.496563Z","caller":"traceutil/trace.go:171","msg":"trace[1925020193] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"923.175927ms","start":"2026-05-09T21:39:43.573373Z","end":"2026-05-09T21:39:44.496549Z","steps":["trace[1925020193] 'agreement among raft nodes before linearized reading' (duration: 923.092916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:44.497269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.573362Z","time spent":"923.892152ms","remote":"127.0.0.1:43500","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-05-09T21:39:44.496618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.198926ms","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-05-09T21:39:44.497276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.521973Z","time spent":"974.959574ms","remote":"127.0.0.1:43438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:39:44.496509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.597495Z","time spent":"898.367001ms","remote":"127.0.0.1:43896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:39:44.497321Z","caller":"traceutil/trace.go:171","msg":"trace[6775138] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"899.928911ms","start":"2026-05-09T21:39:43.597382Z","end":"2026-05-09T21:39:44.497306Z","steps":["trace[6775138] 'agreement among raft nodes before linearized reading' (duration: 899.207366ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:44.497443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.597368Z","time spent":"900.062882ms","remote":"127.0.0.1:43470","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":"info","ts":"2026-05-09T21:39:44.497456Z","caller":"traceutil/trace.go:171","msg":"trace[748205065] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"898.132069ms","start":"2026-05-09T21:39:43.597637Z","end":"2026-05-09T21:39:44.495769Z","steps":["trace[748205065] 'process raft request' (duration: 897.814027ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:44.497516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:43.597628Z","time spent":"899.85693ms","remote":"127.0.0.1:43896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:39:52.42368Z","caller":"traceutil/trace.go:171","msg":"trace[1489591765] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:352; }","duration":"421.076739ms","start":"2026-05-09T21:39:52.002584Z","end":"2026-05-09T21:39:52.423661Z","steps":["trace[1489591765] 'read index received' (duration: 420.943938ms)","trace[1489591765] 'applied index is now lower than readState.Index' (duration: 132.141µs)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:39:52.423802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.20171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-09T21:39:52.423777Z","caller":"traceutil/trace.go:171","msg":"trace[1504800684] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"430.314785ms","start":"2026-05-09T21:39:51.993439Z","end":"2026-05-09T21:39:52.423754Z","steps":["trace[1504800684] 'process raft request' (duration: 430.095743ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:52.423977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:51.993417Z","time spent":"430.466637ms","remote":"127.0.0.1:43576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6946,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:39:52.423836Z","caller":"traceutil/trace.go:171","msg":"trace[503017138] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:343; }","duration":"421.282761ms","start":"2026-05-09T21:39:52.002544Z","end":"2026-05-09T21:39:52.423826Z","steps":["trace[503017138] 'agreement among raft nodes before linearized reading' (duration: 421.21169ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:52.424163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:52.002524Z","time spent":"421.601693ms","remote":"127.0.0.1:43500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-09T21:40:03.891581Z","caller":"traceutil/trace.go:171","msg":"trace[1949424404] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"261.185038ms","start":"2026-05-09T21:40:03.630373Z","end":"2026-05-09T21:40:03.891558Z","steps":["trace[1949424404] 'process raft request' (duration: 247.425364ms)","trace[1949424404] 'compare' (duration: 13.575718ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:40:10.437729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.016627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"info","ts":"2026-05-09T21:40:10.437856Z","caller":"traceutil/trace.go:171","msg":"trace[2010885199] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:473; }","duration":"262.223025ms","start":"2026-05-09T21:40:10.175602Z","end":"2026-05-09T21:40:10.437825Z","steps":["trace[2010885199] 'range keys from in-memory index tree' (duration: 261.8008ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:12.651267Z","caller":"traceutil/trace.go:171","msg":"trace[1420625398] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:528; }","duration":"125.37034ms","start":"2026-05-09T21:40:12.52587Z","end":"2026-05-09T21:40:12.65124Z","steps":["trace[1420625398] 'read index received' (duration: 125.211955ms)","trace[1420625398] 'applied index is now lower than readState.Index' (duration: 157.245µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:40:12.651306Z","caller":"traceutil/trace.go:171","msg":"trace[109128015] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"136.655698ms","start":"2026-05-09T21:40:12.514621Z","end":"2026-05-09T21:40:12.651276Z","steps":["trace[109128015] 'process raft request' (duration: 136.479253ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:12.651413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.521246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:12.651477Z","caller":"traceutil/trace.go:171","msg":"trace[1910082186] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:513; }","duration":"125.65447ms","start":"2026-05-09T21:40:12.525803Z","end":"2026-05-09T21:40:12.651457Z","steps":["trace[1910082186] 'agreement among raft nodes before linearized reading' (duration: 125.543716ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:13.902141Z","caller":"traceutil/trace.go:171","msg":"trace[1241739903] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"857.349089ms","start":"2026-05-09T21:40:13.044759Z","end":"2026-05-09T21:40:13.902108Z","steps":["trace[1241739903] 'process raft request' (duration: 857.198904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:13.902453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:13.044738Z","time spent":"857.501125ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:40:13.921426Z","caller":"traceutil/trace.go:171","msg":"trace[1392120937] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"870.585826ms","start":"2026-05-09T21:40:13.050807Z","end":"2026-05-09T21:40:13.921393Z","steps":["trace[1392120937] 'process raft request' (duration: 870.031588ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:13.921563Z","caller":"traceutil/trace.go:171","msg":"trace[718025306] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"870.627336ms","start":"2026-05-09T21:40:13.050854Z","end":"2026-05-09T21:40:13.921481Z","steps":["trace[718025306] 'process raft request' (duration: 870.214643ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:13.92174Z","caller":"traceutil/trace.go:171","msg":"trace[28466329] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"866.033812ms","start":"2026-05-09T21:40:13.055585Z","end":"2026-05-09T21:40:13.921619Z","steps":["trace[28466329] 'process raft request' (duration: 865.640309ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:13.921809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:13.05085Z","time spent":"870.818792ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:40:13.921837Z","caller":"traceutil/trace.go:171","msg":"trace[1725162197] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"858.739933ms","start":"2026-05-09T21:40:13.063047Z","end":"2026-05-09T21:40:13.921787Z","steps":["trace[1725162197] 'process raft request' (duration: 858.488545ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:13.92171Z","caller":"traceutil/trace.go:171","msg":"trace[2054775646] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"864.545385ms","start":"2026-05-09T21:40:13.057137Z","end":"2026-05-09T21:40:13.921682Z","steps":["trace[2054775646] 'process raft request' (duration: 864.347649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:13.922003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:13.063027Z","time spent":"858.899417ms","remote":"127.0.0.1:43434","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-05-09T21:40:13.921831Z","caller":"traceutil/trace.go:171","msg":"trace[169762074] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"858.678231ms","start":"2026-05-09T21:40:13.063119Z","end":"2026-05-09T21:40:13.921798Z","steps":["trace[169762074] 'process raft request' (duration: 858.465084ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:13.922134Z","caller":"traceutil/trace.go:171","msg":"trace[404343999] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"856.086159ms","start":"2026-05-09T21:40:13.06604Z","end":"2026-05-09T21:40:13.922126Z","steps":["trace[404343999] 'process raft request' (duration: 855.759409ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:13.922127Z","caller":"traceutil/trace.go:171","msg":"trace[2032746852] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"856.228163ms","start":"2026-05-09T21:40:13.065875Z","end":"2026-05-09T21:40:13.922103Z","steps":["trace[2032746852] 'process raft request' (duration: 855.852452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:13.922174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:13.066002Z","time spent":"856.152361ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:40:13.922194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:13.05711Z","time spent":"865.0231ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:40:13.922237Z","caller":"traceutil/trace.go:171","msg":"trace[1141416525] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"836.198265ms","start":"2026-05-09T21:40:13.086033Z","end":"2026-05-09T21:40:13.922231Z","steps":["trace[1141416525] 'process raft request' (duration: 835.946628ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:13.922278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:13.086014Z","time spent":"836.249886ms","remote":"127.0.0.1:43434","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-05-09T21:40:13.922409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:13.063112Z","time spent":"858.938499ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:40:13.922464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:13.065869Z","time spent":"856.309906ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:40:13.922562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:13.05079Z","time spent":"870.764281ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:40:13.922392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:13.055556Z","time spent":"866.556789ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:40:13.922662Z","caller":"traceutil/trace.go:171","msg":"trace[1930247482] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"698.219013ms","start":"2026-05-09T21:40:13.224426Z","end":"2026-05-09T21:40:13.922645Z","steps":["trace[1930247482] 'process raft request' (duration: 697.936133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:13.922803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:13.224397Z","time spent":"698.361457ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:40:13.922641Z","caller":"traceutil/trace.go:171","msg":"trace[798586289] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"799.421439ms","start":"2026-05-09T21:40:13.123205Z","end":"2026-05-09T21:40:13.922626Z","steps":["trace[798586289] 'process raft request' (duration: 798.835281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:13.922876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.491256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-09T21:40:13.922901Z","caller":"traceutil/trace.go:171","msg":"trace[1461786730] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:525; }","duration":"207.553868ms","start":"2026-05-09T21:40:13.71534Z","end":"2026-05-09T21:40:13.922894Z","steps":["trace[1461786730] 'agreement among raft nodes before linearized reading' (duration: 207.405003ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:13.922727Z","caller":"traceutil/trace.go:171","msg":"trace[3188687] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:529; }","duration":"207.32797ms","start":"2026-05-09T21:40:13.71539Z","end":"2026-05-09T21:40:13.922717Z","steps":["trace[3188687] 'read index received' (duration: 186.697572ms)","trace[3188687] 'applied index is now lower than readState.Index' (duration: 20.627318ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:40:13.923054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:13.12318Z","time spent":"799.709109ms","remote":"127.0.0.1:43434","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-05-09T21:40:15.474534Z","caller":"traceutil/trace.go:171","msg":"trace[1204518124] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"191.917554ms","start":"2026-05-09T21:40:15.28259Z","end":"2026-05-09T21:40:15.474508Z","steps":["trace[1204518124] 'read index received' (duration: 191.536102ms)","trace[1204518124] 'applied index is now lower than readState.Index' (duration: 380.532µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:40:15.474645Z","caller":"traceutil/trace.go:171","msg":"trace[1921861762] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"200.200718ms","start":"2026-05-09T21:40:15.274414Z","end":"2026-05-09T21:40:15.474614Z","steps":["trace[1921861762] 'process raft request' (duration: 199.825777ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:15.47484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.223002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoypatchpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:20866"} {"level":"info","ts":"2026-05-09T21:40:15.474935Z","caller":"traceutil/trace.go:171","msg":"trace[1213199441] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoypatchpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:593; }","duration":"192.392518ms","start":"2026-05-09T21:40:15.282518Z","end":"2026-05-09T21:40:15.47491Z","steps":["trace[1213199441] 'agreement among raft nodes before linearized reading' (duration: 192.114489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:18.600579Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088156358952415965,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-09T21:40:18.774172Z","caller":"traceutil/trace.go:171","msg":"trace[633258862] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"674.129234ms","start":"2026-05-09T21:40:18.100017Z","end":"2026-05-09T21:40:18.774146Z","steps":["trace[633258862] 'read index received' (duration: 673.115974ms)","trace[633258862] 'applied index is now lower than readState.Index' (duration: 1.01209ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:40:18.774257Z","caller":"traceutil/trace.go:171","msg":"trace[382234030] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"700.329514ms","start":"2026-05-09T21:40:18.073893Z","end":"2026-05-09T21:40:18.774222Z","steps":["trace[382234030] 'process raft request' (duration: 699.407696ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:18.774382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.352022ms","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-05-09T21:40:18.774416Z","caller":"traceutil/trace.go:171","msg":"trace[1775757215] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:608; }","duration":"674.433554ms","start":"2026-05-09T21:40:18.099972Z","end":"2026-05-09T21:40:18.774405Z","steps":["trace[1775757215] 'agreement among raft nodes before linearized reading' (duration: 674.3031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:18.774433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:18.073858Z","time spent":"700.477858ms","remote":"127.0.0.1:43476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036157,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:40:18.774467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:18.099956Z","time spent":"674.502996ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-09T21:40:18.774756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.543886ms","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-05-09T21:40:18.774792Z","caller":"traceutil/trace.go:171","msg":"trace[664275884] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:608; }","duration":"105.621888ms","start":"2026-05-09T21:40:18.66916Z","end":"2026-05-09T21:40:18.774782Z","steps":["trace[664275884] 'agreement among raft nodes before linearized reading' (duration: 105.529705ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:19.381828Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088156358952415969,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:40:19.512998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.634411ms","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-05-09T21:40:19.513113Z","caller":"traceutil/trace.go:171","msg":"trace[73487346] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:608; }","duration":"581.768565ms","start":"2026-05-09T21:40:18.931326Z","end":"2026-05-09T21:40:19.513095Z","steps":["trace[73487346] 'range keys from in-memory index tree' (duration: 581.615191ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:19.517607Z","caller":"traceutil/trace.go:171","msg":"trace[1985119213] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"739.547144ms","start":"2026-05-09T21:40:18.778031Z","end":"2026-05-09T21:40:19.517578Z","steps":["trace[1985119213] 'process raft request' (duration: 739.42521ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:19.517752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:18.778011Z","time spent":"739.667457ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:40:19.51805Z","caller":"traceutil/trace.go:171","msg":"trace[1633610208] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:630; }","duration":"637.013866ms","start":"2026-05-09T21:40:18.881017Z","end":"2026-05-09T21:40:19.518031Z","steps":["trace[1633610208] 'read index received' (duration: 636.366316ms)","trace[1633610208] 'applied index is now lower than readState.Index' (duration: 646.96µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:40:19.518126Z","caller":"traceutil/trace.go:171","msg":"trace[639765077] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"737.549454ms","start":"2026-05-09T21:40:18.780563Z","end":"2026-05-09T21:40:19.518112Z","steps":["trace[639765077] 'process raft request' (duration: 737.345168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:19.518155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.127249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:19.518179Z","caller":"traceutil/trace.go:171","msg":"trace[537216896] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"637.203842ms","start":"2026-05-09T21:40:18.880969Z","end":"2026-05-09T21:40:19.518173Z","steps":["trace[537216896] 'agreement among raft nodes before linearized reading' (duration: 637.130939ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:19.518188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:18.780553Z","time spent":"737.602195ms","remote":"127.0.0.1:43658","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-05-09T21:40:19.518206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:18.88095Z","time spent":"637.250752ms","remote":"127.0.0.1:43366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-09T21:40:19.518398Z","caller":"traceutil/trace.go:171","msg":"trace[897924866] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"681.063895ms","start":"2026-05-09T21:40:18.837329Z","end":"2026-05-09T21:40:19.518393Z","steps":["trace[897924866] 'process raft request' (duration: 680.675054ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:19.518448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:18.837308Z","time spent":"681.109666ms","remote":"127.0.0.1:43712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:40:20.468505Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088156358952415980,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:40:20.472862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:20.076739Z","time spent":"396.11669ms","remote":"127.0.0.1:55974","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-09T21:40:20.490757Z","caller":"traceutil/trace.go:171","msg":"trace[1240975739] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"523.108955ms","start":"2026-05-09T21:40:19.967627Z","end":"2026-05-09T21:40:20.490736Z","steps":["trace[1240975739] 'read index received' (duration: 522.353233ms)","trace[1240975739] 'applied index is now lower than readState.Index' (duration: 754.772µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:40:20.490905Z","caller":"traceutil/trace.go:171","msg":"trace[1305958393] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"572.466657ms","start":"2026-05-09T21:40:19.918378Z","end":"2026-05-09T21:40:20.490845Z","steps":["trace[1305958393] 'process raft request' (duration: 571.831138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:20.491028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.064948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-84fqf\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-09T21:40:20.491096Z","caller":"traceutil/trace.go:171","msg":"trace[2022054637] range","detail":"{range_begin:/registry/pods/kube-system/cilium-84fqf; range_end:; response_count:1; response_revision:615; }","duration":"191.13239ms","start":"2026-05-09T21:40:20.29992Z","end":"2026-05-09T21:40:20.491053Z","steps":["trace[2022054637] 'agreement among raft nodes before linearized reading' (duration: 191.048477ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:20.490938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.301531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-09T21:40:20.491193Z","caller":"traceutil/trace.go:171","msg":"trace[1753864009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:615; }","duration":"523.597469ms","start":"2026-05-09T21:40:19.967573Z","end":"2026-05-09T21:40:20.491171Z","steps":["trace[1753864009] 'agreement among raft nodes before linearized reading' (duration: 523.258579ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:20.491248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:19.967553Z","time spent":"523.678482ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-09T21:40:20.491211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:19.91835Z","time spent":"572.642212ms","remote":"127.0.0.1:43476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:40:20.491219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.118549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-09T21:40:20.491331Z","caller":"traceutil/trace.go:171","msg":"trace[1592942312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:615; }","duration":"420.274403ms","start":"2026-05-09T21:40:20.071028Z","end":"2026-05-09T21:40:20.491302Z","steps":["trace[1592942312] 'agreement among raft nodes before linearized reading' (duration: 419.895872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:20.491394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:20.071009Z","time spent":"420.369496ms","remote":"127.0.0.1:43658","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-05-09T21:40:20.75433Z","caller":"traceutil/trace.go:171","msg":"trace[561174561] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"258.988492ms","start":"2026-05-09T21:40:20.495299Z","end":"2026-05-09T21:40:20.754287Z","steps":["trace[561174561] 'process raft request' (duration: 214.052585ms)","trace[561174561] 'compare' (duration: 44.814854ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:40:21.38118Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088156358952415983,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-09T21:40:21.544406Z","caller":"traceutil/trace.go:171","msg":"trace[1354839061] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"1.048205688s","start":"2026-05-09T21:40:20.496172Z","end":"2026-05-09T21:40:21.544378Z","steps":["trace[1354839061] 'process raft request' (duration: 1.034943627s)","trace[1354839061] 'compare' (duration: 13.102756ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:40:21.544563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:20.496155Z","time spent":"1.048327502s","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:40:21.585695Z","caller":"traceutil/trace.go:171","msg":"trace[1172451859] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"1.08136759s","start":"2026-05-09T21:40:20.504303Z","end":"2026-05-09T21:40:21.58567Z","steps":["trace[1172451859] 'process raft request' (duration: 1.081115042s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:21.585856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:20.504273Z","time spent":"1.081499693s","remote":"127.0.0.1:43576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:40:21.585924Z","caller":"traceutil/trace.go:171","msg":"trace[240315612] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"1.039056519s","start":"2026-05-09T21:40:20.546851Z","end":"2026-05-09T21:40:21.585907Z","steps":["trace[240315612] 'process raft request' (duration: 1.038750139s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:21.586047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.557679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:40:21.586056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:20.546832Z","time spent":"1.039147141s","remote":"127.0.0.1:43726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:40:21.586092Z","caller":"traceutil/trace.go:171","msg":"trace[1630525108] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"705.641912ms","start":"2026-05-09T21:40:20.880438Z","end":"2026-05-09T21:40:21.58608Z","steps":["trace[1630525108] 'agreement among raft nodes before linearized reading' (duration: 705.524759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:21.586123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:20.880418Z","time spent":"705.697504ms","remote":"127.0.0.1:43366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-09T21:40:21.585919Z","caller":"traceutil/trace.go:171","msg":"trace[1723496772] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:638; }","duration":"705.412466ms","start":"2026-05-09T21:40:20.880483Z","end":"2026-05-09T21:40:21.585896Z","steps":["trace[1723496772] 'read index received' (duration: 650.525266ms)","trace[1723496772] 'applied index is now lower than readState.Index' (duration: 54.88588ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:40:23.395716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.7402851s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:40:23.395816Z","caller":"traceutil/trace.go:171","msg":"trace[487148555] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:642; }","duration":"1.799467182s","start":"2026-05-09T21:40:21.596318Z","end":"2026-05-09T21:40:23.395785Z","steps":["trace[487148555] 'read index received' (duration: 20.713936ms)","trace[487148555] 'applied index is now lower than readState.Index' (duration: 1.778750576s)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:40:23.395913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.799590956s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.396013Z","caller":"traceutil/trace.go:171","msg":"trace[783339798] range","detail":"{range_begin:/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:621; }","duration":"1.799701558s","start":"2026-05-09T21:40:21.596301Z","end":"2026-05-09T21:40:23.396002Z","steps":["trace[783339798] 'agreement among raft nodes before linearized reading' (duration: 1.799561095s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.396039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:21.596291Z","time spent":"1.79974154s","remote":"127.0.0.1:43734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" "} {"level":"info","ts":"2026-05-09T21:40:23.395904Z","caller":"traceutil/trace.go:171","msg":"trace[921147579] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"1.804798036s","start":"2026-05-09T21:40:21.591064Z","end":"2026-05-09T21:40:23.395862Z","steps":["trace[921147579] 'process raft request' (duration: 64.209338ms)","trace[921147579] 'compare' (duration: 1.739747674s)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:40:23.396022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.515206443s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.396242Z","caller":"traceutil/trace.go:171","msg":"trace[996145267] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"1.51545068s","start":"2026-05-09T21:40:21.880763Z","end":"2026-05-09T21:40:23.396214Z","steps":["trace[996145267] 'agreement among raft nodes before linearized reading' (duration: 1.515219403s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.396272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:21.880739Z","time spent":"1.515526463s","remote":"127.0.0.1:43366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T21:40:23.39638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.944657ms","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-05-09T21:40:23.396438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.197204ms","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":"info","ts":"2026-05-09T21:40:23.396495Z","caller":"traceutil/trace.go:171","msg":"trace[936615002] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:621; }","duration":"459.254686ms","start":"2026-05-09T21:40:22.937225Z","end":"2026-05-09T21:40:23.39648Z","steps":["trace[936615002] 'agreement among raft nodes before linearized reading' (duration: 459.182434ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.396417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:21.591046Z","time spent":"1.805103796s","remote":"127.0.0.1:43658","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-05-09T21:40:23.396533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.937205Z","time spent":"459.318417ms","remote":"127.0.0.1:56022","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-05-09T21:40:23.396687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.510523ms","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-05-09T21:40:23.396704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.153462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.396727Z","caller":"traceutil/trace.go:171","msg":"trace[1056533822] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:621; }","duration":"132.179652ms","start":"2026-05-09T21:40:23.264541Z","end":"2026-05-09T21:40:23.39672Z","steps":["trace[1056533822] 'agreement among raft nodes before linearized reading' (duration: 132.142441ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:23.396723Z","caller":"traceutil/trace.go:171","msg":"trace[694592080] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:621; }","duration":"459.586335ms","start":"2026-05-09T21:40:22.937128Z","end":"2026-05-09T21:40:23.396714Z","steps":["trace[694592080] 'agreement among raft nodes before linearized reading' (duration: 459.519233ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.396753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.937112Z","time spent":"459.633676ms","remote":"127.0.0.1:56022","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-05-09T21:40:23.396844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.055687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.396869Z","caller":"traceutil/trace.go:171","msg":"trace[1744588374] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:621; }","duration":"133.110529ms","start":"2026-05-09T21:40:23.263749Z","end":"2026-05-09T21:40:23.39686Z","steps":["trace[1744588374] 'agreement among raft nodes before linearized reading' (duration: 133.078218ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.396884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.802014ms","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-05-09T21:40:23.396913Z","caller":"traceutil/trace.go:171","msg":"trace[1211547558] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:621; }","duration":"594.850995ms","start":"2026-05-09T21:40:22.802054Z","end":"2026-05-09T21:40:23.396905Z","steps":["trace[1211547558] 'agreement among raft nodes before linearized reading' (duration: 594.806264ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.396913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.647859ms","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-05-09T21:40:23.39694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.802046Z","time spent":"594.887507ms","remote":"127.0.0.1:56016","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":"warn","ts":"2026-05-09T21:40:23.396971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.784303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.396969Z","caller":"traceutil/trace.go:171","msg":"trace[342839455] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:621; }","duration":"294.727041ms","start":"2026-05-09T21:40:23.102227Z","end":"2026-05-09T21:40:23.396954Z","steps":["trace[342839455] 'agreement among raft nodes before linearized reading' (duration: 294.635548ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.396953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.601315ms","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-05-09T21:40:23.397025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.037319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:40:23.397035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.562589ms","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-05-09T21:40:23.397046Z","caller":"traceutil/trace.go:171","msg":"trace[269231832] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:621; }","duration":"440.082909ms","start":"2026-05-09T21:40:22.956956Z","end":"2026-05-09T21:40:23.397039Z","steps":["trace[269231832] 'agreement among raft nodes before linearized reading' (duration: 440.054798ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:23.397033Z","caller":"traceutil/trace.go:171","msg":"trace[2114258868] 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:621; }","duration":"681.708948ms","start":"2026-05-09T21:40:22.715308Z","end":"2026-05-09T21:40:23.397017Z","steps":["trace[2114258868] 'agreement among raft nodes before linearized reading' (duration: 681.562074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.39707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.956947Z","time spent":"440.117361ms","remote":"127.0.0.1:56026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-05-09T21:40:23.397073Z","caller":"traceutil/trace.go:171","msg":"trace[136802870] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:621; }","duration":"704.625361ms","start":"2026-05-09T21:40:22.692433Z","end":"2026-05-09T21:40:23.397058Z","steps":["trace[136802870] 'agreement among raft nodes before linearized reading' (duration: 704.581419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.397104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.715295Z","time spent":"681.79659ms","remote":"127.0.0.1:55986","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-05-09T21:40:23.397108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.692411Z","time spent":"704.688512ms","remote":"127.0.0.1:55980","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":"warn","ts":"2026-05-09T21:40:23.397157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.315929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.397203Z","caller":"traceutil/trace.go:171","msg":"trace[1921994182] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:621; }","duration":"174.390951ms","start":"2026-05-09T21:40:23.222802Z","end":"2026-05-09T21:40:23.397193Z","steps":["trace[1921994182] 'agreement among raft nodes before linearized reading' (duration: 174.319879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.397229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.438719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.397252Z","caller":"traceutil/trace.go:171","msg":"trace[1530195881] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:621; }","duration":"440.46152ms","start":"2026-05-09T21:40:22.956782Z","end":"2026-05-09T21:40:23.397244Z","steps":["trace[1530195881] 'agreement among raft nodes before linearized reading' (duration: 440.407108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.397297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.95676Z","time spent":"440.511661ms","remote":"127.0.0.1:56026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:40:23.397349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.347648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.397385Z","caller":"traceutil/trace.go:171","msg":"trace[1943163547] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:621; }","duration":"175.3918ms","start":"2026-05-09T21:40:23.221985Z","end":"2026-05-09T21:40:23.397376Z","steps":["trace[1943163547] 'agreement among raft nodes before linearized reading' (duration: 175.338249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.396984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.315091ms","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":"info","ts":"2026-05-09T21:40:23.397466Z","caller":"traceutil/trace.go:171","msg":"trace[408218618] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:621; }","duration":"704.841616ms","start":"2026-05-09T21:40:22.692591Z","end":"2026-05-09T21:40:23.397433Z","steps":["trace[408218618] 'agreement among raft nodes before linearized reading' (duration: 704.325022ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.397499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.69257Z","time spent":"704.920039ms","remote":"127.0.0.1:55980","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-05-09T21:40:23.397524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.581366ms","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-05-09T21:40:23.397538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.867742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:40:23.397546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.018538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.397652Z","caller":"traceutil/trace.go:171","msg":"trace[95347036] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:621; }","duration":"596.264915ms","start":"2026-05-09T21:40:22.801372Z","end":"2026-05-09T21:40:23.397636Z","steps":["trace[95347036] 'agreement among raft nodes before linearized reading' (duration: 595.996677ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.397727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.801354Z","time spent":"596.357969ms","remote":"127.0.0.1:56016","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-05-09T21:40:23.397824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.903983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.397858Z","caller":"traceutil/trace.go:171","msg":"trace[1370732292] 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:621; }","duration":"681.949875ms","start":"2026-05-09T21:40:22.7159Z","end":"2026-05-09T21:40:23.39785Z","steps":["trace[1370732292] 'agreement among raft nodes before linearized reading' (duration: 681.899684ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:23.396449Z","caller":"traceutil/trace.go:171","msg":"trace[1366860620] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:621; }","duration":"459.009229ms","start":"2026-05-09T21:40:22.937405Z","end":"2026-05-09T21:40:23.396415Z","steps":["trace[1366860620] 'agreement among raft nodes before linearized reading' (duration: 458.914476ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.397888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.715895Z","time spent":"681.985916ms","remote":"127.0.0.1:55986","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":"warn","ts":"2026-05-09T21:40:23.397905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.9374Z","time spent":"460.49024ms","remote":"127.0.0.1:56022","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-05-09T21:40:23.397948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.234337ms","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-05-09T21:40:23.396994Z","caller":"traceutil/trace.go:171","msg":"trace[1959080838] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:621; }","duration":"294.810184ms","start":"2026-05-09T21:40:23.102178Z","end":"2026-05-09T21:40:23.396988Z","steps":["trace[1959080838] 'agreement among raft nodes before linearized reading' (duration: 294.773803ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.398035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.317733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:40:23.398056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.194186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-09T21:40:23.398063Z","caller":"traceutil/trace.go:171","msg":"trace[84622282] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:621; }","duration":"134.374535ms","start":"2026-05-09T21:40:23.26368Z","end":"2026-05-09T21:40:23.398055Z","steps":["trace[84622282] 'agreement among raft nodes before linearized reading' (duration: 134.333584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.39811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.071751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.398131Z","caller":"traceutil/trace.go:171","msg":"trace[1576583816] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:621; }","duration":"654.115013ms","start":"2026-05-09T21:40:22.744011Z","end":"2026-05-09T21:40:23.398126Z","steps":["trace[1576583816] 'agreement among raft nodes before linearized reading' (duration: 654.083752ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.398151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.743993Z","time spent":"654.153334ms","remote":"127.0.0.1:56002","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-05-09T21:40:23.398081Z","caller":"traceutil/trace.go:171","msg":"trace[1073756880] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:621; }","duration":"640.243828ms","start":"2026-05-09T21:40:22.75783Z","end":"2026-05-09T21:40:23.398074Z","steps":["trace[1073756880] 'agreement among raft nodes before linearized reading' (duration: 640.144425ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.398196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.78985ms","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-05-09T21:40:23.398236Z","caller":"traceutil/trace.go:171","msg":"trace[2106572135] 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:621; }","duration":"682.842761ms","start":"2026-05-09T21:40:22.715384Z","end":"2026-05-09T21:40:23.398227Z","steps":["trace[2106572135] 'agreement among raft nodes before linearized reading' (duration: 682.785629ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.39826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.242106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.397605Z","caller":"traceutil/trace.go:171","msg":"trace[633268350] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:621; }","duration":"440.938444ms","start":"2026-05-09T21:40:22.956651Z","end":"2026-05-09T21:40:23.39759Z","steps":["trace[633268350] 'agreement among raft nodes before linearized reading' (duration: 440.839211ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.398274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.715378Z","time spent":"682.887452ms","remote":"127.0.0.1:55986","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-05-09T21:40:23.398244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.757813Z","time spent":"640.417692ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-09T21:40:23.397485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.094254ms","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":"warn","ts":"2026-05-09T21:40:23.398309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.319528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.398329Z","caller":"traceutil/trace.go:171","msg":"trace[951691572] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:621; }","duration":"654.337608ms","start":"2026-05-09T21:40:22.743984Z","end":"2026-05-09T21:40:23.398321Z","steps":["trace[951691572] 'agreement among raft nodes before linearized reading' (duration: 654.311138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.397961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.561064ms","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-05-09T21:40:23.398337Z","caller":"traceutil/trace.go:171","msg":"trace[749766066] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:621; }","duration":"705.983588ms","start":"2026-05-09T21:40:22.692336Z","end":"2026-05-09T21:40:23.39832Z","steps":["trace[749766066] 'agreement among raft nodes before linearized reading' (duration: 705.087413ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.398355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.743947Z","time spent":"654.40237ms","remote":"127.0.0.1:56002","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"info","ts":"2026-05-09T21:40:23.398281Z","caller":"traceutil/trace.go:171","msg":"trace[1251440320] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:621; }","duration":"654.276717ms","start":"2026-05-09T21:40:22.743998Z","end":"2026-05-09T21:40:23.398274Z","steps":["trace[1251440320] 'agreement among raft nodes before linearized reading' (duration: 654.243216ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:23.398364Z","caller":"traceutil/trace.go:171","msg":"trace[1465459920] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:621; }","duration":"597.015676ms","start":"2026-05-09T21:40:22.801336Z","end":"2026-05-09T21:40:23.398352Z","steps":["trace[1465459920] 'agreement among raft nodes before linearized reading' (duration: 596.608495ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.398387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.743988Z","time spent":"654.38869ms","remote":"127.0.0.1:56002","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-09T21:40:23.398317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.956639Z","time spent":"441.654084ms","remote":"127.0.0.1:56026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T21:40:23.398406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.801309Z","time spent":"597.087328ms","remote":"127.0.0.1:56016","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":"warn","ts":"2026-05-09T21:40:23.398388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:22.692315Z","time spent":"706.055381ms","remote":"127.0.0.1:55980","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":"info","ts":"2026-05-09T21:40:23.397552Z","caller":"traceutil/trace.go:171","msg":"trace[1766879641] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:621; }","duration":"175.634598ms","start":"2026-05-09T21:40:23.22191Z","end":"2026-05-09T21:40:23.397545Z","steps":["trace[1766879641] 'agreement among raft nodes before linearized reading' (duration: 175.590947ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:23.397994Z","caller":"traceutil/trace.go:171","msg":"trace[649051627] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:621; }","duration":"158.300339ms","start":"2026-05-09T21:40:23.239683Z","end":"2026-05-09T21:40:23.397983Z","steps":["trace[649051627] 'agreement among raft nodes before linearized reading' (duration: 158.231727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.398743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.315067ms","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":"info","ts":"2026-05-09T21:40:23.398806Z","caller":"traceutil/trace.go:171","msg":"trace[1750970107] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:621; }","duration":"159.384858ms","start":"2026-05-09T21:40:23.239402Z","end":"2026-05-09T21:40:23.398787Z","steps":["trace[1750970107] 'agreement among raft nodes before linearized reading' (duration: 159.309616ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.398807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.45443ms","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-05-09T21:40:23.39885Z","caller":"traceutil/trace.go:171","msg":"trace[870794545] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:621; }","duration":"159.518233ms","start":"2026-05-09T21:40:23.23932Z","end":"2026-05-09T21:40:23.398838Z","steps":["trace[870794545] 'agreement among raft nodes before linearized reading' (duration: 157.535347ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:23.562827Z","caller":"traceutil/trace.go:171","msg":"trace[1149380609] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"154.526554ms","start":"2026-05-09T21:40:23.408276Z","end":"2026-05-09T21:40:23.562802Z","steps":["trace[1149380609] 'read index received' (duration: 146.208289ms)","trace[1149380609] 'applied index is now lower than readState.Index' (duration: 8.317255ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:40:23.562891Z","caller":"traceutil/trace.go:171","msg":"trace[1168682431] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"155.533741ms","start":"2026-05-09T21:40:23.407336Z","end":"2026-05-09T21:40:23.56287Z","steps":["trace[1168682431] 'process raft request' (duration: 147.180115ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.563031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.179231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.563141Z","caller":"traceutil/trace.go:171","msg":"trace[1838126074] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:622; }","duration":"139.342566ms","start":"2026-05-09T21:40:23.423782Z","end":"2026-05-09T21:40:23.563124Z","steps":["trace[1838126074] 'agreement among raft nodes before linearized reading' (duration: 139.173551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.563278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.433004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.563351Z","caller":"traceutil/trace.go:171","msg":"trace[2011641865] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:622; }","duration":"108.504866ms","start":"2026-05-09T21:40:23.454831Z","end":"2026-05-09T21:40:23.563336Z","steps":["trace[2011641865] 'agreement among raft nodes before linearized reading' (duration: 108.253329ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.563397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.734633ms","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-05-09T21:40:23.56342Z","caller":"traceutil/trace.go:171","msg":"trace[490957355] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:622; }","duration":"108.760993ms","start":"2026-05-09T21:40:23.454653Z","end":"2026-05-09T21:40:23.563414Z","steps":["trace[490957355] 'agreement among raft nodes before linearized reading' (duration: 108.727393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.563502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.701312ms","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-05-09T21:40:23.563522Z","caller":"traceutil/trace.go:171","msg":"trace[1454004632] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:622; }","duration":"108.761284ms","start":"2026-05-09T21:40:23.454753Z","end":"2026-05-09T21:40:23.563514Z","steps":["trace[1454004632] 'agreement among raft nodes before linearized reading' (duration: 108.735694ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.56304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.74402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.563646Z","caller":"traceutil/trace.go:171","msg":"trace[1876750128] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"155.384197ms","start":"2026-05-09T21:40:23.408256Z","end":"2026-05-09T21:40:23.56364Z","steps":["trace[1876750128] 'agreement among raft nodes before linearized reading' (duration: 154.722239ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:23.563634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.761827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:23.563725Z","caller":"traceutil/trace.go:171","msg":"trace[1590022401] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:622; }","duration":"139.87547ms","start":"2026-05-09T21:40:23.423841Z","end":"2026-05-09T21:40:23.563716Z","steps":["trace[1590022401] 'agreement among raft nodes before linearized reading' (duration: 139.753456ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:24.690893Z","caller":"traceutil/trace.go:171","msg":"trace[482687112] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"214.908499ms","start":"2026-05-09T21:40:24.475954Z","end":"2026-05-09T21:40:24.690862Z","steps":["trace[482687112] 'process raft request' (duration: 212.636117ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:26.509467Z","caller":"traceutil/trace.go:171","msg":"trace[157157161] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"167.139191ms","start":"2026-05-09T21:40:26.34229Z","end":"2026-05-09T21:40:26.509429Z","steps":["trace[157157161] 'process raft request' (duration: 166.950096ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:28.305873Z","caller":"traceutil/trace.go:171","msg":"trace[322927738] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"190.841002ms","start":"2026-05-09T21:40:28.114984Z","end":"2026-05-09T21:40:28.305825Z","steps":["trace[322927738] 'process raft request' (duration: 141.681588ms)","trace[322927738] 'compare' (duration: 48.929298ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:40:29.071015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.444629ms","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-05-09T21:40:29.071142Z","caller":"traceutil/trace.go:171","msg":"trace[1327933318] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:709; }","duration":"139.586343ms","start":"2026-05-09T21:40:28.931538Z","end":"2026-05-09T21:40:29.071124Z","steps":["trace[1327933318] 'range keys from in-memory index tree' (duration: 139.429979ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:29.12876Z","caller":"traceutil/trace.go:171","msg":"trace[1188468733] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:733; }","duration":"249.560167ms","start":"2026-05-09T21:40:28.87917Z","end":"2026-05-09T21:40:29.12873Z","steps":["trace[1188468733] 'read index received' (duration: 249.272319ms)","trace[1188468733] 'applied index is now lower than readState.Index' (duration: 286.858µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:40:29.128828Z","caller":"traceutil/trace.go:171","msg":"trace[809001276] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"330.459349ms","start":"2026-05-09T21:40:28.798345Z","end":"2026-05-09T21:40:29.128805Z","steps":["trace[809001276] 'process raft request' (duration: 330.14305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:29.128894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.71094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:29.128927Z","caller":"traceutil/trace.go:171","msg":"trace[1603583999] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:710; }","duration":"249.787432ms","start":"2026-05-09T21:40:28.879129Z","end":"2026-05-09T21:40:29.128916Z","steps":["trace[1603583999] 'agreement among raft nodes before linearized reading' (duration: 249.719321ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:29.128995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:28.798309Z","time spent":"330.595902ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:40:29.158182Z","caller":"traceutil/trace.go:171","msg":"trace[831859357] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"272.015798ms","start":"2026-05-09T21:40:28.886145Z","end":"2026-05-09T21:40:29.158161Z","steps":["trace[831859357] 'process raft request' (duration: 271.444432ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:39.344413Z","caller":"traceutil/trace.go:171","msg":"trace[309893583] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"132.269357ms","start":"2026-05-09T21:40:39.212121Z","end":"2026-05-09T21:40:39.34439Z","steps":["trace[309893583] 'process raft request' (duration: 132.130743ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:53.789328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.342344ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:40:53.789406Z","caller":"traceutil/trace.go:171","msg":"trace[1693065605] linearizableReadLoop","detail":"{readStateIndex:984; appliedIndex:983; }","duration":"235.221158ms","start":"2026-05-09T21:40:53.554173Z","end":"2026-05-09T21:40:53.789394Z","steps":["trace[1693065605] 'read index received' (duration: 64.818633ms)","trace[1693065605] 'applied index is now lower than readState.Index' (duration: 170.401464ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:40:53.789479Z","caller":"traceutil/trace.go:171","msg":"trace[224903079] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"320.832738ms","start":"2026-05-09T21:40:53.468634Z","end":"2026-05-09T21:40:53.789467Z","steps":["trace[224903079] 'process raft request' (duration: 150.289531ms)","trace[224903079] 'compare' (duration: 170.273332ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:40:53.789525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.468622Z","time spent":"320.87925ms","remote":"127.0.0.1:43576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3702,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:40:53.790054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.870502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-09T21:40:53.79027Z","caller":"traceutil/trace.go:171","msg":"trace[278360733] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:953; }","duration":"236.119486ms","start":"2026-05-09T21:40:53.554128Z","end":"2026-05-09T21:40:53.790247Z","steps":["trace[278360733] 'agreement among raft nodes before linearized reading' (duration: 235.81814ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:54.354533Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088156358952416633,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-09T21:40:54.38239Z","caller":"traceutil/trace.go:171","msg":"trace[251852207] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"587.575729ms","start":"2026-05-09T21:40:53.794776Z","end":"2026-05-09T21:40:54.382352Z","steps":["trace[251852207] 'process raft request' (duration: 570.072694ms)","trace[251852207] 'compare' (duration: 17.144147ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:40:54.38262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.794753Z","time spent":"587.765653ms","remote":"127.0.0.1:43658","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-05-09T21:40:54.474699Z","caller":"traceutil/trace.go:171","msg":"trace[2107932066] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"678.718849ms","start":"2026-05-09T21:40:53.795963Z","end":"2026-05-09T21:40:54.474682Z","steps":["trace[2107932066] 'process raft request' (duration: 678.610446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:54.474819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.795952Z","time spent":"678.80669ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:40:54.475001Z","caller":"traceutil/trace.go:171","msg":"trace[919718056] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"678.970773ms","start":"2026-05-09T21:40:53.795994Z","end":"2026-05-09T21:40:54.474964Z","steps":["trace[919718056] 'process raft request' (duration: 678.663817ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:54.475149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.79598Z","time spent":"679.090917ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:40:54.475245Z","caller":"traceutil/trace.go:171","msg":"trace[1617175741] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"678.668819ms","start":"2026-05-09T21:40:53.796568Z","end":"2026-05-09T21:40:54.475237Z","steps":["trace[1617175741] 'process raft request' (duration: 678.318171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:54.475286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.796552Z","time spent":"678.715049ms","remote":"127.0.0.1:43658","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-05-09T21:40:54.47534Z","caller":"traceutil/trace.go:171","msg":"trace[1624487265] linearizableReadLoop","detail":"{readStateIndex:989; appliedIndex:984; }","duration":"621.341793ms","start":"2026-05-09T21:40:53.853993Z","end":"2026-05-09T21:40:54.475335Z","steps":["trace[1624487265] 'read index received' (duration: 510.860319ms)","trace[1624487265] 'applied index is now lower than readState.Index' (duration: 110.480874ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:40:54.475386Z","caller":"traceutil/trace.go:171","msg":"trace[1724371163] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"677.380501ms","start":"2026-05-09T21:40:53.798002Z","end":"2026-05-09T21:40:54.475383Z","steps":["trace[1724371163] 'process raft request' (duration: 677.130496ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:54.475415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.797988Z","time spent":"677.411362ms","remote":"127.0.0.1:43852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3297,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:40:54.475519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.554777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-q5g4k\" ","response":"range_response_count:1 size:5673"} {"level":"info","ts":"2026-05-09T21:40:54.475541Z","caller":"traceutil/trace.go:171","msg":"trace[1513167317] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-q5g4k; range_end:; response_count:1; response_revision:958; }","duration":"621.611568ms","start":"2026-05-09T21:40:53.853923Z","end":"2026-05-09T21:40:54.475534Z","steps":["trace[1513167317] 'agreement among raft nodes before linearized reading' (duration: 621.529346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:54.475555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.853903Z","time spent":"621.649119ms","remote":"127.0.0.1:43576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":5696,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-q5g4k\" "} {"level":"warn","ts":"2026-05-09T21:40:54.475642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.972256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:40:54.475648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.913229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:40:54.475737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.242087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:54.47575Z","caller":"traceutil/trace.go:171","msg":"trace[2051900615] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:958; }","duration":"568.064962ms","start":"2026-05-09T21:40:53.907668Z","end":"2026-05-09T21:40:54.475733Z","steps":["trace[2051900615] 'agreement among raft nodes before linearized reading' (duration: 567.904749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:54.475758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.947511ms","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-05-09T21:40:54.475771Z","caller":"traceutil/trace.go:171","msg":"trace[1430224465] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:958; }","duration":"540.288067ms","start":"2026-05-09T21:40:53.935474Z","end":"2026-05-09T21:40:54.475762Z","steps":["trace[1430224465] 'agreement among raft nodes before linearized reading' (duration: 540.241796ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:54.475782Z","caller":"traceutil/trace.go:171","msg":"trace[1941311212] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:958; }","duration":"540.984172ms","start":"2026-05-09T21:40:53.934792Z","end":"2026-05-09T21:40:54.475776Z","steps":["trace[1941311212] 'agreement among raft nodes before linearized reading' (duration: 540.944811ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:54.475807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.934787Z","time spent":"541.015542ms","remote":"127.0.0.1:45380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:40:54.475808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.935468Z","time spent":"540.332098ms","remote":"127.0.0.1:45380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "} {"level":"warn","ts":"2026-05-09T21:40:54.475945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.161585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:54.475977Z","caller":"traceutil/trace.go:171","msg":"trace[1235311528] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:958; }","duration":"541.212686ms","start":"2026-05-09T21:40:53.934757Z","end":"2026-05-09T21:40:54.475969Z","steps":["trace[1235311528] 'agreement among raft nodes before linearized reading' (duration: 541.123384ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:54.476006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.934748Z","time spent":"541.250177ms","remote":"127.0.0.1:45380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T21:40:54.47604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.162291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:54.476064Z","caller":"traceutil/trace.go:171","msg":"trace[181536648] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:958; }","duration":"556.199841ms","start":"2026-05-09T21:40:53.919858Z","end":"2026-05-09T21:40:54.476058Z","steps":["trace[181536648] 'agreement among raft nodes before linearized reading' (duration: 556.162711ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:54.476082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.919851Z","time spent":"556.223382ms","remote":"127.0.0.1:45376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T21:40:54.476164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.833274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:54.476181Z","caller":"traceutil/trace.go:171","msg":"trace[239390085] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:958; }","duration":"555.875715ms","start":"2026-05-09T21:40:53.920302Z","end":"2026-05-09T21:40:54.476177Z","steps":["trace[239390085] 'agreement among raft nodes before linearized reading' (duration: 555.850274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:54.476196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.920287Z","time spent":"555.904256ms","remote":"127.0.0.1:45376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:40:54.476308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.0693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:54.47635Z","caller":"traceutil/trace.go:171","msg":"trace[405149160] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:958; }","duration":"567.127882ms","start":"2026-05-09T21:40:53.90921Z","end":"2026-05-09T21:40:54.476338Z","steps":["trace[405149160] 'agreement among raft nodes before linearized reading' (duration: 567.064951ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:54.476381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.184944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:40:54.476409Z","caller":"traceutil/trace.go:171","msg":"trace[1031166300] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:958; }","duration":"567.248025ms","start":"2026-05-09T21:40:53.909152Z","end":"2026-05-09T21:40:54.4764Z","steps":["trace[1031166300] 'agreement among raft nodes before linearized reading' (duration: 567.212534ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:54.476443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.90913Z","time spent":"567.304066ms","remote":"127.0.0.1:45366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"info","ts":"2026-05-09T21:40:54.475695Z","caller":"traceutil/trace.go:171","msg":"trace[147212667] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:958; }","duration":"555.042698ms","start":"2026-05-09T21:40:53.920638Z","end":"2026-05-09T21:40:54.475681Z","steps":["trace[147212667] 'agreement among raft nodes before linearized reading' (duration: 554.968176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:54.477501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.92063Z","time spent":"556.849965ms","remote":"127.0.0.1:45376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-09T21:40:54.477888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.907648Z","time spent":"570.198507ms","remote":"127.0.0.1:45366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T21:40:54.480116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:53.909205Z","time spent":"567.169364ms","remote":"127.0.0.1:45366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "} {"level":"info","ts":"2026-05-09T21:40:54.596881Z","caller":"traceutil/trace.go:171","msg":"trace[2014267080] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"114.661041ms","start":"2026-05-09T21:40:54.482194Z","end":"2026-05-09T21:40:54.596855Z","steps":["trace[2014267080] 'process raft request' (duration: 114.456836ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:54.7802Z","caller":"traceutil/trace.go:171","msg":"trace[1780870359] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"293.725943ms","start":"2026-05-09T21:40:54.486457Z","end":"2026-05-09T21:40:54.780183Z","steps":["trace[1780870359] 'process raft request' (duration: 293.686053ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:54.780216Z","caller":"traceutil/trace.go:171","msg":"trace[2065566135] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"296.720056ms","start":"2026-05-09T21:40:54.483474Z","end":"2026-05-09T21:40:54.780194Z","steps":["trace[2065566135] 'process raft request' (duration: 296.561342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:55.73599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.739741ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:40:55.736112Z","caller":"traceutil/trace.go:171","msg":"trace[1547014583] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"249.408565ms","start":"2026-05-09T21:40:55.486685Z","end":"2026-05-09T21:40:55.736093Z","steps":["trace[1547014583] 'process raft request' (duration: 59.48281ms)","trace[1547014583] 'compare' (duration: 189.628789ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:40:55.938663Z","caller":"traceutil/trace.go:171","msg":"trace[1093331018] linearizableReadLoop","detail":"{readStateIndex:1002; appliedIndex:1000; }","duration":"449.459289ms","start":"2026-05-09T21:40:55.489177Z","end":"2026-05-09T21:40:55.938636Z","steps":["trace[1093331018] 'read index received' (duration: 57.12552ms)","trace[1093331018] 'applied index is now lower than readState.Index' (duration: 392.332809ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:40:55.938832Z","caller":"traceutil/trace.go:171","msg":"trace[57676840] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"449.723976ms","start":"2026-05-09T21:40:55.489073Z","end":"2026-05-09T21:40:55.938797Z","steps":["trace[57676840] 'process raft request' (duration: 400.137131ms)","trace[57676840] 'compare' (duration: 49.231497ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:40:55.938923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.724606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-4cr48\" ","response":"range_response_count:1 size:5071"} {"level":"warn","ts":"2026-05-09T21:40:55.938946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.153338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-05-09T21:40:55.938998Z","caller":"traceutil/trace.go:171","msg":"trace[448109373] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-4cr48; range_end:; response_count:1; response_revision:970; }","duration":"449.819337ms","start":"2026-05-09T21:40:55.489158Z","end":"2026-05-09T21:40:55.938977Z","steps":["trace[448109373] 'agreement among raft nodes before linearized reading' (duration: 449.628943ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:55.939168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:55.48915Z","time spent":"450.004751ms","remote":"127.0.0.1:43576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5094,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-4cr48\" "} {"level":"warn","ts":"2026-05-09T21:40:55.938995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:55.489061Z","time spent":"449.843798ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:40:55.939009Z","caller":"traceutil/trace.go:171","msg":"trace[1929665202] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:970; }","duration":"201.25394ms","start":"2026-05-09T21:40:55.737736Z","end":"2026-05-09T21:40:55.93899Z","steps":["trace[1929665202] 'agreement among raft nodes before linearized reading' (duration: 201.137988ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:41:10.680002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.454474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-09T21:41:10.68008Z","caller":"traceutil/trace.go:171","msg":"trace[803536137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1022; }","duration":"123.568136ms","start":"2026-05-09T21:41:10.556494Z","end":"2026-05-09T21:41:10.680062Z","steps":["trace[803536137] 'agreement among raft nodes before linearized reading' (duration: 91.366728ms)","trace[803536137] 'range keys from in-memory index tree' (duration: 32.025255ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:41:13.011331Z","caller":"traceutil/trace.go:171","msg":"trace[1591345451] linearizableReadLoop","detail":"{readStateIndex:1063; appliedIndex:1062; }","duration":"359.256128ms","start":"2026-05-09T21:41:12.652051Z","end":"2026-05-09T21:41:13.011307Z","steps":["trace[1591345451] 'read index received' (duration: 359.171177ms)","trace[1591345451] 'applied index is now lower than readState.Index' (duration: 83.701µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:41:13.011454Z","caller":"traceutil/trace.go:171","msg":"trace[452961114] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"449.38462ms","start":"2026-05-09T21:41:12.562011Z","end":"2026-05-09T21:41:13.011395Z","steps":["trace[452961114] 'process raft request' (duration: 449.147595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:41:13.011557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.502623ms","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-05-09T21:41:13.011593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:41:12.561996Z","time spent":"449.523692ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:41:13.011621Z","caller":"traceutil/trace.go:171","msg":"trace[372726628] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1027; }","duration":"359.602695ms","start":"2026-05-09T21:41:12.651997Z","end":"2026-05-09T21:41:13.0116Z","steps":["trace[372726628] 'agreement among raft nodes before linearized reading' (duration: 359.434932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:41:13.011666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:41:12.651979Z","time spent":"359.677946ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-09T21:41:13.141809Z","caller":"traceutil/trace.go:171","msg":"trace[1501992287] linearizableReadLoop","detail":"{readStateIndex:1064; appliedIndex:1063; }","duration":"130.382266ms","start":"2026-05-09T21:41:13.011407Z","end":"2026-05-09T21:41:13.14179Z","steps":["trace[1501992287] 'read index received' (duration: 62.731498ms)","trace[1501992287] 'applied index is now lower than readState.Index' (duration: 67.649868ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:41:13.141822Z","caller":"traceutil/trace.go:171","msg":"trace[1196997911] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"457.538998ms","start":"2026-05-09T21:41:12.684252Z","end":"2026-05-09T21:41:13.141791Z","steps":["trace[1196997911] 'process raft request' (duration: 389.89007ms)","trace[1196997911] 'compare' (duration: 67.494886ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:41:13.141917Z","caller":"traceutil/trace.go:171","msg":"trace[187769303] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"126.362295ms","start":"2026-05-09T21:41:13.015542Z","end":"2026-05-09T21:41:13.141905Z","steps":["trace[187769303] 'process raft request' (duration: 126.213553ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:41:13.141988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.349754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:41:13.142049Z","caller":"traceutil/trace.go:171","msg":"trace[47823229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1029; }","duration":"264.449846ms","start":"2026-05-09T21:41:12.877585Z","end":"2026-05-09T21:41:13.142035Z","steps":["trace[47823229] 'agreement among raft nodes before linearized reading' (duration: 264.246573ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:41:13.142207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:41:12.684221Z","time spent":"457.675761ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:41:13.142238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.663822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:1 size:224"} {"level":"info","ts":"2026-05-09T21:41:13.142322Z","caller":"traceutil/trace.go:171","msg":"trace[1299169329] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:1029; }","duration":"139.799115ms","start":"2026-05-09T21:41:13.002502Z","end":"2026-05-09T21:41:13.142301Z","steps":["trace[1299169329] 'agreement among raft nodes before linearized reading' (duration: 139.310067ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:41:13.142511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.241185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-09T21:41:13.142566Z","caller":"traceutil/trace.go:171","msg":"trace[742526764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1029; }","duration":"446.372167ms","start":"2026-05-09T21:41:12.696178Z","end":"2026-05-09T21:41:13.142551Z","steps":["trace[742526764] 'agreement among raft nodes before linearized reading' (duration: 445.693106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:41:13.142605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:41:12.696166Z","time spent":"446.430128ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-09T21:41:13.338181Z","caller":"traceutil/trace.go:171","msg":"trace[118909236] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"140.362725ms","start":"2026-05-09T21:41:13.197794Z","end":"2026-05-09T21:41:13.338157Z","steps":["trace[118909236] 'process raft request' (duration: 139.751113ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:25.202979Z","caller":"traceutil/trace.go:171","msg":"trace[1334847602] linearizableReadLoop","detail":"{readStateIndex:1358; appliedIndex:1357; }","duration":"167.198554ms","start":"2026-05-09T21:42:25.035758Z","end":"2026-05-09T21:42:25.202957Z","steps":["trace[1334847602] 'read index received' (duration: 167.066433ms)","trace[1334847602] 'applied index is now lower than readState.Index' (duration: 130.951µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:42:25.203033Z","caller":"traceutil/trace.go:171","msg":"trace[277027666] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"277.763644ms","start":"2026-05-09T21:42:24.925238Z","end":"2026-05-09T21:42:25.203001Z","steps":["trace[277027666] 'process raft request' (duration: 277.572522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:25.203154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.371826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:25.203221Z","caller":"traceutil/trace.go:171","msg":"trace[1758731260] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1307; }","duration":"167.494698ms","start":"2026-05-09T21:42:25.03571Z","end":"2026-05-09T21:42:25.203205Z","steps":["trace[1758731260] 'agreement among raft nodes before linearized reading' (duration: 167.373487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:25.203408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.974137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:25.203475Z","caller":"traceutil/trace.go:171","msg":"trace[807954133] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1307; }","duration":"164.061888ms","start":"2026-05-09T21:42:25.039397Z","end":"2026-05-09T21:42:25.203459Z","steps":["trace[807954133] 'agreement among raft nodes before linearized reading' (duration: 163.714533ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:25.692072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.322392ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-05-09T21:42:25.692349Z","caller":"traceutil/trace.go:171","msg":"trace[1793509384] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1359; }","duration":"131.966222ms","start":"2026-05-09T21:42:25.560362Z","end":"2026-05-09T21:42:25.692329Z","steps":["trace[1793509384] 'read index received' (duration: 22.465319ms)","trace[1793509384] 'applied index is now lower than readState.Index' (duration: 109.499843ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:42:25.692569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.197745ms","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-05-09T21:42:25.692594Z","caller":"traceutil/trace.go:171","msg":"trace[2005254204] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"200.815668ms","start":"2026-05-09T21:42:25.491757Z","end":"2026-05-09T21:42:25.692573Z","steps":["trace[2005254204] 'process raft request' (duration: 200.428774ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:25.69264Z","caller":"traceutil/trace.go:171","msg":"trace[2096016577] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1309; }","duration":"132.316478ms","start":"2026-05-09T21:42:25.560309Z","end":"2026-05-09T21:42:25.692625Z","steps":["trace[2096016577] 'agreement among raft nodes before linearized reading' (duration: 132.134036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:26.096617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.863706ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:42:26.096913Z","caller":"traceutil/trace.go:171","msg":"trace[2118689640] linearizableReadLoop","detail":"{readStateIndex:1364; appliedIndex:1361; }","duration":"215.676874ms","start":"2026-05-09T21:42:25.881217Z","end":"2026-05-09T21:42:26.096894Z","steps":["trace[2118689640] 'read index received' (duration: 54.494984ms)","trace[2118689640] 'applied index is now lower than readState.Index' (duration: 161.18105ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:42:26.096887Z","caller":"traceutil/trace.go:171","msg":"trace[145296642] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"403.65865ms","start":"2026-05-09T21:42:25.693154Z","end":"2026-05-09T21:42:26.096813Z","steps":["trace[145296642] 'process raft request' (duration: 242.51946ms)","trace[145296642] 'compare' (duration: 160.552603ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:42:26.096996Z","caller":"traceutil/trace.go:171","msg":"trace[1802235798] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"400.572203ms","start":"2026-05-09T21:42:25.696387Z","end":"2026-05-09T21:42:26.09696Z","steps":["trace[1802235798] 'process raft request' (duration: 400.33644ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:26.097064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.850726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:26.097068Z","caller":"traceutil/trace.go:171","msg":"trace[1804159156] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"400.638844ms","start":"2026-05-09T21:42:25.696397Z","end":"2026-05-09T21:42:26.097036Z","steps":["trace[1804159156] 'process raft request' (duration: 400.435421ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:26.097096Z","caller":"traceutil/trace.go:171","msg":"trace[889557651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1312; }","duration":"215.930367ms","start":"2026-05-09T21:42:25.881154Z","end":"2026-05-09T21:42:26.097085Z","steps":["trace[889557651] 'agreement among raft nodes before linearized reading' (duration: 215.812666ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:26.097134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:25.69314Z","time spent":"403.851972ms","remote":"127.0.0.1:43424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:42:26.097158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:25.696374Z","time spent":"400.700834ms","remote":"127.0.0.1:43658","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-05-09T21:42:26.097278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:25.696372Z","time spent":"400.762525ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}