{"level":"warn","ts":"2026-04-21T17:10:33.407934Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-21T17:10:33.408025Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-21T17:10:33.40809Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-21T17:10:33.408098Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-04-21T17:10:33.408114Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-21T17:10:33.408826Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-04-21T17:10:33.408929Z","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.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-21T17:10:33.414232Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.004732ms"} {"level":"info","ts":"2026-04-21T17:10:33.433676Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-04-21T17:10:33.433776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T17:10:33.4338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-04-21T17:10:33.433917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T17:10:33.433946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-04-21T17:10:33.433991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-04-21T17:10:33.454059Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T17:10:33.455745Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T17:10:33.457659Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-21T17:10:33.870722Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T17:10:33.871751Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T17:10:33.872063Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-21T17:10:33.872223Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-21T17:10:33.872233Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-21T17:10:33.879636Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-21T17:10:33.879782Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-04-21T17:10:33.87987Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-04-21T17:10:33.880783Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T17:10:33.880817Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T17:10:34.147318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-04-21T17:10:34.14748Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-04-21T17:10:34.935061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T17:10:34.935135Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T17:10:34.935166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-04-21T17:10:34.935181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-04-21T17:10:34.935198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-04-21T17:10:34.93521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-04-21T17:10:34.93522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-04-21T17:10:34.936199Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T17:10:34.936204Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T17:10:34.936236Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:10:34.936357Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T17:10:34.936458Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T17:10:34.936529Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T17:10:34.937592Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:10:34.937709Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:10:34.937751Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:10:34.939192Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-04-21T17:10:34.939282Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T17:10:36.623453Z","caller":"traceutil/trace.go:171","msg":"trace[807537997] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"392.477609ms","start":"2026-04-21T17:10:36.230953Z","end":"2026-04-21T17:10:36.623431Z","steps":["trace[807537997] 'process raft request' (duration: 392.289375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:36.624052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.230943Z","time spent":"392.607552ms","remote":"127.0.0.1:41898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:10:37.43609Z","caller":"traceutil/trace.go:171","msg":"trace[182910427] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.134394168s","start":"2026-04-21T17:10:36.301658Z","end":"2026-04-21T17:10:37.436052Z","steps":["trace[182910427] 'process raft request' (duration: 1.134237854s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:10:37.436275Z","caller":"traceutil/trace.go:171","msg":"trace[397557867] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.132966956s","start":"2026-04-21T17:10:36.30329Z","end":"2026-04-21T17:10:37.436257Z","steps":["trace[397557867] 'process raft request' (duration: 1.13275924s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:10:37.43628Z","caller":"traceutil/trace.go:171","msg":"trace[1152214890] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.205183826s","start":"2026-04-21T17:10:36.231062Z","end":"2026-04-21T17:10:37.436246Z","steps":["trace[1152214890] 'process raft request' (duration: 1.204697295s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.436304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.301633Z","time spent":"1.134571012s","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:10:37.43635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.303275Z","time spent":"1.133035638s","remote":"127.0.0.1:42368","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-04-21T17:10:37.43643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.231046Z","time spent":"1.205304139s","remote":"127.0.0.1:41900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:10:37.436405Z","caller":"traceutil/trace.go:171","msg":"trace[329536246] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"1.204898041s","start":"2026-04-21T17:10:36.231477Z","end":"2026-04-21T17:10:37.436375Z","steps":["trace[329536246] 'read index received' (duration: 392.294755ms)","trace[329536246] 'applied index is now lower than readState.Index' (duration: 812.601036ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:10:37.436549Z","caller":"traceutil/trace.go:171","msg":"trace[1040805252] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.13449438s","start":"2026-04-21T17:10:36.302044Z","end":"2026-04-21T17:10:37.436538Z","steps":["trace[1040805252] 'process raft request' (duration: 1.133887786s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.436628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.302027Z","time spent":"1.134579122s","remote":"127.0.0.1:42368","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-04-21T17:10:37.436709Z","caller":"traceutil/trace.go:171","msg":"trace[464013219] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.133701133s","start":"2026-04-21T17:10:36.302992Z","end":"2026-04-21T17:10:37.436693Z","steps":["trace[464013219] 'process raft request' (duration: 1.132967305s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.436754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.302981Z","time spent":"1.133752694s","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:10:37.436826Z","caller":"traceutil/trace.go:171","msg":"trace[2114836275] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.133651501s","start":"2026-04-21T17:10:36.303166Z","end":"2026-04-21T17:10:37.436818Z","steps":["trace[2114836275] 'process raft request' (duration: 1.132831392s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:10:37.43682Z","caller":"traceutil/trace.go:171","msg":"trace[1093726375] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.13268797s","start":"2026-04-21T17:10:36.304115Z","end":"2026-04-21T17:10:37.436803Z","steps":["trace[1093726375] 'process raft request' (duration: 1.131975283s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.436869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.303159Z","time spent":"1.133692302s","remote":"127.0.0.1:42368","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-04-21T17:10:37.436911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.304105Z","time spent":"1.132758372s","remote":"127.0.0.1:42274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:10:37.436923Z","caller":"traceutil/trace.go:171","msg":"trace[1821108825] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.119886994s","start":"2026-04-21T17:10:36.316934Z","end":"2026-04-21T17:10:37.436821Z","steps":["trace[1821108825] 'process raft request' (duration: 1.119220769s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.437174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.316922Z","time spent":"1.120193641s","remote":"127.0.0.1:42098","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-04-21T17:10:37.437203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.205712638s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3169"} {"level":"info","ts":"2026-04-21T17:10:37.437264Z","caller":"traceutil/trace.go:171","msg":"trace[1706879275] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"1.20578791s","start":"2026-04-21T17:10:36.231462Z","end":"2026-04-21T17:10:37.43725Z","steps":["trace[1706879275] 'agreement among raft nodes before linearized reading' (duration: 1.205597436s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.437296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.231455Z","time spent":"1.205834001s","remote":"127.0.0.1:42010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3192,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-21T17:10:37.437435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156348767s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:10:37.43747Z","caller":"traceutil/trace.go:171","msg":"trace[1711414901] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"1.117747796s","start":"2026-04-21T17:10:36.319713Z","end":"2026-04-21T17:10:37.43746Z","steps":["trace[1711414901] 'process raft request' (duration: 1.116494488s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.437467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.133618811s","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":"info","ts":"2026-04-21T17:10:37.437495Z","caller":"traceutil/trace.go:171","msg":"trace[157150392] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.15646173s","start":"2026-04-21T17:10:36.281017Z","end":"2026-04-21T17:10:37.437479Z","steps":["trace[157150392] 'agreement among raft nodes before linearized reading' (duration: 1.156357288s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.437514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.319696Z","time spent":"1.117796988s","remote":"127.0.0.1:42010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3157,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:10:37.437526Z","caller":"traceutil/trace.go:171","msg":"trace[1601935316] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"1.133708652s","start":"2026-04-21T17:10:36.303798Z","end":"2026-04-21T17:10:37.437507Z","steps":["trace[1601935316] 'agreement among raft nodes before linearized reading' (duration: 1.13361032s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.437572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.136149988s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:10:37.437607Z","caller":"traceutil/trace.go:171","msg":"trace[2084014666] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.136215118s","start":"2026-04-21T17:10:36.301383Z","end":"2026-04-21T17:10:37.437598Z","steps":["trace[2084014666] 'agreement among raft nodes before linearized reading' (duration: 1.136170767s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.437639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.301362Z","time spent":"1.13627051s","remote":"127.0.0.1:41948","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-04-21T17:10:37.437661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.30379Z","time spent":"1.133785524s","remote":"127.0.0.1:41920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-04-21T17:10:37.437728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.968494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:10:37.43776Z","caller":"traceutil/trace.go:171","msg":"trace[564801695] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:11; }","duration":"238.033606ms","start":"2026-04-21T17:10:37.199719Z","end":"2026-04-21T17:10:37.437753Z","steps":["trace[564801695] 'agreement among raft nodes before linearized reading' (duration: 237.985875ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.437803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.137759513s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-21T17:10:37.437533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.280997Z","time spent":"1.156528511s","remote":"127.0.0.1:41948","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-04-21T17:10:37.437842Z","caller":"traceutil/trace.go:171","msg":"trace[716426113] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:0; response_revision:11; }","duration":"1.137816344s","start":"2026-04-21T17:10:36.300016Z","end":"2026-04-21T17:10:37.437832Z","steps":["trace[716426113] 'agreement among raft nodes before linearized reading' (duration: 1.137760462s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.437871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.902523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-21T17:10:37.437883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.300004Z","time spent":"1.137866465s","remote":"127.0.0.1:41884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.4\" "} {"level":"info","ts":"2026-04-21T17:10:37.437903Z","caller":"traceutil/trace.go:171","msg":"trace[1613742930] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:11; }","duration":"237.962064ms","start":"2026-04-21T17:10:37.199934Z","end":"2026-04-21T17:10:37.437896Z","steps":["trace[1613742930] 'agreement among raft nodes before linearized reading' (duration: 237.915333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.438037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156639284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:10:37.438072Z","caller":"traceutil/trace.go:171","msg":"trace[1527368354] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.156698715s","start":"2026-04-21T17:10:36.281364Z","end":"2026-04-21T17:10:37.438063Z","steps":["trace[1527368354] 'agreement among raft nodes before linearized reading' (duration: 1.156651694s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.438077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156990762s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-21T17:10:37.438099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.281356Z","time spent":"1.156736726s","remote":"127.0.0.1:41948","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-04-21T17:10:37.438142Z","caller":"traceutil/trace.go:171","msg":"trace[1147276536] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.157054453s","start":"2026-04-21T17:10:36.281072Z","end":"2026-04-21T17:10:37.438126Z","steps":["trace[1147276536] 'agreement among raft nodes before linearized reading' (duration: 1.156962941s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.438137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.085331483s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:10:37.438202Z","caller":"traceutil/trace.go:171","msg":"trace[1776022357] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.085451496s","start":"2026-04-21T17:10:36.352733Z","end":"2026-04-21T17:10:37.438184Z","steps":["trace[1776022357] 'agreement among raft nodes before linearized reading' (duration: 1.085326104s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:37.438197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.281059Z","time spent":"1.157126544s","remote":"127.0.0.1:41948","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-04-21T17:10:37.438259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:36.35272Z","time spent":"1.085518507s","remote":"127.0.0.1:41948","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-04-21T17:10:39.35799Z","caller":"traceutil/trace.go:171","msg":"trace[1620312664] linearizableReadLoop","detail":"{readStateIndex:232; appliedIndex:231; }","duration":"228.244607ms","start":"2026-04-21T17:10:39.129725Z","end":"2026-04-21T17:10:39.35797Z","steps":["trace[1620312664] 'read index received' (duration: 223.192036ms)","trace[1620312664] 'applied index is now lower than readState.Index' (duration: 5.051951ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:10:39.358019Z","caller":"traceutil/trace.go:171","msg":"trace[1602952547] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"255.601878ms","start":"2026-04-21T17:10:39.102396Z","end":"2026-04-21T17:10:39.357998Z","steps":["trace[1602952547] 'process raft request' (duration: 250.611167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:39.358111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.383761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:113"} {"level":"info","ts":"2026-04-21T17:10:39.358257Z","caller":"traceutil/trace.go:171","msg":"trace[1388118028] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:227; }","duration":"228.582895ms","start":"2026-04-21T17:10:39.129664Z","end":"2026-04-21T17:10:39.358247Z","steps":["trace[1388118028] 'agreement among raft nodes before linearized reading' (duration: 228.382931ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:10:41.390443Z","caller":"traceutil/trace.go:171","msg":"trace[819999012] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"110.118874ms","start":"2026-04-21T17:10:41.280249Z","end":"2026-04-21T17:10:41.390368Z","steps":["trace[819999012] 'process raft request' (duration: 16.921727ms)","trace[819999012] 'compare' (duration: 92.83481ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:10:41.585441Z","caller":"traceutil/trace.go:171","msg":"trace[40591376] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"113.817167ms","start":"2026-04-21T17:10:41.471577Z","end":"2026-04-21T17:10:41.585394Z","steps":["trace[40591376] 'process raft request' (duration: 32.398982ms)","trace[40591376] 'compare' (duration: 81.144289ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:10:41.76663Z","caller":"traceutil/trace.go:171","msg":"trace[807738055] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"176.571136ms","start":"2026-04-21T17:10:41.590032Z","end":"2026-04-21T17:10:41.766604Z","steps":["trace[807738055] 'process raft request' (duration: 176.452233ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:10:41.775104Z","caller":"traceutil/trace.go:171","msg":"trace[466181098] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"178.601161ms","start":"2026-04-21T17:10:41.596471Z","end":"2026-04-21T17:10:41.775072Z","steps":["trace[466181098] 'process raft request' (duration: 178.457527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:07.673894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.690754ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:11:07.674171Z","caller":"traceutil/trace.go:171","msg":"trace[366476400] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"498.658596ms","start":"2026-04-21T17:11:07.175491Z","end":"2026-04-21T17:11:07.67415Z","steps":["trace[366476400] 'process raft request' (duration: 498.608245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:07.674258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.175471Z","time spent":"498.749488ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:11:07.674395Z","caller":"traceutil/trace.go:171","msg":"trace[789449115] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"503.824661ms","start":"2026-04-21T17:11:07.170504Z","end":"2026-04-21T17:11:07.674328Z","steps":["trace[789449115] 'process raft request' (duration: 398.40032ms)","trace[789449115] 'compare' (duration: 104.553571ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:11:07.674462Z","caller":"traceutil/trace.go:171","msg":"trace[783440553] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"502.654206ms","start":"2026-04-21T17:11:07.171703Z","end":"2026-04-21T17:11:07.674357Z","steps":["trace[783440553] 'process raft request' (duration: 502.322528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:07.674577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.170485Z","time spent":"504.000566ms","remote":"127.0.0.1:41896","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-04-21T17:11:07.674603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.171685Z","time spent":"502.85278ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:11:07.719288Z","caller":"traceutil/trace.go:171","msg":"trace[483487862] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"527.473139ms","start":"2026-04-21T17:11:07.191765Z","end":"2026-04-21T17:11:07.719238Z","steps":["trace[483487862] 'process raft request' (duration: 527.118851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:07.719538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.191743Z","time spent":"527.657363ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:11:07.71976Z","caller":"traceutil/trace.go:171","msg":"trace[564702229] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"512.993065ms","start":"2026-04-21T17:11:07.206752Z","end":"2026-04-21T17:11:07.719746Z","steps":["trace[564702229] 'process raft request' (duration: 512.584146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:07.719852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.206746Z","time spent":"513.079827ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:11:07.719559Z","caller":"traceutil/trace.go:171","msg":"trace[952775901] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"527.464629ms","start":"2026-04-21T17:11:07.191831Z","end":"2026-04-21T17:11:07.719296Z","steps":["trace[952775901] 'process raft request' (duration: 527.231372ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:07.720101Z","caller":"traceutil/trace.go:171","msg":"trace[1100329328] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"525.74269ms","start":"2026-04-21T17:11:07.194337Z","end":"2026-04-21T17:11:07.72008Z","steps":["trace[1100329328] 'process raft request' (duration: 524.863561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:07.720204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.194329Z","time spent":"525.832913ms","remote":"127.0.0.1:41896","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-04-21T17:11:07.720234Z","caller":"traceutil/trace.go:171","msg":"trace[439551586] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:539; }","duration":"501.52296ms","start":"2026-04-21T17:11:07.218683Z","end":"2026-04-21T17:11:07.720206Z","steps":["trace[439551586] 'read index received' (duration: 350.269527ms)","trace[439551586] 'applied index is now lower than readState.Index' (duration: 151.252463ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:11:07.720316Z","caller":"traceutil/trace.go:171","msg":"trace[1170174459] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"513.65399ms","start":"2026-04-21T17:11:07.20662Z","end":"2026-04-21T17:11:07.720274Z","steps":["trace[1170174459] 'process raft request' (duration: 512.684369ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:07.720364Z","caller":"traceutil/trace.go:171","msg":"trace[1011706201] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"522.57991ms","start":"2026-04-21T17:11:07.197762Z","end":"2026-04-21T17:11:07.720341Z","steps":["trace[1011706201] 'process raft request' (duration: 521.500756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:07.720411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.695024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-21T17:11:07.720451Z","caller":"traceutil/trace.go:171","msg":"trace[721516824] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:534; }","duration":"501.787976ms","start":"2026-04-21T17:11:07.21865Z","end":"2026-04-21T17:11:07.720438Z","steps":["trace[721516824] 'agreement among raft nodes before linearized reading' (duration: 501.663113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:07.720461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.206606Z","time spent":"513.793033ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:11:07.720513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.218633Z","time spent":"501.870247ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T17:11:07.720466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.197752Z","time spent":"522.656691ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:11:07.720723Z","caller":"traceutil/trace.go:171","msg":"trace[275783148] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"497.235044ms","start":"2026-04-21T17:11:07.223471Z","end":"2026-04-21T17:11:07.720706Z","steps":["trace[275783148] 'process raft request' (duration: 496.019547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:07.720798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.223463Z","time spent":"497.306456ms","remote":"127.0.0.1:41896","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-04-21T17:11:07.720742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.191827Z","time spent":"528.267236ms","remote":"127.0.0.1:41896","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-04-21T17:11:07.720936Z","caller":"traceutil/trace.go:171","msg":"trace[672630330] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"506.394339ms","start":"2026-04-21T17:11:07.214525Z","end":"2026-04-21T17:11:07.72092Z","steps":["trace[672630330] 'process raft request' (duration: 504.836695ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:07.720965Z","caller":"traceutil/trace.go:171","msg":"trace[42557632] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"363.589536ms","start":"2026-04-21T17:11:07.357345Z","end":"2026-04-21T17:11:07.720935Z","steps":["trace[42557632] 'process raft request' (duration: 362.613554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:07.721218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.214514Z","time spent":"506.477141ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:11:07.721235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.357319Z","time spent":"363.676818ms","remote":"127.0.0.1:41896","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-04-21T17:11:07.720873Z","caller":"traceutil/trace.go:171","msg":"trace[1961956290] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"495.68659ms","start":"2026-04-21T17:11:07.22517Z","end":"2026-04-21T17:11:07.720857Z","steps":["trace[1961956290] 'process raft request' (duration: 494.430802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:07.721344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.225161Z","time spent":"496.127889ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:11:07.720874Z","caller":"traceutil/trace.go:171","msg":"trace[174957827] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"506.159064ms","start":"2026-04-21T17:11:07.214692Z","end":"2026-04-21T17:11:07.720851Z","steps":["trace[174957827] 'process raft request' (duration: 504.700662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:07.721582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.214685Z","time spent":"506.825818ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:11:07.720912Z","caller":"traceutil/trace.go:171","msg":"trace[1987088635] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"474.484437ms","start":"2026-04-21T17:11:07.246419Z","end":"2026-04-21T17:11:07.720904Z","steps":["trace[1987088635] 'process raft request' (duration: 473.26177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:07.721915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.246353Z","time spent":"475.470708ms","remote":"127.0.0.1:41896","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-04-21T17:11:07.720921Z","caller":"traceutil/trace.go:171","msg":"trace[1897294244] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"501.043339ms","start":"2026-04-21T17:11:07.219867Z","end":"2026-04-21T17:11:07.72091Z","steps":["trace[1897294244] 'process raft request' (duration: 499.576177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:07.722483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:07.219854Z","time spent":"502.559594ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:11:07.90607Z","caller":"traceutil/trace.go:171","msg":"trace[1051278101] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"106.941763ms","start":"2026-04-21T17:11:07.799087Z","end":"2026-04-21T17:11:07.906029Z","steps":["trace[1051278101] 'process raft request' (duration: 106.615746ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:07.906118Z","caller":"traceutil/trace.go:171","msg":"trace[2129000152] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"103.321954ms","start":"2026-04-21T17:11:07.802757Z","end":"2026-04-21T17:11:07.906079Z","steps":["trace[2129000152] 'process raft request' (duration: 103.261782ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:07.906198Z","caller":"traceutil/trace.go:171","msg":"trace[2016891775] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"106.928903ms","start":"2026-04-21T17:11:07.799219Z","end":"2026-04-21T17:11:07.906148Z","steps":["trace[2016891775] 'process raft request' (duration: 106.665757ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:08.266752Z","caller":"traceutil/trace.go:171","msg":"trace[2108241770] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"240.195034ms","start":"2026-04-21T17:11:08.026535Z","end":"2026-04-21T17:11:08.26673Z","steps":["trace[2108241770] 'process raft request' (duration: 231.47768ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:08.268089Z","caller":"traceutil/trace.go:171","msg":"trace[525343377] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"241.228457ms","start":"2026-04-21T17:11:08.026828Z","end":"2026-04-21T17:11:08.268057Z","steps":["trace[525343377] 'process raft request' (duration: 240.946781ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:08.268544Z","caller":"traceutil/trace.go:171","msg":"trace[224468153] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"191.106171ms","start":"2026-04-21T17:11:08.077425Z","end":"2026-04-21T17:11:08.268531Z","steps":["trace[224468153] 'process raft request' (duration: 190.561238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:13.125204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.008401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:13.125261Z","caller":"traceutil/trace.go:171","msg":"trace[149057456] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"114.102843ms","start":"2026-04-21T17:11:13.011147Z","end":"2026-04-21T17:11:13.12525Z","steps":["trace[149057456] 'range keys from in-memory index tree' (duration: 113.927669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:13.928456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.673132ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:11:13.928565Z","caller":"traceutil/trace.go:171","msg":"trace[2124597771] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"131.361839ms","start":"2026-04-21T17:11:13.797186Z","end":"2026-04-21T17:11:13.928548Z","steps":["trace[2124597771] 'read index received' (duration: 74.972µs)","trace[2124597771] 'applied index is now lower than readState.Index' (duration: 131.285717ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:11:13.928811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.622414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-21T17:11:13.928876Z","caller":"traceutil/trace.go:171","msg":"trace[1046990717] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"258.251777ms","start":"2026-04-21T17:11:13.670591Z","end":"2026-04-21T17:11:13.928843Z","steps":["trace[1046990717] 'process raft request' (duration: 123.118865ms)","trace[1046990717] 'compare' (duration: 134.516229ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:11:13.928894Z","caller":"traceutil/trace.go:171","msg":"trace[571313704] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"131.755917ms","start":"2026-04-21T17:11:13.797121Z","end":"2026-04-21T17:11:13.928877Z","steps":["trace[571313704] 'agreement among raft nodes before linearized reading' (duration: 131.533632ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:14.541474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.296773ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:11:14.541568Z","caller":"traceutil/trace.go:171","msg":"trace[2139850665] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"602.732436ms","start":"2026-04-21T17:11:13.938822Z","end":"2026-04-21T17:11:14.541554Z","steps":["trace[2139850665] 'read index received' (duration: 93.252379ms)","trace[2139850665] 'applied index is now lower than readState.Index' (duration: 509.479097ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:11:14.541611Z","caller":"traceutil/trace.go:171","msg":"trace[1428627033] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"606.798437ms","start":"2026-04-21T17:11:13.934779Z","end":"2026-04-21T17:11:14.541578Z","steps":["trace[1428627033] 'process raft request' (duration: 97.343811ms)","trace[1428627033] 'compare' (duration: 509.197031ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:11:14.541831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:13.934762Z","time spent":"607.013772ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:11:14.541723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.884959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:14.541903Z","caller":"traceutil/trace.go:171","msg":"trace[1443648243] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:619; }","duration":"603.060673ms","start":"2026-04-21T17:11:13.938817Z","end":"2026-04-21T17:11:14.541877Z","steps":["trace[1443648243] 'agreement among raft nodes before linearized reading' (duration: 602.807738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:14.542467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:13.938787Z","time spent":"603.664707ms","remote":"127.0.0.1:42340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"warn","ts":"2026-04-21T17:11:14.571268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.232465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-21T17:11:14.571341Z","caller":"traceutil/trace.go:171","msg":"trace[634103446] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:619; }","duration":"144.350938ms","start":"2026-04-21T17:11:14.426971Z","end":"2026-04-21T17:11:14.571322Z","steps":["trace[634103446] 'agreement among raft nodes before linearized reading' (duration: 144.132672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:14.571747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.242858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:14.571835Z","caller":"traceutil/trace.go:171","msg":"trace[366330137] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"420.350811ms","start":"2026-04-21T17:11:14.151455Z","end":"2026-04-21T17:11:14.571806Z","steps":["trace[366330137] 'agreement among raft nodes before linearized reading' (duration: 419.544002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:14.571872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:14.151441Z","time spent":"420.423222ms","remote":"127.0.0.1:41860","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-04-21T17:11:15.474864Z","caller":"traceutil/trace.go:171","msg":"trace[1868684641] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"465.336953ms","start":"2026-04-21T17:11:15.009499Z","end":"2026-04-21T17:11:15.474836Z","steps":["trace[1868684641] 'read index received' (duration: 464.429633ms)","trace[1868684641] 'applied index is now lower than readState.Index' (duration: 905.4µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:11:15.474924Z","caller":"traceutil/trace.go:171","msg":"trace[499803620] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"504.992347ms","start":"2026-04-21T17:11:14.969909Z","end":"2026-04-21T17:11:15.474902Z","steps":["trace[499803620] 'process raft request' (duration: 504.25932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:15.475051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.529097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:15.475099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.229004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:15.475108Z","caller":"traceutil/trace.go:171","msg":"trace[1470931944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"465.63845ms","start":"2026-04-21T17:11:15.009454Z","end":"2026-04-21T17:11:15.475092Z","steps":["trace[1470931944] 'agreement among raft nodes before linearized reading' (duration: 465.539168ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:15.475177Z","caller":"traceutil/trace.go:171","msg":"trace[1909919465] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:626; }","duration":"462.326886ms","start":"2026-04-21T17:11:15.012833Z","end":"2026-04-21T17:11:15.47516Z","steps":["trace[1909919465] 'agreement among raft nodes before linearized reading' (duration: 462.181633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:15.475152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:14.969888Z","time spent":"505.084419ms","remote":"127.0.0.1:41928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:11:15.475264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.01279Z","time spent":"462.427488ms","remote":"127.0.0.1:56914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:11:15.475286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.009436Z","time spent":"465.774962ms","remote":"127.0.0.1:41844","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-04-21T17:11:15.475298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.81448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:15.475375Z","caller":"traceutil/trace.go:171","msg":"trace[923702383] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"324.946533ms","start":"2026-04-21T17:11:15.150408Z","end":"2026-04-21T17:11:15.475354Z","steps":["trace[923702383] 'agreement among raft nodes before linearized reading' (duration: 324.77678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:15.475423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.150385Z","time spent":"325.026955ms","remote":"127.0.0.1:56928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:11:15.475501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.155478ms","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-04-21T17:11:15.475542Z","caller":"traceutil/trace.go:171","msg":"trace[607944486] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"325.25967ms","start":"2026-04-21T17:11:15.150272Z","end":"2026-04-21T17:11:15.475531Z","steps":["trace[607944486] 'agreement among raft nodes before linearized reading' (duration: 325.202949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:15.475579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.150242Z","time spent":"325.328952ms","remote":"127.0.0.1:56928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:11:15.47571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.611357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:15.475772Z","caller":"traceutil/trace.go:171","msg":"trace[157595407] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"211.667708ms","start":"2026-04-21T17:11:15.264075Z","end":"2026-04-21T17:11:15.475743Z","steps":["trace[157595407] 'agreement among raft nodes before linearized reading' (duration: 211.557816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:15.475888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.419598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:15.475877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.793218ms","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-04-21T17:11:15.475932Z","caller":"traceutil/trace.go:171","msg":"trace[1420649212] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:626; }","duration":"462.649063ms","start":"2026-04-21T17:11:15.013272Z","end":"2026-04-21T17:11:15.475921Z","steps":["trace[1420649212] 'agreement among raft nodes before linearized reading' (duration: 462.427338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:15.475967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.01326Z","time spent":"462.696925ms","remote":"127.0.0.1:56914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"info","ts":"2026-04-21T17:11:15.475997Z","caller":"traceutil/trace.go:171","msg":"trace[2074132298] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"211.508314ms","start":"2026-04-21T17:11:15.26444Z","end":"2026-04-21T17:11:15.475949Z","steps":["trace[2074132298] 'agreement among raft nodes before linearized reading' (duration: 210.719787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:15.476117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.141019ms","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-04-21T17:11:15.476162Z","caller":"traceutil/trace.go:171","msg":"trace[780486868] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"212.225891ms","start":"2026-04-21T17:11:15.263925Z","end":"2026-04-21T17:11:15.476151Z","steps":["trace[780486868] 'agreement among raft nodes before linearized reading' (duration: 212.159249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:15.476442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.34362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j46kh\" ","response":"range_response_count:1 size:16957"} {"level":"warn","ts":"2026-04-21T17:11:15.476444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.272022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:15.47649Z","caller":"traceutil/trace.go:171","msg":"trace[1757611412] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"129.464467ms","start":"2026-04-21T17:11:15.347011Z","end":"2026-04-21T17:11:15.476475Z","steps":["trace[1757611412] 'agreement among raft nodes before linearized reading' (duration: 129.398716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:15.47649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.411356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:15.47653Z","caller":"traceutil/trace.go:171","msg":"trace[1710176685] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"173.455247ms","start":"2026-04-21T17:11:15.303063Z","end":"2026-04-21T17:11:15.476518Z","steps":["trace[1710176685] 'agreement among raft nodes before linearized reading' (duration: 173.396396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:15.476121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.996422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:15.476676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.465278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:15.476788Z","caller":"traceutil/trace.go:171","msg":"trace[974175796] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"130.607552ms","start":"2026-04-21T17:11:15.346168Z","end":"2026-04-21T17:11:15.476776Z","steps":["trace[974175796] 'agreement among raft nodes before linearized reading' (duration: 130.478209ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:15.476737Z","caller":"traceutil/trace.go:171","msg":"trace[772408425] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:626; }","duration":"463.612185ms","start":"2026-04-21T17:11:15.013096Z","end":"2026-04-21T17:11:15.476708Z","steps":["trace[772408425] 'agreement among raft nodes before linearized reading' (duration: 462.996902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:15.476908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.013085Z","time spent":"463.801029ms","remote":"127.0.0.1:56914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:11:15.476979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.833725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:15.477018Z","caller":"traceutil/trace.go:171","msg":"trace[1631448934] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"173.877106ms","start":"2026-04-21T17:11:15.303132Z","end":"2026-04-21T17:11:15.477009Z","steps":["trace[1631448934] 'agreement among raft nodes before linearized reading' (duration: 173.817634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:15.476629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.366916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:15.477074Z","caller":"traceutil/trace.go:171","msg":"trace[214015697] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"130.827737ms","start":"2026-04-21T17:11:15.346228Z","end":"2026-04-21T17:11:15.477056Z","steps":["trace[214015697] 'agreement among raft nodes before linearized reading' (duration: 130.381227ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:15.47648Z","caller":"traceutil/trace.go:171","msg":"trace[825933700] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j46kh; range_end:; response_count:1; response_revision:626; }","duration":"219.416192ms","start":"2026-04-21T17:11:15.257055Z","end":"2026-04-21T17:11:15.476471Z","steps":["trace[825933700] 'agreement among raft nodes before linearized reading' (duration: 219.281859ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:15.928361Z","caller":"traceutil/trace.go:171","msg":"trace[1828210345] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"435.964019ms","start":"2026-04-21T17:11:15.492386Z","end":"2026-04-21T17:11:15.92835Z","steps":["trace[1828210345] 'process raft request' (duration: 435.741174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:15.928492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.49237Z","time spent":"436.04832ms","remote":"127.0.0.1:42020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:11:15.928308Z","caller":"traceutil/trace.go:171","msg":"trace[1562854535] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"422.961119ms","start":"2026-04-21T17:11:15.505327Z","end":"2026-04-21T17:11:15.928288Z","steps":["trace[1562854535] 'read index received' (duration: 422.692143ms)","trace[1562854535] 'applied index is now lower than readState.Index' (duration: 266.686µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:11:15.928636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.264635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:15.928749Z","caller":"traceutil/trace.go:171","msg":"trace[1255727121] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:627; }","duration":"423.430469ms","start":"2026-04-21T17:11:15.50528Z","end":"2026-04-21T17:11:15.928711Z","steps":["trace[1255727121] 'agreement among raft nodes before linearized reading' (duration: 423.217344ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:15.928824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.505262Z","time spent":"423.543342ms","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-21T17:11:16.163741Z","caller":"traceutil/trace.go:171","msg":"trace[1346907066] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"235.05873ms","start":"2026-04-21T17:11:15.928659Z","end":"2026-04-21T17:11:16.163718Z","steps":["trace[1346907066] 'read index received' (duration: 200.858307ms)","trace[1346907066] 'applied index is now lower than readState.Index' (duration: 34.199672ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:11:16.163861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.752008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:16.163887Z","caller":"traceutil/trace.go:171","msg":"trace[1741592193] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:628; }","duration":"437.814239ms","start":"2026-04-21T17:11:15.726064Z","end":"2026-04-21T17:11:16.163878Z","steps":["trace[1741592193] 'agreement among raft nodes before linearized reading' (duration: 437.753408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.163864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.662916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:16.163937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.830736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:16.163954Z","caller":"traceutil/trace.go:171","msg":"trace[752343370] 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:628; }","duration":"470.862927ms","start":"2026-04-21T17:11:15.693087Z","end":"2026-04-21T17:11:16.16395Z","steps":["trace[752343370] 'agreement among raft nodes before linearized reading' (duration: 470.834456ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:16.163946Z","caller":"traceutil/trace.go:171","msg":"trace[2048450855] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:628; }","duration":"437.766448ms","start":"2026-04-21T17:11:15.726162Z","end":"2026-04-21T17:11:16.163929Z","steps":["trace[2048450855] 'agreement among raft nodes before linearized reading' (duration: 437.607465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.163968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.693083Z","time spent":"470.880907ms","remote":"127.0.0.1:57048","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-04-21T17:11:16.163992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.726156Z","time spent":"437.826429ms","remote":"127.0.0.1:57052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:11:16.164153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.084891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:16.164126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.360126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:16.164192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.142073ms","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-04-21T17:11:16.164207Z","caller":"traceutil/trace.go:171","msg":"trace[830895131] 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:628; }","duration":"471.156733ms","start":"2026-04-21T17:11:15.693046Z","end":"2026-04-21T17:11:16.164202Z","steps":["trace[830895131] 'agreement among raft nodes before linearized reading' (duration: 471.135983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.164205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.564089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:16.164207Z","caller":"traceutil/trace.go:171","msg":"trace[793029924] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"374.475678ms","start":"2026-04-21T17:11:15.789711Z","end":"2026-04-21T17:11:16.164187Z","steps":["trace[793029924] 'agreement among raft nodes before linearized reading' (duration: 374.322164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.164256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.693033Z","time spent":"471.185894ms","remote":"127.0.0.1:57048","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-04-21T17:11:16.16422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.136807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:16.164265Z","caller":"traceutil/trace.go:171","msg":"trace[98247893] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:628; }","duration":"413.682142ms","start":"2026-04-21T17:11:15.750572Z","end":"2026-04-21T17:11:16.164254Z","steps":["trace[98247893] 'agreement among raft nodes before linearized reading' (duration: 413.604321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.164121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.680199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:16.164284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.789706Z","time spent":"374.56532ms","remote":"127.0.0.1:57072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:11:16.164294Z","caller":"traceutil/trace.go:171","msg":"trace[969234496] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:628; }","duration":"355.227559ms","start":"2026-04-21T17:11:15.809049Z","end":"2026-04-21T17:11:16.164276Z","steps":["trace[969234496] 'agreement among raft nodes before linearized reading' (duration: 355.116746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.164345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.750354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:16.16436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.610953ms","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":"warn","ts":"2026-04-21T17:11:16.164356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.809042Z","time spent":"355.29812ms","remote":"127.0.0.1:57088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"info","ts":"2026-04-21T17:11:16.164382Z","caller":"traceutil/trace.go:171","msg":"trace[2144495084] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:628; }","duration":"413.812895ms","start":"2026-04-21T17:11:15.750559Z","end":"2026-04-21T17:11:16.164372Z","steps":["trace[2144495084] 'agreement among raft nodes before linearized reading' (duration: 413.768004ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:16.16439Z","caller":"traceutil/trace.go:171","msg":"trace[1710188816] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:628; }","duration":"493.651904ms","start":"2026-04-21T17:11:15.670727Z","end":"2026-04-21T17:11:16.164379Z","steps":["trace[1710188816] 'agreement among raft nodes before linearized reading' (duration: 493.612293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.164411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.670719Z","time spent":"493.685475ms","remote":"127.0.0.1:57046","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-04-21T17:11:16.164412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.750541Z","time spent":"413.860557ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:11:16.164458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.840847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:16.164521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.195481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:16.164548Z","caller":"traceutil/trace.go:171","msg":"trace[977509201] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:628; }","duration":"496.236152ms","start":"2026-04-21T17:11:15.668305Z","end":"2026-04-21T17:11:16.164541Z","steps":["trace[977509201] 'agreement among raft nodes before linearized reading' (duration: 496.196501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.164541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.498857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:16.164536Z","caller":"traceutil/trace.go:171","msg":"trace[576721255] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"626.044586ms","start":"2026-04-21T17:11:15.538403Z","end":"2026-04-21T17:11:16.164447Z","steps":["trace[576721255] 'process raft request' (duration: 591.186679ms)","trace[576721255] 'compare' (duration: 33.846574ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:11:16.164627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.920821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:16.164563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.862266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:16.164608Z","caller":"traceutil/trace.go:171","msg":"trace[1528237506] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"374.59219ms","start":"2026-04-21T17:11:15.790002Z","end":"2026-04-21T17:11:16.164594Z","steps":["trace[1528237506] 'agreement among raft nodes before linearized reading' (duration: 374.495918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.164636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.407912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:16.16466Z","caller":"traceutil/trace.go:171","msg":"trace[540454651] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"374.991499ms","start":"2026-04-21T17:11:15.78966Z","end":"2026-04-21T17:11:16.164652Z","steps":["trace[540454651] 'agreement among raft nodes before linearized reading' (duration: 374.878457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.164679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.014693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:16.164687Z","caller":"traceutil/trace.go:171","msg":"trace[2073828011] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:628; }","duration":"355.477144ms","start":"2026-04-21T17:11:15.809196Z","end":"2026-04-21T17:11:16.164673Z","steps":["trace[2073828011] 'agreement among raft nodes before linearized reading' (duration: 355.393083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.164694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.78965Z","time spent":"375.03549ms","remote":"127.0.0.1:57072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:11:16.164691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.789995Z","time spent":"374.675471ms","remote":"127.0.0.1:57062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:11:16.164725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.124926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:16.164731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.80919Z","time spent":"355.526755ms","remote":"127.0.0.1:57088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:11:16.164745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.538374Z","time spent":"626.27199ms","remote":"127.0.0.1:42340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:11:16.164803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.74081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:16.164825Z","caller":"traceutil/trace.go:171","msg":"trace[443745150] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:628; }","duration":"630.791682ms","start":"2026-04-21T17:11:15.534028Z","end":"2026-04-21T17:11:16.16482Z","steps":["trace[443745150] 'agreement among raft nodes before linearized reading' (duration: 630.751161ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:16.164695Z","caller":"traceutil/trace.go:171","msg":"trace[762768033] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:628; }","duration":"547.062115ms","start":"2026-04-21T17:11:15.617628Z","end":"2026-04-21T17:11:16.164691Z","steps":["trace[762768033] 'agreement among raft nodes before linearized reading' (duration: 547.032264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.164868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.821342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:16.164172Z","caller":"traceutil/trace.go:171","msg":"trace[126269254] 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:628; }","duration":"471.122322ms","start":"2026-04-21T17:11:15.693045Z","end":"2026-04-21T17:11:16.164168Z","steps":["trace[126269254] 'agreement among raft nodes before linearized reading' (duration: 471.092242ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:16.16488Z","caller":"traceutil/trace.go:171","msg":"trace[1670801012] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:628; }","duration":"630.860593ms","start":"2026-04-21T17:11:15.534016Z","end":"2026-04-21T17:11:16.164877Z","steps":["trace[1670801012] 'agreement among raft nodes before linearized reading' (duration: 630.841092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.164892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.534001Z","time spent":"630.888403ms","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:11:16.164306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.750558Z","time spent":"413.737293ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:11:16.164568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.6683Z","time spent":"496.262742ms","remote":"127.0.0.1:57046","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-04-21T17:11:16.164912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.693032Z","time spent":"471.860748ms","remote":"127.0.0.1:57048","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":"info","ts":"2026-04-21T17:11:16.16432Z","caller":"traceutil/trace.go:171","msg":"trace[1990948716] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:628; }","duration":"412.937715ms","start":"2026-04-21T17:11:15.751364Z","end":"2026-04-21T17:11:16.164302Z","steps":["trace[1990948716] 'agreement among raft nodes before linearized reading' (duration: 412.69254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.164993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.654844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:16.164994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.751346Z","time spent":"413.63443ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"info","ts":"2026-04-21T17:11:16.165011Z","caller":"traceutil/trace.go:171","msg":"trace[1701477420] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:628; }","duration":"659.725896ms","start":"2026-04-21T17:11:15.505282Z","end":"2026-04-21T17:11:16.165008Z","steps":["trace[1701477420] 'agreement among raft nodes before linearized reading' (duration: 659.695085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.165026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.505265Z","time spent":"659.756906ms","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:11:16.164595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.372505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:16.164889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.61762Z","time spent":"547.247849ms","remote":"127.0.0.1:57032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-21T17:11:16.164745Z","caller":"traceutil/trace.go:171","msg":"trace[15539383] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:628; }","duration":"547.146987ms","start":"2026-04-21T17:11:15.617594Z","end":"2026-04-21T17:11:16.164741Z","steps":["trace[15539383] 'agreement among raft nodes before linearized reading' (duration: 547.117046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.165093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.616504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:16.1651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.973123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:16.165073Z","caller":"traceutil/trace.go:171","msg":"trace[537292723] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:628; }","duration":"496.857096ms","start":"2026-04-21T17:11:15.668193Z","end":"2026-04-21T17:11:16.16505Z","steps":["trace[537292723] 'agreement among raft nodes before linearized reading' (duration: 496.389135ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:16.165115Z","caller":"traceutil/trace.go:171","msg":"trace[2033914755] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"393.651035ms","start":"2026-04-21T17:11:15.771456Z","end":"2026-04-21T17:11:16.165107Z","steps":["trace[2033914755] 'agreement among raft nodes before linearized reading' (duration: 393.616124ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:16.164517Z","caller":"traceutil/trace.go:171","msg":"trace[188520867] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"392.915939ms","start":"2026-04-21T17:11:15.771586Z","end":"2026-04-21T17:11:16.164502Z","steps":["trace[188520867] 'agreement among raft nodes before linearized reading' (duration: 392.816987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.165136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.771448Z","time spent":"393.681735ms","remote":"127.0.0.1:57062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:11:16.16515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.668176Z","time spent":"496.955538ms","remote":"127.0.0.1:57046","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-04-21T17:11:16.164848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.534015Z","time spent":"630.826702ms","remote":"127.0.0.1:57030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:11:16.165176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.771582Z","time spent":"393.575403ms","remote":"127.0.0.1:57062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:11:16.165117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.617572Z","time spent":"547.528475ms","remote":"127.0.0.1:57032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-21T17:11:16.164649Z","caller":"traceutil/trace.go:171","msg":"trace[1216591304] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:628; }","duration":"546.966103ms","start":"2026-04-21T17:11:15.617675Z","end":"2026-04-21T17:11:16.164642Z","steps":["trace[1216591304] 'agreement among raft nodes before linearized reading' (duration: 546.928942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.165465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.617668Z","time spent":"547.773201ms","remote":"127.0.0.1:57032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:11:16.16391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.726053Z","time spent":"437.851131ms","remote":"127.0.0.1:57052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"info","ts":"2026-04-21T17:11:16.165113Z","caller":"traceutil/trace.go:171","msg":"trace[1383387303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"159.044884ms","start":"2026-04-21T17:11:16.006064Z","end":"2026-04-21T17:11:16.165109Z","steps":["trace[1383387303] 'agreement among raft nodes before linearized reading' (duration: 159.023204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.164764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.697669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:16.165599Z","caller":"traceutil/trace.go:171","msg":"trace[1021489351] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:628; }","duration":"631.545359ms","start":"2026-04-21T17:11:15.534045Z","end":"2026-04-21T17:11:16.16559Z","steps":["trace[1021489351] 'agreement among raft nodes before linearized reading' (duration: 630.709169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.165628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.534034Z","time spent":"631.584319ms","remote":"127.0.0.1:57030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:11:16.169989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.097186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:16.170127Z","caller":"traceutil/trace.go:171","msg":"trace[658031576] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:628; }","duration":"360.26685ms","start":"2026-04-21T17:11:15.809847Z","end":"2026-04-21T17:11:16.170114Z","steps":["trace[658031576] 'agreement among raft nodes before linearized reading' (duration: 360.082126ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:16.17023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:15.809841Z","time spent":"360.375932ms","remote":"127.0.0.1:57088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:11:17.08794Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232310842980884282,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:11:17.250216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.26064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-21T17:11:17.250363Z","caller":"traceutil/trace.go:171","msg":"trace[912351515] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:628; }","duration":"704.446944ms","start":"2026-04-21T17:11:16.545895Z","end":"2026-04-21T17:11:17.250342Z","steps":["trace[912351515] 'range keys from in-memory index tree' (duration: 704.054215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:17.25042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:16.545877Z","time spent":"704.529106ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-21T17:11:17.289793Z","caller":"traceutil/trace.go:171","msg":"trace[1065611896] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"702.254334ms","start":"2026-04-21T17:11:16.587514Z","end":"2026-04-21T17:11:17.289768Z","steps":["trace[1065611896] 'read index received' (duration: 701.541439ms)","trace[1065611896] 'applied index is now lower than readState.Index' (duration: 711.805µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:11:17.289862Z","caller":"traceutil/trace.go:171","msg":"trace[1191787433] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"717.783261ms","start":"2026-04-21T17:11:16.572048Z","end":"2026-04-21T17:11:17.289831Z","steps":["trace[1191787433] 'process raft request' (duration: 717.165727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:17.29002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:16.572021Z","time spent":"717.890952ms","remote":"127.0.0.1:41928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:11:17.290078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.542661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-21T17:11:17.290178Z","caller":"traceutil/trace.go:171","msg":"trace[2107545890] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"702.668554ms","start":"2026-04-21T17:11:16.587466Z","end":"2026-04-21T17:11:17.290134Z","steps":["trace[2107545890] 'agreement among raft nodes before linearized reading' (duration: 702.395068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:17.290233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:16.587442Z","time spent":"702.780726ms","remote":"127.0.0.1:42108","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-04-21T17:11:17.291791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.432159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T17:11:17.291864Z","caller":"traceutil/trace.go:171","msg":"trace[610890015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"702.530911ms","start":"2026-04-21T17:11:16.589315Z","end":"2026-04-21T17:11:17.291846Z","steps":["trace[610890015] 'agreement among raft nodes before linearized reading' (duration: 702.317886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:17.29191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:16.589303Z","time spent":"702.597172ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T17:11:17.29219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.023591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T17:11:17.29227Z","caller":"traceutil/trace.go:171","msg":"trace[470823496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:630; }","duration":"585.147634ms","start":"2026-04-21T17:11:16.70711Z","end":"2026-04-21T17:11:17.292257Z","steps":["trace[470823496] 'agreement among raft nodes before linearized reading' (duration: 584.9742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:17.292296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:16.707085Z","time spent":"585.204956ms","remote":"127.0.0.1:42108","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-04-21T17:11:19.005788Z","caller":"traceutil/trace.go:171","msg":"trace[1836041770] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"108.240472ms","start":"2026-04-21T17:11:18.897516Z","end":"2026-04-21T17:11:19.005756Z","steps":["trace[1836041770] 'process raft request' (duration: 93.140826ms)","trace[1836041770] 'compare' (duration: 14.938812ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:11:19.381436Z","caller":"traceutil/trace.go:171","msg":"trace[631232222] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"102.183977ms","start":"2026-04-21T17:11:19.279211Z","end":"2026-04-21T17:11:19.381395Z","steps":["trace[631232222] 'process raft request' (duration: 101.895579ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:19.597676Z","caller":"traceutil/trace.go:171","msg":"trace[523523632] linearizableReadLoop","detail":"{readStateIndex:682; appliedIndex:680; }","duration":"299.836936ms","start":"2026-04-21T17:11:19.297804Z","end":"2026-04-21T17:11:19.59764Z","steps":["trace[523523632] 'read index received' (duration: 83.342985ms)","trace[523523632] 'applied index is now lower than readState.Index' (duration: 216.491901ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:11:19.597854Z","caller":"traceutil/trace.go:171","msg":"trace[1298361858] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"316.051553ms","start":"2026-04-21T17:11:19.281783Z","end":"2026-04-21T17:11:19.597835Z","steps":["trace[1298361858] 'process raft request' (duration: 302.41367ms)","trace[1298361858] 'compare' (duration: 12.911976ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:11:19.59805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:19.281748Z","time spent":"316.171206ms","remote":"127.0.0.1:42020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4865,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:11:19.598446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.641146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-21T17:11:19.598513Z","caller":"traceutil/trace.go:171","msg":"trace[2013502349] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:656; }","duration":"300.751039ms","start":"2026-04-21T17:11:19.297746Z","end":"2026-04-21T17:11:19.598497Z","steps":["trace[2013502349] 'agreement among raft nodes before linearized reading' (duration: 300.068903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:19.598564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:19.297717Z","time spent":"300.834561ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-21T17:11:19.857663Z","caller":"traceutil/trace.go:171","msg":"trace[1389692115] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:682; }","duration":"259.883182ms","start":"2026-04-21T17:11:19.597755Z","end":"2026-04-21T17:11:19.857639Z","steps":["trace[1389692115] 'read index received' (duration: 202.753595ms)","trace[1389692115] 'applied index is now lower than readState.Index' (duration: 57.128457ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:11:19.857715Z","caller":"traceutil/trace.go:171","msg":"trace[712037341] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"423.935231ms","start":"2026-04-21T17:11:19.433741Z","end":"2026-04-21T17:11:19.857676Z","steps":["trace[712037341] 'process raft request' (duration: 366.683591ms)","trace[712037341] 'compare' (duration: 57.071605ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:11:19.857876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:19.433711Z","time spent":"424.078334ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:11:19.857947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.415933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T17:11:19.857994Z","caller":"traceutil/trace.go:171","msg":"trace[1290586175] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:657; }","duration":"546.506275ms","start":"2026-04-21T17:11:19.311477Z","end":"2026-04-21T17:11:19.857983Z","steps":["trace[1290586175] 'agreement among raft nodes before linearized reading' (duration: 546.274829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:19.858034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:19.311462Z","time spent":"546.563617ms","remote":"127.0.0.1:42108","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-04-21T17:11:19.858215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.515355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T17:11:19.858302Z","caller":"traceutil/trace.go:171","msg":"trace[1820802416] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:657; }","duration":"548.816852ms","start":"2026-04-21T17:11:19.309451Z","end":"2026-04-21T17:11:19.858268Z","steps":["trace[1820802416] 'agreement among raft nodes before linearized reading' (duration: 548.525405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:19.858337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:19.309428Z","time spent":"548.902664ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T17:11:19.858261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.135406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-21T17:11:19.858506Z","caller":"traceutil/trace.go:171","msg":"trace[1725164522] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:657; }","duration":"548.433893ms","start":"2026-04-21T17:11:19.310052Z","end":"2026-04-21T17:11:19.858485Z","steps":["trace[1725164522] 'agreement among raft nodes before linearized reading' (duration: 547.838709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:19.858603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:19.31002Z","time spent":"548.570746ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T17:11:19.913904Z","caller":"traceutil/trace.go:171","msg":"trace[1409903901] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"278.364353ms","start":"2026-04-21T17:11:19.635519Z","end":"2026-04-21T17:11:19.913883Z","steps":["trace[1409903901] 'process raft request' (duration: 278.325832ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:19.913932Z","caller":"traceutil/trace.go:171","msg":"trace[405930809] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"310.13718ms","start":"2026-04-21T17:11:19.603768Z","end":"2026-04-21T17:11:19.913905Z","steps":["trace[405930809] 'process raft request' (duration: 309.931455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:19.914266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:19.603736Z","time spent":"310.341455ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:11:20.07285Z","caller":"traceutil/trace.go:171","msg":"trace[187997994] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"237.240346ms","start":"2026-04-21T17:11:19.835583Z","end":"2026-04-21T17:11:20.072823Z","steps":["trace[187997994] 'process raft request' (duration: 236.951589ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.073055Z","caller":"traceutil/trace.go:171","msg":"trace[377445624] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"209.982941ms","start":"2026-04-21T17:11:19.862915Z","end":"2026-04-21T17:11:20.072898Z","steps":["trace[377445624] 'process raft request' (duration: 209.813497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:20.073069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.508038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j46kh\" ","response":"range_response_count:1 size:17239"} {"level":"info","ts":"2026-04-21T17:11:20.072915Z","caller":"traceutil/trace.go:171","msg":"trace[561360598] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:683; }","duration":"215.171767ms","start":"2026-04-21T17:11:19.857726Z","end":"2026-04-21T17:11:20.072898Z","steps":["trace[561360598] 'read index received' (duration: 56.07733ms)","trace[561360598] 'applied index is now lower than readState.Index' (duration: 159.093267ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:11:20.073109Z","caller":"traceutil/trace.go:171","msg":"trace[2120422205] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j46kh; range_end:; response_count:1; response_revision:664; }","duration":"470.60008ms","start":"2026-04-21T17:11:19.6025Z","end":"2026-04-21T17:11:20.0731Z","steps":["trace[2120422205] 'agreement among raft nodes before linearized reading' (duration: 470.447626ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.072942Z","caller":"traceutil/trace.go:171","msg":"trace[721491707] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"206.491996ms","start":"2026-04-21T17:11:19.866436Z","end":"2026-04-21T17:11:20.072928Z","steps":["trace[721491707] 'process raft request' (duration: 206.379303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:20.073142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:19.602476Z","time spent":"470.657283ms","remote":"127.0.0.1:42020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17262,"request content":"key:\"/registry/pods/kube-system/cilium-j46kh\" "} {"level":"info","ts":"2026-04-21T17:11:20.072932Z","caller":"traceutil/trace.go:171","msg":"trace[228328105] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"209.450857ms","start":"2026-04-21T17:11:19.86346Z","end":"2026-04-21T17:11:20.072911Z","steps":["trace[228328105] 'process raft request' (duration: 209.300104ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.073696Z","caller":"traceutil/trace.go:171","msg":"trace[550842515] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"210.825381ms","start":"2026-04-21T17:11:19.862042Z","end":"2026-04-21T17:11:20.072867Z","steps":["trace[550842515] 'process raft request' (duration: 210.628127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:20.134827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.691005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:20.135081Z","caller":"traceutil/trace.go:171","msg":"trace[1318560773] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:665; }","duration":"128.940951ms","start":"2026-04-21T17:11:20.006075Z","end":"2026-04-21T17:11:20.135016Z","steps":["trace[1318560773] 'agreement among raft nodes before linearized reading' (duration: 128.674653ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.134864Z","caller":"traceutil/trace.go:171","msg":"trace[196553770] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"101.935582ms","start":"2026-04-21T17:11:20.032875Z","end":"2026-04-21T17:11:20.134811Z","steps":["trace[196553770] 'process raft request' (duration: 101.744936ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.205862Z","caller":"traceutil/trace.go:171","msg":"trace[247168338] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"122.611206ms","start":"2026-04-21T17:11:20.083226Z","end":"2026-04-21T17:11:20.205837Z","steps":["trace[247168338] 'process raft request' (duration: 122.442542ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.206027Z","caller":"traceutil/trace.go:171","msg":"trace[1783592259] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"123.756714ms","start":"2026-04-21T17:11:20.082262Z","end":"2026-04-21T17:11:20.206019Z","steps":["trace[1783592259] 'process raft request' (duration: 123.325363ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.206073Z","caller":"traceutil/trace.go:171","msg":"trace[631887180] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"118.562327ms","start":"2026-04-21T17:11:20.087506Z","end":"2026-04-21T17:11:20.206069Z","steps":["trace[631887180] 'process raft request' (duration: 118.218728ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.206192Z","caller":"traceutil/trace.go:171","msg":"trace[2040253716] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"125.64267ms","start":"2026-04-21T17:11:20.080518Z","end":"2026-04-21T17:11:20.206161Z","steps":["trace[2040253716] 'process raft request' (duration: 124.845841ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.377994Z","caller":"traceutil/trace.go:171","msg":"trace[1213503105] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"157.194921ms","start":"2026-04-21T17:11:20.220683Z","end":"2026-04-21T17:11:20.377878Z","steps":["trace[1213503105] 'process raft request' (duration: 157.074518ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.378015Z","caller":"traceutil/trace.go:171","msg":"trace[1459765182] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"156.369381ms","start":"2026-04-21T17:11:20.221609Z","end":"2026-04-21T17:11:20.377979Z","steps":["trace[1459765182] 'process raft request' (duration: 155.992202ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.378166Z","caller":"traceutil/trace.go:171","msg":"trace[1244595385] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"140.406031ms","start":"2026-04-21T17:11:20.237719Z","end":"2026-04-21T17:11:20.378125Z","steps":["trace[1244595385] 'process raft request' (duration: 140.106934ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.66448Z","caller":"traceutil/trace.go:171","msg":"trace[823958091] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"411.149087ms","start":"2026-04-21T17:11:20.2533Z","end":"2026-04-21T17:11:20.664449Z","steps":["trace[823958091] 'process raft request' (duration: 410.958852ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.664769Z","caller":"traceutil/trace.go:171","msg":"trace[2031814812] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"297.747627ms","start":"2026-04-21T17:11:20.366993Z","end":"2026-04-21T17:11:20.66474Z","steps":["trace[2031814812] 'process raft request' (duration: 297.413169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:20.664801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:20.253277Z","time spent":"411.446864ms","remote":"127.0.0.1:42020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4671,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:11:20.700369Z","caller":"traceutil/trace.go:171","msg":"trace[962593683] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"315.452528ms","start":"2026-04-21T17:11:20.384895Z","end":"2026-04-21T17:11:20.700347Z","steps":["trace[962593683] 'process raft request' (duration: 315.253613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:20.70053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:20.384855Z","time spent":"315.588452ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:11:20.700712Z","caller":"traceutil/trace.go:171","msg":"trace[2008487083] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"311.282046ms","start":"2026-04-21T17:11:20.389353Z","end":"2026-04-21T17:11:20.700635Z","steps":["trace[2008487083] 'process raft request' (duration: 310.941508ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.701019Z","caller":"traceutil/trace.go:171","msg":"trace[1615589193] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"266.907973ms","start":"2026-04-21T17:11:20.434093Z","end":"2026-04-21T17:11:20.701001Z","steps":["trace[1615589193] 'process raft request' (duration: 266.41762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:20.701068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:20.389326Z","time spent":"311.501943ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13214,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:11:20.908882Z","caller":"traceutil/trace.go:171","msg":"trace[1961767380] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"238.892078ms","start":"2026-04-21T17:11:20.669948Z","end":"2026-04-21T17:11:20.90884Z","steps":["trace[1961767380] 'process raft request' (duration: 215.487976ms)","trace[1961767380] 'compare' (duration: 23.140166ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:11:20.927699Z","caller":"traceutil/trace.go:171","msg":"trace[2119870398] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"219.463264ms","start":"2026-04-21T17:11:20.708195Z","end":"2026-04-21T17:11:20.927658Z","steps":["trace[2119870398] 'process raft request' (duration: 219.151096ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:20.927723Z","caller":"traceutil/trace.go:171","msg":"trace[1077931980] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"212.7978ms","start":"2026-04-21T17:11:20.714896Z","end":"2026-04-21T17:11:20.927693Z","steps":["trace[1077931980] 'process raft request' (duration: 212.615835ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:21.221701Z","caller":"traceutil/trace.go:171","msg":"trace[6335475] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"284.277936ms","start":"2026-04-21T17:11:20.937395Z","end":"2026-04-21T17:11:21.221673Z","steps":["trace[6335475] 'process raft request' (duration: 284.164473ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:21.221835Z","caller":"traceutil/trace.go:171","msg":"trace[1981659986] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"288.53979ms","start":"2026-04-21T17:11:20.933273Z","end":"2026-04-21T17:11:21.221813Z","steps":["trace[1981659986] 'process raft request' (duration: 254.16498ms)","trace[1981659986] 'compare' (duration: 33.99134ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:11:21.226257Z","caller":"traceutil/trace.go:171","msg":"trace[1510841815] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"165.894864ms","start":"2026-04-21T17:11:21.060339Z","end":"2026-04-21T17:11:21.226234Z","steps":["trace[1510841815] 'process raft request' (duration: 165.825922ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:21.226431Z","caller":"traceutil/trace.go:171","msg":"trace[1280528032] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"261.965181ms","start":"2026-04-21T17:11:20.96445Z","end":"2026-04-21T17:11:21.226415Z","steps":["trace[1280528032] 'process raft request' (duration: 261.569942ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:35.640646Z","caller":"traceutil/trace.go:171","msg":"trace[428532360] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"342.354847ms","start":"2026-04-21T17:11:35.298263Z","end":"2026-04-21T17:11:35.640618Z","steps":["trace[428532360] 'process raft request' (duration: 342.204434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:35.640835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:35.298234Z","time spent":"342.509181ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:11:35.776069Z","caller":"traceutil/trace.go:171","msg":"trace[1095908986] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"310.653491ms","start":"2026-04-21T17:11:35.465398Z","end":"2026-04-21T17:11:35.776052Z","steps":["trace[1095908986] 'process raft request' (duration: 310.548739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:35.776182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:35.465367Z","time spent":"310.756834ms","remote":"127.0.0.1:42080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:12:12.504547Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232310842980885097,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:12:13.005491Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232310842980885097,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:12:13.105974Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.302248573s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T17:12:13.106421Z","caller":"traceutil/trace.go:171","msg":"trace[1929673844] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"1.302972421s","start":"2026-04-21T17:12:11.803424Z","end":"2026-04-21T17:12:13.106396Z","steps":["trace[1929673844] 'process raft request' (duration: 1.302802777s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:13.106561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:11.803404Z","time spent":"1.303089764s","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:13.189128Z","caller":"traceutil/trace.go:171","msg":"trace[1195313242] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"549.424777ms","start":"2026-04-21T17:12:12.639683Z","end":"2026-04-21T17:12:13.189108Z","steps":["trace[1195313242] 'process raft request' (duration: 543.267136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:13.189264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:12.63966Z","time spent":"549.529789ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:13.189437Z","caller":"traceutil/trace.go:171","msg":"trace[1965739708] linearizableReadLoop","detail":"{readStateIndex:1060; appliedIndex:1057; }","duration":"1.185142642s","start":"2026-04-21T17:12:12.004235Z","end":"2026-04-21T17:12:13.189378Z","steps":["trace[1965739708] 'read index received' (duration: 1.10196928s)","trace[1965739708] 'applied index is now lower than readState.Index' (duration: 83.171462ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:12:13.189626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.185385138s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:13.189532Z","caller":"traceutil/trace.go:171","msg":"trace[1928625684] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"305.27809ms","start":"2026-04-21T17:12:12.884235Z","end":"2026-04-21T17:12:13.189513Z","steps":["trace[1928625684] 'process raft request' (duration: 304.83966ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:13.189697Z","caller":"traceutil/trace.go:171","msg":"trace[1652327101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1022; }","duration":"1.18548178s","start":"2026-04-21T17:12:12.004191Z","end":"2026-04-21T17:12:13.189673Z","steps":["trace[1652327101] 'agreement among raft nodes before linearized reading' (duration: 1.185402718s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:13.189736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:12.00417Z","time spent":"1.185557602s","remote":"127.0.0.1:41860","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-04-21T17:12:13.18974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:12.884204Z","time spent":"305.505955ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:12:13.190527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.030444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-21T17:12:13.190536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"756.804545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T17:12:13.190559Z","caller":"traceutil/trace.go:171","msg":"trace[1232869096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1022; }","duration":"805.098655ms","start":"2026-04-21T17:12:12.385452Z","end":"2026-04-21T17:12:13.190551Z","steps":["trace[1232869096] 'agreement among raft nodes before linearized reading' (duration: 804.974012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:13.190561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.77676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-21T17:12:13.190585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:12.385435Z","time spent":"805.142946ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-21T17:12:13.19058Z","caller":"traceutil/trace.go:171","msg":"trace[52637331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1022; }","duration":"756.894807ms","start":"2026-04-21T17:12:12.433674Z","end":"2026-04-21T17:12:13.190568Z","steps":["trace[52637331] 'agreement among raft nodes before linearized reading' (duration: 756.736613ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:13.190604Z","caller":"traceutil/trace.go:171","msg":"trace[199967039] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1022; }","duration":"843.850132ms","start":"2026-04-21T17:12:12.346741Z","end":"2026-04-21T17:12:13.190591Z","steps":["trace[199967039] 'agreement among raft nodes before linearized reading' (duration: 843.72926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:13.190618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:12.433656Z","time spent":"756.954149ms","remote":"127.0.0.1:42108","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-04-21T17:12:13.190635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:12.346721Z","time spent":"843.906843ms","remote":"127.0.0.1:42108","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-04-21T17:12:13.190883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.329657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-21T17:12:13.190932Z","caller":"traceutil/trace.go:171","msg":"trace[1007758450] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1022; }","duration":"989.410978ms","start":"2026-04-21T17:12:12.20151Z","end":"2026-04-21T17:12:13.190921Z","steps":["trace[1007758450] 'agreement among raft nodes before linearized reading' (duration: 989.285625ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:13.190961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:12.201492Z","time spent":"989.46219ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-21T17:12:15.374026Z","caller":"traceutil/trace.go:171","msg":"trace[1191618472] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"164.290835ms","start":"2026-04-21T17:12:15.209712Z","end":"2026-04-21T17:12:15.374003Z","steps":["trace[1191618472] 'process raft request' (duration: 164.149432ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:19.385054Z","caller":"traceutil/trace.go:171","msg":"trace[573347534] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"107.22076ms","start":"2026-04-21T17:12:19.277795Z","end":"2026-04-21T17:12:19.385015Z","steps":["trace[573347534] 'process raft request' (duration: 72.284916ms)","trace[573347534] 'compare' (duration: 34.524544ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:12:35.461197Z","caller":"traceutil/trace.go:171","msg":"trace[90884610] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"221.535373ms","start":"2026-04-21T17:12:35.239643Z","end":"2026-04-21T17:12:35.461179Z","steps":["trace[90884610] 'process raft request' (duration: 221.40549ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:35.997604Z","caller":"traceutil/trace.go:171","msg":"trace[229714] linearizableReadLoop","detail":"{readStateIndex:1137; appliedIndex:1135; }","duration":"696.545704ms","start":"2026-04-21T17:12:35.301009Z","end":"2026-04-21T17:12:35.997555Z","steps":["trace[229714] 'read index received' (duration: 160.060127ms)","trace[229714] 'applied index is now lower than readState.Index' (duration: 536.484567ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:12:35.997722Z","caller":"traceutil/trace.go:171","msg":"trace[437422537] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"706.131467ms","start":"2026-04-21T17:12:35.291579Z","end":"2026-04-21T17:12:35.99771Z","steps":["trace[437422537] 'process raft request' (duration: 692.659439ms)","trace[437422537] 'compare' (duration: 12.934255ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:12:35.997842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.9046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:35.997913Z","caller":"traceutil/trace.go:171","msg":"trace[206908438] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1094; }","duration":"654.990652ms","start":"2026-04-21T17:12:35.342903Z","end":"2026-04-21T17:12:35.997894Z","steps":["trace[206908438] 'agreement among raft nodes before linearized reading' (duration: 654.87809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:35.997954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:35.342847Z","time spent":"655.096854ms","remote":"127.0.0.1:56966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:12:35.998057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.115494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-21T17:12:35.998158Z","caller":"traceutil/trace.go:171","msg":"trace[380520988] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1094; }","duration":"498.262328ms","start":"2026-04-21T17:12:35.499878Z","end":"2026-04-21T17:12:35.99814Z","steps":["trace[380520988] 'agreement among raft nodes before linearized reading' (duration: 497.988272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:35.998209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:35.499862Z","time spent":"498.3371ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T17:12:35.998323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.151937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T17:12:35.998371Z","caller":"traceutil/trace.go:171","msg":"trace[1768459916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1094; }","duration":"623.28285ms","start":"2026-04-21T17:12:35.375074Z","end":"2026-04-21T17:12:35.998356Z","steps":["trace[1768459916] 'agreement among raft nodes before linearized reading' (duration: 623.092996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:35.998434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:35.37505Z","time spent":"623.373732ms","remote":"127.0.0.1:42108","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-04-21T17:12:35.998566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.215064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T17:12:35.998605Z","caller":"traceutil/trace.go:171","msg":"trace[888993047] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1094; }","duration":"629.275516ms","start":"2026-04-21T17:12:35.369308Z","end":"2026-04-21T17:12:35.998583Z","steps":["trace[888993047] 'agreement among raft nodes before linearized reading' (duration: 629.197364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:35.998632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:35.369287Z","time spent":"629.339397ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T17:12:35.998653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.63461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-21T17:12:35.998696Z","caller":"traceutil/trace.go:171","msg":"trace[811726147] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1094; }","duration":"697.680491ms","start":"2026-04-21T17:12:35.301004Z","end":"2026-04-21T17:12:35.998685Z","steps":["trace[811726147] 'agreement among raft nodes before linearized reading' (duration: 697.558358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:35.998727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:35.300954Z","time spent":"697.764133ms","remote":"127.0.0.1:42108","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-04-21T17:12:35.99781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:35.291551Z","time spent":"706.194949ms","remote":"127.0.0.1:42108","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-04-21T17:12:36.494075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.24293ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:36.494213Z","caller":"traceutil/trace.go:171","msg":"trace[217037588] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1094; }","duration":"266.410694ms","start":"2026-04-21T17:12:36.227783Z","end":"2026-04-21T17:12:36.494194Z","steps":["trace[217037588] 'range keys from in-memory index tree' (duration: 266.22166ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:36.494313Z","caller":"traceutil/trace.go:171","msg":"trace[941772996] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"491.756629ms","start":"2026-04-21T17:12:36.002494Z","end":"2026-04-21T17:12:36.49425Z","steps":["trace[941772996] 'process raft request' (duration: 436.177565ms)","trace[941772996] 'compare' (duration: 55.185124ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:12:36.49448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:36.002477Z","time spent":"491.890401ms","remote":"127.0.0.1:42108","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-04-21T17:12:36.528809Z","caller":"traceutil/trace.go:171","msg":"trace[1880721190] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"525.833958ms","start":"2026-04-21T17:12:36.002941Z","end":"2026-04-21T17:12:36.528775Z","steps":["trace[1880721190] 'process raft request' (duration: 525.551332ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:36.528977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:36.00292Z","time spent":"525.971452ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:36.52904Z","caller":"traceutil/trace.go:171","msg":"trace[977370801] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"525.943231ms","start":"2026-04-21T17:12:36.003066Z","end":"2026-04-21T17:12:36.529009Z","steps":["trace[977370801] 'process raft request' (duration: 525.542311ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:36.529128Z","caller":"traceutil/trace.go:171","msg":"trace[1038166117] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"525.747097ms","start":"2026-04-21T17:12:36.003348Z","end":"2026-04-21T17:12:36.529095Z","steps":["trace[1038166117] 'process raft request' (duration: 525.569683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:36.529196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:36.003038Z","time spent":"526.077844ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:12:36.529217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.903102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:12:36.529243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:36.003336Z","time spent":"525.852039ms","remote":"127.0.0.1:42108","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-04-21T17:12:36.529254Z","caller":"traceutil/trace.go:171","msg":"trace[626370758] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1098; }","duration":"523.957302ms","start":"2026-04-21T17:12:36.005285Z","end":"2026-04-21T17:12:36.529242Z","steps":["trace[626370758] 'agreement among raft nodes before linearized reading' (duration: 523.893951ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:36.528979Z","caller":"traceutil/trace.go:171","msg":"trace[566554934] linearizableReadLoop","detail":"{readStateIndex:1141; appliedIndex:1137; }","duration":"523.638615ms","start":"2026-04-21T17:12:36.005318Z","end":"2026-04-21T17:12:36.528957Z","steps":["trace[566554934] 'read index received' (duration: 433.346266ms)","trace[566554934] 'applied index is now lower than readState.Index' (duration: 90.291139ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:12:36.529288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:36.005275Z","time spent":"524.007753ms","remote":"127.0.0.1:41860","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-04-21T17:12:37.571192Z","caller":"traceutil/trace.go:171","msg":"trace[385510783] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"101.809559ms","start":"2026-04-21T17:12:37.469348Z","end":"2026-04-21T17:12:37.571157Z","steps":["trace[385510783] 'process raft request' (duration: 101.525472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:38.186752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.849758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:12:38.186815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.919644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:38.187238Z","caller":"traceutil/trace.go:171","msg":"trace[628642493] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1099; }","duration":"181.383435ms","start":"2026-04-21T17:12:38.005834Z","end":"2026-04-21T17:12:38.187217Z","steps":["trace[628642493] 'range keys from in-memory index tree' (duration: 180.805551ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:38.186937Z","caller":"traceutil/trace.go:171","msg":"trace[243491526] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1099; }","duration":"199.081526ms","start":"2026-04-21T17:12:37.987832Z","end":"2026-04-21T17:12:38.186914Z","steps":["trace[243491526] 'count revisions from in-memory index tree' (duration: 198.754006ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:38.20834Z","caller":"traceutil/trace.go:171","msg":"trace[1438626796] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"201.655429ms","start":"2026-04-21T17:12:38.006641Z","end":"2026-04-21T17:12:38.208296Z","steps":["trace[1438626796] 'process raft request' (duration: 201.367312ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:38.618813Z","caller":"traceutil/trace.go:171","msg":"trace[438084603] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"114.800774ms","start":"2026-04-21T17:12:38.503966Z","end":"2026-04-21T17:12:38.618767Z","steps":["trace[438084603] 'process raft request' (duration: 114.458946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:39.659579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.57785ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:12:39.659966Z","caller":"traceutil/trace.go:171","msg":"trace[497087652] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"326.154008ms","start":"2026-04-21T17:12:39.333775Z","end":"2026-04-21T17:12:39.659929Z","steps":["trace[497087652] 'process raft request' (duration: 46.838151ms)","trace[497087652] 'compare' (duration: 278.392855ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:12:39.660786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:39.33375Z","time spent":"326.946888ms","remote":"127.0.0.1:41884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:40.41695Z","caller":"traceutil/trace.go:171","msg":"trace[1495112380] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"202.955221ms","start":"2026-04-21T17:12:40.213957Z","end":"2026-04-21T17:12:40.416912Z","steps":["trace[1495112380] 'process raft request' (duration: 155.828143ms)","trace[1495112380] 'compare' (duration: 46.960724ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:12:53.237294Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232310842980885522,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:12:53.737844Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232310842980885522,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:12:54.238156Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232310842980885522,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:12:54.438828Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.98689902s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T17:12:54.43905Z","caller":"traceutil/trace.go:171","msg":"trace[558729735] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"1.987213569s","start":"2026-04-21T17:12:52.451821Z","end":"2026-04-21T17:12:54.439035Z","steps":["trace[558729735] 'process raft request' (duration: 1.987120826s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:54.439129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:52.451798Z","time spent":"1.98727952s","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:54.439769Z","caller":"traceutil/trace.go:171","msg":"trace[2086301851] linearizableReadLoop","detail":"{readStateIndex:1248; appliedIndex:1246; }","duration":"1.702876988s","start":"2026-04-21T17:12:52.736881Z","end":"2026-04-21T17:12:54.439758Z","steps":["trace[2086301851] 'read index received' (duration: 1.70212458s)","trace[2086301851] 'applied index is now lower than readState.Index' (duration: 751.788µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:12:54.439925Z","caller":"traceutil/trace.go:171","msg":"trace[99530870] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"742.257367ms","start":"2026-04-21T17:12:53.697659Z","end":"2026-04-21T17:12:54.439916Z","steps":["trace[99530870] 'process raft request' (duration: 742.059642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:54.439968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:53.697639Z","time spent":"742.304487ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:12:54.440023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.682277116s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T17:12:54.440042Z","caller":"traceutil/trace.go:171","msg":"trace[1139709900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1200; }","duration":"1.682319317s","start":"2026-04-21T17:12:52.757717Z","end":"2026-04-21T17:12:54.440036Z","steps":["trace[1139709900] 'agreement among raft nodes before linearized reading' (duration: 1.682251175s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:54.440056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:52.757706Z","time spent":"1.682347318s","remote":"127.0.0.1:42108","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-04-21T17:12:54.440133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.703254757s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-21T17:12:54.440147Z","caller":"traceutil/trace.go:171","msg":"trace[1272727082] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1200; }","duration":"1.703268277s","start":"2026-04-21T17:12:52.736875Z","end":"2026-04-21T17:12:54.440143Z","steps":["trace[1272727082] 'agreement among raft nodes before linearized reading' (duration: 1.703230216s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:54.440159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:52.73682Z","time spent":"1.703335689s","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T17:12:54.440201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.434114335s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:54.440224Z","caller":"traceutil/trace.go:171","msg":"trace[771064486] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1200; }","duration":"1.434165177s","start":"2026-04-21T17:12:53.006051Z","end":"2026-04-21T17:12:54.440217Z","steps":["trace[771064486] 'agreement among raft nodes before linearized reading' (duration: 1.434131796s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:54.440237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.647296405s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T17:12:54.440249Z","caller":"traceutil/trace.go:171","msg":"trace[906573033] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1200; }","duration":"1.647330956s","start":"2026-04-21T17:12:52.792915Z","end":"2026-04-21T17:12:54.440246Z","steps":["trace[906573033] 'agreement among raft nodes before linearized reading' (duration: 1.647294865s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:54.440257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:53.006037Z","time spent":"1.434215798s","remote":"127.0.0.1:41860","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-04-21T17:12:54.440262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:52.792903Z","time spent":"1.647356147s","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T17:12:54.440336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.651742823s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-21T17:12:54.440356Z","caller":"traceutil/trace.go:171","msg":"trace[671581502] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1200; }","duration":"1.651788535s","start":"2026-04-21T17:12:52.788562Z","end":"2026-04-21T17:12:54.44035Z","steps":["trace[671581502] 'agreement among raft nodes before linearized reading' (duration: 1.651747983s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:54.440354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.978706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:12:54.440368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:52.788547Z","time spent":"1.651818225s","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T17:12:54.440373Z","caller":"traceutil/trace.go:171","msg":"trace[177141099] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1200; }","duration":"287.031457ms","start":"2026-04-21T17:12:54.153336Z","end":"2026-04-21T17:12:54.440367Z","steps":["trace[177141099] 'agreement among raft nodes before linearized reading' (duration: 287.002607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:54.440508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.088688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-21T17:12:54.44054Z","caller":"traceutil/trace.go:171","msg":"trace[992803807] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1200; }","duration":"614.162399ms","start":"2026-04-21T17:12:53.826372Z","end":"2026-04-21T17:12:54.440534Z","steps":["trace[992803807] 'agreement among raft nodes before linearized reading' (duration: 614.093768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:54.440559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:53.826352Z","time spent":"614.20233ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-21T17:13:06.793129Z","caller":"traceutil/trace.go:171","msg":"trace[931461337] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"262.974061ms","start":"2026-04-21T17:13:06.52955Z","end":"2026-04-21T17:13:06.792524Z","steps":["trace[931461337] 'process raft request' (duration: 261.352521ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:06.793171Z","caller":"traceutil/trace.go:171","msg":"trace[218197125] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"263.556795ms","start":"2026-04-21T17:13:06.529573Z","end":"2026-04-21T17:13:06.79313Z","steps":["trace[218197125] 'process raft request' (duration: 262.860728ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:06.793304Z","caller":"traceutil/trace.go:171","msg":"trace[943668285] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"261.067594ms","start":"2026-04-21T17:13:06.532216Z","end":"2026-04-21T17:13:06.793283Z","steps":["trace[943668285] 'process raft request' (duration: 260.948811ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:06.793769Z","caller":"traceutil/trace.go:171","msg":"trace[684231724] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"263.521365ms","start":"2026-04-21T17:13:06.530232Z","end":"2026-04-21T17:13:06.793753Z","steps":["trace[684231724] 'process raft request' (duration: 262.251774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:06.794409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.808645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-21T17:13:06.794462Z","caller":"traceutil/trace.go:171","msg":"trace[1803583038] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1243; }","duration":"264.907168ms","start":"2026-04-21T17:13:06.529534Z","end":"2026-04-21T17:13:06.794441Z","steps":["trace[1803583038] 'agreement among raft nodes before linearized reading' (duration: 264.771804ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:06.795965Z","caller":"traceutil/trace.go:171","msg":"trace[485545359] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1290; }","duration":"264.736233ms","start":"2026-04-21T17:13:06.529589Z","end":"2026-04-21T17:13:06.794325Z","steps":["trace[485545359] 'read index received' (duration: 261.419783ms)","trace[485545359] 'applied index is now lower than readState.Index' (duration: 2.174283ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:09.460937Z","caller":"traceutil/trace.go:171","msg":"trace[934305557] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"123.733551ms","start":"2026-04-21T17:13:09.337177Z","end":"2026-04-21T17:13:09.46091Z","steps":["trace[934305557] 'process raft request' (duration: 123.580638ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:10.050651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.604644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-8p58c\" ","response":"range_response_count:1 size:11053"} {"level":"info","ts":"2026-04-21T17:13:10.050736Z","caller":"traceutil/trace.go:171","msg":"trace[2019417922] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-8p58c; range_end:; response_count:1; response_revision:1267; }","duration":"274.730237ms","start":"2026-04-21T17:13:09.775988Z","end":"2026-04-21T17:13:10.050718Z","steps":["trace[2019417922] 'range keys from in-memory index tree' (duration: 274.45018ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:10.440301Z","caller":"traceutil/trace.go:171","msg":"trace[663792811] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"379.953558ms","start":"2026-04-21T17:13:10.060312Z","end":"2026-04-21T17:13:10.440266Z","steps":["trace[663792811] 'process raft request' (duration: 379.661481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:10.440487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:10.060297Z","time spent":"380.106171ms","remote":"127.0.0.1:42020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11367,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:13:10.587441Z","caller":"traceutil/trace.go:171","msg":"trace[1393075016] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"135.705442ms","start":"2026-04-21T17:13:10.451715Z","end":"2026-04-21T17:13:10.58742Z","steps":["trace[1393075016] 'process raft request' (duration: 135.659121ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:10.587772Z","caller":"traceutil/trace.go:171","msg":"trace[1321619776] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"142.622701ms","start":"2026-04-21T17:13:10.445135Z","end":"2026-04-21T17:13:10.587758Z","steps":["trace[1321619776] 'process raft request' (duration: 142.137109ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:10.642507Z","caller":"traceutil/trace.go:171","msg":"trace[151966854] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"104.818501ms","start":"2026-04-21T17:13:10.537653Z","end":"2026-04-21T17:13:10.642472Z","steps":["trace[151966854] 'process raft request' (duration: 72.102184ms)","trace[151966854] 'compare' (duration: 32.620434ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:11.127549Z","caller":"traceutil/trace.go:171","msg":"trace[344115698] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"254.824693ms","start":"2026-04-21T17:13:10.872695Z","end":"2026-04-21T17:13:11.12752Z","steps":["trace[344115698] 'process raft request' (duration: 238.66454ms)","trace[344115698] 'compare' (duration: 15.875326ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:11.127553Z","caller":"traceutil/trace.go:171","msg":"trace[2031992316] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"254.404553ms","start":"2026-04-21T17:13:10.873123Z","end":"2026-04-21T17:13:11.127527Z","steps":["trace[2031992316] 'process raft request' (duration: 254.27321ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:11.127698Z","caller":"traceutil/trace.go:171","msg":"trace[1308662234] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1328; }","duration":"122.361107ms","start":"2026-04-21T17:13:11.00532Z","end":"2026-04-21T17:13:11.127681Z","steps":["trace[1308662234] 'read index received' (duration: 106.007039ms)","trace[1308662234] 'applied index is now lower than readState.Index' (duration: 16.353238ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:11.127827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.49129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:11.127819Z","caller":"traceutil/trace.go:171","msg":"trace[583036594] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"175.06485ms","start":"2026-04-21T17:13:10.952731Z","end":"2026-04-21T17:13:11.127796Z","steps":["trace[583036594] 'process raft request' (duration: 174.719412ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:11.127866Z","caller":"traceutil/trace.go:171","msg":"trace[690467406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1279; }","duration":"122.578313ms","start":"2026-04-21T17:13:11.005277Z","end":"2026-04-21T17:13:11.127855Z","steps":["trace[690467406] 'agreement among raft nodes before linearized reading' (duration: 122.47067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:11.638587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.233817ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:13:11.63875Z","caller":"traceutil/trace.go:171","msg":"trace[1115338632] linearizableReadLoop","detail":"{readStateIndex:1332; appliedIndex:1331; }","duration":"366.621304ms","start":"2026-04-21T17:13:11.27207Z","end":"2026-04-21T17:13:11.638691Z","steps":["trace[1115338632] 'read index received' (duration: 66.080278ms)","trace[1115338632] 'applied index is now lower than readState.Index' (duration: 300.538776ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:11.638929Z","caller":"traceutil/trace.go:171","msg":"trace[433667629] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"448.251231ms","start":"2026-04-21T17:13:11.190643Z","end":"2026-04-21T17:13:11.638894Z","steps":["trace[433667629] 'process raft request' (duration: 147.618474ms)","trace[433667629] 'compare' (duration: 299.866958ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:11.63898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.90036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:11.639019Z","caller":"traceutil/trace.go:171","msg":"trace[1180297149] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1280; }","duration":"366.940981ms","start":"2026-04-21T17:13:11.272064Z","end":"2026-04-21T17:13:11.639005Z","steps":["trace[1180297149] 'agreement among raft nodes before linearized reading' (duration: 366.842989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:11.639045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:11.190621Z","time spent":"448.366263ms","remote":"127.0.0.1:41914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:13:11.639066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:11.272008Z","time spent":"367.047454ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-21T17:13:11.639112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.389937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:11.639219Z","caller":"traceutil/trace.go:171","msg":"trace[1797281250] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1280; }","duration":"230.671474ms","start":"2026-04-21T17:13:11.408529Z","end":"2026-04-21T17:13:11.639201Z","steps":["trace[1797281250] 'agreement among raft nodes before linearized reading' (duration: 230.431878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:12.449775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.192941ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:13:12.449907Z","caller":"traceutil/trace.go:171","msg":"trace[1496658943] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"806.367737ms","start":"2026-04-21T17:13:11.643513Z","end":"2026-04-21T17:13:12.449881Z","steps":["trace[1496658943] 'process raft request' (duration: 405.990832ms)","trace[1496658943] 'compare' (duration: 399.892744ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:12.449982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:11.643493Z","time spent":"806.457759ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":456,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:13:12.545055Z","caller":"traceutil/trace.go:171","msg":"trace[947784393] linearizableReadLoop","detail":"{readStateIndex:1334; appliedIndex:1332; }","duration":"539.194283ms","start":"2026-04-21T17:13:12.005846Z","end":"2026-04-21T17:13:12.54504Z","steps":["trace[947784393] 'read index received' (duration: 43.685473ms)","trace[947784393] 'applied index is now lower than readState.Index' (duration: 495.50825ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:12.545194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.334127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:12.545219Z","caller":"traceutil/trace.go:171","msg":"trace[1220777355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1282; }","duration":"539.404829ms","start":"2026-04-21T17:13:12.005807Z","end":"2026-04-21T17:13:12.545212Z","steps":["trace[1220777355] 'agreement among raft nodes before linearized reading' (duration: 539.307156ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:12.54518Z","caller":"traceutil/trace.go:171","msg":"trace[235829375] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"639.573407ms","start":"2026-04-21T17:13:11.905552Z","end":"2026-04-21T17:13:12.545125Z","steps":["trace[235829375] 'process raft request' (duration: 639.398882ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:12.545245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:12.005791Z","time spent":"539.448139ms","remote":"127.0.0.1:41860","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-04-21T17:13:12.545331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:11.90553Z","time spent":"639.732661ms","remote":"127.0.0.1:41914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:13:12.672865Z","caller":"traceutil/trace.go:171","msg":"trace[1985559327] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"217.883683ms","start":"2026-04-21T17:13:12.454955Z","end":"2026-04-21T17:13:12.672839Z","steps":["trace[1985559327] 'process raft request' (duration: 177.052009ms)","trace[1985559327] 'compare' (duration: 40.692721ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:12.672923Z","caller":"traceutil/trace.go:171","msg":"trace[1109210464] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"123.566898ms","start":"2026-04-21T17:13:12.549331Z","end":"2026-04-21T17:13:12.672898Z","steps":["trace[1109210464] 'process raft request' (duration: 123.521047ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:12.673087Z","caller":"traceutil/trace.go:171","msg":"trace[963267477] linearizableReadLoop","detail":"{readStateIndex:1335; appliedIndex:1334; }","duration":"127.981765ms","start":"2026-04-21T17:13:12.545096Z","end":"2026-04-21T17:13:12.673078Z","steps":["trace[963267477] 'read index received' (duration: 86.913115ms)","trace[963267477] 'applied index is now lower than readState.Index' (duration: 41.06771ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:12.673248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.242726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:471"} {"level":"info","ts":"2026-04-21T17:13:12.673274Z","caller":"traceutil/trace.go:171","msg":"trace[743683128] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1284; }","duration":"219.325188ms","start":"2026-04-21T17:13:12.453943Z","end":"2026-04-21T17:13:12.673268Z","steps":["trace[743683128] 'agreement among raft nodes before linearized reading' (duration: 219.187514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:12.709457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.334085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:12.709579Z","caller":"traceutil/trace.go:171","msg":"trace[980477432] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1285; }","duration":"163.499029ms","start":"2026-04-21T17:13:12.546049Z","end":"2026-04-21T17:13:12.709548Z","steps":["trace[980477432] 'agreement among raft nodes before linearized reading' (duration: 163.272773ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:13.159993Z","caller":"traceutil/trace.go:171","msg":"trace[1460002533] linearizableReadLoop","detail":"{readStateIndex:1338; appliedIndex:1337; }","duration":"320.903101ms","start":"2026-04-21T17:13:12.839043Z","end":"2026-04-21T17:13:13.159946Z","steps":["trace[1460002533] 'read index received' (duration: 320.270305ms)","trace[1460002533] 'applied index is now lower than readState.Index' (duration: 630.776µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:13.160407Z","caller":"traceutil/trace.go:171","msg":"trace[1972910190] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"482.896533ms","start":"2026-04-21T17:13:12.677494Z","end":"2026-04-21T17:13:13.160391Z","steps":["trace[1972910190] 'process raft request' (duration: 481.92374ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:13.160454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.6508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:13.160564Z","caller":"traceutil/trace.go:171","msg":"trace[1908688771] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1286; }","duration":"153.815074ms","start":"2026-04-21T17:13:13.006723Z","end":"2026-04-21T17:13:13.160538Z","steps":["trace[1908688771] 'agreement among raft nodes before linearized reading' (duration: 153.627449ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:13.160582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.529857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-21T17:13:13.16058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:12.677468Z","time spent":"482.984716ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:13:13.16062Z","caller":"traceutil/trace.go:171","msg":"trace[2082436040] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1286; }","duration":"229.605438ms","start":"2026-04-21T17:13:12.930999Z","end":"2026-04-21T17:13:13.160604Z","steps":["trace[2082436040] 'agreement among raft nodes before linearized reading' (duration: 229.532287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:13.160663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.615909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T17:13:13.160702Z","caller":"traceutil/trace.go:171","msg":"trace[871190803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1286; }","duration":"321.68677ms","start":"2026-04-21T17:13:12.839007Z","end":"2026-04-21T17:13:13.160693Z","steps":["trace[871190803] 'agreement among raft nodes before linearized reading' (duration: 321.600407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:13.16049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.223551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-21T17:13:13.160727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:12.838984Z","time spent":"321.734841ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-21T17:13:13.160766Z","caller":"traceutil/trace.go:171","msg":"trace[1102746691] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1286; }","duration":"287.542169ms","start":"2026-04-21T17:13:12.873208Z","end":"2026-04-21T17:13:13.16075Z","steps":["trace[1102746691] 'agreement among raft nodes before linearized reading' (duration: 287.126199ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:14.718484Z","caller":"traceutil/trace.go:171","msg":"trace[2085208004] linearizableReadLoop","detail":"{readStateIndex:1344; appliedIndex:1343; }","duration":"381.982487ms","start":"2026-04-21T17:13:14.336477Z","end":"2026-04-21T17:13:14.718459Z","steps":["trace[2085208004] 'read index received' (duration: 381.904525ms)","trace[2085208004] 'applied index is now lower than readState.Index' (duration: 77.012µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:14.718642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.138961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:14.718673Z","caller":"traceutil/trace.go:171","msg":"trace[84108283] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1292; }","duration":"382.229043ms","start":"2026-04-21T17:13:14.336435Z","end":"2026-04-21T17:13:14.718664Z","steps":["trace[84108283] 'agreement among raft nodes before linearized reading' (duration: 382.152851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:14.718708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:14.336415Z","time spent":"382.283614ms","remote":"127.0.0.1:42048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:13:14.718696Z","caller":"traceutil/trace.go:171","msg":"trace[2022626041] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"557.732624ms","start":"2026-04-21T17:13:14.160822Z","end":"2026-04-21T17:13:14.718555Z","steps":["trace[2022626041] 'process raft request' (duration: 557.485889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:14.718954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:14.160804Z","time spent":"557.994231ms","remote":"127.0.0.1:42010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6103,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:13:15.048315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.519438ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-21T17:13:15.048619Z","caller":"traceutil/trace.go:171","msg":"trace[863389041] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"334.120492ms","start":"2026-04-21T17:13:14.714481Z","end":"2026-04-21T17:13:15.048602Z","steps":["trace[863389041] 'process raft request' (duration: 333.906137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:15.048702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:14.714457Z","time spent":"334.194494ms","remote":"127.0.0.1:42108","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-04-21T17:13:15.305975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.87328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:15.306031Z","caller":"traceutil/trace.go:171","msg":"trace[1752829503] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1293; }","duration":"297.986244ms","start":"2026-04-21T17:13:15.008033Z","end":"2026-04-21T17:13:15.306019Z","steps":["trace[1752829503] 'agreement among raft nodes before linearized reading' (duration: 40.553118ms)","trace[1752829503] 'range keys from in-memory index tree' (duration: 257.349644ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:15.306479Z","caller":"traceutil/trace.go:171","msg":"trace[1133219277] linearizableReadLoop","detail":"{readStateIndex:1347; appliedIndex:1346; }","duration":"109.562697ms","start":"2026-04-21T17:13:15.196911Z","end":"2026-04-21T17:13:15.306473Z","steps":["trace[1133219277] 'read index received' (duration: 94.164162ms)","trace[1133219277] 'applied index is now lower than readState.Index' (duration: 15.397985ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:15.306596Z","caller":"traceutil/trace.go:171","msg":"trace[689115353] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"265.82043ms","start":"2026-04-21T17:13:15.040769Z","end":"2026-04-21T17:13:15.30659Z","steps":["trace[689115353] 'process raft request' (duration: 250.281473ms)","trace[689115353] 'compare' (duration: 14.835771ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:15.306718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.812163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-21T17:13:15.306762Z","caller":"traceutil/trace.go:171","msg":"trace[1511423399] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1294; }","duration":"109.902635ms","start":"2026-04-21T17:13:15.196852Z","end":"2026-04-21T17:13:15.306755Z","steps":["trace[1511423399] 'agreement among raft nodes before linearized reading' (duration: 109.790843ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:15.427455Z","caller":"traceutil/trace.go:171","msg":"trace[1912094032] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"116.808142ms","start":"2026-04-21T17:13:15.310619Z","end":"2026-04-21T17:13:15.427427Z","steps":["trace[1912094032] 'process raft request' (duration: 116.773711ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:15.427524Z","caller":"traceutil/trace.go:171","msg":"trace[738850272] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"116.928176ms","start":"2026-04-21T17:13:15.310536Z","end":"2026-04-21T17:13:15.427464Z","steps":["trace[738850272] 'process raft request' (duration: 110.111411ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:15.427711Z","caller":"traceutil/trace.go:171","msg":"trace[1514111267] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"117.127401ms","start":"2026-04-21T17:13:15.310574Z","end":"2026-04-21T17:13:15.427701Z","steps":["trace[1514111267] 'process raft request' (duration: 116.738531ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:15.427781Z","caller":"traceutil/trace.go:171","msg":"trace[1729982987] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"117.176142ms","start":"2026-04-21T17:13:15.310597Z","end":"2026-04-21T17:13:15.427773Z","steps":["trace[1729982987] 'process raft request' (duration: 116.742502ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:25.726795Z","caller":"traceutil/trace.go:171","msg":"trace[1509295140] linearizableReadLoop","detail":"{readStateIndex:1421; appliedIndex:1420; }","duration":"234.6109ms","start":"2026-04-21T17:13:25.492159Z","end":"2026-04-21T17:13:25.72677Z","steps":["trace[1509295140] 'read index received' (duration: 234.572729ms)","trace[1509295140] 'applied index is now lower than readState.Index' (duration: 37.071µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:25.726867Z","caller":"traceutil/trace.go:171","msg":"trace[136971045] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"600.458496ms","start":"2026-04-21T17:13:25.126386Z","end":"2026-04-21T17:13:25.726845Z","steps":["trace[136971045] 'process raft request' (duration: 600.22138ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:25.72702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:25.126362Z","time spent":"600.574928ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:13:25.727051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.891118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T17:13:25.727102Z","caller":"traceutil/trace.go:171","msg":"trace[1565955826] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1366; }","duration":"234.97462ms","start":"2026-04-21T17:13:25.49211Z","end":"2026-04-21T17:13:25.727085Z","steps":["trace[1565955826] 'agreement among raft nodes before linearized reading' (duration: 234.821886ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:25.859902Z","caller":"traceutil/trace.go:171","msg":"trace[1296009394] linearizableReadLoop","detail":"{readStateIndex:1422; appliedIndex:1421; }","duration":"132.954946ms","start":"2026-04-21T17:13:25.726903Z","end":"2026-04-21T17:13:25.859858Z","steps":["trace[1296009394] 'read index received' (duration: 88.835902ms)","trace[1296009394] 'applied index is now lower than readState.Index' (duration: 44.117414ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:25.860138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.412694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-21T17:13:25.860334Z","caller":"traceutil/trace.go:171","msg":"trace[705577344] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1367; }","duration":"358.640799ms","start":"2026-04-21T17:13:25.501675Z","end":"2026-04-21T17:13:25.860315Z","steps":["trace[705577344] 'agreement among raft nodes before linearized reading' (duration: 358.29005ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:25.860129Z","caller":"traceutil/trace.go:171","msg":"trace[1452208423] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"358.941086ms","start":"2026-04-21T17:13:25.501099Z","end":"2026-04-21T17:13:25.86004Z","steps":["trace[1452208423] 'process raft request' (duration: 314.544406ms)","trace[1452208423] 'compare' (duration: 43.997891ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:25.860403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:25.501667Z","time spent":"358.719302ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T17:13:25.860323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.311797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T17:13:25.860722Z","caller":"traceutil/trace.go:171","msg":"trace[1042610167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1367; }","duration":"357.754308ms","start":"2026-04-21T17:13:25.50295Z","end":"2026-04-21T17:13:25.860705Z","steps":["trace[1042610167] 'agreement among raft nodes before linearized reading' (duration: 356.979179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:25.860219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.538977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-21T17:13:25.860847Z","caller":"traceutil/trace.go:171","msg":"trace[834805675] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1367; }","duration":"366.199233ms","start":"2026-04-21T17:13:25.49463Z","end":"2026-04-21T17:13:25.860829Z","steps":["trace[834805675] 'agreement among raft nodes before linearized reading' (duration: 365.444714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:25.860903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:25.494615Z","time spent":"366.274086ms","remote":"127.0.0.1:42108","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-04-21T17:13:25.860258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.031001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-21T17:13:25.861Z","caller":"traceutil/trace.go:171","msg":"trace[230444839] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1367; }","duration":"362.802421ms","start":"2026-04-21T17:13:25.498179Z","end":"2026-04-21T17:13:25.860981Z","steps":["trace[230444839] 'agreement among raft nodes before linearized reading' (duration: 361.810496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:25.861055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:25.498161Z","time spent":"362.880773ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T17:13:25.860531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:25.501089Z","time spent":"359.375986ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:13:25.860788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:25.502928Z","time spent":"357.84302ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-21T17:13:25.864505Z","caller":"traceutil/trace.go:171","msg":"trace[971916695] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"132.599407ms","start":"2026-04-21T17:13:25.731865Z","end":"2026-04-21T17:13:25.864465Z","steps":["trace[971916695] 'process raft request' (duration: 129.772059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:16:05.375902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.587681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:16:05.376555Z","caller":"traceutil/trace.go:171","msg":"trace[804036085] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:2096; }","duration":"187.314358ms","start":"2026-04-21T17:16:05.189224Z","end":"2026-04-21T17:16:05.376539Z","steps":["trace[804036085] 'count revisions from in-memory index tree' (duration: 186.413647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:16:05.376604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.142844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-21T17:16:05.376048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.294556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T17:16:05.376695Z","caller":"traceutil/trace.go:171","msg":"trace[1346781490] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2096; }","duration":"581.043217ms","start":"2026-04-21T17:16:04.795588Z","end":"2026-04-21T17:16:05.376631Z","steps":["trace[1346781490] 'range keys from in-memory index tree' (duration: 579.94115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:16:05.376734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:16:04.79556Z","time spent":"581.16207ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-21T17:16:05.376729Z","caller":"traceutil/trace.go:171","msg":"trace[1428599431] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2096; }","duration":"655.967253ms","start":"2026-04-21T17:16:04.72069Z","end":"2026-04-21T17:16:05.376657Z","steps":["trace[1428599431] 'range keys from in-memory index tree' (duration: 655.144802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:16:05.376796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:16:04.720659Z","time spent":"656.118997ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T17:16:05.376021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.922196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:525"} {"level":"info","ts":"2026-04-21T17:16:05.376964Z","caller":"traceutil/trace.go:171","msg":"trace[1416227108] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2096; }","duration":"324.903441ms","start":"2026-04-21T17:16:05.052031Z","end":"2026-04-21T17:16:05.376934Z","steps":["trace[1416227108] 'range keys from in-memory index tree' (duration: 323.751562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:16:05.377061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:16:05.052007Z","time spent":"325.027813ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-21T17:16:05.376105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.520587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:16:05.377193Z","caller":"traceutil/trace.go:171","msg":"trace[1209272476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2096; }","duration":"373.655006ms","start":"2026-04-21T17:16:05.003521Z","end":"2026-04-21T17:16:05.377176Z","steps":["trace[1209272476] 'range keys from in-memory index tree' (duration: 372.352103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:16:05.376222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.652383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-21T17:16:05.377269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:16:05.003503Z","time spent":"373.748498ms","remote":"127.0.0.1:41844","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-04-21T17:16:05.3773Z","caller":"traceutil/trace.go:171","msg":"trace[1310687365] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2096; }","duration":"609.774001ms","start":"2026-04-21T17:16:04.767518Z","end":"2026-04-21T17:16:05.377292Z","steps":["trace[1310687365] 'range keys from in-memory index tree' (duration: 608.54192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:16:05.377368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:16:04.767499Z","time spent":"609.855763ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T17:16:05.376278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.591044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-21T17:16:05.37629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.711508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-04-21T17:16:05.376291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.613212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-21T17:16:05.378014Z","caller":"traceutil/trace.go:171","msg":"trace[1249279858] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2096; }","duration":"659.454337ms","start":"2026-04-21T17:16:04.718533Z","end":"2026-04-21T17:16:05.377987Z","steps":["trace[1249279858] 'range keys from in-memory index tree' (duration: 657.357725ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:16:05.378029Z","caller":"traceutil/trace.go:171","msg":"trace[450165650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2096; }","duration":"584.373389ms","start":"2026-04-21T17:16:04.793626Z","end":"2026-04-21T17:16:05.378Z","steps":["trace[450165650] 'range keys from in-memory index tree' (duration: 582.454911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:16:05.378084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:16:04.718498Z","time spent":"659.56859ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T17:16:05.37816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:16:04.793601Z","time spent":"584.535232ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-21T17:16:05.378162Z","caller":"traceutil/trace.go:171","msg":"trace[559983167] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2096; }","duration":"582.607435ms","start":"2026-04-21T17:16:04.79553Z","end":"2026-04-21T17:16:05.378138Z","steps":["trace[559983167] 'range keys from in-memory index tree' (duration: 580.551685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:16:05.378281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:16:04.795509Z","time spent":"582.746538ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-04-21T17:16:08.934111Z","caller":"traceutil/trace.go:171","msg":"trace[815901540] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"129.41125ms","start":"2026-04-21T17:16:08.80467Z","end":"2026-04-21T17:16:08.934082Z","steps":["trace[815901540] 'process raft request' (duration: 129.270137ms)"],"step_count":1}