{"level":"warn","ts":"2026-04-02T06:10:02.692086Z","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-02T06:10:02.692265Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.134:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.134:2380","--initial-cluster=instance=https://199.19.213.134:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.134:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.134: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-02T06:10:02.692528Z","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-02T06:10:02.692622Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.134:2380"]} {"level":"info","ts":"2026-04-02T06:10:02.692705Z","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-02T06:10:02.69354Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"]} {"level":"info","ts":"2026-04-02T06:10:02.69371Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.134:2380"],"listen-peer-urls":["https://199.19.213.134:2380"],"advertise-client-urls":["https://199.19.213.134:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.134: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-02T06:10:02.699127Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.122661ms"} {"level":"info","ts":"2026-04-02T06:10:02.706277Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"92da22d3868c86fb","cluster-id":"84450b28e935eb90"} {"level":"info","ts":"2026-04-02T06:10:02.706522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T06:10:02.706633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became follower at term 0"} {"level":"info","ts":"2026-04-02T06:10:02.70673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 92da22d3868c86fb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T06:10:02.70678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became follower at term 1"} {"level":"info","ts":"2026-04-02T06:10:02.706928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=(10581808566351202043)"} {"level":"warn","ts":"2026-04-02T06:10:02.713338Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T06:10:02.718691Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T06:10:02.72362Z","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-02T06:10:02.726698Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"92da22d3868c86fb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T06:10:02.727177Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"92da22d3868c86fb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T06:10:02.727348Z","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-02T06:10:02.727745Z","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-02T06:10:02.72779Z","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-02T06:10:02.729969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=(10581808566351202043)"} {"level":"info","ts":"2026-04-02T06:10:02.730257Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"84450b28e935eb90","local-member-id":"92da22d3868c86fb","added-peer-id":"92da22d3868c86fb","added-peer-peer-urls":["https://199.19.213.134:2380"]} {"level":"info","ts":"2026-04-02T06:10:02.73197Z","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-02T06:10:02.732392Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"92da22d3868c86fb","initial-advertise-peer-urls":["https://199.19.213.134:2380"],"listen-peer-urls":["https://199.19.213.134:2380"],"advertise-client-urls":["https://199.19.213.134:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T06:10:02.732498Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T06:10:02.732173Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.134:2380"} {"level":"info","ts":"2026-04-02T06:10:02.732626Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.134:2380"} {"level":"info","ts":"2026-04-02T06:10:03.107602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T06:10:03.107765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T06:10:03.107836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb received MsgPreVoteResp from 92da22d3868c86fb at term 1"} {"level":"info","ts":"2026-04-02T06:10:03.107909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became candidate at term 2"} {"level":"info","ts":"2026-04-02T06:10:03.107961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb received MsgVoteResp from 92da22d3868c86fb at term 2"} {"level":"info","ts":"2026-04-02T06:10:03.108026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became leader at term 2"} {"level":"info","ts":"2026-04-02T06:10:03.108075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 92da22d3868c86fb elected leader 92da22d3868c86fb at term 2"} {"level":"info","ts":"2026-04-02T06:10:03.109231Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"92da22d3868c86fb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.134:2379]}","request-path":"/0/members/92da22d3868c86fb/attributes","cluster-id":"84450b28e935eb90","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T06:10:03.109472Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T06:10:03.109535Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T06:10:03.109626Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T06:10:03.109826Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T06:10:03.111677Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T06:10:03.111892Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"84450b28e935eb90","local-member-id":"92da22d3868c86fb","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T06:10:03.112033Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T06:10:03.112075Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T06:10:03.114605Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-02T06:10:03.123275Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.134:2379"} {"level":"warn","ts":"2026-04-02T06:10:05.512903Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726540773471900619,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:10:06.013359Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726540773471900619,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:10:06.378967Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.457023947s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-02T06:10:06.96918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.488333ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-02T06:10:06.969351Z","caller":"traceutil/trace.go:171","msg":"trace[918511411] transaction","detail":"{read_only:false; response_revision:69; number_of_response:1; }","duration":"2.047458433s","start":"2026-04-02T06:10:04.921858Z","end":"2026-04-02T06:10:06.969316Z","steps":["trace[918511411] 'process raft request' (duration: 1.457329935s)","trace[918511411] 'compare' (duration: 589.35147ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:10:06.969471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.957272191s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-02T06:10:06.969483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:04.921841Z","time spent":"2.047583357s","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T06:10:06.969347Z","caller":"traceutil/trace.go:171","msg":"trace[1693499094] linearizableReadLoop","detail":"{readStateIndex:73; appliedIndex:72; }","duration":"1.957116438s","start":"2026-04-02T06:10:05.01219Z","end":"2026-04-02T06:10:06.969306Z","steps":["trace[1693499094] 'read index received' (duration: 1.366908298s)","trace[1693499094] 'applied index is now lower than readState.Index' (duration: 590.20608ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:10:06.969549Z","caller":"traceutil/trace.go:171","msg":"trace[817453927] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:69; }","duration":"1.957387454s","start":"2026-04-02T06:10:05.012145Z","end":"2026-04-02T06:10:06.969533Z","steps":["trace[817453927] 'agreement among raft nodes before linearized reading' (duration: 1.957256111s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:06.969598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:05.012124Z","time spent":"1.957460275s","remote":"127.0.0.1:53406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-04-02T06:10:06.969658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.330630724s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:10:06.969712Z","caller":"traceutil/trace.go:171","msg":"trace[2084856562] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:69; }","duration":"1.330709976s","start":"2026-04-02T06:10:05.638984Z","end":"2026-04-02T06:10:06.969694Z","steps":["trace[2084856562] 'agreement among raft nodes before linearized reading' (duration: 1.330629134s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:06.969726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.29856448s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-02T06:10:06.969726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.22848301s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:10:06.96975Z","caller":"traceutil/trace.go:171","msg":"trace[401673528] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:69; }","duration":"1.29861194s","start":"2026-04-02T06:10:05.671131Z","end":"2026-04-02T06:10:06.969743Z","steps":["trace[401673528] 'agreement among raft nodes before linearized reading' (duration: 1.298564999s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:06.969755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:05.638969Z","time spent":"1.330774297s","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-04-02T06:10:06.969769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:05.671119Z","time spent":"1.298646432s","remote":"127.0.0.1:52972","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-02T06:10:06.969775Z","caller":"traceutil/trace.go:171","msg":"trace[218175991] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:69; }","duration":"1.228598763s","start":"2026-04-02T06:10:05.741159Z","end":"2026-04-02T06:10:06.969758Z","steps":["trace[218175991] 'agreement among raft nodes before linearized reading' (duration: 1.22849336s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:06.969808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:05.741107Z","time spent":"1.228693465s","remote":"127.0.0.1:52976","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-02T06:10:06.969829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.318790815s","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-02T06:10:06.969903Z","caller":"traceutil/trace.go:171","msg":"trace[1196049562] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:69; }","duration":"1.318923769s","start":"2026-04-02T06:10:05.650964Z","end":"2026-04-02T06:10:06.969888Z","steps":["trace[1196049562] 'agreement among raft nodes before linearized reading' (duration: 1.318761775s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:06.969958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:05.650948Z","time spent":"1.31900242s","remote":"127.0.0.1:53352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-04-02T06:10:08.006457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.20896ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-02T06:10:08.006666Z","caller":"traceutil/trace.go:171","msg":"trace[1599605256] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"1.031366042s","start":"2026-04-02T06:10:06.975283Z","end":"2026-04-02T06:10:08.006649Z","steps":["trace[1599605256] 'process raft request' (duration: 1.03129766s)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:08.006699Z","caller":"traceutil/trace.go:171","msg":"trace[118992389] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"1.033448871s","start":"2026-04-02T06:10:06.973206Z","end":"2026-04-02T06:10:08.006655Z","steps":["trace[118992389] 'process raft request' (duration: 473.954104ms)","trace[118992389] 'compare' (duration: 559.082718ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:10:08.006747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:06.975274Z","time spent":"1.031436805s","remote":"127.0.0.1:53406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T06:10:08.006798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.032595321s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:10:08.006844Z","caller":"traceutil/trace.go:171","msg":"trace[1940428243] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:71; }","duration":"1.032667403s","start":"2026-04-02T06:10:06.974164Z","end":"2026-04-02T06:10:08.006831Z","steps":["trace[1940428243] 'agreement among raft nodes before linearized reading' (duration: 1.03253676s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:08.006849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:06.973195Z","time spent":"1.033583674s","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T06:10:08.006669Z","caller":"traceutil/trace.go:171","msg":"trace[1241724619] linearizableReadLoop","detail":"{readStateIndex:74; appliedIndex:73; }","duration":"1.032456818s","start":"2026-04-02T06:10:06.974188Z","end":"2026-04-02T06:10:08.006645Z","steps":["trace[1241724619] 'read index received' (duration: 472.982071ms)","trace[1241724619] 'applied index is now lower than readState.Index' (duration: 559.472567ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:10:08.006883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:06.974152Z","time spent":"1.032720164s","remote":"127.0.0.1:53352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"warn","ts":"2026-04-02T06:10:08.00699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.858551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:10:08.007041Z","caller":"traceutil/trace.go:171","msg":"trace[1159874637] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:71; }","duration":"965.935863ms","start":"2026-04-02T06:10:07.041089Z","end":"2026-04-02T06:10:08.007024Z","steps":["trace[1159874637] 'agreement among raft nodes before linearized reading' (duration: 965.855171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:08.007079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:07.041072Z","time spent":"965.997044ms","remote":"127.0.0.1:52972","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-02T06:10:08.007138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.428484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:10:08.007185Z","caller":"traceutil/trace.go:171","msg":"trace[1419504688] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:71; }","duration":"618.477125ms","start":"2026-04-02T06:10:07.388694Z","end":"2026-04-02T06:10:08.007171Z","steps":["trace[1419504688] 'agreement among raft nodes before linearized reading' (duration: 618.388963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:08.007217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:07.388639Z","time spent":"618.570827ms","remote":"127.0.0.1:53126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"warn","ts":"2026-04-02T06:10:08.007236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"947.805296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-02T06:10:08.00725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"876.669632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T06:10:08.007284Z","caller":"traceutil/trace.go:171","msg":"trace[487101178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:71; }","duration":"876.744474ms","start":"2026-04-02T06:10:07.130529Z","end":"2026-04-02T06:10:08.007274Z","steps":["trace[487101178] 'agreement among raft nodes before linearized reading' (duration: 876.659422ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:08.007283Z","caller":"traceutil/trace.go:171","msg":"trace[1842791353] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:71; }","duration":"947.885528ms","start":"2026-04-02T06:10:07.059384Z","end":"2026-04-02T06:10:08.007269Z","steps":["trace[1842791353] 'agreement among raft nodes before linearized reading' (duration: 947.814666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:08.007306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:07.130507Z","time spent":"876.794294ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T06:10:08.007326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:07.05936Z","time spent":"947.95479ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T06:10:36.764466Z","caller":"traceutil/trace.go:171","msg":"trace[1182093294] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"252.233707ms","start":"2026-04-02T06:10:36.512209Z","end":"2026-04-02T06:10:36.764443Z","steps":["trace[1182093294] 'process raft request' (duration: 244.768341ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:36.764636Z","caller":"traceutil/trace.go:171","msg":"trace[1624426390] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:598; }","duration":"106.790853ms","start":"2026-04-02T06:10:36.657835Z","end":"2026-04-02T06:10:36.764626Z","steps":["trace[1624426390] 'read index received' (duration: 99.160013ms)","trace[1624426390] 'applied index is now lower than readState.Index' (duration: 7.63029ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:10:36.764703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.852144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:36.764722Z","caller":"traceutil/trace.go:171","msg":"trace[453631719] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:574; }","duration":"106.906066ms","start":"2026-04-02T06:10:36.65781Z","end":"2026-04-02T06:10:36.764716Z","steps":["trace[453631719] 'agreement among raft nodes before linearized reading' (duration: 106.843864ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:36.764872Z","caller":"traceutil/trace.go:171","msg":"trace[1104505159] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"221.606305ms","start":"2026-04-02T06:10:36.54321Z","end":"2026-04-02T06:10:36.764816Z","steps":["trace[1104505159] 'process raft request' (duration: 221.187795ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:37.774219Z","caller":"traceutil/trace.go:171","msg":"trace[1722277698] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"676.967443ms","start":"2026-04-02T06:10:37.097225Z","end":"2026-04-02T06:10:37.774192Z","steps":["trace[1722277698] 'process raft request' (duration: 676.621274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:37.774356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:37.097204Z","time spent":"677.094805ms","remote":"127.0.0.1:53032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T06:10:38.959314Z","caller":"traceutil/trace.go:171","msg":"trace[1415870368] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"441.777247ms","start":"2026-04-02T06:10:38.517519Z","end":"2026-04-02T06:10:38.959296Z","steps":["trace[1415870368] 'read index received' (duration: 441.50405ms)","trace[1415870368] 'applied index is now lower than readState.Index' (duration: 272.587µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:10:38.959392Z","caller":"traceutil/trace.go:171","msg":"trace[1058743113] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"523.749256ms","start":"2026-04-02T06:10:38.435613Z","end":"2026-04-02T06:10:38.959363Z","steps":["trace[1058743113] 'process raft request' (duration: 523.4868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:38.959489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.948801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:15688"} {"level":"info","ts":"2026-04-02T06:10:38.959519Z","caller":"traceutil/trace.go:171","msg":"trace[743877270] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:594; }","duration":"441.994142ms","start":"2026-04-02T06:10:38.517515Z","end":"2026-04-02T06:10:38.959509Z","steps":["trace[743877270] 'agreement among raft nodes before linearized reading' (duration: 441.880869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:38.959545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:38.517479Z","time spent":"442.059433ms","remote":"127.0.0.1:53032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":15712,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-04-02T06:10:38.95961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.181739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:10:38.959692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:38.435592Z","time spent":"523.866729ms","remote":"127.0.0.1:53032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208470,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:10:38.95975Z","caller":"traceutil/trace.go:171","msg":"trace[2127070121] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"304.370403ms","start":"2026-04-02T06:10:38.655349Z","end":"2026-04-02T06:10:38.959719Z","steps":["trace[2127070121] 'agreement among raft nodes before linearized reading' (duration: 304.126057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:38.959815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:38.655332Z","time spent":"304.472026ms","remote":"127.0.0.1:52976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T06:10:38.959858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.321448ms","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-02T06:10:38.959893Z","caller":"traceutil/trace.go:171","msg":"trace[1144298260] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:594; }","duration":"167.38166ms","start":"2026-04-02T06:10:38.792502Z","end":"2026-04-02T06:10:38.959883Z","steps":["trace[1144298260] 'agreement among raft nodes before linearized reading' (duration: 167.286827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:39.487689Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726540773471901647,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T06:10:39.868125Z","caller":"traceutil/trace.go:171","msg":"trace[645664762] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"905.359256ms","start":"2026-04-02T06:10:38.962735Z","end":"2026-04-02T06:10:39.868094Z","steps":["trace[645664762] 'process raft request' (duration: 865.220442ms)","trace[645664762] 'compare' (duration: 39.992791ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:10:39.868205Z","caller":"traceutil/trace.go:171","msg":"trace[231912672] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:620; }","duration":"880.761628ms","start":"2026-04-02T06:10:38.987427Z","end":"2026-04-02T06:10:39.868189Z","steps":["trace[231912672] 'read index received' (duration: 840.515451ms)","trace[231912672] 'applied index is now lower than readState.Index' (duration: 40.245407ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:10:39.868294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:38.962738Z","time spent":"905.553911ms","remote":"127.0.0.1:53004","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-02T06:10:39.868291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:38.962715Z","time spent":"905.49384ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:10:39.868534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.576582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:39.868577Z","caller":"traceutil/trace.go:171","msg":"trace[1179835778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"206.694355ms","start":"2026-04-02T06:10:39.661875Z","end":"2026-04-02T06:10:39.868569Z","steps":["trace[1179835778] 'agreement among raft nodes before linearized reading' (duration: 206.632183ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:39.86863Z","caller":"traceutil/trace.go:171","msg":"trace[1987812565] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"904.602339ms","start":"2026-04-02T06:10:38.964016Z","end":"2026-04-02T06:10:39.868619Z","steps":["trace[1987812565] 'process raft request' (duration: 904.136858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:39.868712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:38.964003Z","time spent":"904.64793ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:10:39.868981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.547986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:208485"} {"level":"info","ts":"2026-04-02T06:10:39.869009Z","caller":"traceutil/trace.go:171","msg":"trace[914736055] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:596; }","duration":"881.600258ms","start":"2026-04-02T06:10:38.9874Z","end":"2026-04-02T06:10:39.869Z","steps":["trace[914736055] 'agreement among raft nodes before linearized reading' (duration: 881.28244ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:39.86903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:38.987385Z","time spent":"881.640068ms","remote":"127.0.0.1:53032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":208509,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-04-02T06:10:43.668255Z","caller":"traceutil/trace.go:171","msg":"trace[94074627] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"100.012784ms","start":"2026-04-02T06:10:43.56822Z","end":"2026-04-02T06:10:43.668233Z","steps":["trace[94074627] 'process raft request' (duration: 98.368386ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:44.601231Z","caller":"traceutil/trace.go:171","msg":"trace[181858218] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"366.447404ms","start":"2026-04-02T06:10:44.234759Z","end":"2026-04-02T06:10:44.601206Z","steps":["trace[181858218] 'process raft request' (duration: 365.805869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:44.601458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:44.23473Z","time spent":"366.636339ms","remote":"127.0.0.1:53090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036253,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:10:44.740169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.908429ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-02T06:10:44.740414Z","caller":"traceutil/trace.go:171","msg":"trace[90972289] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:645; }","duration":"422.105824ms","start":"2026-04-02T06:10:44.318264Z","end":"2026-04-02T06:10:44.74037Z","steps":["trace[90972289] 'read index received' (duration: 282.12475ms)","trace[90972289] 'applied index is now lower than readState.Index' (duration: 139.977514ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:10:44.740733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.459662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-02T06:10:44.741056Z","caller":"traceutil/trace.go:171","msg":"trace[1669145419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"422.814371ms","start":"2026-04-02T06:10:44.318219Z","end":"2026-04-02T06:10:44.741034Z","steps":["trace[1669145419] 'agreement among raft nodes before linearized reading' (duration: 422.411631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:44.741393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:44.318194Z","time spent":"423.149759ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T06:10:44.740993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.181789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-02T06:10:44.741652Z","caller":"traceutil/trace.go:171","msg":"trace[582561113] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"420.849114ms","start":"2026-04-02T06:10:44.320782Z","end":"2026-04-02T06:10:44.741631Z","steps":["trace[582561113] 'agreement among raft nodes before linearized reading' (duration: 420.158307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:44.741685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:44.32077Z","time spent":"420.907566ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T06:10:45.833397Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726540773471901734,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T06:10:46.009748Z","caller":"traceutil/trace.go:171","msg":"trace[489978833] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"676.612022ms","start":"2026-04-02T06:10:45.333114Z","end":"2026-04-02T06:10:46.009726Z","steps":["trace[489978833] 'read index received' (duration: 675.830454ms)","trace[489978833] 'applied index is now lower than readState.Index' (duration: 780.558µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:10:46.009801Z","caller":"traceutil/trace.go:171","msg":"trace[1636888290] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"797.20139ms","start":"2026-04-02T06:10:45.212574Z","end":"2026-04-02T06:10:46.009775Z","steps":["trace[1636888290] 'process raft request' (duration: 796.590466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.009888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.756545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:10:46.009894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.21255Z","time spent":"797.283093ms","remote":"127.0.0.1:53090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:10:46.009922Z","caller":"traceutil/trace.go:171","msg":"trace[741999335] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:627; }","duration":"676.829837ms","start":"2026-04-02T06:10:45.333083Z","end":"2026-04-02T06:10:46.009912Z","steps":["trace[741999335] 'agreement among raft nodes before linearized reading' (duration: 676.755456ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.009953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.333067Z","time spent":"676.878088ms","remote":"127.0.0.1:41314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T06:10:46.010082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.885189ms","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-02T06:10:46.010166Z","caller":"traceutil/trace.go:171","msg":"trace[1562142324] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:627; }","duration":"676.973751ms","start":"2026-04-02T06:10:45.333181Z","end":"2026-04-02T06:10:46.010155Z","steps":["trace[1562142324] 'agreement among raft nodes before linearized reading' (duration: 676.868489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.010215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.333152Z","time spent":"677.052992ms","remote":"127.0.0.1:41314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"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-02T06:10:46.010247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.568037ms","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-02T06:10:46.010283Z","caller":"traceutil/trace.go:171","msg":"trace[1805895584] 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":"154.630659ms","start":"2026-04-02T06:10:45.855642Z","end":"2026-04-02T06:10:46.010273Z","steps":["trace[1805895584] 'agreement among raft nodes before linearized reading' (duration: 154.571268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.010291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.767684ms","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-02T06:10:46.010316Z","caller":"traceutil/trace.go:171","msg":"trace[1166889338] 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":"180.826316ms","start":"2026-04-02T06:10:45.829481Z","end":"2026-04-02T06:10:46.010307Z","steps":["trace[1166889338] 'agreement among raft nodes before linearized reading' (duration: 180.793735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.010415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.943178ms","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-02T06:10:46.010438Z","caller":"traceutil/trace.go:171","msg":"trace[2131897961] 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":"181.00771ms","start":"2026-04-02T06:10:45.829425Z","end":"2026-04-02T06:10:46.010433Z","steps":["trace[2131897961] 'agreement among raft nodes before linearized reading' (duration: 180.975309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.010423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.16231ms","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":"warn","ts":"2026-04-02T06:10:46.010514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.910405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.010538Z","caller":"traceutil/trace.go:171","msg":"trace[544762136] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:627; }","duration":"213.966085ms","start":"2026-04-02T06:10:45.796566Z","end":"2026-04-02T06:10:46.010532Z","steps":["trace[544762136] 'agreement among raft nodes before linearized reading' (duration: 213.931924ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:46.010516Z","caller":"traceutil/trace.go:171","msg":"trace[2086623467] 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:627; }","duration":"330.268572ms","start":"2026-04-02T06:10:45.680236Z","end":"2026-04-02T06:10:46.010505Z","steps":["trace[2086623467] 'agreement among raft nodes before linearized reading' (duration: 330.16508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.010596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.680223Z","time spent":"330.363214ms","remote":"127.0.0.1:41372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"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-02T06:10:46.01063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.371635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.010652Z","caller":"traceutil/trace.go:171","msg":"trace[396763225] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:627; }","duration":"214.430567ms","start":"2026-04-02T06:10:45.796216Z","end":"2026-04-02T06:10:46.010647Z","steps":["trace[396763225] 'agreement among raft nodes before linearized reading' (duration: 214.398916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.010699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.39125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-02T06:10:46.010728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.500918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.010736Z","caller":"traceutil/trace.go:171","msg":"trace[659679801] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"119.428191ms","start":"2026-04-02T06:10:45.891298Z","end":"2026-04-02T06:10:46.010727Z","steps":["trace[659679801] 'agreement among raft nodes before linearized reading' (duration: 119.365679ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:46.010745Z","caller":"traceutil/trace.go:171","msg":"trace[1504693732] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:627; }","duration":"214.542199ms","start":"2026-04-02T06:10:45.796198Z","end":"2026-04-02T06:10:46.01074Z","steps":["trace[1504693732] 'agreement among raft nodes before linearized reading' (duration: 214.513628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.010821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.57216ms","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-02T06:10:46.010872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.616008ms","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-02T06:10:46.010903Z","caller":"traceutil/trace.go:171","msg":"trace[1525815512] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:627; }","duration":"120.66732ms","start":"2026-04-02T06:10:45.890228Z","end":"2026-04-02T06:10:46.010895Z","steps":["trace[1525815512] 'agreement among raft nodes before linearized reading' (duration: 120.614528ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:46.01089Z","caller":"traceutil/trace.go:171","msg":"trace[151259721] 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:627; }","duration":"330.663841ms","start":"2026-04-02T06:10:45.680219Z","end":"2026-04-02T06:10:46.010883Z","steps":["trace[151259721] 'agreement among raft nodes before linearized reading' (duration: 330.579719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.011093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.558672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:10:46.011109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.406801ms","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-02T06:10:46.011127Z","caller":"traceutil/trace.go:171","msg":"trace[1168934977] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"238.438662ms","start":"2026-04-02T06:10:45.772682Z","end":"2026-04-02T06:10:46.011121Z","steps":["trace[1168934977] 'agreement among raft nodes before linearized reading' (duration: 238.414421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.011162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.829669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.011191Z","caller":"traceutil/trace.go:171","msg":"trace[2042405293] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:627; }","duration":"127.89561ms","start":"2026-04-02T06:10:45.883289Z","end":"2026-04-02T06:10:46.011184Z","steps":["trace[2042405293] 'agreement among raft nodes before linearized reading' (duration: 127.850658ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:46.011125Z","caller":"traceutil/trace.go:171","msg":"trace[478141238] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:627; }","duration":"127.602833ms","start":"2026-04-02T06:10:45.883513Z","end":"2026-04-02T06:10:46.011116Z","steps":["trace[478141238] 'agreement among raft nodes before linearized reading' (duration: 127.537611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.011232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.680201Z","time spent":"330.933388ms","remote":"127.0.0.1:41372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T06:10:46.011081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.156139ms","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":"warn","ts":"2026-04-02T06:10:46.011301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.271034ms","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-02T06:10:46.011317Z","caller":"traceutil/trace.go:171","msg":"trace[412319925] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"239.405095ms","start":"2026-04-02T06:10:45.771906Z","end":"2026-04-02T06:10:46.011311Z","steps":["trace[412319925] 'agreement among raft nodes before linearized reading' (duration: 239.151669ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:46.01133Z","caller":"traceutil/trace.go:171","msg":"trace[1828672523] 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":"155.314106ms","start":"2026-04-02T06:10:45.856008Z","end":"2026-04-02T06:10:46.011322Z","steps":["trace[1828672523] 'agreement among raft nodes before linearized reading' (duration: 155.239814ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.011159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.895444ms","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":"warn","ts":"2026-04-02T06:10:46.011442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.671203ms","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-02T06:10:46.011476Z","caller":"traceutil/trace.go:171","msg":"trace[249136004] 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":"155.707694ms","start":"2026-04-02T06:10:45.85576Z","end":"2026-04-02T06:10:46.011468Z","steps":["trace[249136004] 'agreement among raft nodes before linearized reading' (duration: 155.659053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.011533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.572097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:10:46.011567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.530938ms","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-02T06:10:46.011441Z","caller":"traceutil/trace.go:171","msg":"trace[1383267262] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"279.488148ms","start":"2026-04-02T06:10:45.731928Z","end":"2026-04-02T06:10:46.011416Z","steps":["trace[1383267262] 'agreement among raft nodes before linearized reading' (duration: 278.844173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.011587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.55339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.011597Z","caller":"traceutil/trace.go:171","msg":"trace[1749204382] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"279.58075ms","start":"2026-04-02T06:10:45.732006Z","end":"2026-04-02T06:10:46.011586Z","steps":["trace[1749204382] 'agreement among raft nodes before linearized reading' (duration: 279.543129ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:46.011625Z","caller":"traceutil/trace.go:171","msg":"trace[1359150901] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:627; }","duration":"446.609591ms","start":"2026-04-02T06:10:45.565007Z","end":"2026-04-02T06:10:46.011616Z","steps":["trace[1359150901] 'agreement among raft nodes before linearized reading' (duration: 446.56293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.011655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.564996Z","time spent":"446.651041ms","remote":"127.0.0.1:41354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"info","ts":"2026-04-02T06:10:46.011629Z","caller":"traceutil/trace.go:171","msg":"trace[960720568] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:627; }","duration":"352.66635ms","start":"2026-04-02T06:10:45.658913Z","end":"2026-04-02T06:10:46.01158Z","steps":["trace[960720568] 'agreement among raft nodes before linearized reading' (duration: 352.565347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.011717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.658895Z","time spent":"352.811723ms","remote":"127.0.0.1:41370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T06:10:46.011799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.892476ms","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-02T06:10:46.011833Z","caller":"traceutil/trace.go:171","msg":"trace[712186851] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:627; }","duration":"352.964467ms","start":"2026-04-02T06:10:45.65886Z","end":"2026-04-02T06:10:46.011824Z","steps":["trace[712186851] 'agreement among raft nodes before linearized reading' (duration: 352.906405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.011862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.658849Z","time spent":"353.004018ms","remote":"127.0.0.1:41370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:10:46.011919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.157873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:10:46.011933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.554601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.011948Z","caller":"traceutil/trace.go:171","msg":"trace[1729207216] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:627; }","duration":"427.198994ms","start":"2026-04-02T06:10:45.584742Z","end":"2026-04-02T06:10:46.011941Z","steps":["trace[1729207216] 'agreement among raft nodes before linearized reading' (duration: 427.158343ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:46.011968Z","caller":"traceutil/trace.go:171","msg":"trace[1577530573] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:627; }","duration":"404.602882ms","start":"2026-04-02T06:10:45.607354Z","end":"2026-04-02T06:10:46.011957Z","steps":["trace[1577530573] 'agreement among raft nodes before linearized reading' (duration: 404.54896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.012001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.207292ms","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-02T06:10:46.012033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.279537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:10:46.012044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.183032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.012061Z","caller":"traceutil/trace.go:171","msg":"trace[1919754698] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:627; }","duration":"405.317489ms","start":"2026-04-02T06:10:45.606735Z","end":"2026-04-02T06:10:46.012052Z","steps":["trace[1919754698] 'agreement among raft nodes before linearized reading' (duration: 405.285378ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:46.012069Z","caller":"traceutil/trace.go:171","msg":"trace[1093106284] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:627; }","duration":"353.237893ms","start":"2026-04-02T06:10:45.658823Z","end":"2026-04-02T06:10:46.012061Z","steps":["trace[1093106284] 'agreement among raft nodes before linearized reading' (duration: 353.198732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.012088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.606726Z","time spent":"405.35536ms","remote":"127.0.0.1:41366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T06:10:46.012097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.658809Z","time spent":"353.278154ms","remote":"127.0.0.1:41370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T06:10:46.01197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.774568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.012255Z","caller":"traceutil/trace.go:171","msg":"trace[2141900256] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:627; }","duration":"428.074445ms","start":"2026-04-02T06:10:45.584174Z","end":"2026-04-02T06:10:46.012249Z","steps":["trace[2141900256] 'agreement among raft nodes before linearized reading' (duration: 427.779568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.01228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.584165Z","time spent":"428.106255ms","remote":"127.0.0.1:41358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T06:10:46.012243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.679296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:10:46.011034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.268866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:10:46.012429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.711741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.012433Z","caller":"traceutil/trace.go:171","msg":"trace[1511152169] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:627; }","duration":"128.694169ms","start":"2026-04-02T06:10:45.883733Z","end":"2026-04-02T06:10:46.012427Z","steps":["trace[1511152169] 'agreement among raft nodes before linearized reading' (duration: 127.268085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.012432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.302736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.012455Z","caller":"traceutil/trace.go:171","msg":"trace[2137774432] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:627; }","duration":"502.750972ms","start":"2026-04-02T06:10:45.509695Z","end":"2026-04-02T06:10:46.012446Z","steps":["trace[2137774432] 'agreement among raft nodes before linearized reading' (duration: 502.716121ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:46.01248Z","caller":"traceutil/trace.go:171","msg":"trace[992186459] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:627; }","duration":"529.379588ms","start":"2026-04-02T06:10:45.483085Z","end":"2026-04-02T06:10:46.012464Z","steps":["trace[992186459] 'agreement among raft nodes before linearized reading' (duration: 529.288056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.012008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.873608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:10:46.012483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.509685Z","time spent":"502.788853ms","remote":"127.0.0.1:41342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-02T06:10:46.012508Z","caller":"traceutil/trace.go:171","msg":"trace[649932518] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:627; }","duration":"405.425262ms","start":"2026-04-02T06:10:45.607077Z","end":"2026-04-02T06:10:46.012502Z","steps":["trace[649932518] 'agreement among raft nodes before linearized reading' (duration: 404.91379ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.012514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.48307Z","time spent":"529.434539ms","remote":"127.0.0.1:41330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:10:46.012536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.607054Z","time spent":"405.473612ms","remote":"127.0.0.1:41366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-02T06:10:46.012489Z","caller":"traceutil/trace.go:171","msg":"trace[316308162] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:627; }","duration":"501.899592ms","start":"2026-04-02T06:10:45.510522Z","end":"2026-04-02T06:10:46.012421Z","steps":["trace[316308162] 'agreement among raft nodes before linearized reading' (duration: 501.691487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.011976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.584735Z","time spent":"427.230765ms","remote":"127.0.0.1:41358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T06:10:46.012607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.510507Z","time spent":"502.088747ms","remote":"127.0.0.1:41342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-02T06:10:46.012004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.607345Z","time spent":"404.649543ms","remote":"127.0.0.1:41366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T06:10:46.012702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.577835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.012721Z","caller":"traceutil/trace.go:171","msg":"trace[1941772946] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"357.620787ms","start":"2026-04-02T06:10:45.655094Z","end":"2026-04-02T06:10:46.012715Z","steps":["trace[1941772946] 'agreement among raft nodes before linearized reading' (duration: 357.591586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.012736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.655079Z","time spent":"357.653147ms","remote":"127.0.0.1:52976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T06:10:46.012766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.88566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.012804Z","caller":"traceutil/trace.go:171","msg":"trace[2123773043] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:627; }","duration":"529.959782ms","start":"2026-04-02T06:10:45.482834Z","end":"2026-04-02T06:10:46.012794Z","steps":["trace[2123773043] 'agreement among raft nodes before linearized reading' (duration: 529.89974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.012866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.482816Z","time spent":"530.013422ms","remote":"127.0.0.1:41330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T06:10:46.011531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.744872ms","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-02T06:10:46.013023Z","caller":"traceutil/trace.go:171","msg":"trace[1199016778] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"241.265628ms","start":"2026-04-02T06:10:45.771748Z","end":"2026-04-02T06:10:46.013014Z","steps":["trace[1199016778] 'agreement among raft nodes before linearized reading' (duration: 239.746902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.012356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.05149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.013111Z","caller":"traceutil/trace.go:171","msg":"trace[1840938066] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:627; }","duration":"529.820098ms","start":"2026-04-02T06:10:45.483278Z","end":"2026-04-02T06:10:46.013098Z","steps":["trace[1840938066] 'agreement among raft nodes before linearized reading' (duration: 529.05335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.012071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.784075ms","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":"warn","ts":"2026-04-02T06:10:46.01315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.483268Z","time spent":"529.87038ms","remote":"127.0.0.1:41330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T06:10:46.011939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.579163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.013179Z","caller":"traceutil/trace.go:171","msg":"trace[1461096130] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:627; }","duration":"428.825982ms","start":"2026-04-02T06:10:45.584349Z","end":"2026-04-02T06:10:46.013175Z","steps":["trace[1461096130] 'agreement among raft nodes before linearized reading' (duration: 427.566373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.013217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.584343Z","time spent":"428.857643ms","remote":"127.0.0.1:41358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-02T06:10:46.012034Z","caller":"traceutil/trace.go:171","msg":"trace[1188827230] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:627; }","duration":"446.282603ms","start":"2026-04-02T06:10:45.565743Z","end":"2026-04-02T06:10:46.012026Z","steps":["trace[1188827230] 'agreement among raft nodes before linearized reading' (duration: 446.240242ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:46.013153Z","caller":"traceutil/trace.go:171","msg":"trace[733463634] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:627; }","duration":"447.879981ms","start":"2026-04-02T06:10:45.565265Z","end":"2026-04-02T06:10:46.013145Z","steps":["trace[733463634] 'agreement among raft nodes before linearized reading' (duration: 446.785865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.01327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.565721Z","time spent":"447.534132ms","remote":"127.0.0.1:41354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-02T06:10:46.013292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.565256Z","time spent":"448.023384ms","remote":"127.0.0.1:41354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"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-02T06:10:46.01017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.854632ms","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-02T06:10:46.013368Z","caller":"traceutil/trace.go:171","msg":"trace[1971329723] 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:627; }","duration":"333.052028ms","start":"2026-04-02T06:10:45.680306Z","end":"2026-04-02T06:10:46.013358Z","steps":["trace[1971329723] 'agreement among raft nodes before linearized reading' (duration: 329.840792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.013402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.680253Z","time spent":"333.13665ms","remote":"127.0.0.1:41372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"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-02T06:10:46.012398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.66386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:46.013477Z","caller":"traceutil/trace.go:171","msg":"trace[1092727285] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:627; }","duration":"503.742435ms","start":"2026-04-02T06:10:45.509724Z","end":"2026-04-02T06:10:46.013467Z","steps":["trace[1092727285] 'agreement among raft nodes before linearized reading' (duration: 502.65143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:46.013516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:45.509687Z","time spent":"503.816407ms","remote":"127.0.0.1:41342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:10:47.315727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.213451197s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:10:47.31612Z","caller":"traceutil/trace.go:171","msg":"trace[919016981] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"1.238665931s","start":"2026-04-02T06:10:46.077431Z","end":"2026-04-02T06:10:47.316097Z","steps":["trace[919016981] 'process raft request' (duration: 1.238439486s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.316198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.077412Z","time spent":"1.238757983s","remote":"127.0.0.1:53504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T06:10:47.316288Z","caller":"traceutil/trace.go:171","msg":"trace[1820231094] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"1.290373378s","start":"2026-04-02T06:10:46.025877Z","end":"2026-04-02T06:10:47.31625Z","steps":["trace[1820231094] 'read index received' (duration: 39.237364ms)","trace[1820231094] 'applied index is now lower than readState.Index' (duration: 1.251133044s)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:10:47.316474Z","caller":"traceutil/trace.go:171","msg":"trace[865988599] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"1.296072752s","start":"2026-04-02T06:10:46.020387Z","end":"2026-04-02T06:10:47.31646Z","steps":["trace[865988599] 'process raft request' (duration: 81.766134ms)","trace[865988599] 'compare' (duration: 1.213153811s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:10:47.316544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.020375Z","time spent":"1.296135233s","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:10:47.316636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.290684805s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:10:47.316677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.234323408s","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-02T06:10:47.316678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.217437401s","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-02T06:10:47.316717Z","caller":"traceutil/trace.go:171","msg":"trace[1841895418] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:630; }","duration":"1.234374779s","start":"2026-04-02T06:10:46.082329Z","end":"2026-04-02T06:10:47.316704Z","steps":["trace[1841895418] 'agreement among raft nodes before linearized reading' (duration: 1.234310778s)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:47.316725Z","caller":"traceutil/trace.go:171","msg":"trace[462472572] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:630; }","duration":"1.290797307s","start":"2026-04-02T06:10:46.025904Z","end":"2026-04-02T06:10:47.316702Z","steps":["trace[462472572] 'agreement among raft nodes before linearized reading' (duration: 1.290632814s)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:47.316739Z","caller":"traceutil/trace.go:171","msg":"trace[138073691] 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:630; }","duration":"1.217540614s","start":"2026-04-02T06:10:46.09918Z","end":"2026-04-02T06:10:47.316721Z","steps":["trace[138073691] 'agreement among raft nodes before linearized reading' (duration: 1.217425601s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.316735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.258978899s","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-02T06:10:47.316779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.025902Z","time spent":"1.290860849s","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-02T06:10:47.316666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.290773017s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:10:47.316761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.082326Z","time spent":"1.234425051s","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-04-02T06:10:47.316812Z","caller":"traceutil/trace.go:171","msg":"trace[1438612298] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:630; }","duration":"1.259100992s","start":"2026-04-02T06:10:46.057693Z","end":"2026-04-02T06:10:47.316794Z","steps":["trace[1438612298] 'agreement among raft nodes before linearized reading' (duration: 1.258959968s)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:47.316891Z","caller":"traceutil/trace.go:171","msg":"trace[1178395432] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:630; }","duration":"1.291016492s","start":"2026-04-02T06:10:46.025856Z","end":"2026-04-02T06:10:47.316873Z","steps":["trace[1178395432] 'agreement among raft nodes before linearized reading' (duration: 1.290640064s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.316924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.233821416s","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-02T06:10:47.316862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.259217005s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:10:47.316941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.234613176s","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-02T06:10:47.316955Z","caller":"traceutil/trace.go:171","msg":"trace[501637948] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:630; }","duration":"1.233895628s","start":"2026-04-02T06:10:46.083051Z","end":"2026-04-02T06:10:47.316947Z","steps":["trace[501637948] 'agreement among raft nodes before linearized reading' (duration: 1.233840627s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.316983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.083023Z","time spent":"1.23395433s","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"info","ts":"2026-04-02T06:10:47.316986Z","caller":"traceutil/trace.go:171","msg":"trace[304387703] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:630; }","duration":"1.234682067s","start":"2026-04-02T06:10:46.08229Z","end":"2026-04-02T06:10:47.316972Z","steps":["trace[304387703] 'agreement among raft nodes before linearized reading' (duration: 1.234606765s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.31687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.218223289s","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":"warn","ts":"2026-04-02T06:10:47.317169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.01271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-02T06:10:47.317203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.16945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-02T06:10:47.317225Z","caller":"traceutil/trace.go:171","msg":"trace[1237671649] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"546.094441ms","start":"2026-04-02T06:10:46.771117Z","end":"2026-04-02T06:10:47.317211Z","steps":["trace[1237671649] 'agreement among raft nodes before linearized reading' (duration: 545.925747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.316799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.217936343s","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":"warn","ts":"2026-04-02T06:10:47.317286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.771105Z","time spent":"546.169543ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T06:10:47.317317Z","caller":"traceutil/trace.go:171","msg":"trace[1484504488] 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:630; }","duration":"1.218443185s","start":"2026-04-02T06:10:46.098857Z","end":"2026-04-02T06:10:47.3173Z","steps":["trace[1484504488] 'agreement among raft nodes before linearized reading' (duration: 1.217922312s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.316971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.025845Z","time spent":"1.291092435s","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"info","ts":"2026-04-02T06:10:47.317188Z","caller":"traceutil/trace.go:171","msg":"trace[1165685432] 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:630; }","duration":"1.218600019s","start":"2026-04-02T06:10:46.098573Z","end":"2026-04-02T06:10:47.317173Z","steps":["trace[1165685432] 'agreement among raft nodes before linearized reading' (duration: 1.21824265s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.316932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.057677Z","time spent":"1.259227564s","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"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-02T06:10:47.317384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.098785Z","time spent":"1.218579738s","remote":"127.0.0.1:41478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"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-02T06:10:47.317454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.09855Z","time spent":"1.218889085s","remote":"127.0.0.1:41478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"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-02T06:10:47.317238Z","caller":"traceutil/trace.go:171","msg":"trace[596253504] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:630; }","duration":"548.217272ms","start":"2026-04-02T06:10:46.769001Z","end":"2026-04-02T06:10:47.317219Z","steps":["trace[596253504] 'agreement among raft nodes before linearized reading' (duration: 548.119059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.317664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.768983Z","time spent":"548.667632ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T06:10:47.317016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.183364729s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:47.317768Z","caller":"traceutil/trace.go:171","msg":"trace[1689876721] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:630; }","duration":"1.184111817s","start":"2026-04-02T06:10:46.133635Z","end":"2026-04-02T06:10:47.317747Z","steps":["trace[1689876721] 'agreement among raft nodes before linearized reading' (duration: 1.183340849s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.317022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.082272Z","time spent":"1.234740479s","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T06:10:47.317828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.133629Z","time spent":"1.184179648s","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"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-02T06:10:47.316805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.099164Z","time spent":"1.217625906s","remote":"127.0.0.1:41478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"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-02T06:10:47.317065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.199785166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:47.317957Z","caller":"traceutil/trace.go:171","msg":"trace[457605641] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:630; }","duration":"1.200693387s","start":"2026-04-02T06:10:46.117251Z","end":"2026-04-02T06:10:47.317944Z","steps":["trace[457605641] 'agreement among raft nodes before linearized reading' (duration: 1.199792705s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.318002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.117236Z","time spent":"1.200742868s","remote":"127.0.0.1:41482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"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-02T06:10:47.317015Z","caller":"traceutil/trace.go:171","msg":"trace[1231919320] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:630; }","duration":"1.25948396s","start":"2026-04-02T06:10:46.057513Z","end":"2026-04-02T06:10:47.316997Z","steps":["trace[1231919320] 'agreement among raft nodes before linearized reading' (duration: 1.259142512s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.318123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.057496Z","time spent":"1.260615388s","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T06:10:47.31705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.291113235s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:47.318183Z","caller":"traceutil/trace.go:171","msg":"trace[1264558568] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:630; }","duration":"1.292248262s","start":"2026-04-02T06:10:46.025918Z","end":"2026-04-02T06:10:47.318166Z","steps":["trace[1264558568] 'agreement among raft nodes before linearized reading' (duration: 1.291085585s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.318255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.025915Z","time spent":"1.292320803s","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:10:47.317096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.199760785s","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-02T06:10:47.318333Z","caller":"traceutil/trace.go:171","msg":"trace[1031190473] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:630; }","duration":"1.200993104s","start":"2026-04-02T06:10:46.11732Z","end":"2026-04-02T06:10:47.318313Z","steps":["trace[1031190473] 'agreement among raft nodes before linearized reading' (duration: 1.199757065s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.317095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.183504393s","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-02T06:10:47.318409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.117316Z","time spent":"1.201065516s","remote":"127.0.0.1:41482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-02T06:10:47.318444Z","caller":"traceutil/trace.go:171","msg":"trace[1427972114] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:630; }","duration":"1.184869005s","start":"2026-04-02T06:10:46.133556Z","end":"2026-04-02T06:10:47.318425Z","steps":["trace[1427972114] 'agreement among raft nodes before linearized reading' (duration: 1.183512773s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.317124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.18297243s","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-02T06:10:47.318541Z","caller":"traceutil/trace.go:171","msg":"trace[1277724197] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:630; }","duration":"1.184406903s","start":"2026-04-02T06:10:46.134118Z","end":"2026-04-02T06:10:47.318525Z","steps":["trace[1277724197] 'agreement among raft nodes before linearized reading' (duration: 1.18297439s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.318587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.134108Z","time spent":"1.184463145s","remote":"127.0.0.1:41482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-02T06:10:47.318497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.133539Z","time spent":"1.184941716s","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T06:10:47.317126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.026696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:47.318678Z","caller":"traceutil/trace.go:171","msg":"trace[1130898488] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"662.596544ms","start":"2026-04-02T06:10:46.656071Z","end":"2026-04-02T06:10:47.318667Z","steps":["trace[1130898488] 'agreement among raft nodes before linearized reading' (duration: 661.019307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:47.318711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:46.656055Z","time spent":"662.648094ms","remote":"127.0.0.1:52972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T06:10:47.831308Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726540773471901743,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T06:10:48.27823Z","caller":"traceutil/trace.go:171","msg":"trace[799323421] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"952.906535ms","start":"2026-04-02T06:10:47.325304Z","end":"2026-04-02T06:10:48.27821Z","steps":["trace[799323421] 'process raft request' (duration: 952.769712ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:48.27824Z","caller":"traceutil/trace.go:171","msg":"trace[738714353] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"952.926197ms","start":"2026-04-02T06:10:47.325286Z","end":"2026-04-02T06:10:48.278212Z","steps":["trace[738714353] 'process raft request' (duration: 920.997095ms)","trace[738714353] 'compare' (duration: 31.535002ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:10:48.278279Z","caller":"traceutil/trace.go:171","msg":"trace[190824453] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:658; }","duration":"947.891008ms","start":"2026-04-02T06:10:47.330365Z","end":"2026-04-02T06:10:48.278256Z","steps":["trace[190824453] 'read index received' (duration: 915.892275ms)","trace[190824453] 'applied index is now lower than readState.Index' (duration: 31.997863ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:10:48.278362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:47.325285Z","time spent":"953.006438ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:10:48.278886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.906536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:48.278917Z","caller":"traceutil/trace.go:171","msg":"trace[826686655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"502.985027ms","start":"2026-04-02T06:10:47.775924Z","end":"2026-04-02T06:10:48.278909Z","steps":["trace[826686655] 'agreement among raft nodes before linearized reading' (duration: 502.913425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:48.278372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:47.325253Z","time spent":"953.04869ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:10:48.278939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:47.775906Z","time spent":"503.028288ms","remote":"127.0.0.1:52972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T06:10:48.278983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.497953ms","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-02T06:10:48.2784Z","caller":"traceutil/trace.go:171","msg":"trace[44882968] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"100.603678ms","start":"2026-04-02T06:10:48.17779Z","end":"2026-04-02T06:10:48.278393Z","steps":["trace[44882968] 'process raft request' (duration: 100.369202ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:10:48.279031Z","caller":"traceutil/trace.go:171","msg":"trace[163703827] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:633; }","duration":"210.582455ms","start":"2026-04-02T06:10:48.06843Z","end":"2026-04-02T06:10:48.279012Z","steps":["trace[163703827] 'agreement among raft nodes before linearized reading' (duration: 210.441312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:48.278518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.151944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:10:48.279133Z","caller":"traceutil/trace.go:171","msg":"trace[2099788241] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:633; }","duration":"948.803269ms","start":"2026-04-02T06:10:47.330321Z","end":"2026-04-02T06:10:48.279124Z","steps":["trace[2099788241] 'agreement among raft nodes before linearized reading' (duration: 948.155204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:48.279156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:47.330308Z","time spent":"948.840451ms","remote":"127.0.0.1:53224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-04-02T06:10:50.401384Z","caller":"traceutil/trace.go:171","msg":"trace[292040753] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"337.046752ms","start":"2026-04-02T06:10:50.064313Z","end":"2026-04-02T06:10:50.40136Z","steps":["trace[292040753] 'process raft request' (duration: 336.93066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:50.401498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:10:50.064282Z","time spent":"337.169265ms","remote":"127.0.0.1:53032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T06:10:50.44957Z","caller":"traceutil/trace.go:171","msg":"trace[781168206] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:702; }","duration":"166.545549ms","start":"2026-04-02T06:10:50.283004Z","end":"2026-04-02T06:10:50.449549Z","steps":["trace[781168206] 'read index received' (duration: 118.257743ms)","trace[781168206] 'applied index is now lower than readState.Index' (duration: 48.287206ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:10:50.449629Z","caller":"traceutil/trace.go:171","msg":"trace[187080394] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"184.238396ms","start":"2026-04-02T06:10:50.265372Z","end":"2026-04-02T06:10:50.449611Z","steps":["trace[187080394] 'process raft request' (duration: 184.073442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:50.449891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.863498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-02T06:10:50.44997Z","caller":"traceutil/trace.go:171","msg":"trace[721985187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:675; }","duration":"166.997021ms","start":"2026-04-02T06:10:50.282953Z","end":"2026-04-02T06:10:50.44995Z","steps":["trace[721985187] 'agreement among raft nodes before linearized reading' (duration: 166.706374ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:50.46956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.70385ms","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-02T06:10:50.469631Z","caller":"traceutil/trace.go:171","msg":"trace[692322914] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:677; }","duration":"162.814601ms","start":"2026-04-02T06:10:50.306799Z","end":"2026-04-02T06:10:50.469613Z","steps":["trace[692322914] 'agreement among raft nodes before linearized reading' (duration: 162.487544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:10:50.46956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.412318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-02T06:10:50.469807Z","caller":"traceutil/trace.go:171","msg":"trace[1368438655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:677; }","duration":"186.690733ms","start":"2026-04-02T06:10:50.283087Z","end":"2026-04-02T06:10:50.469778Z","steps":["trace[1368438655] 'agreement among raft nodes before linearized reading' (duration: 186.249363ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:11:01.501965Z","caller":"traceutil/trace.go:171","msg":"trace[141435200] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"117.686689ms","start":"2026-04-02T06:11:01.384259Z","end":"2026-04-02T06:11:01.501945Z","steps":["trace[141435200] 'process raft request' (duration: 117.537876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:11:05.489001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.364581ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-02T06:11:05.489661Z","caller":"traceutil/trace.go:171","msg":"trace[1258522154] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:829; }","duration":"954.684388ms","start":"2026-04-02T06:11:04.534951Z","end":"2026-04-02T06:11:05.489635Z","steps":["trace[1258522154] 'read index received' (duration: 33.531µs)","trace[1258522154] 'applied index is now lower than readState.Index' (duration: 954.649217ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:11:05.489866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.906673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-02T06:11:05.489913Z","caller":"traceutil/trace.go:171","msg":"trace[1417939132] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:798; }","duration":"954.961334ms","start":"2026-04-02T06:11:04.534939Z","end":"2026-04-02T06:11:05.489901Z","steps":["trace[1417939132] 'agreement among raft nodes before linearized reading' (duration: 954.808211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:11:05.489969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:11:04.534894Z","time spent":"955.059746ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T06:11:05.490219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.619159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-02T06:11:05.490277Z","caller":"traceutil/trace.go:171","msg":"trace[1401437203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"949.694121ms","start":"2026-04-02T06:11:04.540568Z","end":"2026-04-02T06:11:05.490262Z","steps":["trace[1401437203] 'agreement among raft nodes before linearized reading' (duration: 949.551147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:11:05.490325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:11:04.540559Z","time spent":"949.755552ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T06:11:05.49044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.048868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T06:11:05.490485Z","caller":"traceutil/trace.go:171","msg":"trace[1596177016] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:798; }","duration":"115.1289ms","start":"2026-04-02T06:11:05.375344Z","end":"2026-04-02T06:11:05.490473Z","steps":["trace[1596177016] 'agreement among raft nodes before linearized reading' (duration: 115.061978ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:11:05.490644Z","caller":"traceutil/trace.go:171","msg":"trace[390258618] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"470.252877ms","start":"2026-04-02T06:11:05.02036Z","end":"2026-04-02T06:11:05.490613Z","steps":["trace[390258618] 'process raft request' (duration: 469.09263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:11:05.490803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:11:05.020339Z","time spent":"470.37083ms","remote":"127.0.0.1:53224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:11:05.490798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.587147ms","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-02T06:11:05.490928Z","caller":"traceutil/trace.go:171","msg":"trace[285818623] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:798; }","duration":"943.773451ms","start":"2026-04-02T06:11:04.547129Z","end":"2026-04-02T06:11:05.490902Z","steps":["trace[285818623] 'agreement among raft nodes before linearized reading' (duration: 943.358921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:11:05.490977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:11:04.547107Z","time spent":"943.861853ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-02T06:11:40.255682Z","caller":"traceutil/trace.go:171","msg":"trace[619474200] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"120.116117ms","start":"2026-04-02T06:11:40.135543Z","end":"2026-04-02T06:11:40.255659Z","steps":["trace[619474200] 'process raft request' (duration: 119.974434ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:11:41.924431Z","caller":"traceutil/trace.go:171","msg":"trace[1154487800] linearizableReadLoop","detail":"{readStateIndex:1059; appliedIndex:1058; }","duration":"219.181188ms","start":"2026-04-02T06:11:41.705228Z","end":"2026-04-02T06:11:41.924409Z","steps":["trace[1154487800] 'read index received' (duration: 218.986633ms)","trace[1154487800] 'applied index is now lower than readState.Index' (duration: 193.685µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:11:41.924524Z","caller":"traceutil/trace.go:171","msg":"trace[281586594] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"219.991888ms","start":"2026-04-02T06:11:41.704501Z","end":"2026-04-02T06:11:41.924493Z","steps":["trace[281586594] 'process raft request' (duration: 219.769932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:11:41.924654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.117757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-02T06:11:41.924654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.424074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-02T06:11:41.924727Z","caller":"traceutil/trace.go:171","msg":"trace[1006296942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1017; }","duration":"219.529296ms","start":"2026-04-02T06:11:41.705185Z","end":"2026-04-02T06:11:41.924714Z","steps":["trace[1006296942] 'agreement among raft nodes before linearized reading' (duration: 219.353302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:11:41.924784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.188811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-02T06:11:41.924813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.197011ms","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-02T06:11:41.924801Z","caller":"traceutil/trace.go:171","msg":"trace[1606814548] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1017; }","duration":"203.224083ms","start":"2026-04-02T06:11:41.721572Z","end":"2026-04-02T06:11:41.924796Z","steps":["trace[1606814548] 'agreement among raft nodes before linearized reading' (duration: 203.136491ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:11:41.924866Z","caller":"traceutil/trace.go:171","msg":"trace[1031158751] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1017; }","duration":"197.285512ms","start":"2026-04-02T06:11:41.727573Z","end":"2026-04-02T06:11:41.924858Z","steps":["trace[1031158751] 'agreement among raft nodes before linearized reading' (duration: 197.121528ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:11:41.924683Z","caller":"traceutil/trace.go:171","msg":"trace[1908122505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1017; }","duration":"205.189579ms","start":"2026-04-02T06:11:41.719486Z","end":"2026-04-02T06:11:41.924675Z","steps":["trace[1908122505] 'agreement among raft nodes before linearized reading' (duration: 205.054476ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:11:42.423728Z","caller":"traceutil/trace.go:171","msg":"trace[1153491826] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"495.485411ms","start":"2026-04-02T06:11:41.928213Z","end":"2026-04-02T06:11:42.423698Z","steps":["trace[1153491826] 'process raft request' (duration: 493.215748ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:11:42.423887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:11:41.928196Z","time spent":"495.605614ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:11:42.428496Z","caller":"traceutil/trace.go:171","msg":"trace[782265994] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"499.719471ms","start":"2026-04-02T06:11:41.92876Z","end":"2026-04-02T06:11:42.428479Z","steps":["trace[782265994] 'process raft request' (duration: 499.525806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:11:42.428616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:11:41.928739Z","time spent":"499.809542ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:11:42.42863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.733365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-02T06:11:42.428494Z","caller":"traceutil/trace.go:171","msg":"trace[1503755610] linearizableReadLoop","detail":"{readStateIndex:1062; appliedIndex:1059; }","duration":"169.575491ms","start":"2026-04-02T06:11:42.258894Z","end":"2026-04-02T06:11:42.42847Z","steps":["trace[1503755610] 'read index received' (duration: 162.553365ms)","trace[1503755610] 'applied index is now lower than readState.Index' (duration: 7.021146ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:11:42.428676Z","caller":"traceutil/trace.go:171","msg":"trace[805246232] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1021; }","duration":"169.810516ms","start":"2026-04-02T06:11:42.258855Z","end":"2026-04-02T06:11:42.428665Z","steps":["trace[805246232] 'agreement among raft nodes before linearized reading' (duration: 169.678933ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:11:42.428693Z","caller":"traceutil/trace.go:171","msg":"trace[483972541] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"499.779782ms","start":"2026-04-02T06:11:41.9289Z","end":"2026-04-02T06:11:42.42868Z","steps":["trace[483972541] 'process raft request' (duration: 499.495575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:11:42.428758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:11:41.928891Z","time spent":"499.833594ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:11:42.428781Z","caller":"traceutil/trace.go:171","msg":"trace[55589814] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"157.980828ms","start":"2026-04-02T06:11:42.270791Z","end":"2026-04-02T06:11:42.428772Z","steps":["trace[55589814] 'process raft request' (duration: 157.64172ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:11:50.011535Z","caller":"traceutil/trace.go:171","msg":"trace[777691162] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"175.446978ms","start":"2026-04-02T06:11:49.836034Z","end":"2026-04-02T06:11:50.011481Z","steps":["trace[777691162] 'process raft request' (duration: 175.197502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:04.801661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.868961ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-02T06:12:04.801824Z","caller":"traceutil/trace.go:171","msg":"trace[306449120] linearizableReadLoop","detail":"{readStateIndex:1136; appliedIndex:1135; }","duration":"702.43911ms","start":"2026-04-02T06:12:04.099371Z","end":"2026-04-02T06:12:04.80181Z","steps":["trace[306449120] 'read index received' (duration: 394.320343ms)","trace[306449120] 'applied index is now lower than readState.Index' (duration: 308.117917ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:04.802029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.608554ms","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-02T06:12:04.802052Z","caller":"traceutil/trace.go:171","msg":"trace[109513672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1089; }","duration":"702.720797ms","start":"2026-04-02T06:12:04.099323Z","end":"2026-04-02T06:12:04.802044Z","steps":["trace[109513672] 'agreement among raft nodes before linearized reading' (duration: 702.580913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:04.802074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:04.099301Z","time spent":"702.767207ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-02T06:12:04.802352Z","caller":"traceutil/trace.go:171","msg":"trace[1597252818] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"290.202267ms","start":"2026-04-02T06:12:04.512053Z","end":"2026-04-02T06:12:04.802255Z","steps":["trace[1597252818] 'process raft request' (duration: 289.691206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:04.872018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.443762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-02T06:12:04.872109Z","caller":"traceutil/trace.go:171","msg":"trace[1980858543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1090; }","duration":"319.576055ms","start":"2026-04-02T06:12:04.552513Z","end":"2026-04-02T06:12:04.872089Z","steps":["trace[1980858543] 'agreement among raft nodes before linearized reading' (duration: 249.7534ms)","trace[1980858543] 'range keys from in-memory index tree' (duration: 69.62918ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:04.872091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.594426ms","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-02T06:12:04.872148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:04.552498Z","time spent":"319.639766ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T06:12:04.872177Z","caller":"traceutil/trace.go:171","msg":"trace[1341770676] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1090; }","duration":"328.729849ms","start":"2026-04-02T06:12:04.543425Z","end":"2026-04-02T06:12:04.872155Z","steps":["trace[1341770676] 'agreement among raft nodes before linearized reading' (duration: 258.853053ms)","trace[1341770676] 'range keys from in-memory index tree' (duration: 69.662962ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:04.872237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:04.543407Z","time spent":"328.819692ms","remote":"127.0.0.1:53256","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-02T06:12:04.872262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.072677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T06:12:04.872333Z","caller":"traceutil/trace.go:171","msg":"trace[338060966] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1090; }","duration":"519.1805ms","start":"2026-04-02T06:12:04.35313Z","end":"2026-04-02T06:12:04.87231Z","steps":["trace[338060966] 'agreement among raft nodes before linearized reading' (duration: 449.122179ms)","trace[338060966] 'count revisions from in-memory index tree' (duration: 69.973978ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:04.872386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:04.35311Z","time spent":"519.263142ms","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:12:04.87244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.491863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-02T06:12:04.872472Z","caller":"traceutil/trace.go:171","msg":"trace[2082546440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1090; }","duration":"319.554045ms","start":"2026-04-02T06:12:04.552906Z","end":"2026-04-02T06:12:04.87246Z","steps":["trace[2082546440] 'agreement among raft nodes before linearized reading' (duration: 249.354401ms)","trace[2082546440] 'range keys from in-memory index tree' (duration: 70.097081ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:04.872501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:04.552899Z","time spent":"319.596565ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T06:12:04.873112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.634899ms","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-02T06:12:04.873187Z","caller":"traceutil/trace.go:171","msg":"trace[652396034] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1090; }","duration":"323.741672ms","start":"2026-04-02T06:12:04.549424Z","end":"2026-04-02T06:12:04.873165Z","steps":["trace[652396034] 'agreement among raft nodes before linearized reading' (duration: 252.848932ms)","trace[652396034] 'range keys from in-memory index tree' (duration: 70.524492ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:04.873237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:04.5494Z","time spent":"323.825705ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-02T06:12:05.048389Z","caller":"traceutil/trace.go:171","msg":"trace[320531428] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"169.09438ms","start":"2026-04-02T06:12:04.879267Z","end":"2026-04-02T06:12:05.048361Z","steps":["trace[320531428] 'process raft request' (duration: 168.898645ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:05.048529Z","caller":"traceutil/trace.go:171","msg":"trace[847492143] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"168.489865ms","start":"2026-04-02T06:12:04.880017Z","end":"2026-04-02T06:12:05.048507Z","steps":["trace[847492143] 'process raft request' (duration: 168.339582ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:05.048425Z","caller":"traceutil/trace.go:171","msg":"trace[601339202] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"169.028209ms","start":"2026-04-02T06:12:04.87937Z","end":"2026-04-02T06:12:05.048398Z","steps":["trace[601339202] 'process raft request' (duration: 168.936677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:07.377317Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726540773471902740,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T06:12:07.58892Z","caller":"traceutil/trace.go:171","msg":"trace[706127389] linearizableReadLoop","detail":"{readStateIndex:1143; appliedIndex:1142; }","duration":"711.988214ms","start":"2026-04-02T06:12:06.876904Z","end":"2026-04-02T06:12:07.588893Z","steps":["trace[706127389] 'read index received' (duration: 711.730568ms)","trace[706127389] 'applied index is now lower than readState.Index' (duration: 255.716µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:12:07.589112Z","caller":"traceutil/trace.go:171","msg":"trace[924217448] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"781.459571ms","start":"2026-04-02T06:12:06.807561Z","end":"2026-04-02T06:12:07.58902Z","steps":["trace[924217448] 'process raft request' (duration: 781.141593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:07.589331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:06.807539Z","time spent":"781.671896ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:07.589498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.371964ms","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-02T06:12:07.589586Z","caller":"traceutil/trace.go:171","msg":"trace[1102278729] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1096; }","duration":"712.707892ms","start":"2026-04-02T06:12:06.87686Z","end":"2026-04-02T06:12:07.589568Z","steps":["trace[1102278729] 'agreement among raft nodes before linearized reading' (duration: 712.20421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:07.589637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:06.876817Z","time spent":"712.808734ms","remote":"127.0.0.1:53256","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-02T06:12:07.589676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.445393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-02T06:12:07.589524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.935053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-02T06:12:07.589738Z","caller":"traceutil/trace.go:171","msg":"trace[1126044073] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1096; }","duration":"536.548555ms","start":"2026-04-02T06:12:07.053174Z","end":"2026-04-02T06:12:07.589723Z","steps":["trace[1126044073] 'agreement among raft nodes before linearized reading' (duration: 536.387501ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:07.589763Z","caller":"traceutil/trace.go:171","msg":"trace[2014134212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1096; }","duration":"630.312961ms","start":"2026-04-02T06:12:06.95944Z","end":"2026-04-02T06:12:07.589753Z","steps":["trace[2014134212] 'agreement among raft nodes before linearized reading' (duration: 629.8616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:07.58979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:07.053147Z","time spent":"536.631128ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T06:12:07.589797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:06.959425Z","time spent":"630.364043ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T06:12:07.58973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.29435ms","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-02T06:12:07.589891Z","caller":"traceutil/trace.go:171","msg":"trace[1232711762] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1096; }","duration":"536.516965ms","start":"2026-04-02T06:12:07.053365Z","end":"2026-04-02T06:12:07.589882Z","steps":["trace[1232711762] 'agreement among raft nodes before linearized reading' (duration: 536.094745ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:07.589919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:07.053357Z","time spent":"536.553586ms","remote":"127.0.0.1:53256","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-02T06:12:07.589974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.11727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T06:12:07.590128Z","caller":"traceutil/trace.go:171","msg":"trace[1398145808] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1096; }","duration":"590.361425ms","start":"2026-04-02T06:12:06.999743Z","end":"2026-04-02T06:12:07.590104Z","steps":["trace[1398145808] 'agreement among raft nodes before linearized reading' (duration: 589.864484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:07.590231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:06.999724Z","time spent":"590.485249ms","remote":"127.0.0.1:53428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:12:07.589945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.515155ms","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-02T06:12:07.590776Z","caller":"traceutil/trace.go:171","msg":"trace[846227129] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1096; }","duration":"537.358034ms","start":"2026-04-02T06:12:07.053399Z","end":"2026-04-02T06:12:07.590757Z","steps":["trace[846227129] 'agreement among raft nodes before linearized reading' (duration: 536.366061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:07.590916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:07.05339Z","time spent":"537.474037ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-02T06:12:07.815136Z","caller":"traceutil/trace.go:171","msg":"trace[1350147415] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"219.455429ms","start":"2026-04-02T06:12:07.595646Z","end":"2026-04-02T06:12:07.815101Z","steps":["trace[1350147415] 'process raft request' (duration: 172.438578ms)","trace[1350147415] 'compare' (duration: 46.800416ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:12:07.881498Z","caller":"traceutil/trace.go:171","msg":"trace[517578793] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"284.84167ms","start":"2026-04-02T06:12:07.596637Z","end":"2026-04-02T06:12:07.881478Z","steps":["trace[517578793] 'process raft request' (duration: 284.791889ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:07.881533Z","caller":"traceutil/trace.go:171","msg":"trace[140736043] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"285.576377ms","start":"2026-04-02T06:12:07.59592Z","end":"2026-04-02T06:12:07.881496Z","steps":["trace[140736043] 'process raft request' (duration: 285.402063ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:07.881819Z","caller":"traceutil/trace.go:171","msg":"trace[1999405221] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"284.824279ms","start":"2026-04-02T06:12:07.596974Z","end":"2026-04-02T06:12:07.881798Z","steps":["trace[1999405221] 'process raft request' (duration: 284.480361ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:07.881963Z","caller":"traceutil/trace.go:171","msg":"trace[1917143771] linearizableReadLoop","detail":"{readStateIndex:1148; appliedIndex:1143; }","duration":"224.851135ms","start":"2026-04-02T06:12:07.657101Z","end":"2026-04-02T06:12:07.881952Z","steps":["trace[1917143771] 'read index received' (duration: 110.994289ms)","trace[1917143771] 'applied index is now lower than readState.Index' (duration: 113.855516ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:12:07.881971Z","caller":"traceutil/trace.go:171","msg":"trace[1349744757] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"284.750727ms","start":"2026-04-02T06:12:07.597213Z","end":"2026-04-02T06:12:07.881964Z","steps":["trace[1349744757] 'process raft request' (duration: 284.495011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:07.882071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.929136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:07.882132Z","caller":"traceutil/trace.go:171","msg":"trace[101434134] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1101; }","duration":"225.038299ms","start":"2026-04-02T06:12:07.657059Z","end":"2026-04-02T06:12:07.882097Z","steps":["trace[101434134] 'agreement among raft nodes before linearized reading' (duration: 224.930927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:09.447185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.7721ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:12:09.447346Z","caller":"traceutil/trace.go:171","msg":"trace[1512480262] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"457.807542ms","start":"2026-04-02T06:12:08.989466Z","end":"2026-04-02T06:12:09.447274Z","steps":["trace[1512480262] 'process raft request' (duration: 43.873388ms)","trace[1512480262] 'compare' (duration: 413.562966ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:09.44741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:08.989447Z","time spent":"457.935266ms","remote":"127.0.0.1:53004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:10.386633Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726540773471902764,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T06:12:10.764341Z","caller":"traceutil/trace.go:171","msg":"trace[592960916] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"932.280603ms","start":"2026-04-02T06:12:09.83204Z","end":"2026-04-02T06:12:10.76432Z","steps":["trace[592960916] 'process raft request' (duration: 932.079088ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:10.764308Z","caller":"traceutil/trace.go:171","msg":"trace[323579954] linearizableReadLoop","detail":"{readStateIndex:1152; appliedIndex:1151; }","duration":"878.610506ms","start":"2026-04-02T06:12:09.885671Z","end":"2026-04-02T06:12:10.764281Z","steps":["trace[323579954] 'read index received' (duration: 878.524494ms)","trace[323579954] 'applied index is now lower than readState.Index' (duration: 84.992µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:10.764466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:09.832015Z","time spent":"932.374556ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:10.764657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.974674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-02T06:12:10.764758Z","caller":"traceutil/trace.go:171","msg":"trace[170151514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1104; }","duration":"879.104648ms","start":"2026-04-02T06:12:09.885637Z","end":"2026-04-02T06:12:10.764742Z","steps":["trace[170151514] 'agreement among raft nodes before linearized reading' (duration: 878.729679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:10.764823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:09.885621Z","time spent":"879.19076ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T06:12:10.807167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.306367ms","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-02T06:12:10.807352Z","caller":"traceutil/trace.go:171","msg":"trace[356286249] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"416.545455ms","start":"2026-04-02T06:12:10.390787Z","end":"2026-04-02T06:12:10.807332Z","steps":["trace[356286249] 'process raft request' (duration: 416.090424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:10.807472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:10.390762Z","time spent":"416.648307ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:10.807493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.270886ms","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-02T06:12:10.807474Z","caller":"traceutil/trace.go:171","msg":"trace[1279955388] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1105; }","duration":"921.579372ms","start":"2026-04-02T06:12:09.885809Z","end":"2026-04-02T06:12:10.807388Z","steps":["trace[1279955388] 'agreement among raft nodes before linearized reading' (duration: 921.199163ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:10.807542Z","caller":"traceutil/trace.go:171","msg":"trace[852112397] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1105; }","duration":"921.346837ms","start":"2026-04-02T06:12:09.886182Z","end":"2026-04-02T06:12:10.807529Z","steps":["trace[852112397] 'agreement among raft nodes before linearized reading' (duration: 921.189303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:10.807596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:09.885798Z","time spent":"921.764756ms","remote":"127.0.0.1:53256","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-02T06:12:10.807604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:09.886171Z","time spent":"921.415729ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T06:12:10.807273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.540422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:10.807668Z","caller":"traceutil/trace.go:171","msg":"trace[1656260090] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1105; }","duration":"149.987513ms","start":"2026-04-02T06:12:10.65767Z","end":"2026-04-02T06:12:10.807657Z","steps":["trace[1656260090] 'agreement among raft nodes before linearized reading' (duration: 149.549832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:10.807799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.8951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-02T06:12:10.807843Z","caller":"traceutil/trace.go:171","msg":"trace[1638730570] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1105; }","duration":"921.972882ms","start":"2026-04-02T06:12:09.885856Z","end":"2026-04-02T06:12:10.807829Z","steps":["trace[1638730570] 'agreement among raft nodes before linearized reading' (duration: 921.868169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:10.80788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:09.885836Z","time spent":"922.036424ms","remote":"127.0.0.1:53256","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-02T06:12:11.285351Z","caller":"traceutil/trace.go:171","msg":"trace[18410969] linearizableReadLoop","detail":"{readStateIndex:1154; appliedIndex:1153; }","duration":"476.746934ms","start":"2026-04-02T06:12:10.808575Z","end":"2026-04-02T06:12:11.285322Z","steps":["trace[18410969] 'read index received' (duration: 476.623141ms)","trace[18410969] 'applied index is now lower than readState.Index' (duration: 122.563µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:11.285585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.988639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:11.285638Z","caller":"traceutil/trace.go:171","msg":"trace[1553581782] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1106; }","duration":"477.094112ms","start":"2026-04-02T06:12:10.808531Z","end":"2026-04-02T06:12:11.285625Z","steps":["trace[1553581782] 'agreement among raft nodes before linearized reading' (duration: 476.950969ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:11.285578Z","caller":"traceutil/trace.go:171","msg":"trace[1726100619] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"515.765837ms","start":"2026-04-02T06:12:10.7697Z","end":"2026-04-02T06:12:11.285465Z","steps":["trace[1726100619] 'process raft request' (duration: 515.373898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:11.285898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:10.769667Z","time spent":"516.117546ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:11.285688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:10.808514Z","time spent":"477.163903ms","remote":"127.0.0.1:52976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T06:12:11.302867Z","caller":"traceutil/trace.go:171","msg":"trace[1619656819] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"490.659299ms","start":"2026-04-02T06:12:10.812182Z","end":"2026-04-02T06:12:11.302842Z","steps":["trace[1619656819] 'process raft request' (duration: 490.488695ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:11.303274Z","caller":"traceutil/trace.go:171","msg":"trace[911222298] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"491.032649ms","start":"2026-04-02T06:12:10.812209Z","end":"2026-04-02T06:12:11.303242Z","steps":["trace[911222298] 'process raft request' (duration: 490.598728ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:11.303412Z","caller":"traceutil/trace.go:171","msg":"trace[116365731] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"491.017398ms","start":"2026-04-02T06:12:10.81238Z","end":"2026-04-02T06:12:11.303398Z","steps":["trace[116365731] 'process raft request' (duration: 490.805353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:11.303509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:10.812373Z","time spent":"491.09989ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:11.303418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:10.812173Z","time spent":"491.167682ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:11.303307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:10.812162Z","time spent":"490.840534ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:11.304211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.061825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T06:12:11.304462Z","caller":"traceutil/trace.go:171","msg":"trace[1642301603] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1109; }","duration":"276.204588ms","start":"2026-04-02T06:12:11.028084Z","end":"2026-04-02T06:12:11.304288Z","steps":["trace[1642301603] 'agreement among raft nodes before linearized reading' (duration: 275.263326ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:23.133284Z","caller":"traceutil/trace.go:171","msg":"trace[2015600829] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"304.506551ms","start":"2026-04-02T06:12:22.828762Z","end":"2026-04-02T06:12:23.133268Z","steps":["trace[2015600829] 'process raft request' (duration: 304.387788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:23.133418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:22.828742Z","time spent":"304.618434ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:24.975004Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726540773471902978,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:12:25.420518Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.097219286s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-02T06:12:26.607478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.186625838s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-04-02T06:12:26.607815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.104767ms","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-02T06:12:26.607927Z","caller":"traceutil/trace.go:171","msg":"trace[882969836] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1201; }","duration":"554.22468ms","start":"2026-04-02T06:12:26.053684Z","end":"2026-04-02T06:12:26.607908Z","steps":["trace[882969836] 'range keys from in-memory index tree' (duration: 554.088387ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:26.607978Z","caller":"traceutil/trace.go:171","msg":"trace[2119592835] linearizableReadLoop","detail":"{readStateIndex:1254; appliedIndex:1253; }","duration":"2.133027652s","start":"2026-04-02T06:12:24.474895Z","end":"2026-04-02T06:12:26.607922Z","steps":["trace[2119592835] 'read index received' (duration: 945.845101ms)","trace[2119592835] 'applied index is now lower than readState.Index' (duration: 1.18715921s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:26.608065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.133147445s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:26.608782Z","caller":"traceutil/trace.go:171","msg":"trace[1681198055] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1201; }","duration":"2.133267447s","start":"2026-04-02T06:12:24.474844Z","end":"2026-04-02T06:12:26.608112Z","steps":["trace[1681198055] 'agreement among raft nodes before linearized reading' (duration: 2.133152965s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:26.608828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:24.474822Z","time spent":"2.133995505s","remote":"127.0.0.1:33660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-02T06:12:26.609006Z","caller":"traceutil/trace.go:171","msg":"trace[232255646] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"840.76276ms","start":"2026-04-02T06:12:25.768228Z","end":"2026-04-02T06:12:26.608991Z","steps":["trace[232255646] 'process raft request' (duration: 839.370687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:26.609093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:25.768194Z","time spent":"840.841331ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:26.612326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.120664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:12:26.612396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.267618594s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-02T06:12:26.6124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.255308376s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-02T06:12:26.612398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.248718592s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-02T06:12:26.612408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.955881154s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:26.61243Z","caller":"traceutil/trace.go:171","msg":"trace[1665192633] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1202; }","duration":"1.267694276s","start":"2026-04-02T06:12:25.344726Z","end":"2026-04-02T06:12:26.61242Z","steps":["trace[1665192633] 'agreement among raft nodes before linearized reading' (duration: 1.264282876s)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:26.61244Z","caller":"traceutil/trace.go:171","msg":"trace[1400539226] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1202; }","duration":"1.255370798s","start":"2026-04-02T06:12:25.357057Z","end":"2026-04-02T06:12:26.612428Z","steps":["trace[1400539226] 'agreement among raft nodes before linearized reading' (duration: 1.251967059s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:26.612455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:25.344705Z","time spent":"1.267744428s","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T06:12:26.612451Z","caller":"traceutil/trace.go:171","msg":"trace[1943437112] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1202; }","duration":"1.248799915s","start":"2026-04-02T06:12:25.363638Z","end":"2026-04-02T06:12:26.612438Z","steps":["trace[1943437112] 'agreement among raft nodes before linearized reading' (duration: 1.245360774s)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:26.612455Z","caller":"traceutil/trace.go:171","msg":"trace[486946977] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1202; }","duration":"1.955953715s","start":"2026-04-02T06:12:24.656487Z","end":"2026-04-02T06:12:26.61244Z","steps":["trace[486946977] 'agreement among raft nodes before linearized reading' (duration: 1.952506904s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:26.612468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:25.357045Z","time spent":"1.255417169s","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T06:12:26.61246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.475875612s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-02T06:12:26.612485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:24.65647Z","time spent":"1.956008937s","remote":"127.0.0.1:52972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T06:12:26.612404Z","caller":"traceutil/trace.go:171","msg":"trace[1743858009] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1202; }","duration":"173.252257ms","start":"2026-04-02T06:12:26.439134Z","end":"2026-04-02T06:12:26.612386Z","steps":["trace[1743858009] 'agreement among raft nodes before linearized reading' (duration: 169.876999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:26.612485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:25.363622Z","time spent":"1.248854245s","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-02T06:12:26.612522Z","caller":"traceutil/trace.go:171","msg":"trace[1868819242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1202; }","duration":"1.475972804s","start":"2026-04-02T06:12:25.136535Z","end":"2026-04-02T06:12:26.612508Z","steps":["trace[1868819242] 'agreement among raft nodes before linearized reading' (duration: 1.472478073s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:26.612557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:25.136518Z","time spent":"1.476031195s","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T06:12:26.612554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.242551868s","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-02T06:12:26.612813Z","caller":"traceutil/trace.go:171","msg":"trace[1370141867] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1202; }","duration":"1.24305322s","start":"2026-04-02T06:12:25.369748Z","end":"2026-04-02T06:12:26.612801Z","steps":["trace[1370141867] 'agreement among raft nodes before linearized reading' (duration: 1.239263832s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:26.612853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:25.369732Z","time spent":"1.243110851s","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-02T06:12:41.835816Z","caller":"traceutil/trace.go:171","msg":"trace[654419948] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"192.051318ms","start":"2026-04-02T06:12:41.643747Z","end":"2026-04-02T06:12:41.835799Z","steps":["trace[654419948] 'process raft request' (duration: 191.943875ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:42.182378Z","caller":"traceutil/trace.go:171","msg":"trace[216017618] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"191.392942ms","start":"2026-04-02T06:12:41.99097Z","end":"2026-04-02T06:12:42.182363Z","steps":["trace[216017618] 'process raft request' (duration: 191.051994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:42.900825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.091516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:42.900908Z","caller":"traceutil/trace.go:171","msg":"trace[741021714] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1274; }","duration":"589.226899ms","start":"2026-04-02T06:12:42.311669Z","end":"2026-04-02T06:12:42.900895Z","steps":["trace[741021714] 'count revisions from in-memory index tree' (duration: 588.988933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:42.900933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:42.311654Z","time spent":"589.27271ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:12:42.900998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.093696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:42.901056Z","caller":"traceutil/trace.go:171","msg":"trace[1296622821] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1274; }","duration":"244.191379ms","start":"2026-04-02T06:12:42.65685Z","end":"2026-04-02T06:12:42.901041Z","steps":["trace[1296622821] 'range keys from in-memory index tree' (duration: 244.031375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:42.901083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.667721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:42.901142Z","caller":"traceutil/trace.go:171","msg":"trace[1173676914] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1274; }","duration":"607.815225ms","start":"2026-04-02T06:12:42.293315Z","end":"2026-04-02T06:12:42.90113Z","steps":["trace[1173676914] 'count revisions from in-memory index tree' (duration: 607.5864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:42.901169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:42.293295Z","time spent":"607.866795ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-04-02T06:12:43.157216Z","caller":"traceutil/trace.go:171","msg":"trace[819718083] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1330; }","duration":"391.217511ms","start":"2026-04-02T06:12:42.765982Z","end":"2026-04-02T06:12:43.1572Z","steps":["trace[819718083] 'read index received' (duration: 391.076128ms)","trace[819718083] 'applied index is now lower than readState.Index' (duration: 140.873µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:43.157489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.864104ms","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-02T06:12:43.15752Z","caller":"traceutil/trace.go:171","msg":"trace[1162262211] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1275; }","duration":"390.933886ms","start":"2026-04-02T06:12:42.766578Z","end":"2026-04-02T06:12:43.157512Z","steps":["trace[1162262211] 'agreement among raft nodes before linearized reading' (duration: 390.799353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:43.157504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.482428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-02T06:12:43.157573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.718869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:43.15759Z","caller":"traceutil/trace.go:171","msg":"trace[325675160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1275; }","duration":"255.749739ms","start":"2026-04-02T06:12:42.901836Z","end":"2026-04-02T06:12:43.157586Z","steps":["trace[325675160] 'agreement among raft nodes before linearized reading' (duration: 255.719949ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:43.157619Z","caller":"traceutil/trace.go:171","msg":"trace[332441465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1275; }","duration":"391.664573ms","start":"2026-04-02T06:12:42.765937Z","end":"2026-04-02T06:12:43.157601Z","steps":["trace[332441465] 'agreement among raft nodes before linearized reading' (duration: 391.372116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:43.157627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.001803ms","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-02T06:12:43.157665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:42.765915Z","time spent":"391.738974ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T06:12:43.157676Z","caller":"traceutil/trace.go:171","msg":"trace[361010926] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1275; }","duration":"387.079865ms","start":"2026-04-02T06:12:42.770586Z","end":"2026-04-02T06:12:43.157666Z","steps":["trace[361010926] 'agreement among raft nodes before linearized reading' (duration: 386.972993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:43.157703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:42.770569Z","time spent":"387.128146ms","remote":"127.0.0.1:53256","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-02T06:12:43.157761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.109149ms","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-02T06:12:43.157782Z","caller":"traceutil/trace.go:171","msg":"trace[1358697254] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1275; }","duration":"391.159501ms","start":"2026-04-02T06:12:42.766617Z","end":"2026-04-02T06:12:43.157777Z","steps":["trace[1358697254] 'agreement among raft nodes before linearized reading' (duration: 391.099519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:43.157798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:42.7666Z","time spent":"391.193981ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T06:12:43.157544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:42.766569Z","time spent":"390.969626ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-02T06:12:43.157525Z","caller":"traceutil/trace.go:171","msg":"trace[1808329776] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"395.795679ms","start":"2026-04-02T06:12:42.761715Z","end":"2026-04-02T06:12:43.157511Z","steps":["trace[1808329776] 'process raft request' (duration: 395.395619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:43.157914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.679945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-02T06:12:43.157918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:42.761697Z","time spent":"396.159018ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:12:43.157947Z","caller":"traceutil/trace.go:171","msg":"trace[528212667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1275; }","duration":"380.731116ms","start":"2026-04-02T06:12:42.777206Z","end":"2026-04-02T06:12:43.157937Z","steps":["trace[528212667] 'agreement among raft nodes before linearized reading' (duration: 380.639754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:43.157981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:42.777195Z","time spent":"380.778147ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T06:12:43.763887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.316312ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:12:43.763991Z","caller":"traceutil/trace.go:171","msg":"trace[505106952] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"602.510929ms","start":"2026-04-02T06:12:43.16146Z","end":"2026-04-02T06:12:43.763971Z","steps":["trace[505106952] 'process raft request' (duration: 264.020953ms)","trace[505106952] 'compare' (duration: 338.21877ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:43.764053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:43.161414Z","time spent":"602.607681ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:12:43.904022Z","caller":"traceutil/trace.go:171","msg":"trace[1700750691] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"741.153175ms","start":"2026-04-02T06:12:43.162844Z","end":"2026-04-02T06:12:43.903997Z","steps":["trace[1700750691] 'process raft request' (duration: 712.052164ms)","trace[1700750691] 'compare' (duration: 28.942468ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:43.904162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:43.162828Z","time spent":"741.263789ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:12:43.904274Z","caller":"traceutil/trace.go:171","msg":"trace[362782972] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"741.393511ms","start":"2026-04-02T06:12:43.162851Z","end":"2026-04-02T06:12:43.904244Z","steps":["trace[362782972] 'process raft request' (duration: 741.101224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:43.904414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:43.162828Z","time spent":"741.513134ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:12:43.904405Z","caller":"traceutil/trace.go:171","msg":"trace[546747708] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"741.368461ms","start":"2026-04-02T06:12:43.163019Z","end":"2026-04-02T06:12:43.904387Z","steps":["trace[546747708] 'process raft request' (duration: 741.127055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:43.904508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:43.16299Z","time spent":"741.462413ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:12:43.904579Z","caller":"traceutil/trace.go:171","msg":"trace[2144107092] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"741.064344ms","start":"2026-04-02T06:12:43.163503Z","end":"2026-04-02T06:12:43.904567Z","steps":["trace[2144107092] 'process raft request' (duration: 740.704075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:43.90464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:43.163496Z","time spent":"741.110485ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:12:43.904694Z","caller":"traceutil/trace.go:171","msg":"trace[102875459] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"551.164667ms","start":"2026-04-02T06:12:43.353521Z","end":"2026-04-02T06:12:43.904686Z","steps":["trace[102875459] 'process raft request' (duration: 550.722156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:43.904734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:43.353497Z","time spent":"551.213178ms","remote":"127.0.0.1:53156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5640,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:12:43.904777Z","caller":"traceutil/trace.go:171","msg":"trace[477875723] linearizableReadLoop","detail":"{readStateIndex:1337; appliedIndex:1332; }","duration":"335.002354ms","start":"2026-04-02T06:12:43.569766Z","end":"2026-04-02T06:12:43.904769Z","steps":["trace[477875723] 'read index received' (duration: 305.122415ms)","trace[477875723] 'applied index is now lower than readState.Index' (duration: 29.879049ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:43.904823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.052196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:43.90487Z","caller":"traceutil/trace.go:171","msg":"trace[1225295500] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1282; }","duration":"335.140998ms","start":"2026-04-02T06:12:43.569722Z","end":"2026-04-02T06:12:43.904863Z","steps":["trace[1225295500] 'agreement among raft nodes before linearized reading' (duration: 335.074866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:43.904892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:43.569703Z","time spent":"335.182388ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"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-02T06:12:44.547168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.724043ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-02T06:12:44.978027Z","caller":"traceutil/trace.go:171","msg":"trace[1191040658] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"151.643321ms","start":"2026-04-02T06:12:44.826362Z","end":"2026-04-02T06:12:44.978005Z","steps":["trace[1191040658] 'process raft request' (duration: 151.516178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:46.218465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.754102ms","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-02T06:12:46.218626Z","caller":"traceutil/trace.go:171","msg":"trace[258013009] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1283; }","duration":"165.934066ms","start":"2026-04-02T06:12:46.052669Z","end":"2026-04-02T06:12:46.218603Z","steps":["trace[258013009] 'range keys from in-memory index tree' (duration: 165.733981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:46.219376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.483847ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:12:46.21949Z","caller":"traceutil/trace.go:171","msg":"trace[1555450333] linearizableReadLoop","detail":"{readStateIndex:1341; appliedIndex:1340; }","duration":"561.459339ms","start":"2026-04-02T06:12:45.658008Z","end":"2026-04-02T06:12:46.219468Z","steps":["trace[1555450333] 'read index received' (duration: 20.729476ms)","trace[1555450333] 'applied index is now lower than readState.Index' (duration: 540.728133ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:12:46.219775Z","caller":"traceutil/trace.go:171","msg":"trace[1774034932] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"1.056616525s","start":"2026-04-02T06:12:45.163138Z","end":"2026-04-02T06:12:46.219755Z","steps":["trace[1774034932] 'process raft request' (duration: 515.648536ms)","trace[1774034932] 'compare' (duration: 540.129039ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:46.219866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:45.163112Z","time spent":"1.056705107s","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:46.220036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.770299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:12:46.220081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.083353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:46.22012Z","caller":"traceutil/trace.go:171","msg":"trace[1129440536] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1284; }","duration":"562.160965ms","start":"2026-04-02T06:12:45.657944Z","end":"2026-04-02T06:12:46.220105Z","steps":["trace[1129440536] 'agreement among raft nodes before linearized reading' (duration: 562.098023ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:46.220133Z","caller":"traceutil/trace.go:171","msg":"trace[1143277057] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1284; }","duration":"489.939703ms","start":"2026-04-02T06:12:45.73018Z","end":"2026-04-02T06:12:46.220119Z","steps":["trace[1143277057] 'agreement among raft nodes before linearized reading' (duration: 489.744679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:46.220151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:45.657921Z","time spent":"562.224547ms","remote":"127.0.0.1:52972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T06:12:46.220153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.924298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-02T06:12:46.220217Z","caller":"traceutil/trace.go:171","msg":"trace[647163039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1284; }","duration":"310.00284ms","start":"2026-04-02T06:12:45.910195Z","end":"2026-04-02T06:12:46.220198Z","steps":["trace[647163039] 'agreement among raft nodes before linearized reading' (duration: 309.797635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:46.220235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.439294ms","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-02T06:12:46.220266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:45.910186Z","time spent":"310.068571ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T06:12:46.220286Z","caller":"traceutil/trace.go:171","msg":"trace[604638344] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1284; }","duration":"311.549476ms","start":"2026-04-02T06:12:45.908721Z","end":"2026-04-02T06:12:46.22027Z","steps":["trace[604638344] 'agreement among raft nodes before linearized reading' (duration: 311.407052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:46.220299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.696351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-02T06:12:46.220285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.0398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-02T06:12:46.220329Z","caller":"traceutil/trace.go:171","msg":"trace[459725466] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1284; }","duration":"452.757033ms","start":"2026-04-02T06:12:45.767562Z","end":"2026-04-02T06:12:46.220319Z","steps":["trace[459725466] 'agreement among raft nodes before linearized reading' (duration: 452.62664ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:46.22033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:45.908691Z","time spent":"311.626938ms","remote":"127.0.0.1:53256","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-02T06:12:46.220367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:45.767542Z","time spent":"452.819634ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-02T06:12:46.220378Z","caller":"traceutil/trace.go:171","msg":"trace[528307821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1284; }","duration":"310.193414ms","start":"2026-04-02T06:12:45.910162Z","end":"2026-04-02T06:12:46.220356Z","steps":["trace[528307821] 'agreement among raft nodes before linearized reading' (duration: 309.909847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:46.220375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.310657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-02T06:12:46.220169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:45.730159Z","time spent":"490.001045ms","remote":"127.0.0.1:41314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"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-02T06:12:46.220427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:45.910137Z","time spent":"310.279796ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T06:12:46.220436Z","caller":"traceutil/trace.go:171","msg":"trace[1017593059] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1284; }","duration":"310.388498ms","start":"2026-04-02T06:12:45.910031Z","end":"2026-04-02T06:12:46.22042Z","steps":["trace[1017593059] 'agreement among raft nodes before linearized reading' (duration: 310.205774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:46.220486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:45.910023Z","time spent":"310.450451ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T06:12:46.967368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.178949ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:12:46.967502Z","caller":"traceutil/trace.go:171","msg":"trace[1570369018] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"742.875577ms","start":"2026-04-02T06:12:46.224613Z","end":"2026-04-02T06:12:46.967489Z","steps":["trace[1570369018] 'process raft request' (duration: 742.829476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:46.967552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:46.224596Z","time spent":"742.928889ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:12:46.967727Z","caller":"traceutil/trace.go:171","msg":"trace[1927955703] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"743.094792ms","start":"2026-04-02T06:12:46.224612Z","end":"2026-04-02T06:12:46.967707Z","steps":["trace[1927955703] 'process raft request' (duration: 214.514543ms)","trace[1927955703] 'compare' (duration: 527.877452ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:46.967778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:46.2246Z","time spent":"743.153284ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:47.318229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.035649ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:12:47.318497Z","caller":"traceutil/trace.go:171","msg":"trace[500188720] linearizableReadLoop","detail":"{readStateIndex:1346; appliedIndex:1343; }","duration":"158.751107ms","start":"2026-04-02T06:12:47.159723Z","end":"2026-04-02T06:12:47.318474Z","steps":["trace[500188720] 'read index received' (duration: 15.303788ms)","trace[500188720] 'applied index is now lower than readState.Index' (duration: 143.445739ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:12:47.318478Z","caller":"traceutil/trace.go:171","msg":"trace[2081690084] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"1.093759184s","start":"2026-04-02T06:12:46.224683Z","end":"2026-04-02T06:12:47.318442Z","steps":["trace[2081690084] 'process raft request' (duration: 950.406258ms)","trace[2081690084] 'compare' (duration: 142.904755ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:12:47.318562Z","caller":"traceutil/trace.go:171","msg":"trace[1290250904] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"1.092974285s","start":"2026-04-02T06:12:46.225577Z","end":"2026-04-02T06:12:47.318551Z","steps":["trace[1290250904] 'process raft request' (duration: 1.09276477s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:47.31862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:46.224659Z","time spent":"1.093913277s","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:12:47.318635Z","caller":"traceutil/trace.go:171","msg":"trace[1175616022] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"1.092834652s","start":"2026-04-02T06:12:46.225776Z","end":"2026-04-02T06:12:47.318611Z","steps":["trace[1175616022] 'process raft request' (duration: 1.092639527s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:47.318692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:46.225563Z","time spent":"1.093047607s","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:47.318722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:46.225767Z","time spent":"1.092910603s","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:47.318836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.108136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:47.318877Z","caller":"traceutil/trace.go:171","msg":"trace[1489851887] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1289; }","duration":"159.180767ms","start":"2026-04-02T06:12:47.159685Z","end":"2026-04-02T06:12:47.318865Z","steps":["trace[1489851887] 'agreement among raft nodes before linearized reading' (duration: 159.112705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:49.281774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.089768ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:12:49.281986Z","caller":"traceutil/trace.go:171","msg":"trace[1384637604] linearizableReadLoop","detail":"{readStateIndex:1350; appliedIndex:1348; }","duration":"310.266626ms","start":"2026-04-02T06:12:48.971697Z","end":"2026-04-02T06:12:49.281964Z","steps":["trace[1384637604] 'read index received' (duration: 73.921681ms)","trace[1384637604] 'applied index is now lower than readState.Index' (duration: 236.343705ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:12:49.282097Z","caller":"traceutil/trace.go:171","msg":"trace[1603246863] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"319.092472ms","start":"2026-04-02T06:12:48.962975Z","end":"2026-04-02T06:12:49.282068Z","steps":["trace[1603246863] 'process raft request' (duration: 82.623505ms)","trace[1603246863] 'compare' (duration: 235.970886ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:49.282205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:48.962961Z","time spent":"319.193485ms","remote":"127.0.0.1:53070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T06:12:49.282307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.602624ms","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-02T06:12:49.282118Z","caller":"traceutil/trace.go:171","msg":"trace[1673303387] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"312.345055ms","start":"2026-04-02T06:12:48.969757Z","end":"2026-04-02T06:12:49.282102Z","steps":["trace[1673303387] 'process raft request' (duration: 312.11614ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:49.282372Z","caller":"traceutil/trace.go:171","msg":"trace[321784659] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1292; }","duration":"310.688606ms","start":"2026-04-02T06:12:48.971666Z","end":"2026-04-02T06:12:49.282354Z","steps":["trace[321784659] 'agreement among raft nodes before linearized reading' (duration: 310.478631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:49.282414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:48.969736Z","time spent":"312.641702ms","remote":"127.0.0.1:53004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:49.282428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:48.971653Z","time spent":"310.761318ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T06:12:49.282659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.611421ms","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-02T06:12:49.28269Z","caller":"traceutil/trace.go:171","msg":"trace[994262134] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1292; }","duration":"236.643492ms","start":"2026-04-02T06:12:49.046039Z","end":"2026-04-02T06:12:49.282682Z","steps":["trace[994262134] 'agreement among raft nodes before linearized reading' (duration: 236.590751ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:49.282675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.516265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-02T06:12:49.282796Z","caller":"traceutil/trace.go:171","msg":"trace[355221380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1292; }","duration":"308.663909ms","start":"2026-04-02T06:12:48.974108Z","end":"2026-04-02T06:12:49.282772Z","steps":["trace[355221380] 'agreement among raft nodes before linearized reading' (duration: 308.414913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:49.282865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:48.973898Z","time spent":"308.950185ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T06:12:49.460651Z","caller":"traceutil/trace.go:171","msg":"trace[1088939548] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"139.105157ms","start":"2026-04-02T06:12:49.32153Z","end":"2026-04-02T06:12:49.460635Z","steps":["trace[1088939548] 'process raft request' (duration: 139.049766ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:49.460742Z","caller":"traceutil/trace.go:171","msg":"trace[1239731261] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"173.208506ms","start":"2026-04-02T06:12:49.287507Z","end":"2026-04-02T06:12:49.460716Z","steps":["trace[1239731261] 'process raft request' (duration: 173.045642ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:12:49.460749Z","caller":"traceutil/trace.go:171","msg":"trace[478515856] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"174.050506ms","start":"2026-04-02T06:12:49.28666Z","end":"2026-04-02T06:12:49.460711Z","steps":["trace[478515856] 'process raft request' (duration: 138.35212ms)","trace[478515856] 'compare' (duration: 35.4524ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:12:49.460857Z","caller":"traceutil/trace.go:171","msg":"trace[1251822633] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1351; }","duration":"139.685821ms","start":"2026-04-02T06:12:49.321146Z","end":"2026-04-02T06:12:49.460831Z","steps":["trace[1251822633] 'read index received' (duration: 103.884542ms)","trace[1251822633] 'applied index is now lower than readState.Index' (duration: 35.800439ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:49.460957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.799823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-02T06:12:49.460981Z","caller":"traceutil/trace.go:171","msg":"trace[138201414] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1296; }","duration":"139.878385ms","start":"2026-04-02T06:12:49.321098Z","end":"2026-04-02T06:12:49.460976Z","steps":["trace[138201414] 'agreement among raft nodes before linearized reading' (duration: 139.812564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:49.461136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.166802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-02T06:12:49.461173Z","caller":"traceutil/trace.go:171","msg":"trace[365156335] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1296; }","duration":"137.257794ms","start":"2026-04-02T06:12:49.323905Z","end":"2026-04-02T06:12:49.461163Z","steps":["trace[365156335] 'agreement among raft nodes before linearized reading' (duration: 137.135962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:49.461193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.424231ms","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-02T06:12:49.46121Z","caller":"traceutil/trace.go:171","msg":"trace[154852454] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1296; }","duration":"135.466892ms","start":"2026-04-02T06:12:49.325737Z","end":"2026-04-02T06:12:49.461204Z","steps":["trace[154852454] 'agreement among raft nodes before linearized reading' (duration: 135.399211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:49.461282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.288175ms","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-02T06:12:49.461293Z","caller":"traceutil/trace.go:171","msg":"trace[613005625] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1296; }","duration":"137.310085ms","start":"2026-04-02T06:12:49.323979Z","end":"2026-04-02T06:12:49.461289Z","steps":["trace[613005625] 'agreement among raft nodes before linearized reading' (duration: 137.276135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:49.848137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.91178ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:12:49.848236Z","caller":"traceutil/trace.go:171","msg":"trace[1962795753] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"384.618677ms","start":"2026-04-02T06:12:49.463598Z","end":"2026-04-02T06:12:49.848217Z","steps":["trace[1962795753] 'process raft request' (duration: 243.573514ms)","trace[1962795753] 'compare' (duration: 140.816208ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:12:49.848286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:49.463582Z","time spent":"384.682719ms","remote":"127.0.0.1:53070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T06:12:49.85494Z","caller":"traceutil/trace.go:171","msg":"trace[1175113419] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"389.762628ms","start":"2026-04-02T06:12:49.465158Z","end":"2026-04-02T06:12:49.854921Z","steps":["trace[1175113419] 'process raft request' (duration: 389.637185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:49.855042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:49.465138Z","time spent":"389.85192ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:12:49.8553Z","caller":"traceutil/trace.go:171","msg":"trace[1282378178] linearizableReadLoop","detail":"{readStateIndex:1357; appliedIndex:1354; }","duration":"389.650666ms","start":"2026-04-02T06:12:49.465629Z","end":"2026-04-02T06:12:49.85528Z","steps":["trace[1282378178] 'read index received' (duration: 241.551887ms)","trace[1282378178] 'applied index is now lower than readState.Index' (duration: 148.097878ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:12:49.855351Z","caller":"traceutil/trace.go:171","msg":"trace[2082336220] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"389.742777ms","start":"2026-04-02T06:12:49.465599Z","end":"2026-04-02T06:12:49.855342Z","steps":["trace[2082336220] 'process raft request' (duration: 389.292546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:49.855395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:49.465589Z","time spent":"389.782919ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:12:49.855399Z","caller":"traceutil/trace.go:171","msg":"trace[836317826] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"389.283487ms","start":"2026-04-02T06:12:49.466105Z","end":"2026-04-02T06:12:49.855388Z","steps":["trace[836317826] 'process raft request' (duration: 389.007881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:49.855481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:49.46609Z","time spent":"389.329568ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:12:49.855563Z","caller":"traceutil/trace.go:171","msg":"trace[1022774597] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"389.067002ms","start":"2026-04-02T06:12:49.466489Z","end":"2026-04-02T06:12:49.855556Z","steps":["trace[1022774597] 'process raft request' (duration: 388.750395ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:49.855589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:49.466479Z","time spent":"389.097172ms","remote":"127.0.0.1:53070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T06:12:49.855666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.883198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:49.85572Z","caller":"traceutil/trace.go:171","msg":"trace[899135021] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1301; }","duration":"359.97762ms","start":"2026-04-02T06:12:49.495727Z","end":"2026-04-02T06:12:49.855705Z","steps":["trace[899135021] 'agreement among raft nodes before linearized reading' (duration: 359.886118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:49.855763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:49.495703Z","time spent":"360.048832ms","remote":"127.0.0.1:33674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:12:49.855783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.152507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-04-02T06:12:49.85581Z","caller":"traceutil/trace.go:171","msg":"trace[1989605763] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1301; }","duration":"390.208639ms","start":"2026-04-02T06:12:49.465594Z","end":"2026-04-02T06:12:49.855802Z","steps":["trace[1989605763] 'agreement among raft nodes before linearized reading' (duration: 390.117567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:49.855831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:49.465582Z","time spent":"390.244699ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-02T06:12:49.855827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.028057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:49.855854Z","caller":"traceutil/trace.go:171","msg":"trace[2113646023] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1301; }","duration":"198.090239ms","start":"2026-04-02T06:12:49.657757Z","end":"2026-04-02T06:12:49.855847Z","steps":["trace[2113646023] 'agreement among raft nodes before linearized reading' (duration: 198.043808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:57.217318Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726540773471903287,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:12:57.717881Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726540773471903287,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:12:57.851702Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.463006371s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T06:12:57.852255Z","caller":"traceutil/trace.go:171","msg":"trace[478225739] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"1.463678177s","start":"2026-04-02T06:12:56.388561Z","end":"2026-04-02T06:12:57.852239Z","steps":["trace[478225739] 'process raft request' (duration: 1.463462662s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:57.852341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:56.388539Z","time spent":"1.463744949s","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:12:57.852588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.135766337s","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-02T06:12:57.852692Z","caller":"traceutil/trace.go:171","msg":"trace[1017752687] linearizableReadLoop","detail":"{readStateIndex:1418; appliedIndex:1417; }","duration":"1.135465601s","start":"2026-04-02T06:12:56.716748Z","end":"2026-04-02T06:12:57.852214Z","steps":["trace[1017752687] 'read index received' (duration: 1.135056751s)","trace[1017752687] 'applied index is now lower than readState.Index' (duration: 408.29µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:12:57.85276Z","caller":"traceutil/trace.go:171","msg":"trace[98147868] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1359; }","duration":"1.135981493s","start":"2026-04-02T06:12:56.7167Z","end":"2026-04-02T06:12:57.852682Z","steps":["trace[98147868] 'agreement among raft nodes before linearized reading' (duration: 1.135700106s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:57.852893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:56.716683Z","time spent":"1.136195698s","remote":"127.0.0.1:41354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"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-02T06:12:57.852957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.960337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T06:12:57.853006Z","caller":"traceutil/trace.go:171","msg":"trace[1104266109] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1359; }","duration":"128.032598ms","start":"2026-04-02T06:12:57.724946Z","end":"2026-04-02T06:12:57.852979Z","steps":["trace[1104266109] 'agreement among raft nodes before linearized reading' (duration: 127.985787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:57.853121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.910352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:12:57.853148Z","caller":"traceutil/trace.go:171","msg":"trace[304241673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1359; }","duration":"196.962662ms","start":"2026-04-02T06:12:57.656177Z","end":"2026-04-02T06:12:57.853139Z","steps":["trace[304241673] 'agreement among raft nodes before linearized reading' (duration: 196.927471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:57.852803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.948612ms","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-02T06:12:57.853346Z","caller":"traceutil/trace.go:171","msg":"trace[1795181103] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1359; }","duration":"507.510735ms","start":"2026-04-02T06:12:57.345822Z","end":"2026-04-02T06:12:57.853332Z","steps":["trace[1795181103] 'agreement among raft nodes before linearized reading' (duration: 506.922041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:57.853379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.761019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-04-02T06:12:57.853412Z","caller":"traceutil/trace.go:171","msg":"trace[46887592] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1359; }","duration":"372.881042ms","start":"2026-04-02T06:12:57.480521Z","end":"2026-04-02T06:12:57.853402Z","steps":["trace[46887592] 'agreement among raft nodes before linearized reading' (duration: 372.77752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:57.853411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:57.345807Z","time spent":"507.593487ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T06:12:57.85344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:57.480506Z","time spent":"372.927293ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-02T06:12:57.85366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.505991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-02T06:12:57.853685Z","caller":"traceutil/trace.go:171","msg":"trace[1303233413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1359; }","duration":"345.578563ms","start":"2026-04-02T06:12:57.5081Z","end":"2026-04-02T06:12:57.853679Z","steps":["trace[1303233413] 'agreement among raft nodes before linearized reading' (duration: 345.135132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:12:57.853704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:12:57.508083Z","time spent":"345.616143ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T06:14:10.442257Z","caller":"traceutil/trace.go:171","msg":"trace[1074634820] transaction","detail":"{read_only:false; response_revision:1694; number_of_response:1; }","duration":"256.042526ms","start":"2026-04-02T06:14:10.186189Z","end":"2026-04-02T06:14:10.442232Z","steps":["trace[1074634820] 'process raft request' (duration: 255.836311ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:14:10.443395Z","caller":"traceutil/trace.go:171","msg":"trace[987319821] linearizableReadLoop","detail":"{readStateIndex:1769; appliedIndex:1767; }","duration":"229.961896ms","start":"2026-04-02T06:14:10.213416Z","end":"2026-04-02T06:14:10.443378Z","steps":["trace[987319821] 'read index received' (duration: 228.677066ms)","trace[987319821] 'applied index is now lower than readState.Index' (duration: 1.2836ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:14:10.444086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.43393ms","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-02T06:14:10.444086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.917065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-02T06:14:10.443634Z","caller":"traceutil/trace.go:171","msg":"trace[222883280] transaction","detail":"{read_only:false; response_revision:1695; number_of_response:1; }","duration":"257.314296ms","start":"2026-04-02T06:14:10.186235Z","end":"2026-04-02T06:14:10.443549Z","steps":["trace[222883280] 'process raft request' (duration: 257.078911ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:14:10.444271Z","caller":"traceutil/trace.go:171","msg":"trace[261006025] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1695; }","duration":"230.122991ms","start":"2026-04-02T06:14:10.214124Z","end":"2026-04-02T06:14:10.444247Z","steps":["trace[261006025] 'agreement among raft nodes before linearized reading' (duration: 229.842884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:14:10.444351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.419208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-02T06:14:10.444443Z","caller":"traceutil/trace.go:171","msg":"trace[311356574] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1695; }","duration":"230.813847ms","start":"2026-04-02T06:14:10.213609Z","end":"2026-04-02T06:14:10.444423Z","steps":["trace[311356574] 'agreement among raft nodes before linearized reading' (duration: 230.309455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:14:10.444193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.462899ms","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-02T06:14:10.444503Z","caller":"traceutil/trace.go:171","msg":"trace[1791129014] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1695; }","duration":"231.146514ms","start":"2026-04-02T06:14:10.213345Z","end":"2026-04-02T06:14:10.444491Z","steps":["trace[1791129014] 'agreement among raft nodes before linearized reading' (duration: 230.216262ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:14:10.444155Z","caller":"traceutil/trace.go:171","msg":"trace[1312930327] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1695; }","duration":"154.542193ms","start":"2026-04-02T06:14:10.289595Z","end":"2026-04-02T06:14:10.444138Z","steps":["trace[1312930327] 'agreement among raft nodes before linearized reading' (duration: 154.344518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:14:11.556989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.917378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-04-02T06:14:11.557111Z","caller":"traceutil/trace.go:171","msg":"trace[982556850] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1699; }","duration":"234.063902ms","start":"2026-04-02T06:14:11.323002Z","end":"2026-04-02T06:14:11.557066Z","steps":["trace[982556850] 'range keys from in-memory index tree' (duration: 233.673463ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:16:17.114678Z","caller":"traceutil/trace.go:171","msg":"trace[104595023] linearizableReadLoop","detail":"{readStateIndex:2403; appliedIndex:2402; }","duration":"266.761328ms","start":"2026-04-02T06:16:16.847893Z","end":"2026-04-02T06:16:17.114655Z","steps":["trace[104595023] 'read index received' (duration: 266.541013ms)","trace[104595023] 'applied index is now lower than readState.Index' (duration: 219.455µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:16:17.115084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.147937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-04-02T06:16:17.11518Z","caller":"traceutil/trace.go:171","msg":"trace[1852344086] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2303; }","duration":"267.307401ms","start":"2026-04-02T06:16:16.847853Z","end":"2026-04-02T06:16:17.11516Z","steps":["trace[1852344086] 'agreement among raft nodes before linearized reading' (duration: 266.977873ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:16:17.115083Z","caller":"traceutil/trace.go:171","msg":"trace[810426241] transaction","detail":"{read_only:false; response_revision:2303; number_of_response:1; }","duration":"343.819094ms","start":"2026-04-02T06:16:16.771226Z","end":"2026-04-02T06:16:17.115046Z","steps":["trace[810426241] 'process raft request' (duration: 343.295292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:16:17.115479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:16:16.771208Z","time spent":"344.185352ms","remote":"127.0.0.1:53256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:16:17.286796Z","caller":"traceutil/trace.go:171","msg":"trace[287418417] transaction","detail":"{read_only:false; response_revision:2304; number_of_response:1; }","duration":"167.003537ms","start":"2026-04-02T06:16:17.119766Z","end":"2026-04-02T06:16:17.28677Z","steps":["trace[287418417] 'process raft request' (duration: 110.545516ms)","trace[287418417] 'compare' (duration: 56.353359ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:16:17.304246Z","caller":"traceutil/trace.go:171","msg":"trace[853291754] transaction","detail":"{read_only:false; response_revision:2310; number_of_response:1; }","duration":"182.137204ms","start":"2026-04-02T06:16:17.12209Z","end":"2026-04-02T06:16:17.304227Z","steps":["trace[853291754] 'process raft request' (duration: 182.104343ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:16:17.304424Z","caller":"traceutil/trace.go:171","msg":"trace[1514348166] transaction","detail":"{read_only:false; response_revision:2306; number_of_response:1; }","duration":"184.593022ms","start":"2026-04-02T06:16:17.119812Z","end":"2026-04-02T06:16:17.304405Z","steps":["trace[1514348166] 'process raft request' (duration: 184.233283ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:16:17.304617Z","caller":"traceutil/trace.go:171","msg":"trace[368414381] transaction","detail":"{read_only:false; response_revision:2309; number_of_response:1; }","duration":"183.000464ms","start":"2026-04-02T06:16:17.121586Z","end":"2026-04-02T06:16:17.304586Z","steps":["trace[368414381] 'process raft request' (duration: 182.553323ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:16:17.30453Z","caller":"traceutil/trace.go:171","msg":"trace[2110935046] transaction","detail":"{read_only:false; response_revision:2305; number_of_response:1; }","duration":"184.720584ms","start":"2026-04-02T06:16:17.119786Z","end":"2026-04-02T06:16:17.304506Z","steps":["trace[2110935046] 'process raft request' (duration: 184.11891ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:16:17.304562Z","caller":"traceutil/trace.go:171","msg":"trace[1693094941] transaction","detail":"{read_only:false; response_revision:2307; number_of_response:1; }","duration":"184.684693ms","start":"2026-04-02T06:16:17.119872Z","end":"2026-04-02T06:16:17.304556Z","steps":["trace[1693094941] 'process raft request' (duration: 184.211662ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:16:17.305135Z","caller":"traceutil/trace.go:171","msg":"trace[1007573734] transaction","detail":"{read_only:false; response_revision:2308; number_of_response:1; }","duration":"185.179346ms","start":"2026-04-02T06:16:17.119938Z","end":"2026-04-02T06:16:17.305117Z","steps":["trace[1007573734] 'process raft request' (duration: 184.171422ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:16:43.507861Z","caller":"traceutil/trace.go:171","msg":"trace[528957930] linearizableReadLoop","detail":"{readStateIndex:2537; appliedIndex:2536; }","duration":"115.560414ms","start":"2026-04-02T06:16:43.392273Z","end":"2026-04-02T06:16:43.507834Z","steps":["trace[528957930] 'read index received' (duration: 115.369009ms)","trace[528957930] 'applied index is now lower than readState.Index' (duration: 190.535µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:16:43.507907Z","caller":"traceutil/trace.go:171","msg":"trace[776187390] transaction","detail":"{read_only:false; response_revision:2431; number_of_response:1; }","duration":"144.889324ms","start":"2026-04-02T06:16:43.362983Z","end":"2026-04-02T06:16:43.507872Z","steps":["trace[776187390] 'process raft request' (duration: 144.71472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:16:43.508074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.783929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/csi-rbd-secret\" ","response":"range_response_count:1 size:880"} {"level":"info","ts":"2026-04-02T06:16:43.508127Z","caller":"traceutil/trace.go:171","msg":"trace[302534613] range","detail":"{range_begin:/registry/secrets/kube-system/csi-rbd-secret; range_end:; response_count:1; response_revision:2431; }","duration":"115.879081ms","start":"2026-04-02T06:16:43.392234Z","end":"2026-04-02T06:16:43.508113Z","steps":["trace[302534613] 'agreement among raft nodes before linearized reading' (duration: 115.704077ms)"],"step_count":1}