{"level":"warn","ts":"2026-04-28T03:24:38.40768Z","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-28T03:24:38.407768Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.33:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.33:2380","--initial-cluster=instance=https://199.204.45.33:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.33:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.33:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-28T03:24:38.407836Z","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-28T03:24:38.407845Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-04-28T03:24:38.407861Z","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-28T03:24:38.408509Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"]} {"level":"info","ts":"2026-04-28T03:24:38.408611Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.33:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-28T03:24:38.413528Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.707625ms"} {"level":"info","ts":"2026-04-28T03:24:38.425106Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e5729930cf7e1f","cluster-id":"14aeb8c3ec66b749"} {"level":"info","ts":"2026-04-28T03:24:38.425184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=()"} {"level":"info","ts":"2026-04-28T03:24:38.425213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 0"} {"level":"info","ts":"2026-04-28T03:24:38.425226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e5729930cf7e1f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-28T03:24:38.425245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 1"} {"level":"info","ts":"2026-04-28T03:24:38.425286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"warn","ts":"2026-04-28T03:24:38.433987Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-28T03:24:38.43551Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-28T03:24:38.437233Z","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-28T03:24:38.440092Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e5729930cf7e1f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-28T03:24:38.441134Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e5729930cf7e1f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-28T03:24:38.446105Z","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-28T03:24:38.446768Z","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-28T03:24:38.446901Z","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-28T03:24:38.447699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"info","ts":"2026-04-28T03:24:38.447867Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","added-peer-id":"f1e5729930cf7e1f","added-peer-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-04-28T03:24:38.451136Z","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-28T03:24:38.451265Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-04-28T03:24:38.451408Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-04-28T03:24:38.451784Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e5729930cf7e1f","initial-advertise-peer-urls":["https://199.204.45.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-28T03:24:38.451855Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-28T03:24:39.326077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f is starting a new election at term 1"} {"level":"info","ts":"2026-04-28T03:24:39.326148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became pre-candidate at term 1"} {"level":"info","ts":"2026-04-28T03:24:39.326202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgPreVoteResp from f1e5729930cf7e1f at term 1"} {"level":"info","ts":"2026-04-28T03:24:39.326225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became candidate at term 2"} {"level":"info","ts":"2026-04-28T03:24:39.326247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgVoteResp from f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-04-28T03:24:39.326263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became leader at term 2"} {"level":"info","ts":"2026-04-28T03:24:39.32628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e5729930cf7e1f elected leader f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-04-28T03:24:39.327832Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e5729930cf7e1f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.33:2379]}","request-path":"/0/members/f1e5729930cf7e1f/attributes","cluster-id":"14aeb8c3ec66b749","publish-timeout":"7s"} {"level":"info","ts":"2026-04-28T03:24:39.327858Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T03:24:39.32793Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T03:24:39.327939Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T03:24:39.328221Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-28T03:24:39.328278Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-28T03:24:39.329127Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T03:24:39.329397Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T03:24:39.329453Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T03:24:39.331577Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.33:2379"} {"level":"info","ts":"2026-04-28T03:24:39.332135Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-28T03:24:49.165154Z","caller":"traceutil/trace.go:171","msg":"trace[1475697292] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:317; }","duration":"211.17218ms","start":"2026-04-28T03:24:48.953957Z","end":"2026-04-28T03:24:49.16513Z","steps":["trace[1475697292] 'read index received' (duration: 199.254405ms)","trace[1475697292] 'applied index is now lower than readState.Index' (duration: 11.916635ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:24:49.165187Z","caller":"traceutil/trace.go:171","msg":"trace[1519279604] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"233.074159ms","start":"2026-04-28T03:24:48.93209Z","end":"2026-04-28T03:24:49.165164Z","steps":["trace[1519279604] 'process raft request' (duration: 221.193124ms)","trace[1519279604] 'compare' (duration: 11.725551ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:24:49.165396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.428325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-28T03:24:49.165466Z","caller":"traceutil/trace.go:171","msg":"trace[1428396931] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:307; }","duration":"211.552038ms","start":"2026-04-28T03:24:48.953901Z","end":"2026-04-28T03:24:49.165453Z","steps":["trace[1428396931] 'agreement among raft nodes before linearized reading' (duration: 211.362454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:24:49.165481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.794166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-28T03:24:49.165525Z","caller":"traceutil/trace.go:171","msg":"trace[1788947008] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:307; }","duration":"160.872197ms","start":"2026-04-28T03:24:49.004638Z","end":"2026-04-28T03:24:49.165511Z","steps":["trace[1788947008] 'agreement among raft nodes before linearized reading' (duration: 160.786506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:24:49.165704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.036686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-28T03:24:49.165735Z","caller":"traceutil/trace.go:171","msg":"trace[1962680836] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:307; }","duration":"111.110067ms","start":"2026-04-28T03:24:49.054613Z","end":"2026-04-28T03:24:49.165724Z","steps":["trace[1962680836] 'agreement among raft nodes before linearized reading' (duration: 111.063466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:24:49.165825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.383144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-28T03:24:49.165866Z","caller":"traceutil/trace.go:171","msg":"trace[581012842] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:307; }","duration":"137.443115ms","start":"2026-04-28T03:24:49.028414Z","end":"2026-04-28T03:24:49.165857Z","steps":["trace[581012842] 'agreement among raft nodes before linearized reading' (duration: 137.349833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:24:49.165995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.049321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-28T03:24:49.166061Z","caller":"traceutil/trace.go:171","msg":"trace[1444376752] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:307; }","duration":"156.135823ms","start":"2026-04-28T03:24:49.009911Z","end":"2026-04-28T03:24:49.166047Z","steps":["trace[1444376752] 'agreement among raft nodes before linearized reading' (duration: 155.98961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:24:55.498322Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088156098829917265,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T03:24:55.507724Z","caller":"traceutil/trace.go:171","msg":"trace[1220458132] linearizableReadLoop","detail":"{readStateIndex:383; appliedIndex:382; }","duration":"510.001166ms","start":"2026-04-28T03:24:54.997696Z","end":"2026-04-28T03:24:55.507698Z","steps":["trace[1220458132] 'read index received' (duration: 509.821392ms)","trace[1220458132] 'applied index is now lower than readState.Index' (duration: 178.554µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:24:55.507821Z","caller":"traceutil/trace.go:171","msg":"trace[837824080] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"652.73835ms","start":"2026-04-28T03:24:54.855051Z","end":"2026-04-28T03:24:55.507789Z","steps":["trace[837824080] 'process raft request' (duration: 652.449204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:24:55.507981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.258932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:24:55.50806Z","caller":"traceutil/trace.go:171","msg":"trace[828149614] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:370; }","duration":"510.399055ms","start":"2026-04-28T03:24:54.997645Z","end":"2026-04-28T03:24:55.508044Z","steps":["trace[828149614] 'agreement among raft nodes before linearized reading' (duration: 510.220251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:24:55.507992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.340318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-28T03:24:55.508104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:24:54.997621Z","time spent":"510.477146ms","remote":"127.0.0.1:60834","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-28T03:24:55.50818Z","caller":"traceutil/trace.go:171","msg":"trace[1581310827] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:370; }","duration":"308.578393ms","start":"2026-04-28T03:24:55.199585Z","end":"2026-04-28T03:24:55.508164Z","steps":["trace[1581310827] 'agreement among raft nodes before linearized reading' (duration: 308.296547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:24:55.508231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:24:55.199563Z","time spent":"308.656076ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T03:24:55.508689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:24:54.855039Z","time spent":"652.971645ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:24:56.735751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.921352ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T03:24:56.73588Z","caller":"traceutil/trace.go:171","msg":"trace[1773897016] linearizableReadLoop","detail":"{readStateIndex:384; appliedIndex:383; }","duration":"1.219803379s","start":"2026-04-28T03:24:55.516057Z","end":"2026-04-28T03:24:56.73586Z","steps":["trace[1773897016] 'read index received' (duration: 268.473268ms)","trace[1773897016] 'applied index is now lower than readState.Index' (duration: 951.328121ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:24:56.736017Z","caller":"traceutil/trace.go:171","msg":"trace[500565037] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"1.222033208s","start":"2026-04-28T03:24:55.513972Z","end":"2026-04-28T03:24:56.736005Z","steps":["trace[500565037] 'process raft request' (duration: 270.576654ms)","trace[500565037] 'compare' (duration: 950.657056ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:24:56.736085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:24:55.513957Z","time spent":"1.222103709s","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:24:56.736125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.220036055s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:24:56.736222Z","caller":"traceutil/trace.go:171","msg":"trace[426153919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:371; }","duration":"1.220186957s","start":"2026-04-28T03:24:55.516011Z","end":"2026-04-28T03:24:56.736198Z","steps":["trace[426153919] 'agreement among raft nodes before linearized reading' (duration: 1.220010383s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:24:56.736268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:24:55.515996Z","time spent":"1.22026492s","remote":"127.0.0.1:60844","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-28T03:24:57.236168Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088156098829917272,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T03:24:57.557081Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.772501077s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T03:24:57.557528Z","caller":"traceutil/trace.go:171","msg":"trace[725300128] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:384; }","duration":"821.592946ms","start":"2026-04-28T03:24:56.735911Z","end":"2026-04-28T03:24:57.557504Z","steps":["trace[725300128] 'read index received' (duration: 821.34989ms)","trace[725300128] 'applied index is now lower than readState.Index' (duration: 241.826µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:24:57.557641Z","caller":"traceutil/trace.go:171","msg":"trace[976867029] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"2.036097597s","start":"2026-04-28T03:24:55.521532Z","end":"2026-04-28T03:24:57.55763Z","steps":["trace[976867029] 'process raft request' (duration: 2.035836791s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:24:57.557752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:24:55.521518Z","time spent":"2.036155869s","remote":"127.0.0.1:39722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7279,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:24:57.557963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.283845456s","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-28T03:24:57.557963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.117426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:24:57.558017Z","caller":"traceutil/trace.go:171","msg":"trace[43579340] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:372; }","duration":"1.28397469s","start":"2026-04-28T03:24:56.274026Z","end":"2026-04-28T03:24:57.558001Z","steps":["trace[43579340] 'agreement among raft nodes before linearized reading' (duration: 1.283868167s)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:24:57.558031Z","caller":"traceutil/trace.go:171","msg":"trace[520725929] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:372; }","duration":"812.188287ms","start":"2026-04-28T03:24:56.745826Z","end":"2026-04-28T03:24:57.558014Z","steps":["trace[520725929] 'agreement among raft nodes before linearized reading' (duration: 812.083825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:24:57.558057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:24:56.273987Z","time spent":"1.284061982s","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T03:24:57.558071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:24:56.74578Z","time spent":"812.282289ms","remote":"127.0.0.1:60834","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-28T03:24:57.558228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.346512345s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-28T03:24:57.558269Z","caller":"traceutil/trace.go:171","msg":"trace[668799331] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:372; }","duration":"1.346591155s","start":"2026-04-28T03:24:56.211666Z","end":"2026-04-28T03:24:57.558257Z","steps":["trace[668799331] 'agreement among raft nodes before linearized reading' (duration: 1.346532494s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:24:57.558296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:24:56.211641Z","time spent":"1.346648577s","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T03:24:57.558496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.921737356s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"} {"level":"info","ts":"2026-04-28T03:24:57.558597Z","caller":"traceutil/trace.go:171","msg":"trace[1152659909] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:372; }","duration":"1.92192901s","start":"2026-04-28T03:24:55.636597Z","end":"2026-04-28T03:24:57.558526Z","steps":["trace[1152659909] 'agreement among raft nodes before linearized reading' (duration: 1.921266186s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:24:57.55863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:24:55.636568Z","time spent":"1.922053632s","remote":"127.0.0.1:40034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4079,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-04-28T03:25:11.92767Z","caller":"traceutil/trace.go:171","msg":"trace[1476502368] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"644.22739ms","start":"2026-04-28T03:25:11.283418Z","end":"2026-04-28T03:25:11.927645Z","steps":["trace[1476502368] 'process raft request' (duration: 644.104337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:11.92784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.283395Z","time spent":"644.356693ms","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T03:25:12.111357Z","caller":"traceutil/trace.go:171","msg":"trace[1361983778] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"827.590539ms","start":"2026-04-28T03:25:11.283729Z","end":"2026-04-28T03:25:12.111319Z","steps":["trace[1361983778] 'process raft request' (duration: 827.407075ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:12.111417Z","caller":"traceutil/trace.go:171","msg":"trace[1404570506] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"814.742743ms","start":"2026-04-28T03:25:11.296631Z","end":"2026-04-28T03:25:12.111374Z","steps":["trace[1404570506] 'process raft request' (duration: 814.637271ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:12.111456Z","caller":"traceutil/trace.go:171","msg":"trace[1390462181] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"788.216141ms","start":"2026-04-28T03:25:11.323201Z","end":"2026-04-28T03:25:12.111417Z","steps":["trace[1390462181] 'process raft request' (duration: 788.108999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:12.111512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.283699Z","time spent":"827.738823ms","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T03:25:12.111574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.323183Z","time spent":"788.330923ms","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T03:25:12.111544Z","caller":"traceutil/trace.go:171","msg":"trace[2010112468] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"778.473395ms","start":"2026-04-28T03:25:11.333018Z","end":"2026-04-28T03:25:12.111492Z","steps":["trace[2010112468] 'process raft request' (duration: 778.365083ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:12.111563Z","caller":"traceutil/trace.go:171","msg":"trace[324169876] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"776.990612ms","start":"2026-04-28T03:25:11.334524Z","end":"2026-04-28T03:25:12.111515Z","steps":["trace[324169876] 'process raft request' (duration: 776.888359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:12.111617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.296613Z","time spent":"814.891577ms","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T03:25:12.111645Z","caller":"traceutil/trace.go:171","msg":"trace[132229273] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"774.881664ms","start":"2026-04-28T03:25:11.336753Z","end":"2026-04-28T03:25:12.111635Z","steps":["trace[132229273] 'process raft request' (duration: 774.69238ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:12.111667Z","caller":"traceutil/trace.go:171","msg":"trace[678231327] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"767.131971ms","start":"2026-04-28T03:25:11.344529Z","end":"2026-04-28T03:25:12.111661Z","steps":["trace[678231327] 'process raft request' (duration: 766.949467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:12.111695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.336747Z","time spent":"774.921935ms","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T03:25:12.111702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.344522Z","time spent":"767.160251ms","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T03:25:12.111712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.333009Z","time spent":"778.617888ms","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T03:25:12.112133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.334516Z","time spent":"777.125874ms","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T03:25:12.113912Z","caller":"traceutil/trace.go:171","msg":"trace[1315190218] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"780.427437ms","start":"2026-04-28T03:25:11.331315Z","end":"2026-04-28T03:25:12.111742Z","steps":["trace[1315190218] 'process raft request' (duration: 780.034239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:12.114095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.331309Z","time spent":"782.737869ms","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T03:25:12.114326Z","caller":"traceutil/trace.go:171","msg":"trace[1467821350] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"765.984186ms","start":"2026-04-28T03:25:11.345762Z","end":"2026-04-28T03:25:12.111746Z","steps":["trace[1467821350] 'process raft request' (duration: 765.781871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:12.114388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.345756Z","time spent":"768.595894ms","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T03:25:12.115631Z","caller":"traceutil/trace.go:171","msg":"trace[1841843092] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"750.816637ms","start":"2026-04-28T03:25:11.364789Z","end":"2026-04-28T03:25:12.115605Z","steps":["trace[1841843092] 'process raft request' (duration: 746.838898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:12.115734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.364759Z","time spent":"750.92063ms","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T03:25:12.118809Z","caller":"traceutil/trace.go:171","msg":"trace[795274215] linearizableReadLoop","detail":"{readStateIndex:497; appliedIndex:486; }","duration":"471.308593ms","start":"2026-04-28T03:25:11.647453Z","end":"2026-04-28T03:25:12.118761Z","steps":["trace[795274215] 'read index received' (duration: 280.504767ms)","trace[795274215] 'applied index is now lower than readState.Index' (duration: 189.926576ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:25:12.118964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.510857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T03:25:12.119Z","caller":"traceutil/trace.go:171","msg":"trace[132539486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:482; }","duration":"471.598559ms","start":"2026-04-28T03:25:11.647394Z","end":"2026-04-28T03:25:12.118992Z","steps":["trace[132539486] 'agreement among raft nodes before linearized reading' (duration: 470.492904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:12.119024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.647372Z","time spent":"471.6469ms","remote":"127.0.0.1:39800","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-28T03:25:12.119285Z","caller":"traceutil/trace.go:171","msg":"trace[2143324917] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"289.60213ms","start":"2026-04-28T03:25:11.829675Z","end":"2026-04-28T03:25:12.119277Z","steps":["trace[2143324917] 'process raft request' (duration: 288.092187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:12.119505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.188961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-28T03:25:12.119525Z","caller":"traceutil/trace.go:171","msg":"trace[1770658180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:483; }","duration":"467.233012ms","start":"2026-04-28T03:25:11.652285Z","end":"2026-04-28T03:25:12.119518Z","steps":["trace[1770658180] 'agreement among raft nodes before linearized reading' (duration: 467.186351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:12.11959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.652273Z","time spent":"467.263703ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-28T03:25:12.120003Z","caller":"traceutil/trace.go:171","msg":"trace[1544840416] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"184.866954ms","start":"2026-04-28T03:25:11.935034Z","end":"2026-04-28T03:25:12.119901Z","steps":["trace[1544840416] 'process raft request' (duration: 184.340272ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:12.120828Z","caller":"traceutil/trace.go:171","msg":"trace[875216997] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"651.607915ms","start":"2026-04-28T03:25:11.466266Z","end":"2026-04-28T03:25:12.117874Z","steps":["trace[875216997] 'process raft request' (duration: 649.966238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:12.121124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.466229Z","time spent":"654.819787ms","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T03:25:12.121261Z","caller":"traceutil/trace.go:171","msg":"trace[231341742] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"183.34152ms","start":"2026-04-28T03:25:11.934524Z","end":"2026-04-28T03:25:12.117866Z","steps":["trace[231341742] 'process raft request' (duration: 183.299439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:12.121533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.616393ms","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-28T03:25:12.121555Z","caller":"traceutil/trace.go:171","msg":"trace[2043857771] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:483; }","duration":"468.680304ms","start":"2026-04-28T03:25:11.652868Z","end":"2026-04-28T03:25:12.121548Z","steps":["trace[2043857771] 'agreement among raft nodes before linearized reading' (duration: 468.636473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:12.121585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:11.652835Z","time spent":"468.729515ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-28T03:25:12.122616Z","caller":"traceutil/trace.go:171","msg":"trace[1620786094] transaction","detail":"{read_only:false; number_of_response:1; response_revision:483; }","duration":"183.997983ms","start":"2026-04-28T03:25:11.935694Z","end":"2026-04-28T03:25:12.119692Z","steps":["trace[1620786094] 'process raft request' (duration: 183.749678ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:18.489486Z","caller":"traceutil/trace.go:171","msg":"trace[164434044] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"192.452234ms","start":"2026-04-28T03:25:18.297009Z","end":"2026-04-28T03:25:18.489461Z","steps":["trace[164434044] 'process raft request' (duration: 192.080106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:18.686105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.055262ms","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-28T03:25:18.686186Z","caller":"traceutil/trace.go:171","msg":"trace[532648604] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:581; }","duration":"110.201385ms","start":"2026-04-28T03:25:18.575968Z","end":"2026-04-28T03:25:18.68617Z","steps":["trace[532648604] 'count revisions from in-memory index tree' (duration: 110.010061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:18.68636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.010353ms","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-28T03:25:18.686424Z","caller":"traceutil/trace.go:171","msg":"trace[1025161269] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:581; }","duration":"111.098045ms","start":"2026-04-28T03:25:18.57531Z","end":"2026-04-28T03:25:18.686408Z","steps":["trace[1025161269] 'range keys from in-memory index tree' (duration: 110.947762ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:19.181221Z","caller":"traceutil/trace.go:171","msg":"trace[701704894] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"409.53931ms","start":"2026-04-28T03:25:18.771653Z","end":"2026-04-28T03:25:19.181192Z","steps":["trace[701704894] 'read index received' (duration: 408.438536ms)","trace[701704894] 'applied index is now lower than readState.Index' (duration: 1.099384ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:25:19.18144Z","caller":"traceutil/trace.go:171","msg":"trace[1091755340] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"570.533326ms","start":"2026-04-28T03:25:18.610867Z","end":"2026-04-28T03:25:19.181401Z","steps":["trace[1091755340] 'process raft request' (duration: 569.436322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.185355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.610833Z","time spent":"574.341972ms","remote":"127.0.0.1:39648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:25:19.185887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.112983ms","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-28T03:25:19.185999Z","caller":"traceutil/trace.go:171","msg":"trace[1778601333] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:582; }","duration":"414.246976ms","start":"2026-04-28T03:25:18.771707Z","end":"2026-04-28T03:25:19.185954Z","steps":["trace[1778601333] 'agreement among raft nodes before linearized reading' (duration: 414.087523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.186065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.771684Z","time spent":"414.362228ms","remote":"127.0.0.1:38674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:25:19.187401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.164153ms","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-28T03:25:19.187467Z","caller":"traceutil/trace.go:171","msg":"trace[1028556490] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"158.277875ms","start":"2026-04-28T03:25:19.029171Z","end":"2026-04-28T03:25:19.187449Z","steps":["trace[1028556490] 'agreement among raft nodes before linearized reading' (duration: 158.166963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.18768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.531101ms","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-28T03:25:19.187723Z","caller":"traceutil/trace.go:171","msg":"trace[1858070897] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"158.593552ms","start":"2026-04-28T03:25:19.029116Z","end":"2026-04-28T03:25:19.18771Z","steps":["trace[1858070897] 'agreement among raft nodes before linearized reading' (duration: 158.52146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.187947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.928769ms","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-28T03:25:19.187981Z","caller":"traceutil/trace.go:171","msg":"trace[222377977] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"159.002891ms","start":"2026-04-28T03:25:19.028968Z","end":"2026-04-28T03:25:19.187971Z","steps":["trace[222377977] 'agreement among raft nodes before linearized reading' (duration: 158.933089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.188182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.130013ms","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-28T03:25:19.188359Z","caller":"traceutil/trace.go:171","msg":"trace[1347218620] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:582; }","duration":"341.322677ms","start":"2026-04-28T03:25:18.846948Z","end":"2026-04-28T03:25:19.188271Z","steps":["trace[1347218620] 'agreement among raft nodes before linearized reading' (duration: 341.02268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.188395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.596371ms","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-28T03:25:19.188429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.500758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T03:25:19.188449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.846934Z","time spent":"341.496022ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:25:19.188542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.832376ms","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":"info","ts":"2026-04-28T03:25:19.188597Z","caller":"traceutil/trace.go:171","msg":"trace[1807001172] 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:582; }","duration":"368.624851ms","start":"2026-04-28T03:25:18.819885Z","end":"2026-04-28T03:25:19.18851Z","steps":["trace[1807001172] 'agreement among raft nodes before linearized reading' (duration: 368.18792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.188652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.819881Z","time spent":"368.755033ms","remote":"127.0.0.1:38698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-28T03:25:19.188468Z","caller":"traceutil/trace.go:171","msg":"trace[515299277] 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:582; }","duration":"368.696553ms","start":"2026-04-28T03:25:18.819738Z","end":"2026-04-28T03:25:19.188435Z","steps":["trace[515299277] 'agreement among raft nodes before linearized reading' (duration: 368.588341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.188686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.81728ms","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":"warn","ts":"2026-04-28T03:25:19.188763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.819717Z","time spent":"369.02739ms","remote":"127.0.0.1:38698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-28T03:25:19.188787Z","caller":"traceutil/trace.go:171","msg":"trace[1698492581] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:582; }","duration":"390.946193ms","start":"2026-04-28T03:25:18.797809Z","end":"2026-04-28T03:25:19.188755Z","steps":["trace[1698492581] 'agreement among raft nodes before linearized reading' (duration: 390.775139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.188902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.031967ms","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-28T03:25:19.188928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.797797Z","time spent":"391.108316ms","remote":"127.0.0.1:38686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:25:19.188936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.560857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:25:19.188966Z","caller":"traceutil/trace.go:171","msg":"trace[401370713] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:582; }","duration":"254.097028ms","start":"2026-04-28T03:25:18.934842Z","end":"2026-04-28T03:25:19.188939Z","steps":["trace[401370713] 'agreement among raft nodes before linearized reading' (duration: 254.021426ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:19.188982Z","caller":"traceutil/trace.go:171","msg":"trace[815956606] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:582; }","duration":"306.633459ms","start":"2026-04-28T03:25:18.882334Z","end":"2026-04-28T03:25:19.188967Z","steps":["trace[815956606] 'agreement among raft nodes before linearized reading' (duration: 306.546487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.189021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.882326Z","time spent":"306.68492ms","remote":"127.0.0.1:38718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:25:19.189089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.435396ms","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-28T03:25:19.189182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.598055ms","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-28T03:25:19.189217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.398809ms","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-28T03:25:19.189222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.525298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-28T03:25:19.189349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.356781ms","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-28T03:25:19.189396Z","caller":"traceutil/trace.go:171","msg":"trace[621792878] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:582; }","duration":"391.450204ms","start":"2026-04-28T03:25:18.797925Z","end":"2026-04-28T03:25:19.189375Z","steps":["trace[621792878] 'agreement among raft nodes before linearized reading' (duration: 391.367572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.189403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.668495ms","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-28T03:25:19.189401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.110796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T03:25:19.189449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.797906Z","time spent":"391.533175ms","remote":"127.0.0.1:38686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-28T03:25:19.189464Z","caller":"traceutil/trace.go:171","msg":"trace[34816755] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"199.734386ms","start":"2026-04-28T03:25:18.989706Z","end":"2026-04-28T03:25:19.18944Z","steps":["trace[34816755] 'agreement among raft nodes before linearized reading' (duration: 199.613954ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:19.189471Z","caller":"traceutil/trace.go:171","msg":"trace[1870313311] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:582; }","duration":"306.212809ms","start":"2026-04-28T03:25:18.883243Z","end":"2026-04-28T03:25:19.189456Z","steps":["trace[1870313311] 'agreement among raft nodes before linearized reading' (duration: 306.096356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.189517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.883209Z","time spent":"306.28836ms","remote":"127.0.0.1:38718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-28T03:25:19.18949Z","caller":"traceutil/trace.go:171","msg":"trace[1753667115] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"307.647171ms","start":"2026-04-28T03:25:18.881669Z","end":"2026-04-28T03:25:19.189316Z","steps":["trace[1753667115] 'agreement among raft nodes before linearized reading' (duration: 307.304404ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:19.1886Z","caller":"traceutil/trace.go:171","msg":"trace[1549928009] 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:582; }","duration":"368.900847ms","start":"2026-04-28T03:25:18.819676Z","end":"2026-04-28T03:25:19.188577Z","steps":["trace[1549928009] 'agreement among raft nodes before linearized reading' (duration: 368.820705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.189611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.88163Z","time spent":"307.940878ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T03:25:19.189837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.827119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:25:19.18989Z","caller":"traceutil/trace.go:171","msg":"trace[297662198] 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:582; }","duration":"284.88535ms","start":"2026-04-28T03:25:18.90499Z","end":"2026-04-28T03:25:19.189876Z","steps":["trace[297662198] 'agreement among raft nodes before linearized reading' (duration: 284.813368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.189915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.865309ms","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":"warn","ts":"2026-04-28T03:25:19.190021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.036796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T03:25:19.189611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.819666Z","time spent":"369.93013ms","remote":"127.0.0.1:38698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-28T03:25:19.19007Z","caller":"traceutil/trace.go:171","msg":"trace[1940052710] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:582; }","duration":"343.097077ms","start":"2026-04-28T03:25:18.846953Z","end":"2026-04-28T03:25:19.19005Z","steps":["trace[1940052710] 'agreement among raft nodes before linearized reading' (duration: 343.022885ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:19.190017Z","caller":"traceutil/trace.go:171","msg":"trace[1318590579] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:582; }","duration":"341.987692ms","start":"2026-04-28T03:25:18.848005Z","end":"2026-04-28T03:25:19.189993Z","steps":["trace[1318590579] 'agreement among raft nodes before linearized reading' (duration: 341.86057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.190105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.846941Z","time spent":"343.154668ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T03:25:19.188681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.061274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T03:25:19.190204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.847994Z","time spent":"342.193497ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"info","ts":"2026-04-28T03:25:19.189254Z","caller":"traceutil/trace.go:171","msg":"trace[867367456] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:582; }","duration":"390.691057ms","start":"2026-04-28T03:25:18.798549Z","end":"2026-04-28T03:25:19.18924Z","steps":["trace[867367456] 'agreement among raft nodes before linearized reading' (duration: 390.589475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.190399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.798539Z","time spent":"391.828082ms","remote":"127.0.0.1:38686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"info","ts":"2026-04-28T03:25:19.189272Z","caller":"traceutil/trace.go:171","msg":"trace[1356879820] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"199.45819ms","start":"2026-04-28T03:25:18.989788Z","end":"2026-04-28T03:25:19.189246Z","steps":["trace[1356879820] 'agreement among raft nodes before linearized reading' (duration: 199.378608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.189271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.820403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:25:19.190607Z","caller":"traceutil/trace.go:171","msg":"trace[828170662] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:582; }","duration":"308.195724ms","start":"2026-04-28T03:25:18.882398Z","end":"2026-04-28T03:25:19.190593Z","steps":["trace[828170662] 'agreement among raft nodes before linearized reading' (duration: 306.818073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.190649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.882384Z","time spent":"308.253445ms","remote":"127.0.0.1:38718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-28T03:25:19.190657Z","caller":"traceutil/trace.go:171","msg":"trace[2114238311] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:582; }","duration":"416.621598ms","start":"2026-04-28T03:25:18.773587Z","end":"2026-04-28T03:25:19.190209Z","steps":["trace[2114238311] 'agreement among raft nodes before linearized reading' (duration: 415.035593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.188718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.706174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T03:25:19.190732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.773557Z","time spent":"417.159722ms","remote":"127.0.0.1:38674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"info","ts":"2026-04-28T03:25:19.190732Z","caller":"traceutil/trace.go:171","msg":"trace[319066349] 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:582; }","duration":"285.940104ms","start":"2026-04-28T03:25:18.904777Z","end":"2026-04-28T03:25:19.190717Z","steps":["trace[319066349] 'agreement among raft nodes before linearized reading' (duration: 283.305884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.189256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.477421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:25:19.191254Z","caller":"traceutil/trace.go:171","msg":"trace[807186719] 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:582; }","duration":"286.519317ms","start":"2026-04-28T03:25:18.904719Z","end":"2026-04-28T03:25:19.191239Z","steps":["trace[807186719] 'agreement among raft nodes before linearized reading' (duration: 284.479121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.191655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.569256ms","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-28T03:25:19.191722Z","caller":"traceutil/trace.go:171","msg":"trace[165192702] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:582; }","duration":"257.645268ms","start":"2026-04-28T03:25:18.93405Z","end":"2026-04-28T03:25:19.191695Z","steps":["trace[165192702] 'agreement among raft nodes before linearized reading' (duration: 255.364157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.192446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.778062ms","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-28T03:25:19.192676Z","caller":"traceutil/trace.go:171","msg":"trace[154131096] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:582; }","duration":"421.048909ms","start":"2026-04-28T03:25:18.771608Z","end":"2026-04-28T03:25:19.192657Z","steps":["trace[154131096] 'agreement among raft nodes before linearized reading' (duration: 409.828656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.192713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:18.771592Z","time spent":"421.103919ms","remote":"127.0.0.1:38674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"info","ts":"2026-04-28T03:25:19.189367Z","caller":"traceutil/trace.go:171","msg":"trace[3921522] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:582; }","duration":"254.726612ms","start":"2026-04-28T03:25:18.934441Z","end":"2026-04-28T03:25:19.189167Z","steps":["trace[3921522] 'agreement among raft nodes before linearized reading' (duration: 254.432936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:19.79478Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088156098829917658,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T03:25:20.295387Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088156098829917658,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T03:25:20.299072Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.039566131s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-28T03:25:20.674218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.199544886s","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-28T03:25:20.674325Z","caller":"traceutil/trace.go:171","msg":"trace[982675541] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:583; }","duration":"1.199666019s","start":"2026-04-28T03:25:19.474642Z","end":"2026-04-28T03:25:20.6743Z","steps":["trace[982675541] 'range keys from in-memory index tree' (duration: 1.199531756s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.674516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.2213ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T03:25:20.674645Z","caller":"traceutil/trace.go:171","msg":"trace[279391110] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"1.380250116s","start":"2026-04-28T03:25:19.294377Z","end":"2026-04-28T03:25:20.674627Z","steps":["trace[279391110] 'read index received' (duration: 1.004936614s)","trace[279391110] 'applied index is now lower than readState.Index' (duration: 375.312392ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:25:20.674718Z","caller":"traceutil/trace.go:171","msg":"trace[2112392482] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"1.420470478s","start":"2026-04-28T03:25:19.254234Z","end":"2026-04-28T03:25:20.674705Z","steps":["trace[2112392482] 'process raft request' (duration: 1.044996853s)","trace[2112392482] 'compare' (duration: 374.989145ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:25:20.674797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.254222Z","time spent":"1.42052316s","remote":"127.0.0.1:39778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T03:25:20.674824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.38042802s","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-28T03:25:20.674857Z","caller":"traceutil/trace.go:171","msg":"trace[1872833753] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:584; }","duration":"1.380501872s","start":"2026-04-28T03:25:19.294344Z","end":"2026-04-28T03:25:20.674846Z","steps":["trace[1872833753] 'agreement among raft nodes before linearized reading' (duration: 1.380405629s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.674898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.294324Z","time spent":"1.380563372s","remote":"127.0.0.1:38778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:25:20.674956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077365061s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T03:25:20.674972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"968.755302ms","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":"warn","ts":"2026-04-28T03:25:20.674948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.065505ms","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-28T03:25:20.67503Z","caller":"traceutil/trace.go:171","msg":"trace[1574166726] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:584; }","duration":"968.859674ms","start":"2026-04-28T03:25:19.706154Z","end":"2026-04-28T03:25:20.675014Z","steps":["trace[1574166726] 'agreement among raft nodes before linearized reading' (duration: 968.762862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.675042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"969.719203ms","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-28T03:25:20.675053Z","caller":"traceutil/trace.go:171","msg":"trace[1615998603] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:584; }","duration":"984.201019ms","start":"2026-04-28T03:25:19.690833Z","end":"2026-04-28T03:25:20.675034Z","steps":["trace[1615998603] 'agreement among raft nodes before linearized reading' (duration: 984.030745ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:20.67508Z","caller":"traceutil/trace.go:171","msg":"trace[512982452] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:584; }","duration":"969.757023ms","start":"2026-04-28T03:25:19.705313Z","end":"2026-04-28T03:25:20.67507Z","steps":["trace[512982452] 'agreement among raft nodes before linearized reading' (duration: 969.701072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.675085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.706133Z","time spent":"968.939486ms","remote":"127.0.0.1:56322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-28T03:25:20.675102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.705245Z","time spent":"969.852036ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:25:20.675112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.690823Z","time spent":"984.2768ms","remote":"127.0.0.1:56322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T03:25:20.67515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.817396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-28T03:25:20.675165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077718068s","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-28T03:25:20.674891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.38046901s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:25:20.675198Z","caller":"traceutil/trace.go:171","msg":"trace[873779694] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:584; }","duration":"1.07778431s","start":"2026-04-28T03:25:19.597404Z","end":"2026-04-28T03:25:20.675188Z","steps":["trace[873779694] 'agreement among raft nodes before linearized reading' (duration: 1.077706758s)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:20.675196Z","caller":"traceutil/trace.go:171","msg":"trace[1181465300] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:584; }","duration":"392.870467ms","start":"2026-04-28T03:25:20.282308Z","end":"2026-04-28T03:25:20.675178Z","steps":["trace[1181465300] 'agreement among raft nodes before linearized reading' (duration: 392.702553ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:20.675217Z","caller":"traceutil/trace.go:171","msg":"trace[653583640] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:584; }","duration":"1.380829118s","start":"2026-04-28T03:25:19.294376Z","end":"2026-04-28T03:25:20.675205Z","steps":["trace[653583640] 'agreement among raft nodes before linearized reading' (duration: 1.38045564s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.67523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"969.848016ms","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-28T03:25:20.67523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.008080085s","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-28T03:25:20.675242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:20.282304Z","time spent":"392.930668ms","remote":"127.0.0.1:39800","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-28T03:25:20.675267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.294358Z","time spent":"1.380890269s","remote":"127.0.0.1:38778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-28T03:25:20.67527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.316761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T03:25:20.675281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.210502312s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:25:20.675288Z","caller":"traceutil/trace.go:171","msg":"trace[68710421] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:584; }","duration":"1.008134346s","start":"2026-04-28T03:25:19.667133Z","end":"2026-04-28T03:25:20.675268Z","steps":["trace[68710421] 'agreement among raft nodes before linearized reading' (duration: 1.008068004s)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:20.67531Z","caller":"traceutil/trace.go:171","msg":"trace[703655249] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:584; }","duration":"984.364761ms","start":"2026-04-28T03:25:19.690932Z","end":"2026-04-28T03:25:20.675296Z","steps":["trace[703655249] 'agreement among raft nodes before linearized reading' (duration: 984.3111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.675337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.667129Z","time spent":"1.008198077s","remote":"127.0.0.1:56312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-28T03:25:20.675345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.690927Z","time spent":"984.409442ms","remote":"127.0.0.1:56322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-28T03:25:20.674999Z","caller":"traceutil/trace.go:171","msg":"trace[1919328671] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:584; }","duration":"1.077405272s","start":"2026-04-28T03:25:19.597579Z","end":"2026-04-28T03:25:20.674984Z","steps":["trace[1919328671] 'agreement among raft nodes before linearized reading' (duration: 1.07735428s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.675366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"952.347703ms","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-28T03:25:20.675395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.597546Z","time spent":"1.077841281s","remote":"127.0.0.1:56290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-28T03:25:20.675117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058030597s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T03:25:20.675393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.380961581s","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-28T03:25:20.675407Z","caller":"traceutil/trace.go:171","msg":"trace[1068649458] 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:584; }","duration":"952.390334ms","start":"2026-04-28T03:25:19.723005Z","end":"2026-04-28T03:25:20.675395Z","steps":["trace[1068649458] 'agreement among raft nodes before linearized reading' (duration: 952.327262ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:20.675428Z","caller":"traceutil/trace.go:171","msg":"trace[530231021] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:584; }","duration":"1.058518527s","start":"2026-04-28T03:25:19.616898Z","end":"2026-04-28T03:25:20.675417Z","steps":["trace[530231021] 'agreement among raft nodes before linearized reading' (duration: 1.057995946s)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:20.675433Z","caller":"traceutil/trace.go:171","msg":"trace[413647660] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:584; }","duration":"1.381012822s","start":"2026-04-28T03:25:19.29441Z","end":"2026-04-28T03:25:20.675423Z","steps":["trace[413647660] 'agreement among raft nodes before linearized reading' (duration: 1.380961311s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.675443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.72298Z","time spent":"952.453626ms","remote":"127.0.0.1:56352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T03:25:20.675465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.616881Z","time spent":"1.058572278s","remote":"127.0.0.1:56308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T03:25:20.675469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.294403Z","time spent":"1.381057603s","remote":"127.0.0.1:38778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T03:25:20.675488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.45027ms","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-28T03:25:20.675313Z","caller":"traceutil/trace.go:171","msg":"trace[797017727] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:584; }","duration":"1.210563724s","start":"2026-04-28T03:25:19.464741Z","end":"2026-04-28T03:25:20.675304Z","steps":["trace[797017727] 'agreement among raft nodes before linearized reading' (duration: 1.210516373s)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:20.67552Z","caller":"traceutil/trace.go:171","msg":"trace[1256464220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"393.502961ms","start":"2026-04-28T03:25:20.282008Z","end":"2026-04-28T03:25:20.675511Z","steps":["trace[1256464220] 'agreement among raft nodes before linearized reading' (duration: 393.415129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.675548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:20.281989Z","time spent":"393.552942ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T03:25:20.675547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.464726Z","time spent":"1.210805549s","remote":"127.0.0.1:56290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T03:25:20.675576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058625379s","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-28T03:25:20.675611Z","caller":"traceutil/trace.go:171","msg":"trace[42645142] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:584; }","duration":"1.05866736s","start":"2026-04-28T03:25:19.616933Z","end":"2026-04-28T03:25:20.675601Z","steps":["trace[42645142] 'agreement among raft nodes before linearized reading' (duration: 1.058615429s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.675621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"952.637399ms","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-28T03:25:20.675655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.61693Z","time spent":"1.058715861s","remote":"127.0.0.1:56308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:25:20.675661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.009391364s","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-28T03:25:20.675673Z","caller":"traceutil/trace.go:171","msg":"trace[326297724] 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:584; }","duration":"952.699301ms","start":"2026-04-28T03:25:19.722962Z","end":"2026-04-28T03:25:20.675661Z","steps":["trace[326297724] 'agreement among raft nodes before linearized reading' (duration: 952.630379ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:20.675685Z","caller":"traceutil/trace.go:171","msg":"trace[2000618702] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:584; }","duration":"1.009484606s","start":"2026-04-28T03:25:19.666193Z","end":"2026-04-28T03:25:20.675678Z","steps":["trace[2000618702] 'agreement among raft nodes before linearized reading' (duration: 1.009381514s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.675353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.210580694s","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-28T03:25:20.675704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.666166Z","time spent":"1.009533177s","remote":"127.0.0.1:56312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:25:20.675709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.722954Z","time spent":"952.745461ms","remote":"127.0.0.1:56352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-04-28T03:25:20.675716Z","caller":"traceutil/trace.go:171","msg":"trace[2127276035] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:584; }","duration":"1.210969022s","start":"2026-04-28T03:25:19.464734Z","end":"2026-04-28T03:25:20.675703Z","steps":["trace[2127276035] 'agreement among raft nodes before linearized reading' (duration: 1.210600384s)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:20.675256Z","caller":"traceutil/trace.go:171","msg":"trace[1168375897] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:584; }","duration":"969.933817ms","start":"2026-04-28T03:25:19.705315Z","end":"2026-04-28T03:25:20.675249Z","steps":["trace[1168375897] 'agreement among raft nodes before linearized reading' (duration: 969.895167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.67574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.476829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-04-28T03:25:20.675754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.464713Z","time spent":"1.211029494s","remote":"127.0.0.1:56290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:25:20.675237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.597382Z","time spent":"1.077845001s","remote":"127.0.0.1:56306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-28T03:25:20.675772Z","caller":"traceutil/trace.go:171","msg":"trace[549379082] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:584; }","duration":"478.54231ms","start":"2026-04-28T03:25:20.197219Z","end":"2026-04-28T03:25:20.675762Z","steps":["trace[549379082] 'agreement among raft nodes before linearized reading' (duration: 478.452127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.675768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.705296Z","time spent":"970.455061ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T03:25:20.675799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:20.1972Z","time spent":"478.593681ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T03:25:20.674963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.643314ms","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-28T03:25:20.675852Z","caller":"traceutil/trace.go:171","msg":"trace[1288616935] 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:584; }","duration":"951.565545ms","start":"2026-04-28T03:25:19.724274Z","end":"2026-04-28T03:25:20.675839Z","steps":["trace[1288616935] 'agreement among raft nodes before linearized reading' (duration: 950.600183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.675805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.00961825s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T03:25:20.67556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.057788761s","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-28T03:25:20.675892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.724268Z","time spent":"951.611536ms","remote":"127.0.0.1:56352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"info","ts":"2026-04-28T03:25:20.675895Z","caller":"traceutil/trace.go:171","msg":"trace[1440611792] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:584; }","duration":"1.009731462s","start":"2026-04-28T03:25:19.66615Z","end":"2026-04-28T03:25:20.675881Z","steps":["trace[1440611792] 'agreement among raft nodes before linearized reading' (duration: 1.00963453s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.675929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.666131Z","time spent":"1.009788633s","remote":"127.0.0.1:56312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"info","ts":"2026-04-28T03:25:20.675924Z","caller":"traceutil/trace.go:171","msg":"trace[599679282] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:584; }","duration":"1.058178351s","start":"2026-04-28T03:25:19.617732Z","end":"2026-04-28T03:25:20.67591Z","steps":["trace[599679282] 'agreement among raft nodes before linearized reading' (duration: 1.057806152s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.675971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.906631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T03:25:20.675978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.61772Z","time spent":"1.058241562s","remote":"127.0.0.1:56308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-28T03:25:20.675092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077501814s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:25:20.676Z","caller":"traceutil/trace.go:171","msg":"trace[62347961] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"654.971883ms","start":"2026-04-28T03:25:20.021018Z","end":"2026-04-28T03:25:20.67599Z","steps":["trace[62347961] 'agreement among raft nodes before linearized reading' (duration: 654.932442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.676029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:20.020997Z","time spent":"655.027334ms","remote":"127.0.0.1:60834","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-28T03:25:20.676033Z","caller":"traceutil/trace.go:171","msg":"trace[1319072304] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:584; }","duration":"1.078532877s","start":"2026-04-28T03:25:19.597487Z","end":"2026-04-28T03:25:20.67602Z","steps":["trace[1319072304] 'agreement among raft nodes before linearized reading' (duration: 1.077535834s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.676078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:19.597479Z","time spent":"1.078582878s","remote":"127.0.0.1:56306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T03:25:20.675931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.233272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:25:20.676136Z","caller":"traceutil/trace.go:171","msg":"trace[1376623673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"563.471218ms","start":"2026-04-28T03:25:20.112655Z","end":"2026-04-28T03:25:20.676126Z","steps":["trace[1376623673] 'agreement among raft nodes before linearized reading' (duration: 563.247683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:20.676175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:20.112635Z","time spent":"563.53024ms","remote":"127.0.0.1:60844","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-28T03:25:22.76197Z","caller":"traceutil/trace.go:171","msg":"trace[849413498] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"288.4534ms","start":"2026-04-28T03:25:22.473492Z","end":"2026-04-28T03:25:22.761945Z","steps":["trace[849413498] 'process raft request' (duration: 288.098012ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:22.762287Z","caller":"traceutil/trace.go:171","msg":"trace[674635537] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"169.397475ms","start":"2026-04-28T03:25:22.59286Z","end":"2026-04-28T03:25:22.762258Z","steps":["trace[674635537] 'process raft request' (duration: 168.894054ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:25:36.778495Z","caller":"traceutil/trace.go:171","msg":"trace[994134621] linearizableReadLoop","detail":"{readStateIndex:773; appliedIndex:772; }","duration":"366.755099ms","start":"2026-04-28T03:25:36.411713Z","end":"2026-04-28T03:25:36.778468Z","steps":["trace[994134621] 'read index received' (duration: 366.520394ms)","trace[994134621] 'applied index is now lower than readState.Index' (duration: 233.525µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:25:36.778577Z","caller":"traceutil/trace.go:171","msg":"trace[1308521535] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"467.650436ms","start":"2026-04-28T03:25:36.310896Z","end":"2026-04-28T03:25:36.778546Z","steps":["trace[1308521535] 'process raft request' (duration: 467.330009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:36.778766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:36.310864Z","time spent":"467.792849ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:25:36.778964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.134317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2vzhm\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-28T03:25:36.779013Z","caller":"traceutil/trace.go:171","msg":"trace[880266470] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2vzhm; range_end:; response_count:1; response_revision:747; }","duration":"367.332282ms","start":"2026-04-28T03:25:36.411666Z","end":"2026-04-28T03:25:36.778998Z","steps":["trace[880266470] 'agreement among raft nodes before linearized reading' (duration: 366.912172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:36.779059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:25:36.411647Z","time spent":"367.394793ms","remote":"127.0.0.1:39722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2vzhm\" "} {"level":"info","ts":"2026-04-28T03:25:36.969486Z","caller":"traceutil/trace.go:171","msg":"trace[1679981578] linearizableReadLoop","detail":"{readStateIndex:774; appliedIndex:773; }","duration":"121.53955ms","start":"2026-04-28T03:25:36.847928Z","end":"2026-04-28T03:25:36.969467Z","steps":["trace[1679981578] 'read index received' (duration: 121.283385ms)","trace[1679981578] 'applied index is now lower than readState.Index' (duration: 255.535µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:25:36.969557Z","caller":"traceutil/trace.go:171","msg":"trace[185740918] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"182.462799ms","start":"2026-04-28T03:25:36.78707Z","end":"2026-04-28T03:25:36.969533Z","steps":["trace[185740918] 'process raft request' (duration: 182.213073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:36.969768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.825727ms","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-28T03:25:36.969828Z","caller":"traceutil/trace.go:171","msg":"trace[507667439] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:748; }","duration":"121.93235ms","start":"2026-04-28T03:25:36.847876Z","end":"2026-04-28T03:25:36.969808Z","steps":["trace[507667439] 'agreement among raft nodes before linearized reading' (duration: 121.691115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:36.969823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.543076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T03:25:36.969876Z","caller":"traceutil/trace.go:171","msg":"trace[1980400941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:748; }","duration":"119.622527ms","start":"2026-04-28T03:25:36.850241Z","end":"2026-04-28T03:25:36.969863Z","steps":["trace[1980400941] 'agreement among raft nodes before linearized reading' (duration: 119.500954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:36.970007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.86914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-28T03:25:36.970043Z","caller":"traceutil/trace.go:171","msg":"trace[2048642788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:748; }","duration":"118.957402ms","start":"2026-04-28T03:25:36.851077Z","end":"2026-04-28T03:25:36.970034Z","steps":["trace[2048642788] 'agreement among raft nodes before linearized reading' (duration: 118.86952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:41.191997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.196914ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T03:25:41.192148Z","caller":"traceutil/trace.go:171","msg":"trace[101037174] linearizableReadLoop","detail":"{readStateIndex:821; appliedIndex:820; }","duration":"118.161784ms","start":"2026-04-28T03:25:41.073967Z","end":"2026-04-28T03:25:41.192129Z","steps":["trace[101037174] 'read index received' (duration: 50.301µs)","trace[101037174] 'applied index is now lower than readState.Index' (duration: 118.110083ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:25:41.192157Z","caller":"traceutil/trace.go:171","msg":"trace[1060356809] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"189.21839ms","start":"2026-04-28T03:25:41.002908Z","end":"2026-04-28T03:25:41.192127Z","steps":["trace[1060356809] 'process raft request' (duration: 50.796471ms)","trace[1060356809] 'compare' (duration: 138.01338ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:25:41.193778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.797591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050264"} {"level":"info","ts":"2026-04-28T03:25:41.193869Z","caller":"traceutil/trace.go:171","msg":"trace[356464587] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:794; }","duration":"119.934264ms","start":"2026-04-28T03:25:41.073917Z","end":"2026-04-28T03:25:41.193852Z","steps":["trace[356464587] 'agreement among raft nodes before linearized reading' (duration: 118.334858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:25:47.659358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.595126ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-28T03:26:06.133702Z","caller":"traceutil/trace.go:171","msg":"trace[1446906540] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"146.86546ms","start":"2026-04-28T03:26:05.986818Z","end":"2026-04-28T03:26:06.133683Z","steps":["trace[1446906540] 'process raft request' (duration: 146.736356ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:26:09.447686Z","caller":"traceutil/trace.go:171","msg":"trace[958204225] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"130.269537ms","start":"2026-04-28T03:26:09.317382Z","end":"2026-04-28T03:26:09.447652Z","steps":["trace[958204225] 'process raft request' (duration: 95.571207ms)","trace[958204225] 'compare' (duration: 34.524475ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:26:10.200094Z","caller":"traceutil/trace.go:171","msg":"trace[360237837] linearizableReadLoop","detail":"{readStateIndex:987; appliedIndex:986; }","duration":"108.196ms","start":"2026-04-28T03:26:10.091855Z","end":"2026-04-28T03:26:10.200051Z","steps":["trace[360237837] 'read index received' (duration: 108.071748ms)","trace[360237837] 'applied index is now lower than readState.Index' (duration: 123.092µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:26:10.200202Z","caller":"traceutil/trace.go:171","msg":"trace[1613810128] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"136.809833ms","start":"2026-04-28T03:26:10.063366Z","end":"2026-04-28T03:26:10.200176Z","steps":["trace[1613810128] 'process raft request' (duration: 136.557917ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:10.200274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.395135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:26:10.200335Z","caller":"traceutil/trace.go:171","msg":"trace[953390423] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:953; }","duration":"108.490697ms","start":"2026-04-28T03:26:10.091828Z","end":"2026-04-28T03:26:10.200318Z","steps":["trace[953390423] 'agreement among raft nodes before linearized reading' (duration: 108.366014ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:26:10.265391Z","caller":"traceutil/trace.go:171","msg":"trace[1008702918] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"121.98803ms","start":"2026-04-28T03:26:10.143324Z","end":"2026-04-28T03:26:10.265312Z","steps":["trace[1008702918] 'process raft request' (duration: 121.847467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:11.593206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.473988ms","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-28T03:26:11.593294Z","caller":"traceutil/trace.go:171","msg":"trace[1046033863] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:959; }","duration":"141.614571ms","start":"2026-04-28T03:26:11.45166Z","end":"2026-04-28T03:26:11.593275Z","steps":["trace[1046033863] 'range keys from in-memory index tree' (duration: 141.287374ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:26:12.228845Z","caller":"traceutil/trace.go:171","msg":"trace[1840288241] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"632.424615ms","start":"2026-04-28T03:26:11.596396Z","end":"2026-04-28T03:26:12.228821Z","steps":["trace[1840288241] 'process raft request' (duration: 632.272512ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:12.229013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:11.596376Z","time spent":"632.551199ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:26:12.835259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.34187ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T03:26:12.835383Z","caller":"traceutil/trace.go:171","msg":"trace[1264012832] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"564.328428ms","start":"2026-04-28T03:26:12.271044Z","end":"2026-04-28T03:26:12.835372Z","steps":["trace[1264012832] 'process raft request' (duration: 564.282797ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:26:12.835368Z","caller":"traceutil/trace.go:171","msg":"trace[1072198572] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"1.237621172s","start":"2026-04-28T03:26:11.597716Z","end":"2026-04-28T03:26:12.835337Z","steps":["trace[1072198572] 'process raft request' (duration: 725.14475ms)","trace[1072198572] 'compare' (duration: 512.269498ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:26:12.835426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:12.271021Z","time spent":"564.38845ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:26:12.835492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:11.597698Z","time spent":"1.237725685s","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:26:12.836296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.695044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T03:26:12.836322Z","caller":"traceutil/trace.go:171","msg":"trace[1379937978] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:962; }","duration":"673.753135ms","start":"2026-04-28T03:26:12.162562Z","end":"2026-04-28T03:26:12.836316Z","steps":["trace[1379937978] 'agreement among raft nodes before linearized reading' (duration: 673.700914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:12.836338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:12.162546Z","time spent":"673.788006ms","remote":"127.0.0.1:39722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":11,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-04-28T03:26:12.83632Z","caller":"traceutil/trace.go:171","msg":"trace[1821541681] linearizableReadLoop","detail":"{readStateIndex:996; appliedIndex:994; }","duration":"672.858315ms","start":"2026-04-28T03:26:12.162596Z","end":"2026-04-28T03:26:12.835454Z","steps":["trace[1821541681] 'read index received' (duration: 66.188496ms)","trace[1821541681] 'applied index is now lower than readState.Index' (duration: 606.667639ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:26:12.836847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.968493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-28T03:26:12.836847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.891722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.33\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-28T03:26:12.836871Z","caller":"traceutil/trace.go:171","msg":"trace[1809354272] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:962; }","duration":"322.023705ms","start":"2026-04-28T03:26:12.514841Z","end":"2026-04-28T03:26:12.836865Z","steps":["trace[1809354272] 'agreement among raft nodes before linearized reading' (duration: 321.977824ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:26:12.836883Z","caller":"traceutil/trace.go:171","msg":"trace[727366479] range","detail":"{range_begin:/registry/masterleases/199.204.45.33; range_end:; response_count:1; response_revision:962; }","duration":"370.983744ms","start":"2026-04-28T03:26:12.465886Z","end":"2026-04-28T03:26:12.836869Z","steps":["trace[727366479] 'agreement among raft nodes before linearized reading' (duration: 370.844501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:12.836899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:12.514824Z","time spent":"322.068576ms","remote":"127.0.0.1:40106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:26:12.836911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:12.465863Z","time spent":"371.041915ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.33\" "} {"level":"warn","ts":"2026-04-28T03:26:13.551148Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088156098829918427,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T03:26:14.675828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.219704ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-04-28T03:26:14.675889Z","caller":"traceutil/trace.go:171","msg":"trace[955319006] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:997; }","duration":"1.652119294s","start":"2026-04-28T03:26:13.023759Z","end":"2026-04-28T03:26:14.675878Z","steps":["trace[955319006] 'read index received' (duration: 889.842139ms)","trace[955319006] 'applied index is now lower than readState.Index' (duration: 762.276275ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:26:14.675929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:12.837731Z","time spent":"1.838196965s","remote":"127.0.0.1:60868","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-28T03:26:14.676092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.652339439s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:489"} {"level":"info","ts":"2026-04-28T03:26:14.676107Z","caller":"traceutil/trace.go:171","msg":"trace[1312768901] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:962; }","duration":"1.652412501s","start":"2026-04-28T03:26:13.023689Z","end":"2026-04-28T03:26:14.676101Z","steps":["trace[1312768901] 'agreement among raft nodes before linearized reading' (duration: 1.652333729s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:14.67612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:13.023662Z","time spent":"1.652454461s","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-28T03:26:14.681733Z","caller":"traceutil/trace.go:171","msg":"trace[231143257] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"1.019186846s","start":"2026-04-28T03:26:13.662528Z","end":"2026-04-28T03:26:14.681715Z","steps":["trace[231143257] 'process raft request' (duration: 1.018972441s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:14.681783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.370716493s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-28T03:26:14.681819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.102157ms","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-28T03:26:14.681846Z","caller":"traceutil/trace.go:171","msg":"trace[777842019] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:963; }","duration":"448.164329ms","start":"2026-04-28T03:26:14.233675Z","end":"2026-04-28T03:26:14.681839Z","steps":["trace[777842019] 'agreement among raft nodes before linearized reading' (duration: 448.069937ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:14.68184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:13.662511Z","time spent":"1.019270017s","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:26:14.681862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:14.233595Z","time spent":"448.263891ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-28T03:26:14.681852Z","caller":"traceutil/trace.go:171","msg":"trace[293761209] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:963; }","duration":"1.370820936s","start":"2026-04-28T03:26:13.311015Z","end":"2026-04-28T03:26:14.681836Z","steps":["trace[293761209] 'agreement among raft nodes before linearized reading' (duration: 1.370673402s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:14.681894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:13.311005Z","time spent":"1.370879497s","remote":"127.0.0.1:39860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":16,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:26:14.681975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.375371708s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-28T03:26:14.681969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.383708715s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T03:26:14.681999Z","caller":"traceutil/trace.go:171","msg":"trace[489903877] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:963; }","duration":"1.37544755s","start":"2026-04-28T03:26:13.306544Z","end":"2026-04-28T03:26:14.681992Z","steps":["trace[489903877] 'agreement among raft nodes before linearized reading' (duration: 1.375404789s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:14.682026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:13.306534Z","time spent":"1.375487541s","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:26:14.682116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.387786977s","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-28T03:26:14.682133Z","caller":"traceutil/trace.go:171","msg":"trace[514293295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:963; }","duration":"1.387858688s","start":"2026-04-28T03:26:13.29427Z","end":"2026-04-28T03:26:14.682129Z","steps":["trace[514293295] 'agreement among raft nodes before linearized reading' (duration: 1.387812007s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:14.682147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:13.294238Z","time spent":"1.387905248s","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-28T03:26:14.682143Z","caller":"traceutil/trace.go:171","msg":"trace[1296667287] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:963; }","duration":"1.383812878s","start":"2026-04-28T03:26:13.298204Z","end":"2026-04-28T03:26:14.682017Z","steps":["trace[1296667287] 'agreement among raft nodes before linearized reading' (duration: 1.383581252s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:14.682193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:13.298191Z","time spent":"1.383989661s","remote":"127.0.0.1:39800","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-28T03:26:14.682232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.58783405s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:26:14.682267Z","caller":"traceutil/trace.go:171","msg":"trace[1478488928] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:963; }","duration":"1.587891442s","start":"2026-04-28T03:26:13.094366Z","end":"2026-04-28T03:26:14.682257Z","steps":["trace[1478488928] 'agreement among raft nodes before linearized reading' (duration: 1.587839551s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:14.682304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:13.094353Z","time spent":"1.587944293s","remote":"127.0.0.1:60834","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-28T03:26:14.682575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.653438734s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:26:14.682621Z","caller":"traceutil/trace.go:171","msg":"trace[76906679] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:963; }","duration":"1.653529136s","start":"2026-04-28T03:26:13.029082Z","end":"2026-04-28T03:26:14.682611Z","steps":["trace[76906679] 'agreement among raft nodes before linearized reading' (duration: 1.652570415s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:14.682649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:13.029063Z","time spent":"1.653579096s","remote":"127.0.0.1:39750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:26:15.21492Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088156098829918438,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T03:26:15.317107Z","caller":"traceutil/trace.go:171","msg":"trace[1067513691] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"630.477784ms","start":"2026-04-28T03:26:14.686608Z","end":"2026-04-28T03:26:15.317086Z","steps":["trace[1067513691] 'process raft request' (duration: 630.428713ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:26:15.317178Z","caller":"traceutil/trace.go:171","msg":"trace[1486850335] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"632.004978ms","start":"2026-04-28T03:26:14.685127Z","end":"2026-04-28T03:26:15.317132Z","steps":["trace[1486850335] 'process raft request' (duration: 631.757932ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:26:15.317195Z","caller":"traceutil/trace.go:171","msg":"trace[1379016069] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"631.322313ms","start":"2026-04-28T03:26:14.685838Z","end":"2026-04-28T03:26:15.317161Z","steps":["trace[1379016069] 'process raft request' (duration: 631.17215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:15.317241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:14.686593Z","time spent":"630.578996ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:26:15.317311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:14.685116Z","time spent":"632.114971ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:26:15.317385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:14.685828Z","time spent":"631.448316ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T03:26:15.321725Z","caller":"traceutil/trace.go:171","msg":"trace[1579254661] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1001; }","duration":"607.107248ms","start":"2026-04-28T03:26:14.714602Z","end":"2026-04-28T03:26:15.32171Z","steps":["trace[1579254661] 'read index received' (duration: 602.310461ms)","trace[1579254661] 'applied index is now lower than readState.Index' (duration: 4.795997ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:26:15.321814Z","caller":"traceutil/trace.go:171","msg":"trace[1988827562] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"480.272609ms","start":"2026-04-28T03:26:14.841535Z","end":"2026-04-28T03:26:15.321807Z","steps":["trace[1988827562] 'process raft request' (duration: 480.084825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:15.321885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:14.841496Z","time spent":"480.33897ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:26:15.321974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.365523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-04-28T03:26:15.322016Z","caller":"traceutil/trace.go:171","msg":"trace[1026643968] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:969; }","duration":"607.440415ms","start":"2026-04-28T03:26:14.714566Z","end":"2026-04-28T03:26:15.322006Z","steps":["trace[1026643968] 'agreement among raft nodes before linearized reading' (duration: 607.332053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:15.322029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.216007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T03:26:15.322051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:14.714552Z","time spent":"607.489106ms","remote":"127.0.0.1:39710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-04-28T03:26:15.322065Z","caller":"traceutil/trace.go:171","msg":"trace[879743345] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:969; }","duration":"103.256388ms","start":"2026-04-28T03:26:15.218798Z","end":"2026-04-28T03:26:15.322054Z","steps":["trace[879743345] 'agreement among raft nodes before linearized reading' (duration: 103.104995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:15.32215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.377472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T03:26:15.322182Z","caller":"traceutil/trace.go:171","msg":"trace[325917161] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:969; }","duration":"245.441474ms","start":"2026-04-28T03:26:15.076733Z","end":"2026-04-28T03:26:15.322175Z","steps":["trace[325917161] 'agreement among raft nodes before linearized reading' (duration: 245.374762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:15.32235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.502292ms","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-28T03:26:15.322382Z","caller":"traceutil/trace.go:171","msg":"trace[897365277] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:969; }","duration":"483.570583ms","start":"2026-04-28T03:26:14.838804Z","end":"2026-04-28T03:26:15.322375Z","steps":["trace[897365277] 'agreement among raft nodes before linearized reading' (duration: 483.458071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:15.322409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:14.838786Z","time spent":"483.617485ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T03:26:15.322451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.155435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:26:15.322517Z","caller":"traceutil/trace.go:171","msg":"trace[232917693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:969; }","duration":"601.302178ms","start":"2026-04-28T03:26:14.7212Z","end":"2026-04-28T03:26:15.322502Z","steps":["trace[232917693] 'agreement among raft nodes before linearized reading' (duration: 600.675723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:15.322556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:14.721191Z","time spent":"601.358099ms","remote":"127.0.0.1:60834","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-28T03:26:36.600203Z","caller":"traceutil/trace.go:171","msg":"trace[1633249167] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"463.695266ms","start":"2026-04-28T03:26:36.136472Z","end":"2026-04-28T03:26:36.600167Z","steps":["trace[1633249167] 'process raft request' (duration: 463.477271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:36.600452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:36.136439Z","time spent":"463.87733ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:26:37.725639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.717602ms","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-28T03:26:37.725734Z","caller":"traceutil/trace.go:171","msg":"trace[1957429792] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1037; }","duration":"896.860355ms","start":"2026-04-28T03:26:36.828843Z","end":"2026-04-28T03:26:37.725703Z","steps":["trace[1957429792] 'range keys from in-memory index tree' (duration: 896.501048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:37.72578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:36.828821Z","time spent":"896.949888ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-28T03:26:37.725857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.458589ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T03:26:37.725935Z","caller":"traceutil/trace.go:171","msg":"trace[433555171] linearizableReadLoop","detail":"{readStateIndex:1078; appliedIndex:1077; }","duration":"299.88856ms","start":"2026-04-28T03:26:37.426033Z","end":"2026-04-28T03:26:37.725922Z","steps":["trace[433555171] 'read index received' (duration: 156.188296ms)","trace[433555171] 'applied index is now lower than readState.Index' (duration: 143.699164ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:26:37.726071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.036873ms","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-28T03:26:37.726032Z","caller":"traceutil/trace.go:171","msg":"trace[1747964777] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"300.299929ms","start":"2026-04-28T03:26:37.425689Z","end":"2026-04-28T03:26:37.725989Z","steps":["trace[1747964777] 'process raft request' (duration: 156.632996ms)","trace[1747964777] 'compare' (duration: 143.282044ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:26:37.726091Z","caller":"traceutil/trace.go:171","msg":"trace[1870405873] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1038; }","duration":"300.089045ms","start":"2026-04-28T03:26:37.425995Z","end":"2026-04-28T03:26:37.726084Z","steps":["trace[1870405873] 'agreement among raft nodes before linearized reading' (duration: 299.982943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:37.726115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:37.425976Z","time spent":"300.133705ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T03:26:37.726217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:37.425648Z","time spent":"300.460122ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:26:37.819736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.772152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-28T03:26:37.819805Z","caller":"traceutil/trace.go:171","msg":"trace[361217942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1040; }","duration":"385.897855ms","start":"2026-04-28T03:26:37.433891Z","end":"2026-04-28T03:26:37.819789Z","steps":["trace[361217942] 'agreement among raft nodes before linearized reading' (duration: 385.719811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:37.819846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:37.433851Z","time spent":"385.984937ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T03:26:37.820316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.022667ms","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-28T03:26:37.820448Z","caller":"traceutil/trace.go:171","msg":"trace[70112585] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1040; }","duration":"385.206701ms","start":"2026-04-28T03:26:37.435226Z","end":"2026-04-28T03:26:37.820433Z","steps":["trace[70112585] 'agreement among raft nodes before linearized reading' (duration: 385.013417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:37.820495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:37.435201Z","time spent":"385.276792ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T03:26:37.821083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.786003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T03:26:37.822651Z","caller":"traceutil/trace.go:171","msg":"trace[1814149075] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1040; }","duration":"387.250826ms","start":"2026-04-28T03:26:37.435225Z","end":"2026-04-28T03:26:37.822476Z","steps":["trace[1814149075] 'agreement among raft nodes before linearized reading' (duration: 385.464657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:37.822755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:37.435214Z","time spent":"387.521463ms","remote":"127.0.0.1:39800","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-28T03:26:37.964661Z","caller":"traceutil/trace.go:171","msg":"trace[1063171462] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"139.787337ms","start":"2026-04-28T03:26:37.824834Z","end":"2026-04-28T03:26:37.964622Z","steps":["trace[1063171462] 'process raft request' (duration: 139.579732ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:26:37.970242Z","caller":"traceutil/trace.go:171","msg":"trace[1029339978] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"144.378049ms","start":"2026-04-28T03:26:37.825839Z","end":"2026-04-28T03:26:37.970217Z","steps":["trace[1029339978] 'process raft request' (duration: 144.086262ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:26:37.970249Z","caller":"traceutil/trace.go:171","msg":"trace[1258484376] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"143.645583ms","start":"2026-04-28T03:26:37.826576Z","end":"2026-04-28T03:26:37.970222Z","steps":["trace[1258484376] 'process raft request' (duration: 143.573301ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:26:39.852685Z","caller":"traceutil/trace.go:171","msg":"trace[1574642653] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"120.719667ms","start":"2026-04-28T03:26:39.731932Z","end":"2026-04-28T03:26:39.852652Z","steps":["trace[1574642653] 'process raft request' (duration: 120.005772ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:42.134411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.69673ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T03:26:42.134555Z","caller":"traceutil/trace.go:171","msg":"trace[230635218] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"220.534844ms","start":"2026-04-28T03:26:41.913966Z","end":"2026-04-28T03:26:42.134501Z","steps":["trace[230635218] 'process raft request' (duration: 86.63123ms)","trace[230635218] 'compare' (duration: 133.543006ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:26:42.14612Z","caller":"traceutil/trace.go:171","msg":"trace[1860956271] linearizableReadLoop","detail":"{readStateIndex:1093; appliedIndex:1091; }","duration":"147.219824ms","start":"2026-04-28T03:26:41.998876Z","end":"2026-04-28T03:26:42.146096Z","steps":["trace[1860956271] 'read index received' (duration: 1.7448ms)","trace[1860956271] 'applied index is now lower than readState.Index' (duration: 145.474004ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:26:42.146298Z","caller":"traceutil/trace.go:171","msg":"trace[395462141] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"231.259085ms","start":"2026-04-28T03:26:41.915027Z","end":"2026-04-28T03:26:42.146287Z","steps":["trace[395462141] 'process raft request' (duration: 230.965749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:42.146479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.913089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-28T03:26:42.146524Z","caller":"traceutil/trace.go:171","msg":"trace[402211784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1052; }","duration":"112.000671ms","start":"2026-04-28T03:26:42.034512Z","end":"2026-04-28T03:26:42.146512Z","steps":["trace[402211784] 'agreement among raft nodes before linearized reading' (duration: 111.822257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:42.146624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.854468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:26:42.146649Z","caller":"traceutil/trace.go:171","msg":"trace[2028500581] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1052; }","duration":"147.916979ms","start":"2026-04-28T03:26:41.998724Z","end":"2026-04-28T03:26:42.146641Z","steps":["trace[2028500581] 'agreement among raft nodes before linearized reading' (duration: 147.875838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:42.146862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.365511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T03:26:42.146894Z","caller":"traceutil/trace.go:171","msg":"trace[1600680750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1052; }","duration":"101.413772ms","start":"2026-04-28T03:26:42.045473Z","end":"2026-04-28T03:26:42.146886Z","steps":["trace[1600680750] 'agreement among raft nodes before linearized reading' (duration: 101.33289ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:26:42.297424Z","caller":"traceutil/trace.go:171","msg":"trace[1982656274] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"144.422571ms","start":"2026-04-28T03:26:42.152971Z","end":"2026-04-28T03:26:42.297394Z","steps":["trace[1982656274] 'process raft request' (duration: 144.343729ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:26:42.297721Z","caller":"traceutil/trace.go:171","msg":"trace[1150918525] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"145.892334ms","start":"2026-04-28T03:26:42.151786Z","end":"2026-04-28T03:26:42.297678Z","steps":["trace[1150918525] 'process raft request' (duration: 130.568259ms)","trace[1150918525] 'compare' (duration: 14.844295ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:26:55.593229Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088156098829918876,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T03:26:55.909845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.608470944s","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-28T03:26:55.909906Z","caller":"traceutil/trace.go:171","msg":"trace[459337022] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1143; }","duration":"1.608597327s","start":"2026-04-28T03:26:54.301295Z","end":"2026-04-28T03:26:55.909893Z","steps":["trace[459337022] 'range keys from in-memory index tree' (duration: 1.608326581s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:55.909932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:54.301281Z","time spent":"1.608645578s","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T03:26:55.910745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.437526137s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T03:26:55.910857Z","caller":"traceutil/trace.go:171","msg":"trace[1518569306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1143; }","duration":"1.437686s","start":"2026-04-28T03:26:54.473145Z","end":"2026-04-28T03:26:55.910831Z","steps":["trace[1518569306] 'range keys from in-memory index tree' (duration: 1.437325212s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:55.910918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:54.473132Z","time spent":"1.437771672s","remote":"127.0.0.1:39800","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-28T03:26:55.911103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.436756238s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-28T03:26:55.911132Z","caller":"traceutil/trace.go:171","msg":"trace[1569126032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1143; }","duration":"1.436803999s","start":"2026-04-28T03:26:54.474319Z","end":"2026-04-28T03:26:55.911123Z","steps":["trace[1569126032] 'range keys from in-memory index tree' (duration: 1.436689827s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:55.91115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:54.47431Z","time spent":"1.436836061s","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-28T03:26:55.9113Z","caller":"traceutil/trace.go:171","msg":"trace[1725253747] linearizableReadLoop","detail":"{readStateIndex:1190; appliedIndex:1189; }","duration":"818.829661ms","start":"2026-04-28T03:26:55.092462Z","end":"2026-04-28T03:26:55.911292Z","steps":["trace[1725253747] 'read index received' (duration: 816.518039ms)","trace[1725253747] 'applied index is now lower than readState.Index' (duration: 2.310472ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:26:55.911359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.903943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:26:55.911372Z","caller":"traceutil/trace.go:171","msg":"trace[1685367561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1144; }","duration":"818.949764ms","start":"2026-04-28T03:26:55.092418Z","end":"2026-04-28T03:26:55.911367Z","steps":["trace[1685367561] 'agreement among raft nodes before linearized reading' (duration: 818.904423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:55.911387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:55.092398Z","time spent":"818.985235ms","remote":"127.0.0.1:60834","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-28T03:26:55.911521Z","caller":"traceutil/trace.go:171","msg":"trace[793406742] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"826.702538ms","start":"2026-04-28T03:26:55.084808Z","end":"2026-04-28T03:26:55.91151Z","steps":["trace[793406742] 'process raft request' (duration: 824.240612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:26:55.911588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:26:55.084763Z","time spent":"826.777369ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T03:27:12.16146Z","caller":"traceutil/trace.go:171","msg":"trace[2145586259] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"154.512967ms","start":"2026-04-28T03:27:12.00692Z","end":"2026-04-28T03:27:12.161433Z","steps":["trace[2145586259] 'process raft request' (duration: 154.271912ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:27:12.867519Z","caller":"traceutil/trace.go:171","msg":"trace[1070134838] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"857.595184ms","start":"2026-04-28T03:27:12.009899Z","end":"2026-04-28T03:27:12.867494Z","steps":["trace[1070134838] 'process raft request' (duration: 857.41334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:12.867694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:12.009876Z","time spent":"857.717756ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T03:27:12.867748Z","caller":"traceutil/trace.go:171","msg":"trace[1251920470] linearizableReadLoop","detail":"{readStateIndex:1255; appliedIndex:1254; }","duration":"857.715836ms","start":"2026-04-28T03:27:12.010001Z","end":"2026-04-28T03:27:12.867717Z","steps":["trace[1251920470] 'read index received' (duration: 151.456469ms)","trace[1251920470] 'applied index is now lower than readState.Index' (duration: 706.257166ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:27:12.867893Z","caller":"traceutil/trace.go:171","msg":"trace[1972695268] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"839.801993ms","start":"2026-04-28T03:27:12.028075Z","end":"2026-04-28T03:27:12.867877Z","steps":["trace[1972695268] 'process raft request' (duration: 839.378483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:12.868023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:12.02805Z","time spent":"839.886404ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:27:12.868042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.988569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:27:12.86823Z","caller":"traceutil/trace.go:171","msg":"trace[552973824] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1207; }","duration":"773.223003ms","start":"2026-04-28T03:27:12.094987Z","end":"2026-04-28T03:27:12.86821Z","steps":["trace[552973824] 'agreement among raft nodes before linearized reading' (duration: 772.920237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:12.868273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.711274ms","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-28T03:27:12.868318Z","caller":"traceutil/trace.go:171","msg":"trace[1837045247] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1207; }","duration":"485.784895ms","start":"2026-04-28T03:27:12.382523Z","end":"2026-04-28T03:27:12.868308Z","steps":["trace[1837045247] 'agreement among raft nodes before linearized reading' (duration: 485.630851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:12.868323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.655066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.33\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-28T03:27:12.868359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:12.382501Z","time spent":"485.846256ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-28T03:27:12.868361Z","caller":"traceutil/trace.go:171","msg":"trace[2093603583] range","detail":"{range_begin:/registry/masterleases/199.204.45.33; range_end:; response_count:1; response_revision:1207; }","duration":"399.711368ms","start":"2026-04-28T03:27:12.468639Z","end":"2026-04-28T03:27:12.86835Z","steps":["trace[2093603583] 'agreement among raft nodes before linearized reading' (duration: 399.632496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:12.868393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:12.468623Z","time spent":"399.764088ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.33\" "} {"level":"warn","ts":"2026-04-28T03:27:12.868407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:12.094965Z","time spent":"773.369097ms","remote":"127.0.0.1:60834","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-28T03:27:12.86856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.536723ms","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-28T03:27:12.868693Z","caller":"traceutil/trace.go:171","msg":"trace[189737362] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1207; }","duration":"670.722687ms","start":"2026-04-28T03:27:12.197939Z","end":"2026-04-28T03:27:12.868661Z","steps":["trace[189737362] 'agreement among raft nodes before linearized reading' (duration: 670.465382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:12.868249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"858.247838ms","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-28T03:27:12.868756Z","caller":"traceutil/trace.go:171","msg":"trace[875529418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1207; }","duration":"858.77454ms","start":"2026-04-28T03:27:12.009971Z","end":"2026-04-28T03:27:12.868745Z","steps":["trace[875529418] 'agreement among raft nodes before linearized reading' (duration: 858.226698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:12.86877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:12.197925Z","time spent":"670.826319ms","remote":"127.0.0.1:56306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:27:12.868794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:12.009964Z","time spent":"858.820181ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T03:27:12.868171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.564503ms","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-28T03:27:12.868941Z","caller":"traceutil/trace.go:171","msg":"trace[1913680964] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1207; }","duration":"432.355011ms","start":"2026-04-28T03:27:12.436573Z","end":"2026-04-28T03:27:12.868928Z","steps":["trace[1913680964] 'agreement among raft nodes before linearized reading' (duration: 431.501212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:12.869009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:12.436556Z","time spent":"432.442123ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-28T03:27:12.976231Z","caller":"traceutil/trace.go:171","msg":"trace[1143249803] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"102.886706ms","start":"2026-04-28T03:27:12.873308Z","end":"2026-04-28T03:27:12.976195Z","steps":["trace[1143249803] 'process raft request' (duration: 99.05581ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:27:12.976464Z","caller":"traceutil/trace.go:171","msg":"trace[282723235] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"102.065317ms","start":"2026-04-28T03:27:12.874373Z","end":"2026-04-28T03:27:12.976438Z","steps":["trace[282723235] 'process raft request' (duration: 102.005325ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:27:12.976744Z","caller":"traceutil/trace.go:171","msg":"trace[1654827037] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"103.286795ms","start":"2026-04-28T03:27:12.873448Z","end":"2026-04-28T03:27:12.976735Z","steps":["trace[1654827037] 'process raft request' (duration: 102.781074ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:27:13.033576Z","caller":"traceutil/trace.go:171","msg":"trace[1299369261] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"151.593352ms","start":"2026-04-28T03:27:12.881936Z","end":"2026-04-28T03:27:13.033529Z","steps":["trace[1299369261] 'process raft request' (duration: 151.409088ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:27:14.341345Z","caller":"traceutil/trace.go:171","msg":"trace[1533717449] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"154.478347ms","start":"2026-04-28T03:27:14.186819Z","end":"2026-04-28T03:27:14.341298Z","steps":["trace[1533717449] 'process raft request' (duration: 154.331433ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:27:15.036135Z","caller":"traceutil/trace.go:171","msg":"trace[286808689] linearizableReadLoop","detail":"{readStateIndex:1264; appliedIndex:1263; }","duration":"162.828135ms","start":"2026-04-28T03:27:14.873283Z","end":"2026-04-28T03:27:15.036111Z","steps":["trace[286808689] 'read index received' (duration: 162.720233ms)","trace[286808689] 'applied index is now lower than readState.Index' (duration: 107.062µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:27:15.036187Z","caller":"traceutil/trace.go:171","msg":"trace[824272709] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"209.419454ms","start":"2026-04-28T03:27:14.826743Z","end":"2026-04-28T03:27:15.036163Z","steps":["trace[824272709] 'process raft request' (duration: 209.169668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:15.036512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.227155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-28T03:27:15.036559Z","caller":"traceutil/trace.go:171","msg":"trace[2096808636] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1214; }","duration":"163.342737ms","start":"2026-04-28T03:27:14.873205Z","end":"2026-04-28T03:27:15.036547Z","steps":["trace[2096808636] 'agreement among raft nodes before linearized reading' (duration: 163.0296ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:27:15.057455Z","caller":"traceutil/trace.go:171","msg":"trace[217061809] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"182.540019ms","start":"2026-04-28T03:27:14.874895Z","end":"2026-04-28T03:27:15.057435Z","steps":["trace[217061809] 'process raft request' (duration: 182.264803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:15.057817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.500942ms","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-28T03:27:15.058102Z","caller":"traceutil/trace.go:171","msg":"trace[1541424747] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1215; }","duration":"116.997773ms","start":"2026-04-28T03:27:14.941091Z","end":"2026-04-28T03:27:15.058089Z","steps":["trace[1541424747] 'agreement among raft nodes before linearized reading' (duration: 116.228536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:15.223822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.330128ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T03:27:15.223922Z","caller":"traceutil/trace.go:171","msg":"trace[911259223] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"182.047457ms","start":"2026-04-28T03:27:15.041854Z","end":"2026-04-28T03:27:15.223902Z","steps":["trace[911259223] 'process raft request' (duration: 73.551325ms)","trace[911259223] 'compare' (duration: 108.227425ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:27:15.438399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.605729ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T03:27:15.438847Z","caller":"traceutil/trace.go:171","msg":"trace[489326430] linearizableReadLoop","detail":"{readStateIndex:1271; appliedIndex:1265; }","duration":"345.454895ms","start":"2026-04-28T03:27:15.093372Z","end":"2026-04-28T03:27:15.438826Z","steps":["trace[489326430] 'read index received' (duration: 22.077417ms)","trace[489326430] 'applied index is now lower than readState.Index' (duration: 323.376158ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:27:15.438916Z","caller":"traceutil/trace.go:171","msg":"trace[1837563671] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"375.634515ms","start":"2026-04-28T03:27:15.063266Z","end":"2026-04-28T03:27:15.4389Z","steps":["trace[1837563671] 'process raft request' (duration: 268.436722ms)","trace[1837563671] 'compare' (duration: 106.463786ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:27:15.439052Z","caller":"traceutil/trace.go:171","msg":"trace[663473797] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"374.363286ms","start":"2026-04-28T03:27:15.064682Z","end":"2026-04-28T03:27:15.439045Z","steps":["trace[663473797] 'process raft request' (duration: 374.009728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:15.439836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:15.06464Z","time spent":"375.163465ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T03:27:15.439081Z","caller":"traceutil/trace.go:171","msg":"trace[397034417] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"375.532413ms","start":"2026-04-28T03:27:15.063544Z","end":"2026-04-28T03:27:15.439077Z","steps":["trace[397034417] 'process raft request' (duration: 375.049482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:15.439994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:15.063532Z","time spent":"376.441773ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T03:27:15.43911Z","caller":"traceutil/trace.go:171","msg":"trace[965621401] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"373.726791ms","start":"2026-04-28T03:27:15.065377Z","end":"2026-04-28T03:27:15.439104Z","steps":["trace[965621401] 'process raft request' (duration: 373.352943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:15.440102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:15.065368Z","time spent":"374.716424ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T03:27:15.439139Z","caller":"traceutil/trace.go:171","msg":"trace[1405760092] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"371.558923ms","start":"2026-04-28T03:27:15.067574Z","end":"2026-04-28T03:27:15.439133Z","steps":["trace[1405760092] 'process raft request' (duration: 371.185284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:15.440289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:15.067565Z","time spent":"372.698589ms","remote":"127.0.0.1:39630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T03:27:15.439216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.891385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:27:15.440427Z","caller":"traceutil/trace.go:171","msg":"trace[2073094111] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1221; }","duration":"347.164494ms","start":"2026-04-28T03:27:15.093252Z","end":"2026-04-28T03:27:15.440417Z","steps":["trace[2073094111] 'agreement among raft nodes before linearized reading' (duration: 345.912285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:15.440451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:15.093208Z","time spent":"347.235406ms","remote":"127.0.0.1:60834","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-28T03:27:15.440675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:15.063246Z","time spent":"376.236418ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:27:16.099263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.85152ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T03:27:16.099343Z","caller":"traceutil/trace.go:171","msg":"trace[247838500] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"650.87247ms","start":"2026-04-28T03:27:15.448457Z","end":"2026-04-28T03:27:16.099329Z","steps":["trace[247838500] 'process raft request' (duration: 405.905467ms)","trace[247838500] 'compare' (duration: 244.473552ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:27:16.099378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:15.448447Z","time spent":"650.918111ms","remote":"127.0.0.1:39630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T03:27:16.102318Z","caller":"traceutil/trace.go:171","msg":"trace[234333497] linearizableReadLoop","detail":"{readStateIndex:1274; appliedIndex:1272; }","duration":"308.126925ms","start":"2026-04-28T03:27:15.79418Z","end":"2026-04-28T03:27:16.102307Z","steps":["trace[234333497] 'read index received' (duration: 60.179045ms)","trace[234333497] 'applied index is now lower than readState.Index' (duration: 247.94718ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:27:16.102382Z","caller":"traceutil/trace.go:171","msg":"trace[101637618] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"583.012573ms","start":"2026-04-28T03:27:15.519363Z","end":"2026-04-28T03:27:16.102376Z","steps":["trace[101637618] 'process raft request' (duration: 582.88675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:16.102432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:15.519343Z","time spent":"583.057803ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:27:16.102565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.383991ms","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-28T03:27:16.102599Z","caller":"traceutil/trace.go:171","msg":"trace[1603435754] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1224; }","duration":"308.450972ms","start":"2026-04-28T03:27:15.79414Z","end":"2026-04-28T03:27:16.102591Z","steps":["trace[1603435754] 'agreement among raft nodes before linearized reading' (duration: 308.393321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:16.102645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:15.794124Z","time spent":"308.513533ms","remote":"127.0.0.1:38628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:27:16.102843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.742912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:27:16.102872Z","caller":"traceutil/trace.go:171","msg":"trace[1476584837] 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:1224; }","duration":"257.798593ms","start":"2026-04-28T03:27:15.845067Z","end":"2026-04-28T03:27:16.102866Z","steps":["trace[1476584837] 'agreement among raft nodes before linearized reading' (duration: 257.357993ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:27:16.555326Z","caller":"traceutil/trace.go:171","msg":"trace[1667585569] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"138.807255ms","start":"2026-04-28T03:27:16.416497Z","end":"2026-04-28T03:27:16.555304Z","steps":["trace[1667585569] 'process raft request' (duration: 138.644661ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:27:16.588716Z","caller":"traceutil/trace.go:171","msg":"trace[1408110982] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"144.853861ms","start":"2026-04-28T03:27:16.443831Z","end":"2026-04-28T03:27:16.588684Z","steps":["trace[1408110982] 'process raft request' (duration: 144.658617ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:26.944194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.231597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T03:27:26.944274Z","caller":"traceutil/trace.go:171","msg":"trace[1716674593] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1309; }","duration":"581.36375ms","start":"2026-04-28T03:27:26.362893Z","end":"2026-04-28T03:27:26.944256Z","steps":["trace[1716674593] 'count revisions from in-memory index tree' (duration: 581.148404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:26.944346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:26.362873Z","time spent":"581.459501ms","remote":"127.0.0.1:39974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-04-28T03:27:26.946359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.530602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T03:27:26.947034Z","caller":"traceutil/trace.go:171","msg":"trace[1365909170] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1309; }","duration":"350.244038ms","start":"2026-04-28T03:27:26.596764Z","end":"2026-04-28T03:27:26.947008Z","steps":["trace[1365909170] 'range keys from in-memory index tree' (duration: 347.282712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:26.947104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:26.596745Z","time spent":"350.333369ms","remote":"127.0.0.1:39800","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-28T03:27:26.946913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.305161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-28T03:27:26.947409Z","caller":"traceutil/trace.go:171","msg":"trace[1358312081] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1309; }","duration":"524.44549ms","start":"2026-04-28T03:27:26.422951Z","end":"2026-04-28T03:27:26.947396Z","steps":["trace[1358312081] 'range keys from in-memory index tree' (duration: 521.136217ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:26.947495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:27:26.422938Z","time spent":"524.537993ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-28T03:27:57.32787Z","caller":"traceutil/trace.go:171","msg":"trace[59806827] linearizableReadLoop","detail":"{readStateIndex:1507; appliedIndex:1506; }","duration":"220.430133ms","start":"2026-04-28T03:27:57.107415Z","end":"2026-04-28T03:27:57.327845Z","steps":["trace[59806827] 'read index received' (duration: 220.341951ms)","trace[59806827] 'applied index is now lower than readState.Index' (duration: 86.982µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:27:57.328014Z","caller":"traceutil/trace.go:171","msg":"trace[1508553508] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"222.021009ms","start":"2026-04-28T03:27:57.105962Z","end":"2026-04-28T03:27:57.327983Z","steps":["trace[1508553508] 'process raft request' (duration: 221.720413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:57.328096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.665928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:27:57.32813Z","caller":"traceutil/trace.go:171","msg":"trace[1874929087] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1449; }","duration":"220.7444ms","start":"2026-04-28T03:27:57.107376Z","end":"2026-04-28T03:27:57.32812Z","steps":["trace[1874929087] 'agreement among raft nodes before linearized reading' (duration: 220.614707ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:27:57.332887Z","caller":"traceutil/trace.go:171","msg":"trace[1093084464] transaction","detail":"{read_only:false; response_revision:1450; number_of_response:1; }","duration":"136.634896ms","start":"2026-04-28T03:27:57.196224Z","end":"2026-04-28T03:27:57.332859Z","steps":["trace[1093084464] 'process raft request' (duration: 136.509683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:27:57.332937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.40675ms","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-28T03:27:57.332924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.027828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T03:27:57.332963Z","caller":"traceutil/trace.go:171","msg":"trace[1837766462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1450; }","duration":"149.454151ms","start":"2026-04-28T03:27:57.183502Z","end":"2026-04-28T03:27:57.332956Z","steps":["trace[1837766462] 'agreement among raft nodes before linearized reading' (duration: 149.365879ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:27:57.332993Z","caller":"traceutil/trace.go:171","msg":"trace[1421293366] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1450; }","duration":"195.12301ms","start":"2026-04-28T03:27:57.137853Z","end":"2026-04-28T03:27:57.332976Z","steps":["trace[1421293366] 'agreement among raft nodes before linearized reading' (duration: 194.964476ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:27:59.635158Z","caller":"traceutil/trace.go:171","msg":"trace[174497092] transaction","detail":"{read_only:false; response_revision:1462; number_of_response:1; }","duration":"156.152461ms","start":"2026-04-28T03:27:59.478978Z","end":"2026-04-28T03:27:59.635131Z","steps":["trace[174497092] 'process raft request' (duration: 85.485106ms)","trace[174497092] 'compare' (duration: 70.559963ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:27:59.980571Z","caller":"traceutil/trace.go:171","msg":"trace[3369122] transaction","detail":"{read_only:false; response_revision:1466; number_of_response:1; }","duration":"146.804423ms","start":"2026-04-28T03:27:59.833739Z","end":"2026-04-28T03:27:59.980543Z","steps":["trace[3369122] 'process raft request' (duration: 146.761242ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:27:59.981177Z","caller":"traceutil/trace.go:171","msg":"trace[488663694] transaction","detail":"{read_only:false; response_revision:1464; number_of_response:1; }","duration":"149.592904ms","start":"2026-04-28T03:27:59.83157Z","end":"2026-04-28T03:27:59.981163Z","steps":["trace[488663694] 'process raft request' (duration: 145.880152ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:27:59.981444Z","caller":"traceutil/trace.go:171","msg":"trace[355039422] transaction","detail":"{read_only:false; response_revision:1465; number_of_response:1; }","duration":"149.227717ms","start":"2026-04-28T03:27:59.832199Z","end":"2026-04-28T03:27:59.981427Z","steps":["trace[355039422] 'process raft request' (duration: 148.244414ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:29:50.551321Z","caller":"traceutil/trace.go:171","msg":"trace[761526868] transaction","detail":"{read_only:false; response_revision:1970; number_of_response:1; }","duration":"103.50805ms","start":"2026-04-28T03:29:50.44779Z","end":"2026-04-28T03:29:50.551298Z","steps":["trace[761526868] 'process raft request' (duration: 58.016809ms)","trace[761526868] 'compare' (duration: 45.341888ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:29:50.551322Z","caller":"traceutil/trace.go:171","msg":"trace[2109958170] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"102.989777ms","start":"2026-04-28T03:29:50.448319Z","end":"2026-04-28T03:29:50.551309Z","steps":["trace[2109958170] 'process raft request' (duration: 102.937326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:29:50.790948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.349976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T03:29:50.791034Z","caller":"traceutil/trace.go:171","msg":"trace[1258563813] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1974; }","duration":"112.54408ms","start":"2026-04-28T03:29:50.678467Z","end":"2026-04-28T03:29:50.791011Z","steps":["trace[1258563813] 'count revisions from in-memory index tree' (duration: 112.189283ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:30:32.984819Z","caller":"traceutil/trace.go:171","msg":"trace[1161366394] linearizableReadLoop","detail":"{readStateIndex:2280; appliedIndex:2279; }","duration":"170.939308ms","start":"2026-04-28T03:30:32.813856Z","end":"2026-04-28T03:30:32.984795Z","steps":["trace[1161366394] 'read index received' (duration: 170.809965ms)","trace[1161366394] 'applied index is now lower than readState.Index' (duration: 128.503µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:30:32.984855Z","caller":"traceutil/trace.go:171","msg":"trace[1341088767] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"172.820181ms","start":"2026-04-28T03:30:32.81201Z","end":"2026-04-28T03:30:32.98483Z","steps":["trace[1341088767] 'process raft request' (duration: 172.637607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:30:32.98503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.789381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-28T03:30:32.985068Z","caller":"traceutil/trace.go:171","msg":"trace[2038062484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2189; }","duration":"168.879493ms","start":"2026-04-28T03:30:32.81618Z","end":"2026-04-28T03:30:32.985059Z","steps":["trace[2038062484] 'agreement among raft nodes before linearized reading' (duration: 168.7353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:30:32.985115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.078625ms","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-28T03:30:32.985031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.157204ms","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-28T03:30:32.985145Z","caller":"traceutil/trace.go:171","msg":"trace[743504834] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2189; }","duration":"168.125865ms","start":"2026-04-28T03:30:32.81701Z","end":"2026-04-28T03:30:32.985136Z","steps":["trace[743504834] 'agreement among raft nodes before linearized reading' (duration: 168.053794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:30:32.985135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.69033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-28T03:30:32.985179Z","caller":"traceutil/trace.go:171","msg":"trace[2049380296] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2189; }","duration":"171.308006ms","start":"2026-04-28T03:30:32.81383Z","end":"2026-04-28T03:30:32.985138Z","steps":["trace[2049380296] 'agreement among raft nodes before linearized reading' (duration: 171.071381ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:30:32.985195Z","caller":"traceutil/trace.go:171","msg":"trace[1176067277] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2189; }","duration":"160.786272ms","start":"2026-04-28T03:30:32.824394Z","end":"2026-04-28T03:30:32.98518Z","steps":["trace[1176067277] 'agreement among raft nodes before linearized reading' (duration: 160.587498ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:30:38.768114Z","caller":"traceutil/trace.go:171","msg":"trace[104347843] linearizableReadLoop","detail":"{readStateIndex:2310; appliedIndex:2309; }","duration":"279.882329ms","start":"2026-04-28T03:30:38.488206Z","end":"2026-04-28T03:30:38.768089Z","steps":["trace[104347843] 'read index received' (duration: 279.694725ms)","trace[104347843] 'applied index is now lower than readState.Index' (duration: 186.234µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:30:38.768255Z","caller":"traceutil/trace.go:171","msg":"trace[2124501688] transaction","detail":"{read_only:false; response_revision:2218; number_of_response:1; }","duration":"492.699488ms","start":"2026-04-28T03:30:38.275524Z","end":"2026-04-28T03:30:38.768223Z","steps":["trace[2124501688] 'process raft request' (duration: 492.437512ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:30:38.768421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T03:30:38.275514Z","time spent":"492.81593ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T03:30:38.7685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.239976ms","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-28T03:30:38.768547Z","caller":"traceutil/trace.go:171","msg":"trace[1547500033] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2218; }","duration":"280.36407ms","start":"2026-04-28T03:30:38.488172Z","end":"2026-04-28T03:30:38.768536Z","steps":["trace[1547500033] 'agreement among raft nodes before linearized reading' (duration: 280.050393ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:31:55.370679Z","caller":"traceutil/trace.go:171","msg":"trace[241561169] transaction","detail":"{read_only:false; response_revision:2578; number_of_response:1; }","duration":"101.631999ms","start":"2026-04-28T03:31:55.269022Z","end":"2026-04-28T03:31:55.370654Z","steps":["trace[241561169] 'process raft request' (duration: 33.292938ms)","trace[241561169] 'compare' (duration: 68.229699ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:31:56.404327Z","caller":"traceutil/trace.go:171","msg":"trace[1930919171] transaction","detail":"{read_only:false; response_revision:2584; number_of_response:1; }","duration":"127.743752ms","start":"2026-04-28T03:31:56.276557Z","end":"2026-04-28T03:31:56.404301Z","steps":["trace[1930919171] 'process raft request' (duration: 127.572818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:31:57.661272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.168781ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T03:31:57.661524Z","caller":"traceutil/trace.go:171","msg":"trace[1558193721] transaction","detail":"{read_only:false; response_revision:2589; number_of_response:1; }","duration":"165.849042ms","start":"2026-04-28T03:31:57.495654Z","end":"2026-04-28T03:31:57.661503Z","steps":["trace[1558193721] 'process raft request' (duration: 17.356014ms)","trace[1558193721] 'compare' (duration: 147.974037ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:31:57.674004Z","caller":"traceutil/trace.go:171","msg":"trace[1746627554] transaction","detail":"{read_only:false; response_revision:2591; number_of_response:1; }","duration":"177.622706ms","start":"2026-04-28T03:31:57.496362Z","end":"2026-04-28T03:31:57.673985Z","steps":["trace[1746627554] 'process raft request' (duration: 177.579925ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:31:57.674069Z","caller":"traceutil/trace.go:171","msg":"trace[1019110442] transaction","detail":"{read_only:false; response_revision:2590; number_of_response:1; }","duration":"177.956733ms","start":"2026-04-28T03:31:57.496085Z","end":"2026-04-28T03:31:57.674042Z","steps":["trace[1019110442] 'process raft request' (duration: 177.757659ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:31:57.750571Z","caller":"traceutil/trace.go:171","msg":"trace[989474268] linearizableReadLoop","detail":"{readStateIndex:2699; appliedIndex:2696; }","duration":"161.677493ms","start":"2026-04-28T03:31:57.588881Z","end":"2026-04-28T03:31:57.750558Z","steps":["trace[989474268] 'read index received' (duration: 84.95359ms)","trace[989474268] 'applied index is now lower than readState.Index' (duration: 76.722403ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:31:57.750679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.777135ms","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-28T03:31:57.750719Z","caller":"traceutil/trace.go:171","msg":"trace[1689578451] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:2591; }","duration":"161.866377ms","start":"2026-04-28T03:31:57.588845Z","end":"2026-04-28T03:31:57.750711Z","steps":["trace[1689578451] 'agreement among raft nodes before linearized reading' (duration: 161.784616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:31:59.81509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.772224ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T03:31:59.815174Z","caller":"traceutil/trace.go:171","msg":"trace[2117584595] linearizableReadLoop","detail":"{readStateIndex:2705; appliedIndex:2704; }","duration":"149.628394ms","start":"2026-04-28T03:31:59.665532Z","end":"2026-04-28T03:31:59.815161Z","steps":["trace[2117584595] 'read index received' (duration: 49.251µs)","trace[2117584595] 'applied index is now lower than readState.Index' (duration: 149.578193ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T03:31:59.815275Z","caller":"traceutil/trace.go:171","msg":"trace[1178607067] transaction","detail":"{read_only:false; response_revision:2597; number_of_response:1; }","duration":"296.870864ms","start":"2026-04-28T03:31:59.518378Z","end":"2026-04-28T03:31:59.815249Z","steps":["trace[1178607067] 'process raft request' (duration: 95.858244ms)","trace[1178607067] 'compare' (duration: 200.666522ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:31:59.815403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.701064ms","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-28T03:31:59.815418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.333128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-28T03:31:59.81549Z","caller":"traceutil/trace.go:171","msg":"trace[1411605508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2597; }","duration":"137.44851ms","start":"2026-04-28T03:31:59.678026Z","end":"2026-04-28T03:31:59.815475Z","steps":["trace[1411605508] 'agreement among raft nodes before linearized reading' (duration: 137.247126ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:31:59.815426Z","caller":"traceutil/trace.go:171","msg":"trace[880721356] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2597; }","duration":"136.752236ms","start":"2026-04-28T03:31:59.678668Z","end":"2026-04-28T03:31:59.81542Z","steps":["trace[880721356] 'agreement among raft nodes before linearized reading' (duration: 136.687255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T03:31:59.815652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.105743ms","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:533"} {"level":"info","ts":"2026-04-28T03:31:59.815776Z","caller":"traceutil/trace.go:171","msg":"trace[339269954] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2597; }","duration":"150.288677ms","start":"2026-04-28T03:31:59.665464Z","end":"2026-04-28T03:31:59.815753Z","steps":["trace[339269954] 'agreement among raft nodes before linearized reading' (duration: 149.836547ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:31:59.961886Z","caller":"traceutil/trace.go:171","msg":"trace[726825618] transaction","detail":"{read_only:false; response_revision:2599; number_of_response:1; }","duration":"141.679972ms","start":"2026-04-28T03:31:59.820175Z","end":"2026-04-28T03:31:59.961855Z","steps":["trace[726825618] 'process raft request' (duration: 137.328118ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:31:59.96202Z","caller":"traceutil/trace.go:171","msg":"trace[353942830] transaction","detail":"{read_only:false; response_revision:2600; number_of_response:1; }","duration":"141.106369ms","start":"2026-04-28T03:31:59.820801Z","end":"2026-04-28T03:31:59.961907Z","steps":["trace[353942830] 'process raft request' (duration: 140.835984ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T03:32:02.040925Z","caller":"traceutil/trace.go:171","msg":"trace[893013941] transaction","detail":"{read_only:false; response_revision:2607; number_of_response:1; }","duration":"120.788392ms","start":"2026-04-28T03:32:01.920106Z","end":"2026-04-28T03:32:02.040895Z","steps":["trace[893013941] 'process raft request' (duration: 57.57705ms)","trace[893013941] 'compare' (duration: 63.07819ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T03:32:07.799342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.621925ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"}