{"level":"warn","ts":"2026-05-06T05:05:12.112492Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-06T05:05:12.112615Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.67:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.67:2380","--initial-cluster=instance=https://199.19.213.67:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.67:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.67:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-06T05:05:12.1127Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-06T05:05:12.112715Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.67:2380"]} {"level":"info","ts":"2026-05-06T05:05:12.112739Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-06T05:05:12.113768Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.67:2379"]} {"level":"info","ts":"2026-05-06T05:05:12.113894Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.67:2380"],"listen-peer-urls":["https://199.19.213.67:2380"],"advertise-client-urls":["https://199.19.213.67:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.67:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.67:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-06T05:05:12.119218Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.030659ms"} {"level":"info","ts":"2026-05-06T05:05:12.127493Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fba6d6d8cd5f215c","cluster-id":"f3c660457a1c2c72"} {"level":"info","ts":"2026-05-06T05:05:12.127885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c switched to configuration voters=()"} {"level":"info","ts":"2026-05-06T05:05:12.127929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c became follower at term 0"} {"level":"info","ts":"2026-05-06T05:05:12.127956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fba6d6d8cd5f215c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-06T05:05:12.127975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c became follower at term 1"} {"level":"info","ts":"2026-05-06T05:05:12.128126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c switched to configuration voters=(18133417176300724572)"} {"level":"warn","ts":"2026-05-06T05:05:12.137709Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-06T05:05:12.140311Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-06T05:05:12.144485Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-06T05:05:12.147946Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fba6d6d8cd5f215c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-06T05:05:12.148446Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fba6d6d8cd5f215c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-06T05:05:12.149384Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-06T05:05:12.15063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c switched to configuration voters=(18133417176300724572)"} {"level":"info","ts":"2026-05-06T05:05:12.150865Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f3c660457a1c2c72","local-member-id":"fba6d6d8cd5f215c","added-peer-id":"fba6d6d8cd5f215c","added-peer-peer-urls":["https://199.19.213.67:2380"]} {"level":"info","ts":"2026-05-06T05:05:12.149516Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-06T05:05:12.151072Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-06T05:05:12.154554Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-06T05:05:12.15483Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.67:2380"} {"level":"info","ts":"2026-05-06T05:05:12.154848Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fba6d6d8cd5f215c","initial-advertise-peer-urls":["https://199.19.213.67:2380"],"listen-peer-urls":["https://199.19.213.67:2380"],"advertise-client-urls":["https://199.19.213.67:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.67:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-06T05:05:12.154907Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-06T05:05:12.154888Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.67:2380"} {"level":"info","ts":"2026-05-06T05:05:12.728966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c is starting a new election at term 1"} {"level":"info","ts":"2026-05-06T05:05:12.729038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c became pre-candidate at term 1"} {"level":"info","ts":"2026-05-06T05:05:12.729076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c received MsgPreVoteResp from fba6d6d8cd5f215c at term 1"} {"level":"info","ts":"2026-05-06T05:05:12.729095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c became candidate at term 2"} {"level":"info","ts":"2026-05-06T05:05:12.729106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c received MsgVoteResp from fba6d6d8cd5f215c at term 2"} {"level":"info","ts":"2026-05-06T05:05:12.729122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c became leader at term 2"} {"level":"info","ts":"2026-05-06T05:05:12.729142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fba6d6d8cd5f215c elected leader fba6d6d8cd5f215c at term 2"} {"level":"info","ts":"2026-05-06T05:05:12.73017Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T05:05:12.731992Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f3c660457a1c2c72","local-member-id":"fba6d6d8cd5f215c","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T05:05:12.732093Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T05:05:12.732125Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T05:05:12.732163Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fba6d6d8cd5f215c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.67:2379]}","request-path":"/0/members/fba6d6d8cd5f215c/attributes","cluster-id":"f3c660457a1c2c72","publish-timeout":"7s"} {"level":"info","ts":"2026-05-06T05:05:12.735574Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T05:05:12.736686Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T05:05:12.736904Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-06T05:05:12.73692Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-06T05:05:12.739017Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-06T05:05:12.741316Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.67:2379"} {"level":"info","ts":"2026-05-06T05:05:14.382135Z","caller":"traceutil/trace.go:171","msg":"trace[1054171745] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"315.656455ms","start":"2026-05-06T05:05:14.066446Z","end":"2026-05-06T05:05:14.382103Z","steps":["trace[1054171745] 'read index received' (duration: 315.44434ms)","trace[1054171745] 'applied index is now lower than readState.Index' (duration: 210.945µs)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:05:14.38239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.016386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T05:05:14.382492Z","caller":"traceutil/trace.go:171","msg":"trace[1180045008] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:2; }","duration":"319.16573ms","start":"2026-05-06T05:05:14.063306Z","end":"2026-05-06T05:05:14.382472Z","steps":["trace[1180045008] 'agreement among raft nodes before linearized reading' (duration: 318.880763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:14.382552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:14.062967Z","time spent":"319.572119ms","remote":"127.0.0.1:33222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":28,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-05-06T05:05:14.382698Z","caller":"traceutil/trace.go:171","msg":"trace[1971472869] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"318.533164ms","start":"2026-05-06T05:05:14.063602Z","end":"2026-05-06T05:05:14.382135Z","steps":["trace[1971472869] 'process raft request' (duration: 318.251667ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:14.383685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:14.063589Z","time spent":"319.2236ms","remote":"127.0.0.1:33216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:05:14.391734Z","caller":"traceutil/trace.go:171","msg":"trace[757848025] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"251.800505ms","start":"2026-05-06T05:05:14.139883Z","end":"2026-05-06T05:05:14.391684Z","steps":["trace[757848025] 'process raft request' (duration: 251.60462ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:14.391822Z","caller":"traceutil/trace.go:171","msg":"trace[192633374] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"249.145911ms","start":"2026-05-06T05:05:14.14267Z","end":"2026-05-06T05:05:14.391815Z","steps":["trace[192633374] 'process raft request' (duration: 248.975827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:14.391929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.596138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T05:05:14.391882Z","caller":"traceutil/trace.go:171","msg":"trace[2052881565] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"249.327026ms","start":"2026-05-06T05:05:14.142432Z","end":"2026-05-06T05:05:14.391759Z","steps":["trace[2052881565] 'process raft request' (duration: 249.178152ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:14.392004Z","caller":"traceutil/trace.go:171","msg":"trace[1599622654] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"316.858734ms","start":"2026-05-06T05:05:14.075132Z","end":"2026-05-06T05:05:14.39199Z","steps":["trace[1599622654] 'agreement among raft nodes before linearized reading' (duration: 316.67006ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:14.392039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.730229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T05:05:14.392132Z","caller":"traceutil/trace.go:171","msg":"trace[81155651] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"197.882883ms","start":"2026-05-06T05:05:14.194229Z","end":"2026-05-06T05:05:14.392111Z","steps":["trace[81155651] 'agreement among raft nodes before linearized reading' (duration: 197.707569ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:14.392187Z","caller":"traceutil/trace.go:171","msg":"trace[1795503848] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"248.671701ms","start":"2026-05-06T05:05:14.143506Z","end":"2026-05-06T05:05:14.392178Z","steps":["trace[1795503848] 'process raft request' (duration: 248.182509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:14.392196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.007827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T05:05:14.392271Z","caller":"traceutil/trace.go:171","msg":"trace[1951941800] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"248.6271ms","start":"2026-05-06T05:05:14.143636Z","end":"2026-05-06T05:05:14.392264Z","steps":["trace[1951941800] 'process raft request' (duration: 248.078707ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:14.392272Z","caller":"traceutil/trace.go:171","msg":"trace[832125985] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"251.082739ms","start":"2026-05-06T05:05:14.141179Z","end":"2026-05-06T05:05:14.392262Z","steps":["trace[832125985] 'agreement among raft nodes before linearized reading' (duration: 250.964216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:14.392372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.536139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T05:05:14.392385Z","caller":"traceutil/trace.go:171","msg":"trace[459559696] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"245.129616ms","start":"2026-05-06T05:05:14.147243Z","end":"2026-05-06T05:05:14.392373Z","steps":["trace[459559696] 'process raft request' (duration: 244.489001ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:14.392407Z","caller":"traceutil/trace.go:171","msg":"trace[248014946] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"251.590911ms","start":"2026-05-06T05:05:14.140803Z","end":"2026-05-06T05:05:14.392394Z","steps":["trace[248014946] 'agreement among raft nodes before linearized reading' (duration: 251.519789ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:14.392505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.717246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-06T05:05:14.392634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.683818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T05:05:14.392649Z","caller":"traceutil/trace.go:171","msg":"trace[605171052] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"234.125141ms","start":"2026-05-06T05:05:14.158513Z","end":"2026-05-06T05:05:14.392638Z","steps":["trace[605171052] 'process raft request' (duration: 233.248571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:14.39263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.015683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-06T05:05:14.392083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:14.07512Z","time spent":"316.950686ms","remote":"127.0.0.1:33504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-05-06T05:05:14.39272Z","caller":"traceutil/trace.go:171","msg":"trace[1330038574] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"278.144556ms","start":"2026-05-06T05:05:14.114562Z","end":"2026-05-06T05:05:14.392707Z","steps":["trace[1330038574] 'agreement among raft nodes before linearized reading' (duration: 277.997513ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:14.392672Z","caller":"traceutil/trace.go:171","msg":"trace[78675625] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"278.713139ms","start":"2026-05-06T05:05:14.113942Z","end":"2026-05-06T05:05:14.392656Z","steps":["trace[78675625] 'agreement among raft nodes before linearized reading' (duration: 278.667238ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:14.39265Z","caller":"traceutil/trace.go:171","msg":"trace[230980594] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"277.944781ms","start":"2026-05-06T05:05:14.114664Z","end":"2026-05-06T05:05:14.392609Z","steps":["trace[230980594] 'agreement among raft nodes before linearized reading' (duration: 277.632673ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:14.392504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.742402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.67\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T05:05:14.392983Z","caller":"traceutil/trace.go:171","msg":"trace[925850863] range","detail":"{range_begin:/registry/masterleases/199.19.213.67; range_end:; response_count:0; response_revision:10; }","duration":"254.227164ms","start":"2026-05-06T05:05:14.138723Z","end":"2026-05-06T05:05:14.39295Z","steps":["trace[925850863] 'agreement among raft nodes before linearized reading' (duration: 253.63365ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:14.391767Z","caller":"traceutil/trace.go:171","msg":"trace[1702466868] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"248.763902ms","start":"2026-05-06T05:05:14.142982Z","end":"2026-05-06T05:05:14.391745Z","steps":["trace[1702466868] 'process raft request' (duration: 248.685531ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:39.885303Z","caller":"traceutil/trace.go:171","msg":"trace[1087281232] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"222.754088ms","start":"2026-05-06T05:05:39.662518Z","end":"2026-05-06T05:05:39.885272Z","steps":["trace[1087281232] 'process raft request' (duration: 222.572844ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:40.165761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.15361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-06T05:05:40.165844Z","caller":"traceutil/trace.go:171","msg":"trace[372455415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:426; }","duration":"173.247592ms","start":"2026-05-06T05:05:39.992577Z","end":"2026-05-06T05:05:40.165825Z","steps":["trace[372455415] 'range keys from in-memory index tree' (duration: 173.030347ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:45.788578Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2403970005373797414,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-06T05:05:45.844294Z","caller":"traceutil/trace.go:171","msg":"trace[1583542232] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"645.645863ms","start":"2026-05-06T05:05:45.198611Z","end":"2026-05-06T05:05:45.844256Z","steps":["trace[1583542232] 'process raft request' (duration: 645.383667ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:45.844775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:45.198593Z","time spent":"645.992112ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T05:05:45.854835Z","caller":"traceutil/trace.go:171","msg":"trace[845069487] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"654.676151ms","start":"2026-05-06T05:05:45.200107Z","end":"2026-05-06T05:05:45.854783Z","steps":["trace[845069487] 'process raft request' (duration: 654.505637ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:45.854904Z","caller":"traceutil/trace.go:171","msg":"trace[1275853733] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"654.589889ms","start":"2026-05-06T05:05:45.200286Z","end":"2026-05-06T05:05:45.854876Z","steps":["trace[1275853733] 'process raft request' (duration: 654.455096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:45.854946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:45.200091Z","time spent":"654.794233ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T05:05:45.855031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:45.200245Z","time spent":"654.722292ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T05:05:45.855076Z","caller":"traceutil/trace.go:171","msg":"trace[956808986] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"630.837319ms","start":"2026-05-06T05:05:45.224218Z","end":"2026-05-06T05:05:45.855055Z","steps":["trace[956808986] 'process raft request' (duration: 630.715216ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:45.855052Z","caller":"traceutil/trace.go:171","msg":"trace[683656336] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"631.083305ms","start":"2026-05-06T05:05:45.223908Z","end":"2026-05-06T05:05:45.854992Z","steps":["trace[683656336] 'process raft request' (duration: 630.963902ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:45.855134Z","caller":"traceutil/trace.go:171","msg":"trace[294652514] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"631.057534ms","start":"2026-05-06T05:05:45.224008Z","end":"2026-05-06T05:05:45.855065Z","steps":["trace[294652514] 'process raft request' (duration: 630.89533ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:45.855273Z","caller":"traceutil/trace.go:171","msg":"trace[179904781] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"567.889791ms","start":"2026-05-06T05:05:45.287373Z","end":"2026-05-06T05:05:45.855262Z","steps":["trace[179904781] 'process raft request' (duration: 567.754158ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:45.855314Z","caller":"traceutil/trace.go:171","msg":"trace[904314129] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"627.715204ms","start":"2026-05-06T05:05:45.227551Z","end":"2026-05-06T05:05:45.855266Z","steps":["trace[904314129] 'process raft request' (duration: 627.405807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:45.855341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:45.287362Z","time spent":"567.947172ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:05:45.855255Z","caller":"traceutil/trace.go:171","msg":"trace[1277863494] linearizableReadLoop","detail":"{readStateIndex:501; appliedIndex:488; }","duration":"567.114061ms","start":"2026-05-06T05:05:45.288117Z","end":"2026-05-06T05:05:45.855231Z","steps":["trace[1277863494] 'read index received' (duration: 556.050506ms)","trace[1277863494] 'applied index is now lower than readState.Index' (duration: 11.062885ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:05:45.855406Z","caller":"traceutil/trace.go:171","msg":"trace[487580105] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"608.3461ms","start":"2026-05-06T05:05:45.247054Z","end":"2026-05-06T05:05:45.8554Z","steps":["trace[487580105] 'process raft request' (duration: 607.93397ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:45.855432Z","caller":"traceutil/trace.go:171","msg":"trace[1591809119] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"479.724868ms","start":"2026-05-06T05:05:45.375698Z","end":"2026-05-06T05:05:45.855422Z","steps":["trace[1591809119] 'process raft request' (duration: 479.489192ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:45.855458Z","caller":"traceutil/trace.go:171","msg":"trace[335143223] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"607.856488ms","start":"2026-05-06T05:05:45.247596Z","end":"2026-05-06T05:05:45.855452Z","steps":["trace[335143223] 'process raft request' (duration: 607.428708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:45.855483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:45.24759Z","time spent":"607.881989ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T05:05:45.855465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:45.223999Z","time spent":"631.29274ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T05:05:45.855509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:45.37568Z","time spent":"479.789619ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T05:05:45.855362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:45.22754Z","time spent":"627.800666ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T05:05:45.855402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.266965ms","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-05-06T05:05:45.855246Z","caller":"traceutil/trace.go:171","msg":"trace[853658846] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"580.168574ms","start":"2026-05-06T05:05:45.275069Z","end":"2026-05-06T05:05:45.855237Z","steps":["trace[853658846] 'process raft request' (duration: 580.008631ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:45.855685Z","caller":"traceutil/trace.go:171","msg":"trace[1694640100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:483; }","duration":"567.574653ms","start":"2026-05-06T05:05:45.288102Z","end":"2026-05-06T05:05:45.855676Z","steps":["trace[1694640100] 'agreement among raft nodes before linearized reading' (duration: 567.233055ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:45.855712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:45.288095Z","time spent":"567.610333ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-06T05:05:45.855717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:45.275036Z","time spent":"580.661356ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T05:05:45.855435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:45.247039Z","time spent":"608.384871ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T05:05:45.856011Z","caller":"traceutil/trace.go:171","msg":"trace[1906860828] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"643.075873ms","start":"2026-05-06T05:05:45.21197Z","end":"2026-05-06T05:05:45.855046Z","steps":["trace[1906860828] 'process raft request' (duration: 642.801886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:45.856123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:45.211948Z","time spent":"644.139297ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T05:05:45.855181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:45.224212Z","time spent":"630.932311ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T05:05:45.856381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:45.223883Z","time spent":"631.350481ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T05:05:49.267677Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2403970005373797553,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-06T05:05:49.545201Z","caller":"traceutil/trace.go:171","msg":"trace[1928692621] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:580; }","duration":"777.967915ms","start":"2026-05-06T05:05:48.767173Z","end":"2026-05-06T05:05:49.545141Z","steps":["trace[1928692621] 'read index received' (duration: 771.48955ms)","trace[1928692621] 'applied index is now lower than readState.Index' (duration: 6.477535ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:05:49.545263Z","caller":"traceutil/trace.go:171","msg":"trace[1824314450] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"800.659839ms","start":"2026-05-06T05:05:48.744569Z","end":"2026-05-06T05:05:49.545228Z","steps":["trace[1824314450] 'process raft request' (duration: 799.257756ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:49.545375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:48.744502Z","time spent":"800.817963ms","remote":"127.0.0.1:33236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T05:05:49.545453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.275012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-06T05:05:49.545486Z","caller":"traceutil/trace.go:171","msg":"trace[1557434328] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:559; }","duration":"778.398035ms","start":"2026-05-06T05:05:48.767079Z","end":"2026-05-06T05:05:49.545477Z","steps":["trace[1557434328] 'agreement among raft nodes before linearized reading' (duration: 778.19001ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:49.545529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:48.767054Z","time spent":"778.469116ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-06T05:05:52.941478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.799417ms","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":"warn","ts":"2026-05-06T05:05:52.941561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.062977ms","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-05-06T05:05:52.941567Z","caller":"traceutil/trace.go:171","msg":"trace[1224211395] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"534.92416ms","start":"2026-05-06T05:05:52.406627Z","end":"2026-05-06T05:05:52.941551Z","steps":["trace[1224211395] 'range keys from in-memory index tree' (duration: 534.762027ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:52.941566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.439675ms","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-05-06T05:05:52.941532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.221449ms","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-05-06T05:05:52.941546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.311463ms","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-05-06T05:05:52.941604Z","caller":"traceutil/trace.go:171","msg":"trace[1999778789] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"566.116578ms","start":"2026-05-06T05:05:52.375472Z","end":"2026-05-06T05:05:52.941589Z","steps":["trace[1999778789] 'range keys from in-memory index tree' (duration: 566.008206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:52.941609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.406623Z","time spent":"534.976821ms","remote":"127.0.0.1:53304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"info","ts":"2026-05-06T05:05:52.94162Z","caller":"traceutil/trace.go:171","msg":"trace[910332439] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:580; }","duration":"606.518746ms","start":"2026-05-06T05:05:52.33508Z","end":"2026-05-06T05:05:52.941598Z","steps":["trace[910332439] 'count revisions from in-memory index tree' (duration: 606.398794ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:52.941641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.37541Z","time spent":"566.221661ms","remote":"127.0.0.1:53304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-05-06T05:05:52.941645Z","caller":"traceutil/trace.go:171","msg":"trace[1090465421] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:580; }","duration":"624.430776ms","start":"2026-05-06T05:05:52.317193Z","end":"2026-05-06T05:05:52.941624Z","steps":["trace[1090465421] 'count revisions from in-memory index tree' (duration: 624.275672ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:52.941638Z","caller":"traceutil/trace.go:171","msg":"trace[488869799] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:580; }","duration":"606.411854ms","start":"2026-05-06T05:05:52.335203Z","end":"2026-05-06T05:05:52.941615Z","steps":["trace[488869799] 'range keys from in-memory index tree' (duration: 606.070156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:52.941656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.335059Z","time spent":"606.588238ms","remote":"127.0.0.1:53290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-06T05:05:52.941696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.317191Z","time spent":"624.493857ms","remote":"127.0.0.1:53288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-06T05:05:52.941696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.335177Z","time spent":"606.506966ms","remote":"127.0.0.1:53290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-06T05:05:52.941748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.351313ms","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-05-06T05:05:52.941496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.65525ms","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":"warn","ts":"2026-05-06T05:05:52.941831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.33678ms","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-05-06T05:05:52.941853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.430742ms","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-05-06T05:05:52.941867Z","caller":"traceutil/trace.go:171","msg":"trace[1807911229] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"535.385351ms","start":"2026-05-06T05:05:52.406472Z","end":"2026-05-06T05:05:52.941857Z","steps":["trace[1807911229] 'count revisions from in-memory index tree' (duration: 535.303289ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:52.941894Z","caller":"traceutil/trace.go:171","msg":"trace[329428322] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"535.500964ms","start":"2026-05-06T05:05:52.406379Z","end":"2026-05-06T05:05:52.94188Z","steps":["trace[329428322] 'range keys from in-memory index tree' (duration: 535.290818ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:52.9419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.406468Z","time spent":"535.424142ms","remote":"127.0.0.1:53312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-06T05:05:52.94193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.406357Z","time spent":"535.564526ms","remote":"127.0.0.1:53312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-05-06T05:05:52.941787Z","caller":"traceutil/trace.go:171","msg":"trace[946121302] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"566.413735ms","start":"2026-05-06T05:05:52.375363Z","end":"2026-05-06T05:05:52.941777Z","steps":["trace[946121302] 'count revisions from in-memory index tree' (duration: 566.273651ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:52.941987Z","caller":"traceutil/trace.go:171","msg":"trace[273826682] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:580; }","duration":"607.07983ms","start":"2026-05-06T05:05:52.334778Z","end":"2026-05-06T05:05:52.941857Z","steps":["trace[273826682] 'range keys from in-memory index tree' (duration: 606.551728ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:52.942153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.375351Z","time spent":"566.663421ms","remote":"127.0.0.1:53304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-06T05:05:52.94148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.315073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T05:05:52.942217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.334753Z","time spent":"607.377446ms","remote":"127.0.0.1:53290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"info","ts":"2026-05-06T05:05:52.942328Z","caller":"traceutil/trace.go:171","msg":"trace[522843300] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:580; }","duration":"625.116842ms","start":"2026-05-06T05:05:52.317107Z","end":"2026-05-06T05:05:52.942224Z","steps":["trace[522843300] 'range keys from in-memory index tree' (duration: 624.20271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:52.942441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.317086Z","time spent":"625.303617ms","remote":"127.0.0.1:53288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-06T05:05:52.969647Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2403970005373797623,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-06T05:05:53.001668Z","caller":"traceutil/trace.go:171","msg":"trace[622459852] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"532.331028ms","start":"2026-05-06T05:05:52.469306Z","end":"2026-05-06T05:05:53.001637Z","steps":["trace[622459852] 'read index received' (duration: 531.415307ms)","trace[622459852] 'applied index is now lower than readState.Index' (duration: 914.591µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:05:53.001761Z","caller":"traceutil/trace.go:171","msg":"trace[823460364] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"553.333501ms","start":"2026-05-06T05:05:52.448397Z","end":"2026-05-06T05:05:53.00173Z","steps":["trace[823460364] 'process raft request' (duration: 552.626534ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.00188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.541873ms","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":"warn","ts":"2026-05-06T05:05:53.001879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.477652ms","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-05-06T05:05:53.001933Z","caller":"traceutil/trace.go:171","msg":"trace[451962285] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:581; }","duration":"532.611265ms","start":"2026-05-06T05:05:52.469301Z","end":"2026-05-06T05:05:53.001912Z","steps":["trace[451962285] 'agreement among raft nodes before linearized reading' (duration: 532.482922ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:53.001948Z","caller":"traceutil/trace.go:171","msg":"trace[723796517] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:581; }","duration":"532.579524ms","start":"2026-05-06T05:05:52.469357Z","end":"2026-05-06T05:05:53.001937Z","steps":["trace[723796517] 'agreement among raft nodes before linearized reading' (duration: 532.453591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.001981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.469279Z","time spent":"532.680676ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-06T05:05:53.00203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.633268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.002051Z","caller":"traceutil/trace.go:171","msg":"trace[1611384715] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:581; }","duration":"278.682179ms","start":"2026-05-06T05:05:52.723362Z","end":"2026-05-06T05:05:53.002044Z","steps":["trace[1611384715] 'agreement among raft nodes before linearized reading' (duration: 278.648008ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.002102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.448364Z","time spent":"553.571917ms","remote":"127.0.0.1:33236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:05:53.001974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.469352Z","time spent":"532.614545ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-06T05:05:53.002085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.922713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T05:05:53.002225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.892363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.002273Z","caller":"traceutil/trace.go:171","msg":"trace[999162074] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:581; }","duration":"278.997556ms","start":"2026-05-06T05:05:52.723268Z","end":"2026-05-06T05:05:53.002266Z","steps":["trace[999162074] 'agreement among raft nodes before linearized reading' (duration: 278.935755ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:53.002272Z","caller":"traceutil/trace.go:171","msg":"trace[1846502712] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:581; }","duration":"246.144318ms","start":"2026-05-06T05:05:52.756113Z","end":"2026-05-06T05:05:53.002257Z","steps":["trace[1846502712] 'agreement among raft nodes before linearized reading' (duration: 245.895952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.002408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.260927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.002434Z","caller":"traceutil/trace.go:171","msg":"trace[794800473] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:581; }","duration":"280.335909ms","start":"2026-05-06T05:05:52.722091Z","end":"2026-05-06T05:05:53.002427Z","steps":["trace[794800473] 'agreement among raft nodes before linearized reading' (duration: 280.276568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.002491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.258076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.002545Z","caller":"traceutil/trace.go:171","msg":"trace[1150503452] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:581; }","duration":"449.328249ms","start":"2026-05-06T05:05:52.553206Z","end":"2026-05-06T05:05:53.002535Z","steps":["trace[1150503452] 'agreement among raft nodes before linearized reading' (duration: 449.245677ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.002543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.150896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.002583Z","caller":"traceutil/trace.go:171","msg":"trace[1673680887] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:581; }","duration":"472.222928ms","start":"2026-05-06T05:05:52.530353Z","end":"2026-05-06T05:05:53.002576Z","steps":["trace[1673680887] 'agreement among raft nodes before linearized reading' (duration: 472.170416ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.002586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.553199Z","time spent":"449.37662ms","remote":"127.0.0.1:53358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-06T05:05:53.002609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.53033Z","time spent":"472.271609ms","remote":"127.0.0.1:53344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-06T05:05:53.002749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.756191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.002775Z","caller":"traceutil/trace.go:171","msg":"trace[73134383] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:581; }","duration":"472.803502ms","start":"2026-05-06T05:05:52.529965Z","end":"2026-05-06T05:05:53.002768Z","steps":["trace[73134383] 'agreement among raft nodes before linearized reading' (duration: 472.762901ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.002816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.529953Z","time spent":"472.855973ms","remote":"127.0.0.1:53344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-06T05:05:53.002867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.964687ms","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-05-06T05:05:53.002974Z","caller":"traceutil/trace.go:171","msg":"trace[1142121373] 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":"133.10252ms","start":"2026-05-06T05:05:52.869833Z","end":"2026-05-06T05:05:53.002936Z","steps":["trace[1142121373] 'agreement among raft nodes before linearized reading' (duration: 132.939176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.002999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.524978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zz4vh\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-06T05:05:53.003021Z","caller":"traceutil/trace.go:171","msg":"trace[1605311031] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zz4vh; range_end:; response_count:1; response_revision:581; }","duration":"473.55961ms","start":"2026-05-06T05:05:52.529455Z","end":"2026-05-06T05:05:53.003014Z","steps":["trace[1605311031] 'agreement among raft nodes before linearized reading' (duration: 473.455198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.003008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.406937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T05:05:53.003063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.529448Z","time spent":"473.609981ms","remote":"127.0.0.1:33318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-zz4vh\" "} {"level":"info","ts":"2026-05-06T05:05:53.003112Z","caller":"traceutil/trace.go:171","msg":"trace[2044039576] 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":"133.4963ms","start":"2026-05-06T05:05:52.869566Z","end":"2026-05-06T05:05:53.003062Z","steps":["trace[2044039576] 'agreement among raft nodes before linearized reading' (duration: 133.379397ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.003215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.461179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.00324Z","caller":"traceutil/trace.go:171","msg":"trace[615858944] 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:581; }","duration":"506.497509ms","start":"2026-05-06T05:05:52.496737Z","end":"2026-05-06T05:05:53.003234Z","steps":["trace[615858944] 'agreement among raft nodes before linearized reading' (duration: 506.439838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.00326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.496732Z","time spent":"506.52255ms","remote":"127.0.0.1:53338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-05-06T05:05:53.003397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.599563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T05:05:53.003475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.584045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.003447Z","caller":"traceutil/trace.go:171","msg":"trace[1720123117] 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":"161.658535ms","start":"2026-05-06T05:05:52.841774Z","end":"2026-05-06T05:05:53.003433Z","steps":["trace[1720123117] 'agreement among raft nodes before linearized reading' (duration: 161.587173ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:53.003499Z","caller":"traceutil/trace.go:171","msg":"trace[227874352] 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:581; }","duration":"507.643356ms","start":"2026-05-06T05:05:52.49585Z","end":"2026-05-06T05:05:53.003493Z","steps":["trace[227874352] 'agreement among raft nodes before linearized reading' (duration: 507.579885ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.00354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.495831Z","time spent":"507.683617ms","remote":"127.0.0.1:53338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-05-06T05:05:53.003655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.142572ms","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-05-06T05:05:53.0037Z","caller":"traceutil/trace.go:171","msg":"trace[1277077284] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:581; }","duration":"534.189673ms","start":"2026-05-06T05:05:52.469504Z","end":"2026-05-06T05:05:53.003693Z","steps":["trace[1277077284] 'agreement among raft nodes before linearized reading' (duration: 534.130492ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.003646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.225273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.003763Z","caller":"traceutil/trace.go:171","msg":"trace[1451753457] 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":"133.371827ms","start":"2026-05-06T05:05:52.870378Z","end":"2026-05-06T05:05:53.00375Z","steps":["trace[1451753457] 'agreement among raft nodes before linearized reading' (duration: 133.228194ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.003806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.032093ms","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-05-06T05:05:53.003884Z","caller":"traceutil/trace.go:171","msg":"trace[706440109] 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":"162.096954ms","start":"2026-05-06T05:05:52.841742Z","end":"2026-05-06T05:05:53.003839Z","steps":["trace[706440109] 'agreement among raft nodes before linearized reading' (duration: 161.955261ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.003727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.469499Z","time spent":"534.221394ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-06T05:05:53.004094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.272304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.0042Z","caller":"traceutil/trace.go:171","msg":"trace[2127896723] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:581; }","duration":"196.410748ms","start":"2026-05-06T05:05:52.807776Z","end":"2026-05-06T05:05:53.004187Z","steps":["trace[2127896723] 'agreement among raft nodes before linearized reading' (duration: 196.280245ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.004308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.132164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.004338Z","caller":"traceutil/trace.go:171","msg":"trace[210748110] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:581; }","duration":"197.177295ms","start":"2026-05-06T05:05:52.807154Z","end":"2026-05-06T05:05:53.004331Z","steps":["trace[210748110] 'agreement among raft nodes before linearized reading' (duration: 197.128304ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.004437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.509833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.00446Z","caller":"traceutil/trace.go:171","msg":"trace[542430493] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:581; }","duration":"197.565995ms","start":"2026-05-06T05:05:52.806888Z","end":"2026-05-06T05:05:53.004454Z","steps":["trace[542430493] 'agreement among raft nodes before linearized reading' (duration: 197.514794ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.003417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.504803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T05:05:53.004612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.396132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T05:05:53.004701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.540858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T05:05:53.00482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.686171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.004822Z","caller":"traceutil/trace.go:171","msg":"trace[1444684277] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:581; }","duration":"296.67227ms","start":"2026-05-06T05:05:52.708117Z","end":"2026-05-06T05:05:53.00479Z","steps":["trace[1444684277] 'agreement among raft nodes before linearized reading' (duration: 296.553277ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:53.004854Z","caller":"traceutil/trace.go:171","msg":"trace[1805526962] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:581; }","duration":"450.751253ms","start":"2026-05-06T05:05:52.554096Z","end":"2026-05-06T05:05:53.004847Z","steps":["trace[1805526962] 'agreement among raft nodes before linearized reading' (duration: 450.700322ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.004858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.805968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T05:05:53.004932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.131426ms","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-05-06T05:05:53.004955Z","caller":"traceutil/trace.go:171","msg":"trace[1749860916] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:581; }","duration":"247.919211ms","start":"2026-05-06T05:05:52.757024Z","end":"2026-05-06T05:05:53.004943Z","steps":["trace[1749860916] 'agreement among raft nodes before linearized reading' (duration: 247.760228ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:53.004979Z","caller":"traceutil/trace.go:171","msg":"trace[317793849] 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:581; }","duration":"432.193038ms","start":"2026-05-06T05:05:52.57278Z","end":"2026-05-06T05:05:53.004973Z","steps":["trace[317793849] 'agreement among raft nodes before linearized reading' (duration: 432.137337ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.005001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.572768Z","time spent":"432.225979ms","remote":"127.0.0.1:53374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-06T05:05:53.004904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.554084Z","time spent":"450.811894ms","remote":"127.0.0.1:53344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-05-06T05:05:53.00469Z","caller":"traceutil/trace.go:171","msg":"trace[1459367827] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:581; }","duration":"248.491284ms","start":"2026-05-06T05:05:52.756186Z","end":"2026-05-06T05:05:53.004677Z","steps":["trace[1459367827] 'agreement among raft nodes before linearized reading' (duration: 248.287999ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:53.004619Z","caller":"traceutil/trace.go:171","msg":"trace[2109232178] 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:581; }","duration":"508.702452ms","start":"2026-05-06T05:05:52.495904Z","end":"2026-05-06T05:05:53.004606Z","steps":["trace[2109232178] 'agreement among raft nodes before linearized reading' (duration: 507.492903ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.004715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.557888ms","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-05-06T05:05:53.005247Z","caller":"traceutil/trace.go:171","msg":"trace[704873182] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:581; }","duration":"297.133181ms","start":"2026-05-06T05:05:52.708106Z","end":"2026-05-06T05:05:53.005239Z","steps":["trace[704873182] 'agreement among raft nodes before linearized reading' (duration: 296.582558ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.005286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.031003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T05:05:53.00509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.585213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.005379Z","caller":"traceutil/trace.go:171","msg":"trace[405469345] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:581; }","duration":"452.134566ms","start":"2026-05-06T05:05:52.553209Z","end":"2026-05-06T05:05:53.005344Z","steps":["trace[405469345] 'agreement among raft nodes before linearized reading' (duration: 452.005513ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:53.005407Z","caller":"traceutil/trace.go:171","msg":"trace[1213102903] 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:581; }","duration":"431.920361ms","start":"2026-05-06T05:05:52.573478Z","end":"2026-05-06T05:05:53.005398Z","steps":["trace[1213102903] 'agreement among raft nodes before linearized reading' (duration: 431.566493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.005255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.495893Z","time spent":"509.326456ms","remote":"127.0.0.1:53338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-05-06T05:05:53.005459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.573475Z","time spent":"431.973803ms","remote":"127.0.0.1:53374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-06T05:05:53.005452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.055936ms","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-05-06T05:05:53.005421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.553191Z","time spent":"452.216488ms","remote":"127.0.0.1:53358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-06T05:05:53.004608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.744228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:53.005507Z","caller":"traceutil/trace.go:171","msg":"trace[1089193816] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:581; }","duration":"296.137058ms","start":"2026-05-06T05:05:52.709359Z","end":"2026-05-06T05:05:53.005496Z","steps":["trace[1089193816] 'agreement among raft nodes before linearized reading' (duration: 293.370221ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:53.00554Z","caller":"traceutil/trace.go:171","msg":"trace[1661419306] 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:581; }","duration":"432.716981ms","start":"2026-05-06T05:05:52.572809Z","end":"2026-05-06T05:05:53.005526Z","steps":["trace[1661419306] 'agreement among raft nodes before linearized reading' (duration: 431.725747ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:53.005597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:52.572807Z","time spent":"432.766132ms","remote":"127.0.0.1:53374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-06T05:05:53.532751Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2403970005373797626,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-06T05:05:54.079784Z","caller":"traceutil/trace.go:171","msg":"trace[147380056] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:604; }","duration":"1.047908186s","start":"2026-05-06T05:05:53.031846Z","end":"2026-05-06T05:05:54.079754Z","steps":["trace[147380056] 'read index received' (duration: 997.503448ms)","trace[147380056] 'applied index is now lower than readState.Index' (duration: 50.403048ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:05:54.080216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.048332676s","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-05-06T05:05:54.080319Z","caller":"traceutil/trace.go:171","msg":"trace[1867729358] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"1.04849367s","start":"2026-05-06T05:05:53.03181Z","end":"2026-05-06T05:05:54.080304Z","steps":["trace[1867729358] 'agreement among raft nodes before linearized reading' (duration: 1.048336506s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:54.080403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:53.03179Z","time spent":"1.048595022s","remote":"127.0.0.1:53472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-06T05:05:54.080473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.028456579s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:54.080453Z","caller":"traceutil/trace.go:171","msg":"trace[290046844] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"1.050879167s","start":"2026-05-06T05:05:53.029532Z","end":"2026-05-06T05:05:54.080412Z","steps":["trace[290046844] 'process raft request' (duration: 999.802793ms)","trace[290046844] 'compare' (duration: 50.190683ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:05:54.080516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.320839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:54.080588Z","caller":"traceutil/trace.go:171","msg":"trace[1056074163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"905.450832ms","start":"2026-05-06T05:05:53.175121Z","end":"2026-05-06T05:05:54.080571Z","steps":["trace[1056074163] 'agreement among raft nodes before linearized reading' (duration: 905.306609ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:54.080638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:53.175097Z","time spent":"905.532843ms","remote":"127.0.0.1:33154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-06T05:05:54.080638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.277129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-06T05:05:54.080642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.02892549s","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-05-06T05:05:54.080638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:53.029518Z","time spent":"1.05102225s","remote":"127.0.0.1:33318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:05:54.080613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.985739ms","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-05-06T05:05:54.080698Z","caller":"traceutil/trace.go:171","msg":"trace[506052487] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"1.029069344s","start":"2026-05-06T05:05:53.051618Z","end":"2026-05-06T05:05:54.080687Z","steps":["trace[506052487] 'agreement among raft nodes before linearized reading' (duration: 1.028999262s)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:54.080703Z","caller":"traceutil/trace.go:171","msg":"trace[106400155] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:583; }","duration":"109.370772ms","start":"2026-05-06T05:05:53.971311Z","end":"2026-05-06T05:05:54.080682Z","steps":["trace[106400155] 'agreement among raft nodes before linearized reading' (duration: 109.165737ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:54.080735Z","caller":"traceutil/trace.go:171","msg":"trace[1999022441] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:583; }","duration":"176.189213ms","start":"2026-05-06T05:05:53.904529Z","end":"2026-05-06T05:05:54.080718Z","steps":["trace[1999022441] 'agreement among raft nodes before linearized reading' (duration: 175.900697ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:54.080739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:53.051598Z","time spent":"1.029130436s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-06T05:05:54.080376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.048396397s","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-05-06T05:05:54.080958Z","caller":"traceutil/trace.go:171","msg":"trace[989585415] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"1.049024642s","start":"2026-05-06T05:05:53.031918Z","end":"2026-05-06T05:05:54.080943Z","steps":["trace[989585415] 'agreement among raft nodes before linearized reading' (duration: 1.048376926s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:54.081042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:53.031885Z","time spent":"1.049137185s","remote":"127.0.0.1:53472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-05-06T05:05:54.080096Z","caller":"traceutil/trace.go:171","msg":"trace[1307945616] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"1.003402349s","start":"2026-05-06T05:05:53.076655Z","end":"2026-05-06T05:05:54.080058Z","steps":["trace[1307945616] 'process raft request' (duration: 1.00304009s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:54.081253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:53.076631Z","time spent":"1.004548167s","remote":"127.0.0.1:33606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T05:05:54.080596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.028852869s","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-05-06T05:05:54.081475Z","caller":"traceutil/trace.go:171","msg":"trace[159631520] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"1.029730261s","start":"2026-05-06T05:05:53.051726Z","end":"2026-05-06T05:05:54.081456Z","steps":["trace[159631520] 'agreement among raft nodes before linearized reading' (duration: 1.028841859s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:54.081522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:53.051722Z","time spent":"1.029785932s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-05-06T05:05:54.080538Z","caller":"traceutil/trace.go:171","msg":"trace[1990806789] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"1.028518741s","start":"2026-05-06T05:05:53.051998Z","end":"2026-05-06T05:05:54.080517Z","steps":["trace[1990806789] 'agreement among raft nodes before linearized reading' (duration: 1.028443129s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:54.08169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:53.051994Z","time spent":"1.029676519s","remote":"127.0.0.1:53472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-05-06T05:05:54.080901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.188222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-06T05:05:54.081864Z","caller":"traceutil/trace.go:171","msg":"trace[66589755] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:583; }","duration":"507.194586ms","start":"2026-05-06T05:05:53.57466Z","end":"2026-05-06T05:05:54.081854Z","steps":["trace[66589755] 'agreement among raft nodes before linearized reading' (duration: 506.187721ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:54.081901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:53.574634Z","time spent":"507.258718ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-06T05:05:54.614747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.286918ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T05:05:54.614963Z","caller":"traceutil/trace.go:171","msg":"trace[801258736] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:606; }","duration":"521.718924ms","start":"2026-05-06T05:05:54.093227Z","end":"2026-05-06T05:05:54.614946Z","steps":["trace[801258736] 'read index received' (duration: 352.207582ms)","trace[801258736] 'applied index is now lower than readState.Index' (duration: 169.510222ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:05:54.615069Z","caller":"traceutil/trace.go:171","msg":"trace[1466337707] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"524.01845ms","start":"2026-05-06T05:05:54.091038Z","end":"2026-05-06T05:05:54.615057Z","steps":["trace[1466337707] 'process raft request' (duration: 354.168418ms)","trace[1466337707] 'compare' (duration: 169.151695ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:05:54.615106Z","caller":"traceutil/trace.go:171","msg":"trace[1126330247] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"523.472266ms","start":"2026-05-06T05:05:54.091613Z","end":"2026-05-06T05:05:54.615085Z","steps":["trace[1126330247] 'process raft request' (duration: 523.299872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:54.615137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:54.091011Z","time spent":"524.091062ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:05:54.615306Z","caller":"traceutil/trace.go:171","msg":"trace[1549307310] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"524.067471ms","start":"2026-05-06T05:05:54.091202Z","end":"2026-05-06T05:05:54.61527Z","steps":["trace[1549307310] 'process raft request' (duration: 523.659691ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:54.615331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:54.091585Z","time spent":"523.579019ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:05:54.615359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:54.091172Z","time spent":"524.157003ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:05:54.615496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.243797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:05:54.615584Z","caller":"traceutil/trace.go:171","msg":"trace[1018123305] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:586; }","duration":"522.37944ms","start":"2026-05-06T05:05:54.093185Z","end":"2026-05-06T05:05:54.615564Z","steps":["trace[1018123305] 'agreement among raft nodes before linearized reading' (duration: 522.244346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:54.615629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:54.093174Z","time spent":"522.446972ms","remote":"127.0.0.1:33362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-06T05:05:54.615782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.57495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-06T05:05:54.615885Z","caller":"traceutil/trace.go:171","msg":"trace[1490717825] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:586; }","duration":"342.730294ms","start":"2026-05-06T05:05:54.273142Z","end":"2026-05-06T05:05:54.615872Z","steps":["trace[1490717825] 'agreement among raft nodes before linearized reading' (duration: 342.087599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:54.615973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:54.273124Z","time spent":"342.837527ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-06T05:05:55.216677Z","caller":"traceutil/trace.go:171","msg":"trace[615570395] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"206.395396ms","start":"2026-05-06T05:05:55.010244Z","end":"2026-05-06T05:05:55.216639Z","steps":["trace[615570395] 'process raft request' (duration: 201.730674ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:57.024862Z","caller":"traceutil/trace.go:171","msg":"trace[399982718] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"266.049017ms","start":"2026-05-06T05:05:56.758777Z","end":"2026-05-06T05:05:57.024826Z","steps":["trace[399982718] 'process raft request' (duration: 265.906663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:59.862798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.095368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-05-06T05:05:59.862925Z","caller":"traceutil/trace.go:171","msg":"trace[1589121858] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:664; }","duration":"105.371345ms","start":"2026-05-06T05:05:59.757526Z","end":"2026-05-06T05:05:59.862898Z","steps":["trace[1589121858] 'range keys from in-memory index tree' (duration: 104.875363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:08.873666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.104888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-06T05:06:08.873802Z","caller":"traceutil/trace.go:171","msg":"trace[760861784] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:735; }","duration":"193.310193ms","start":"2026-05-06T05:06:08.680461Z","end":"2026-05-06T05:06:08.873771Z","steps":["trace[760861784] 'range keys from in-memory index tree' (duration: 192.847932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:08.873843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.19114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-06T05:06:08.873894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.148901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-06T05:06:08.873862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.388877ms","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-05-06T05:06:08.873933Z","caller":"traceutil/trace.go:171","msg":"trace[895681525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:735; }","duration":"193.352964ms","start":"2026-05-06T05:06:08.68056Z","end":"2026-05-06T05:06:08.873913Z","steps":["trace[895681525] 'range keys from in-memory index tree' (duration: 192.984075ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:08.873947Z","caller":"traceutil/trace.go:171","msg":"trace[125840249] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:735; }","duration":"191.201312ms","start":"2026-05-06T05:06:08.682731Z","end":"2026-05-06T05:06:08.873932Z","steps":["trace[125840249] 'range keys from in-memory index tree' (duration: 191.003767ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:08.873985Z","caller":"traceutil/trace.go:171","msg":"trace[610565540] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:735; }","duration":"181.578021ms","start":"2026-05-06T05:06:08.692373Z","end":"2026-05-06T05:06:08.873951Z","steps":["trace[610565540] 'range keys from in-memory index tree' (duration: 181.140811ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:08.873669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.847997ms","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-05-06T05:06:08.8741Z","caller":"traceutil/trace.go:171","msg":"trace[2104602306] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:735; }","duration":"411.332888ms","start":"2026-05-06T05:06:08.462746Z","end":"2026-05-06T05:06:08.874079Z","steps":["trace[2104602306] 'range keys from in-memory index tree' (duration: 410.641903ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:08.874164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:08.462715Z","time spent":"411.429061ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-06T05:06:11.220077Z","caller":"traceutil/trace.go:171","msg":"trace[1486945774] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"329.499719ms","start":"2026-05-06T05:06:10.89055Z","end":"2026-05-06T05:06:11.220049Z","steps":["trace[1486945774] 'process raft request' (duration: 329.315814ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:11.22032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:10.890534Z","time spent":"329.632772ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:06:11.248489Z","caller":"traceutil/trace.go:171","msg":"trace[713347483] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"357.257964ms","start":"2026-05-06T05:06:10.891216Z","end":"2026-05-06T05:06:11.248473Z","steps":["trace[713347483] 'process raft request' (duration: 357.031869ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:11.248631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:10.891206Z","time spent":"357.352676ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:06:11.249025Z","caller":"traceutil/trace.go:171","msg":"trace[1216607224] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"357.749666ms","start":"2026-05-06T05:06:10.891248Z","end":"2026-05-06T05:06:11.248997Z","steps":["trace[1216607224] 'process raft request' (duration: 357.150642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:11.249261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:10.891224Z","time spent":"357.9057ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:06:11.249138Z","caller":"traceutil/trace.go:171","msg":"trace[1033878782] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"356.668449ms","start":"2026-05-06T05:06:10.892434Z","end":"2026-05-06T05:06:11.249102Z","steps":["trace[1033878782] 'process raft request' (duration: 356.471705ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:11.24943Z","caller":"traceutil/trace.go:171","msg":"trace[139093176] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"356.924305ms","start":"2026-05-06T05:06:10.892432Z","end":"2026-05-06T05:06:11.249356Z","steps":["trace[139093176] 'process raft request' (duration: 356.568327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:11.24963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:10.892421Z","time spent":"357.07824ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:06:11.249687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:10.892408Z","time spent":"357.213063ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:06:11.492631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.564599ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-06T05:06:12.701682Z","caller":"traceutil/trace.go:171","msg":"trace[189354017] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"137.274351ms","start":"2026-05-06T05:06:12.564382Z","end":"2026-05-06T05:06:12.701657Z","steps":["trace[189354017] 'process raft request' (duration: 137.005035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:13.913394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.030794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-06T05:06:13.913486Z","caller":"traceutil/trace.go:171","msg":"trace[623143878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:754; }","duration":"660.169927ms","start":"2026-05-06T05:06:13.253294Z","end":"2026-05-06T05:06:13.913464Z","steps":["trace[623143878] 'range keys from in-memory index tree' (duration: 659.827749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:13.913533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:13.253287Z","time spent":"660.233738ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-06T05:06:13.913886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.447589ms","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-05-06T05:06:13.913971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.016947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-06T05:06:13.913976Z","caller":"traceutil/trace.go:171","msg":"trace[55329492] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:754; }","duration":"659.579142ms","start":"2026-05-06T05:06:13.254376Z","end":"2026-05-06T05:06:13.913955Z","steps":["trace[55329492] 'range keys from in-memory index tree' (duration: 658.976358ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:13.914007Z","caller":"traceutil/trace.go:171","msg":"trace[144548746] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:754; }","duration":"661.083589ms","start":"2026-05-06T05:06:13.252911Z","end":"2026-05-06T05:06:13.913995Z","steps":["trace[144548746] 'range keys from in-memory index tree' (duration: 660.912795ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:13.914005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.65649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-06T05:06:13.914037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:13.252895Z","time spent":"661.135619ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-06T05:06:13.914029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:13.254362Z","time spent":"659.652274ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-06T05:06:13.914042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.044907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:06:13.914068Z","caller":"traceutil/trace.go:171","msg":"trace[1491678800] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:754; }","duration":"688.768232ms","start":"2026-05-06T05:06:13.225287Z","end":"2026-05-06T05:06:13.914055Z","steps":["trace[1491678800] 'range keys from in-memory index tree' (duration: 688.501615ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:13.914114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:13.225262Z","time spent":"688.843944ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-06T05:06:13.914111Z","caller":"traceutil/trace.go:171","msg":"trace[1063737446] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:754; }","duration":"739.167941ms","start":"2026-05-06T05:06:13.174928Z","end":"2026-05-06T05:06:13.914096Z","steps":["trace[1063737446] 'range keys from in-memory index tree' (duration: 738.904074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:13.914171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:13.174896Z","time spent":"739.267823ms","remote":"127.0.0.1:33154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-06T05:06:13.913931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.780291ms","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-05-06T05:06:13.914285Z","caller":"traceutil/trace.go:171","msg":"trace[1353115541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:754; }","duration":"661.191731ms","start":"2026-05-06T05:06:13.25307Z","end":"2026-05-06T05:06:13.914261Z","steps":["trace[1353115541] 'range keys from in-memory index tree' (duration: 660.562817ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:13.914339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:13.253041Z","time spent":"661.284173ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-06T05:06:13.919408Z","caller":"traceutil/trace.go:171","msg":"trace[767802311] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"197.658098ms","start":"2026-05-06T05:06:13.721722Z","end":"2026-05-06T05:06:13.91938Z","steps":["trace[767802311] 'process raft request' (duration: 196.950191ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:17.848532Z","caller":"traceutil/trace.go:171","msg":"trace[1297363835] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"106.543225ms","start":"2026-05-06T05:06:17.741964Z","end":"2026-05-06T05:06:17.848507Z","steps":["trace[1297363835] 'process raft request' (duration: 106.410921ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:18.355549Z","caller":"traceutil/trace.go:171","msg":"trace[539267059] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"101.185765ms","start":"2026-05-06T05:06:18.254333Z","end":"2026-05-06T05:06:18.355519Z","steps":["trace[539267059] 'process raft request' (duration: 101.120944ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:18.355608Z","caller":"traceutil/trace.go:171","msg":"trace[454947051] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"102.565569ms","start":"2026-05-06T05:06:18.252988Z","end":"2026-05-06T05:06:18.355554Z","steps":["trace[454947051] 'process raft request' (duration: 77.066478ms)","trace[454947051] 'compare' (duration: 25.191454ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:06:19.013618Z","caller":"traceutil/trace.go:171","msg":"trace[1052622651] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"354.629252ms","start":"2026-05-06T05:06:18.658957Z","end":"2026-05-06T05:06:19.013586Z","steps":["trace[1052622651] 'process raft request' (duration: 354.432828ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:19.013817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:18.658942Z","time spent":"354.769135ms","remote":"127.0.0.1:33568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5601,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:06:19.033916Z","caller":"traceutil/trace.go:171","msg":"trace[1807172435] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"374.826556ms","start":"2026-05-06T05:06:18.659059Z","end":"2026-05-06T05:06:19.033885Z","steps":["trace[1807172435] 'process raft request' (duration: 374.515768ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:19.034091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:18.659027Z","time spent":"374.967139ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:06:19.03601Z","caller":"traceutil/trace.go:171","msg":"trace[959848394] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"275.882115ms","start":"2026-05-06T05:06:18.760106Z","end":"2026-05-06T05:06:19.035988Z","steps":["trace[959848394] 'process raft request' (duration: 274.192314ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:38.496399Z","caller":"traceutil/trace.go:171","msg":"trace[1411872479] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"339.595541ms","start":"2026-05-06T05:06:38.156786Z","end":"2026-05-06T05:06:38.496382Z","steps":["trace[1411872479] 'process raft request' (duration: 339.527429ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:38.496386Z","caller":"traceutil/trace.go:171","msg":"trace[1350048172] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"340.82661ms","start":"2026-05-06T05:06:38.155494Z","end":"2026-05-06T05:06:38.496321Z","steps":["trace[1350048172] 'process raft request' (duration: 340.503713ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:38.496592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:38.15677Z","time spent":"339.709004ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:06:38.496796Z","caller":"traceutil/trace.go:171","msg":"trace[2012679352] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"339.900738ms","start":"2026-05-06T05:06:38.156838Z","end":"2026-05-06T05:06:38.496739Z","steps":["trace[2012679352] 'process raft request' (duration: 339.511689ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:38.49683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:38.155438Z","time spent":"341.207159ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:06:38.496457Z","caller":"traceutil/trace.go:171","msg":"trace[36839782] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"339.97356ms","start":"2026-05-06T05:06:38.156423Z","end":"2026-05-06T05:06:38.496397Z","steps":["trace[36839782] 'process raft request' (duration: 339.746685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:38.497056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:38.156807Z","time spent":"340.134304ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:06:38.497235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:38.1564Z","time spent":"340.670908ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:06:44.693567Z","caller":"traceutil/trace.go:171","msg":"trace[1818217988] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"124.658058ms","start":"2026-05-06T05:06:44.568885Z","end":"2026-05-06T05:06:44.693543Z","steps":["trace[1818217988] 'process raft request' (duration: 124.434173ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:44.695467Z","caller":"traceutil/trace.go:171","msg":"trace[316869002] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"126.015551ms","start":"2026-05-06T05:06:44.569441Z","end":"2026-05-06T05:06:44.695457Z","steps":["trace[316869002] 'process raft request' (duration: 125.96074ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:51.01044Z","caller":"traceutil/trace.go:171","msg":"trace[210652626] linearizableReadLoop","detail":"{readStateIndex:1020; appliedIndex:1019; }","duration":"293.208228ms","start":"2026-05-06T05:06:50.717204Z","end":"2026-05-06T05:06:51.010412Z","steps":["trace[210652626] 'read index received' (duration: 265.106314ms)","trace[210652626] 'applied index is now lower than readState.Index' (duration: 28.101004ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:06:51.010508Z","caller":"traceutil/trace.go:171","msg":"trace[211025538] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"409.534388ms","start":"2026-05-06T05:06:50.600938Z","end":"2026-05-06T05:06:51.010473Z","steps":["trace[211025538] 'process raft request' (duration: 381.374723ms)","trace[211025538] 'compare' (duration: 27.935709ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:06:51.010681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:50.600918Z","time spent":"409.663051ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:06:51.010703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.479834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-06T05:06:51.010734Z","caller":"traceutil/trace.go:171","msg":"trace[196860186] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:981; }","duration":"293.572708ms","start":"2026-05-06T05:06:50.71715Z","end":"2026-05-06T05:06:51.010723Z","steps":["trace[196860186] 'agreement among raft nodes before linearized reading' (duration: 293.413233ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:51.010769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.693097ms","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-05-06T05:06:51.010872Z","caller":"traceutil/trace.go:171","msg":"trace[1674067591] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:981; }","duration":"292.84416ms","start":"2026-05-06T05:06:50.717998Z","end":"2026-05-06T05:06:51.010843Z","steps":["trace[1674067591] 'agreement among raft nodes before linearized reading' (duration: 292.602894ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:51.158552Z","caller":"traceutil/trace.go:171","msg":"trace[770264349] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"143.967101ms","start":"2026-05-06T05:06:51.014557Z","end":"2026-05-06T05:06:51.158524Z","steps":["trace[770264349] 'process raft request' (duration: 128.247954ms)","trace[770264349] 'compare' (duration: 15.532713ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:06:52.291769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.037907ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:06:52.29193Z","caller":"traceutil/trace.go:171","msg":"trace[1879520154] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:983; }","duration":"885.217421ms","start":"2026-05-06T05:06:51.406691Z","end":"2026-05-06T05:06:52.291908Z","steps":["trace[1879520154] 'range keys from in-memory index tree' (duration: 885.018776ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:52.800902Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2403970005373798456,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-06T05:06:52.955746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.415538ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-06T05:06:52.956209Z","caller":"traceutil/trace.go:171","msg":"trace[1019292330] linearizableReadLoop","detail":"{readStateIndex:1024; appliedIndex:1022; }","duration":"656.302633ms","start":"2026-05-06T05:06:52.299863Z","end":"2026-05-06T05:06:52.956166Z","steps":["trace[1019292330] 'read index received' (duration: 531.01515ms)","trace[1019292330] 'applied index is now lower than readState.Index' (duration: 125.285913ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:06:52.956513Z","caller":"traceutil/trace.go:171","msg":"trace[961077458] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"1.076090187s","start":"2026-05-06T05:06:51.880405Z","end":"2026-05-06T05:06:52.956495Z","steps":["trace[961077458] 'process raft request' (duration: 1.075455862s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:52.956668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:51.880342Z","time spent":"1.07621571s","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:06:52.956743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.374431ms","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-05-06T05:06:52.9568Z","caller":"traceutil/trace.go:171","msg":"trace[7985870] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:984; }","duration":"257.482403ms","start":"2026-05-06T05:06:52.699299Z","end":"2026-05-06T05:06:52.956782Z","steps":["trace[7985870] 'agreement among raft nodes before linearized reading' (duration: 257.274688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:52.95695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.062001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-06T05:06:52.957026Z","caller":"traceutil/trace.go:171","msg":"trace[1683544316] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:984; }","duration":"657.191314ms","start":"2026-05-06T05:06:52.299818Z","end":"2026-05-06T05:06:52.957009Z","steps":["trace[1683544316] 'agreement among raft nodes before linearized reading' (duration: 656.900847ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:52.95707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:52.299802Z","time spent":"657.261065ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-06T05:06:53.478608Z","caller":"traceutil/trace.go:171","msg":"trace[323512524] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"517.398493ms","start":"2026-05-06T05:06:52.961185Z","end":"2026-05-06T05:06:53.478584Z","steps":["trace[323512524] 'process raft request' (duration: 515.422776ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:53.478758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:52.961146Z","time spent":"517.533626ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:06:53.482257Z","caller":"traceutil/trace.go:171","msg":"trace[519340417] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"520.499488ms","start":"2026-05-06T05:06:52.961742Z","end":"2026-05-06T05:06:53.482241Z","steps":["trace[519340417] 'process raft request' (duration: 520.260633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:53.48241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:52.961719Z","time spent":"520.603201ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:06:53.482481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.537088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-06T05:06:53.482564Z","caller":"traceutil/trace.go:171","msg":"trace[938385428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:986; }","duration":"467.633531ms","start":"2026-05-06T05:06:53.014915Z","end":"2026-05-06T05:06:53.482549Z","steps":["trace[938385428] 'agreement among raft nodes before linearized reading' (duration: 467.401445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:53.482603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:53.014847Z","time spent":"467.748154ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-06T05:06:53.482177Z","caller":"traceutil/trace.go:171","msg":"trace[592086678] linearizableReadLoop","detail":"{readStateIndex:1026; appliedIndex:1024; }","duration":"467.214841ms","start":"2026-05-06T05:06:53.014931Z","end":"2026-05-06T05:06:53.482146Z","steps":["trace[592086678] 'read index received' (duration: 461.779871ms)","trace[592086678] 'applied index is now lower than readState.Index' (duration: 5.43399ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:06:53.482978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.550847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:06:53.483025Z","caller":"traceutil/trace.go:171","msg":"trace[1474855698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:986; }","duration":"308.635668ms","start":"2026-05-06T05:06:53.174375Z","end":"2026-05-06T05:06:53.48301Z","steps":["trace[1474855698] 'agreement among raft nodes before linearized reading' (duration: 308.563827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:53.483063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:53.174354Z","time spent":"308.701331ms","remote":"127.0.0.1:33154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-06T05:06:53.483307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.92637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-06T05:06:53.483429Z","caller":"traceutil/trace.go:171","msg":"trace[2083786560] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:986; }","duration":"320.167965ms","start":"2026-05-06T05:06:53.163238Z","end":"2026-05-06T05:06:53.483406Z","steps":["trace[2083786560] 'agreement among raft nodes before linearized reading' (duration: 319.754875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:53.483483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:53.16319Z","time spent":"320.281227ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-06T05:06:53.483562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.531049ms","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-05-06T05:06:53.483933Z","caller":"traceutil/trace.go:171","msg":"trace[1064286006] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:986; }","duration":"442.947959ms","start":"2026-05-06T05:06:53.040972Z","end":"2026-05-06T05:06:53.48392Z","steps":["trace[1064286006] 'agreement among raft nodes before linearized reading' (duration: 441.939465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:53.484112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:53.040939Z","time spent":"443.161094ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-06T05:06:55.730822Z","caller":"traceutil/trace.go:171","msg":"trace[1268680042] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"212.257928ms","start":"2026-05-06T05:06:55.518536Z","end":"2026-05-06T05:06:55.730794Z","steps":["trace[1268680042] 'process raft request' (duration: 212.208457ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:55.730869Z","caller":"traceutil/trace.go:171","msg":"trace[834564114] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"212.31675ms","start":"2026-05-06T05:06:55.518533Z","end":"2026-05-06T05:06:55.73085Z","steps":["trace[834564114] 'process raft request' (duration: 211.999822ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:03.761867Z","caller":"traceutil/trace.go:171","msg":"trace[1383202325] linearizableReadLoop","detail":"{readStateIndex:1060; appliedIndex:1059; }","duration":"130.766454ms","start":"2026-05-06T05:07:03.631078Z","end":"2026-05-06T05:07:03.761845Z","steps":["trace[1383202325] 'read index received' (duration: 130.535169ms)","trace[1383202325] 'applied index is now lower than readState.Index' (duration: 230.145µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:07:03.761891Z","caller":"traceutil/trace.go:171","msg":"trace[83870817] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"183.307434ms","start":"2026-05-06T05:07:03.578559Z","end":"2026-05-06T05:07:03.761866Z","steps":["trace[83870817] 'process raft request' (duration: 183.13878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:03.762052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.966358ms","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-05-06T05:07:03.762084Z","caller":"traceutil/trace.go:171","msg":"trace[1662324017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1018; }","duration":"131.04001ms","start":"2026-05-06T05:07:03.631035Z","end":"2026-05-06T05:07:03.762075Z","steps":["trace[1662324017] 'agreement among raft nodes before linearized reading' (duration: 130.913577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:03.762082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.909198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-06T05:07:03.762117Z","caller":"traceutil/trace.go:171","msg":"trace[532580484] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1018; }","duration":"120.967559ms","start":"2026-05-06T05:07:03.64114Z","end":"2026-05-06T05:07:03.762107Z","steps":["trace[532580484] 'agreement among raft nodes before linearized reading' (duration: 120.865567ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:05.148463Z","caller":"traceutil/trace.go:171","msg":"trace[1126355391] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"116.43157ms","start":"2026-05-06T05:07:05.032008Z","end":"2026-05-06T05:07:05.14844Z","steps":["trace[1126355391] 'process raft request' (duration: 116.047821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:05.445476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.827625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:07:05.445616Z","caller":"traceutil/trace.go:171","msg":"trace[1763066636] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1023; }","duration":"196.023129ms","start":"2026-05-06T05:07:05.249569Z","end":"2026-05-06T05:07:05.445592Z","steps":["trace[1763066636] 'count revisions from in-memory index tree' (duration: 195.752603ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:05.911445Z","caller":"traceutil/trace.go:171","msg":"trace[1876012155] linearizableReadLoop","detail":"{readStateIndex:1066; appliedIndex:1065; }","duration":"102.017257ms","start":"2026-05-06T05:07:05.809409Z","end":"2026-05-06T05:07:05.911426Z","steps":["trace[1876012155] 'read index received' (duration: 101.841823ms)","trace[1876012155] 'applied index is now lower than readState.Index' (duration: 174.474µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:07:05.911561Z","caller":"traceutil/trace.go:171","msg":"trace[1274166635] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"142.605869ms","start":"2026-05-06T05:07:05.768944Z","end":"2026-05-06T05:07:05.91155Z","steps":["trace[1274166635] 'process raft request' (duration: 142.335112ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:05.911744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.330114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.67\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-06T05:07:05.91177Z","caller":"traceutil/trace.go:171","msg":"trace[1132147097] range","detail":"{range_begin:/registry/masterleases/199.19.213.67; range_end:; response_count:1; response_revision:1024; }","duration":"102.395265ms","start":"2026-05-06T05:07:05.809368Z","end":"2026-05-06T05:07:05.911764Z","steps":["trace[1132147097] 'agreement among raft nodes before linearized reading' (duration: 102.299673ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:06.073869Z","caller":"traceutil/trace.go:171","msg":"trace[112945777] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"128.744337ms","start":"2026-05-06T05:07:05.945103Z","end":"2026-05-06T05:07:06.073847Z","steps":["trace[112945777] 'process raft request' (duration: 128.701076ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:06.074156Z","caller":"traceutil/trace.go:171","msg":"trace[1850171542] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"158.114611ms","start":"2026-05-06T05:07:05.916004Z","end":"2026-05-06T05:07:06.074119Z","steps":["trace[1850171542] 'process raft request' (duration: 157.68878ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:06.074177Z","caller":"traceutil/trace.go:171","msg":"trace[1614013685] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"157.789054ms","start":"2026-05-06T05:07:05.916353Z","end":"2026-05-06T05:07:06.074142Z","steps":["trace[1614013685] 'process raft request' (duration: 157.411155ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:06.074217Z","caller":"traceutil/trace.go:171","msg":"trace[608536761] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"158.180353ms","start":"2026-05-06T05:07:05.916012Z","end":"2026-05-06T05:07:06.074193Z","steps":["trace[608536761] 'process raft request' (duration: 157.720952ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:06.074384Z","caller":"traceutil/trace.go:171","msg":"trace[1756639010] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"158.565862ms","start":"2026-05-06T05:07:05.915801Z","end":"2026-05-06T05:07:06.074367Z","steps":["trace[1756639010] 'process raft request' (duration: 65.249454ms)","trace[1756639010] 'compare' (duration: 92.533129ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:07:07.272907Z","caller":"traceutil/trace.go:171","msg":"trace[1872161499] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"119.956846ms","start":"2026-05-06T05:07:07.152922Z","end":"2026-05-06T05:07:07.272879Z","steps":["trace[1872161499] 'process raft request' (duration: 119.623327ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:08.250928Z","caller":"traceutil/trace.go:171","msg":"trace[287389124] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"166.247206ms","start":"2026-05-06T05:07:08.084659Z","end":"2026-05-06T05:07:08.250906Z","steps":["trace[287389124] 'process raft request' (duration: 166.140504ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:08.250927Z","caller":"traceutil/trace.go:171","msg":"trace[746672645] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"167.125516ms","start":"2026-05-06T05:07:08.083774Z","end":"2026-05-06T05:07:08.250899Z","steps":["trace[746672645] 'process raft request' (duration: 166.902181ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:08.251072Z","caller":"traceutil/trace.go:171","msg":"trace[846654914] linearizableReadLoop","detail":"{readStateIndex:1079; appliedIndex:1076; }","duration":"129.30871ms","start":"2026-05-06T05:07:08.121746Z","end":"2026-05-06T05:07:08.251055Z","steps":["trace[846654914] 'read index received' (duration: 128.917791ms)","trace[846654914] 'applied index is now lower than readState.Index' (duration: 390.079µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:07:08.251115Z","caller":"traceutil/trace.go:171","msg":"trace[2014362516] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"166.298637ms","start":"2026-05-06T05:07:08.084807Z","end":"2026-05-06T05:07:08.251106Z","steps":["trace[2014362516] 'process raft request' (duration: 166.069932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:08.251211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.444263ms","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":"info","ts":"2026-05-06T05:07:08.251259Z","caller":"traceutil/trace.go:171","msg":"trace[1174772214] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1036; }","duration":"129.542965ms","start":"2026-05-06T05:07:08.121701Z","end":"2026-05-06T05:07:08.251244Z","steps":["trace[1174772214] 'agreement among raft nodes before linearized reading' (duration: 129.420782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:14.340471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.84322ms","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-05-06T05:07:14.340565Z","caller":"traceutil/trace.go:171","msg":"trace[60252500] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1051; }","duration":"176.997843ms","start":"2026-05-06T05:07:14.163547Z","end":"2026-05-06T05:07:14.340545Z","steps":["trace[60252500] 'range keys from in-memory index tree' (duration: 176.624334ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:14.340602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.046507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:07:14.34067Z","caller":"traceutil/trace.go:171","msg":"trace[1628777135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1051; }","duration":"165.17094ms","start":"2026-05-06T05:07:14.175482Z","end":"2026-05-06T05:07:14.340653Z","steps":["trace[1628777135] 'range keys from in-memory index tree' (duration: 164.936174ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:14.535645Z","caller":"traceutil/trace.go:171","msg":"trace[550672681] linearizableReadLoop","detail":"{readStateIndex:1096; appliedIndex:1095; }","duration":"171.898718ms","start":"2026-05-06T05:07:14.363724Z","end":"2026-05-06T05:07:14.535623Z","steps":["trace[550672681] 'read index received' (duration: 171.707744ms)","trace[550672681] 'applied index is now lower than readState.Index' (duration: 190.124µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:07:14.535767Z","caller":"traceutil/trace.go:171","msg":"trace[1461688139] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"190.480104ms","start":"2026-05-06T05:07:14.345276Z","end":"2026-05-06T05:07:14.535756Z","steps":["trace[1461688139] 'process raft request' (duration: 190.221418ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:14.536007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.766308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-06T05:07:14.5361Z","caller":"traceutil/trace.go:171","msg":"trace[1142738117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1052; }","duration":"164.892821ms","start":"2026-05-06T05:07:14.371186Z","end":"2026-05-06T05:07:14.536079Z","steps":["trace[1142738117] 'agreement among raft nodes before linearized reading' (duration: 164.602924ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:14.536348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.631124ms","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-05-06T05:07:14.53648Z","caller":"traceutil/trace.go:171","msg":"trace[2074014750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1052; }","duration":"164.812728ms","start":"2026-05-06T05:07:14.37164Z","end":"2026-05-06T05:07:14.536453Z","steps":["trace[2074014750] 'agreement among raft nodes before linearized reading' (duration: 164.394798ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:14.536353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.561974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-06T05:07:14.536648Z","caller":"traceutil/trace.go:171","msg":"trace[1341257380] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1052; }","duration":"172.946263ms","start":"2026-05-06T05:07:14.363678Z","end":"2026-05-06T05:07:14.536624Z","steps":["trace[1341257380] 'agreement among raft nodes before linearized reading' (duration: 172.254107ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:15.465749Z","caller":"traceutil/trace.go:171","msg":"trace[1893185581] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"133.997652ms","start":"2026-05-06T05:07:15.33172Z","end":"2026-05-06T05:07:15.465717Z","steps":["trace[1893185581] 'process raft request' (duration: 133.756546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:16.762229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"951.369797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.67\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-05-06T05:07:16.762268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.184743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-06T05:07:16.762316Z","caller":"traceutil/trace.go:171","msg":"trace[2146082436] range","detail":"{range_begin:/registry/masterleases/199.19.213.67; range_end:; response_count:1; response_revision:1056; }","duration":"951.534602ms","start":"2026-05-06T05:07:15.810762Z","end":"2026-05-06T05:07:16.762296Z","steps":["trace[2146082436] 'range keys from in-memory index tree' (duration: 951.116621ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:16.762305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.53399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-06T05:07:16.762409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.384397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:07:16.762422Z","caller":"traceutil/trace.go:171","msg":"trace[1607657909] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1056; }","duration":"138.701073ms","start":"2026-05-06T05:07:16.623692Z","end":"2026-05-06T05:07:16.762393Z","steps":["trace[1607657909] 'range keys from in-memory index tree' (duration: 138.365515ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:16.762456Z","caller":"traceutil/trace.go:171","msg":"trace[584609986] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1056; }","duration":"585.465429ms","start":"2026-05-06T05:07:16.176974Z","end":"2026-05-06T05:07:16.76244Z","steps":["trace[584609986] 'range keys from in-memory index tree' (duration: 585.292235ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:16.762499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:16.176948Z","time spent":"585.53944ms","remote":"127.0.0.1:33154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-06T05:07:16.762585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.147985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-06T05:07:16.762644Z","caller":"traceutil/trace.go:171","msg":"trace[1474776703] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1056; }","duration":"134.231647ms","start":"2026-05-06T05:07:16.628391Z","end":"2026-05-06T05:07:16.762623Z","steps":["trace[1474776703] 'count revisions from in-memory index tree' (duration: 134.082833ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:16.762726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.185741ms","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-05-06T05:07:16.762763Z","caller":"traceutil/trace.go:171","msg":"trace[154098001] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1056; }","duration":"221.227522ms","start":"2026-05-06T05:07:16.541525Z","end":"2026-05-06T05:07:16.762753Z","steps":["trace[154098001] 'range keys from in-memory index tree' (duration: 221.007317ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:16.76236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:15.81073Z","time spent":"951.621003ms","remote":"127.0.0.1:33192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.67\" "} {"level":"warn","ts":"2026-05-06T05:07:16.762987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.313039ms","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-05-06T05:07:16.763045Z","caller":"traceutil/trace.go:171","msg":"trace[1808445370] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1056; }","duration":"139.400191ms","start":"2026-05-06T05:07:16.623626Z","end":"2026-05-06T05:07:16.763026Z","steps":["trace[1808445370] 'range keys from in-memory index tree' (duration: 139.170564ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:16.762353Z","caller":"traceutil/trace.go:171","msg":"trace[785669068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1056; }","duration":"156.327576ms","start":"2026-05-06T05:07:16.606007Z","end":"2026-05-06T05:07:16.762335Z","steps":["trace[785669068] 'range keys from in-memory index tree' (duration: 155.985859ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:16.763537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.126031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-06T05:07:16.763794Z","caller":"traceutil/trace.go:171","msg":"trace[19576989] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1056; }","duration":"717.818102ms","start":"2026-05-06T05:07:16.04596Z","end":"2026-05-06T05:07:16.763778Z","steps":["trace[19576989] 'range keys from in-memory index tree' (duration: 715.789213ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:16.764189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:16.045927Z","time spent":"718.246561ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-06T05:07:17.039329Z","caller":"traceutil/trace.go:171","msg":"trace[647030165] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"272.179671ms","start":"2026-05-06T05:07:16.767119Z","end":"2026-05-06T05:07:17.039299Z","steps":["trace[647030165] 'process raft request' (duration: 255.465191ms)","trace[647030165] 'compare' (duration: 16.311451ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:07:17.039693Z","caller":"traceutil/trace.go:171","msg":"trace[746818294] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"271.310321ms","start":"2026-05-06T05:07:16.768346Z","end":"2026-05-06T05:07:17.039656Z","steps":["trace[746818294] 'process raft request' (duration: 270.8488ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:17.040011Z","caller":"traceutil/trace.go:171","msg":"trace[401320754] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"270.84115ms","start":"2026-05-06T05:07:16.76915Z","end":"2026-05-06T05:07:17.039991Z","steps":["trace[401320754] 'process raft request' (duration: 270.601734ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:17.040084Z","caller":"traceutil/trace.go:171","msg":"trace[281203688] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"271.445375ms","start":"2026-05-06T05:07:16.76862Z","end":"2026-05-06T05:07:17.040065Z","steps":["trace[281203688] 'process raft request' (duration: 270.743358ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:17.04026Z","caller":"traceutil/trace.go:171","msg":"trace[397535206] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"271.574938ms","start":"2026-05-06T05:07:16.768673Z","end":"2026-05-06T05:07:17.040248Z","steps":["trace[397535206] 'process raft request' (duration: 270.900482ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:17.048666Z","caller":"traceutil/trace.go:171","msg":"trace[1229527004] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"242.564672ms","start":"2026-05-06T05:07:16.806087Z","end":"2026-05-06T05:07:17.048652Z","steps":["trace[1229527004] 'process raft request' (duration: 242.507681ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:18.346706Z","caller":"traceutil/trace.go:171","msg":"trace[83160956] linearizableReadLoop","detail":"{readStateIndex:1109; appliedIndex:1108; }","duration":"170.877464ms","start":"2026-05-06T05:07:18.175805Z","end":"2026-05-06T05:07:18.346682Z","steps":["trace[83160956] 'read index received' (duration: 170.630207ms)","trace[83160956] 'applied index is now lower than readState.Index' (duration: 246.287µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:07:18.346818Z","caller":"traceutil/trace.go:171","msg":"trace[1470204826] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"220.813561ms","start":"2026-05-06T05:07:18.125985Z","end":"2026-05-06T05:07:18.346799Z","steps":["trace[1470204826] 'process raft request' (duration: 220.538844ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:18.346853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.027808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:07:18.346885Z","caller":"traceutil/trace.go:171","msg":"trace[314350246] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1064; }","duration":"171.10349ms","start":"2026-05-06T05:07:18.175772Z","end":"2026-05-06T05:07:18.346876Z","steps":["trace[314350246] 'agreement among raft nodes before linearized reading' (duration: 171.024288ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:19.904593Z","caller":"traceutil/trace.go:171","msg":"trace[1706835619] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"855.572581ms","start":"2026-05-06T05:07:19.048989Z","end":"2026-05-06T05:07:19.904562Z","steps":["trace[1706835619] 'process raft request' (duration: 855.429578ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:19.905219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:19.048962Z","time spent":"856.167436ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:07:19.97513Z","caller":"traceutil/trace.go:171","msg":"trace[1971424386] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"925.493168ms","start":"2026-05-06T05:07:19.049608Z","end":"2026-05-06T05:07:19.975101Z","steps":["trace[1971424386] 'process raft request' (duration: 925.382055ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:19.975325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:19.049597Z","time spent":"925.61198ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:07:19.975362Z","caller":"traceutil/trace.go:171","msg":"trace[1130255790] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"925.460466ms","start":"2026-05-06T05:07:19.049888Z","end":"2026-05-06T05:07:19.975349Z","steps":["trace[1130255790] 'process raft request' (duration: 925.164259ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:19.975452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:19.049879Z","time spent":"925.525017ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:07:19.975651Z","caller":"traceutil/trace.go:171","msg":"trace[56418881] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"925.384204ms","start":"2026-05-06T05:07:19.050256Z","end":"2026-05-06T05:07:19.97564Z","steps":["trace[56418881] 'process raft request' (duration: 925.052226ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:19.975689Z","caller":"traceutil/trace.go:171","msg":"trace[1812444524] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"926.209994ms","start":"2026-05-06T05:07:19.049459Z","end":"2026-05-06T05:07:19.975669Z","steps":["trace[1812444524] 'process raft request' (duration: 880.801446ms)","trace[1812444524] 'compare' (duration: 44.581589ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:07:19.97571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:19.050246Z","time spent":"925.435556ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:07:19.975777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:19.049441Z","time spent":"926.291497ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:07:19.975872Z","caller":"traceutil/trace.go:171","msg":"trace[1078108354] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"418.785705ms","start":"2026-05-06T05:07:19.557076Z","end":"2026-05-06T05:07:19.975862Z","steps":["trace[1078108354] 'process raft request' (duration: 418.516839ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:19.975933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:19.557044Z","time spent":"418.856507ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:07:21.59089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.142645ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-06T05:07:21.591037Z","caller":"traceutil/trace.go:171","msg":"trace[1871157978] linearizableReadLoop","detail":"{readStateIndex:1117; appliedIndex:1116; }","duration":"466.037588ms","start":"2026-05-06T05:07:21.124952Z","end":"2026-05-06T05:07:21.59099Z","steps":["trace[1871157978] 'read index received' (duration: 114.770681ms)","trace[1871157978] 'applied index is now lower than readState.Index' (duration: 351.265227ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:07:21.591216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.135444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T05:07:21.591217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.227262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:07:21.591335Z","caller":"traceutil/trace.go:171","msg":"trace[289787406] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1071; }","duration":"466.422897ms","start":"2026-05-06T05:07:21.124888Z","end":"2026-05-06T05:07:21.59131Z","steps":["trace[289787406] 'agreement among raft nodes before linearized reading' (duration: 466.190871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:21.591145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.233155ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:07:21.591482Z","caller":"traceutil/trace.go:171","msg":"trace[1380265815] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1071; }","duration":"184.757017ms","start":"2026-05-06T05:07:21.406704Z","end":"2026-05-06T05:07:21.591461Z","steps":["trace[1380265815] 'range keys from in-memory index tree' (duration: 184.212085ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:21.591392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:21.124864Z","time spent":"466.515819ms","remote":"127.0.0.1:53250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-05-06T05:07:21.591252Z","caller":"traceutil/trace.go:171","msg":"trace[1271516342] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1071; }","duration":"366.219185ms","start":"2026-05-06T05:07:21.225023Z","end":"2026-05-06T05:07:21.591243Z","steps":["trace[1271516342] 'agreement among raft nodes before linearized reading' (duration: 366.141623ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:21.591728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:21.225003Z","time spent":"366.708707ms","remote":"127.0.0.1:33274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-05-06T05:07:22.480583Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2403970005373798697,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-06T05:07:22.794958Z","caller":"traceutil/trace.go:171","msg":"trace[2043417376] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"880.902149ms","start":"2026-05-06T05:07:21.914029Z","end":"2026-05-06T05:07:22.794931Z","steps":["trace[2043417376] 'process raft request' (duration: 880.735255ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:22.795137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:21.914006Z","time spent":"881.030711ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:07:23.496307Z","caller":"traceutil/trace.go:171","msg":"trace[849008920] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"1.51447528s","start":"2026-05-06T05:07:21.981805Z","end":"2026-05-06T05:07:23.496281Z","steps":["trace[849008920] 'process raft request' (duration: 1.504592563s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:23.497013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:21.981789Z","time spent":"1.515151047s","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:07:23.496577Z","caller":"traceutil/trace.go:171","msg":"trace[12643947] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1117; }","duration":"1.516032177s","start":"2026-05-06T05:07:21.98052Z","end":"2026-05-06T05:07:23.496552Z","steps":["trace[12643947] 'read index received' (duration: 814.21916ms)","trace[12643947] 'applied index is now lower than readState.Index' (duration: 701.810557ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:07:23.496764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.516226142s","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-05-06T05:07:23.497383Z","caller":"traceutil/trace.go:171","msg":"trace[542683608] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1073; }","duration":"1.516891338s","start":"2026-05-06T05:07:21.980476Z","end":"2026-05-06T05:07:23.497367Z","steps":["trace[542683608] 'agreement among raft nodes before linearized reading' (duration: 1.51615804s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:23.49742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:21.98046Z","time spent":"1.516948409s","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-06T05:07:23.497396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.407039226s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:07:23.497501Z","caller":"traceutil/trace.go:171","msg":"trace[131984384] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1073; }","duration":"1.407149168s","start":"2026-05-06T05:07:22.090299Z","end":"2026-05-06T05:07:23.497448Z","steps":["trace[131984384] 'agreement among raft nodes before linearized reading' (duration: 1.407008385s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:23.497529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.516062578s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-06T05:07:23.497582Z","caller":"traceutil/trace.go:171","msg":"trace[140046278] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1073; }","duration":"1.516123659s","start":"2026-05-06T05:07:21.981441Z","end":"2026-05-06T05:07:23.497564Z","steps":["trace[140046278] 'agreement among raft nodes before linearized reading' (duration: 1.516002576s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:23.497598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:22.090283Z","time spent":"1.407302582s","remote":"127.0.0.1:33154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-06T05:07:23.497605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.323315839s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:07:23.497634Z","caller":"traceutil/trace.go:171","msg":"trace[925708669] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1073; }","duration":"1.323386851s","start":"2026-05-06T05:07:22.174239Z","end":"2026-05-06T05:07:23.497626Z","steps":["trace[925708669] 'agreement among raft nodes before linearized reading' (duration: 1.323329349s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:23.497628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:21.981433Z","time spent":"1.51618351s","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-06T05:07:23.497674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:22.17422Z","time spent":"1.323439931s","remote":"127.0.0.1:33156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-06T05:07:23.497407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.516733294s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-06T05:07:23.497878Z","caller":"traceutil/trace.go:171","msg":"trace[1726504440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1073; }","duration":"1.517248975s","start":"2026-05-06T05:07:21.980621Z","end":"2026-05-06T05:07:23.49787Z","steps":["trace[1726504440] 'agreement among raft nodes before linearized reading' (duration: 1.516663182s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:23.497919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:21.9806Z","time spent":"1.517309507s","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-06T05:07:23.497871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.516252983s","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-05-06T05:07:23.498112Z","caller":"traceutil/trace.go:171","msg":"trace[1602798714] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1073; }","duration":"1.516521719s","start":"2026-05-06T05:07:21.981576Z","end":"2026-05-06T05:07:23.498098Z","steps":["trace[1602798714] 'agreement among raft nodes before linearized reading' (duration: 1.515759221s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:23.498158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:21.981523Z","time spent":"1.516621431s","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-06T05:07:23.786742Z","caller":"traceutil/trace.go:171","msg":"trace[2126296070] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"284.740573ms","start":"2026-05-06T05:07:23.501966Z","end":"2026-05-06T05:07:23.786706Z","steps":["trace[2126296070] 'process raft request' (duration: 234.422298ms)","trace[2126296070] 'compare' (duration: 50.174701ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:07:23.834544Z","caller":"traceutil/trace.go:171","msg":"trace[274458658] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"330.548631ms","start":"2026-05-06T05:07:23.503967Z","end":"2026-05-06T05:07:23.834515Z","steps":["trace[274458658] 'process raft request' (duration: 330.382336ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:23.834691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:23.503943Z","time spent":"330.671604ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:07:23.835012Z","caller":"traceutil/trace.go:171","msg":"trace[88720349] linearizableReadLoop","detail":"{readStateIndex:1121; appliedIndex:1119; }","duration":"330.132501ms","start":"2026-05-06T05:07:23.504855Z","end":"2026-05-06T05:07:23.834988Z","steps":["trace[88720349] 'read index received' (duration: 231.630621ms)","trace[88720349] 'applied index is now lower than readState.Index' (duration: 98.50084ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:07:23.835146Z","caller":"traceutil/trace.go:171","msg":"trace[96677104] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"330.201903ms","start":"2026-05-06T05:07:23.50493Z","end":"2026-05-06T05:07:23.835132Z","steps":["trace[96677104] 'process raft request' (duration: 329.872415ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:23.835264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:23.504924Z","time spent":"330.258924ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:07:23.835327Z","caller":"traceutil/trace.go:171","msg":"trace[903065054] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"330.395077ms","start":"2026-05-06T05:07:23.504863Z","end":"2026-05-06T05:07:23.835258Z","steps":["trace[903065054] 'process raft request' (duration: 329.606288ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:23.835451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.594232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:07:23.835484Z","caller":"traceutil/trace.go:171","msg":"trace[124961280] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1077; }","duration":"330.657964ms","start":"2026-05-06T05:07:23.504816Z","end":"2026-05-06T05:07:23.835474Z","steps":["trace[124961280] 'agreement among raft nodes before linearized reading' (duration: 330.604603ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:23.835504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:23.50485Z","time spent":"330.564861ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:07:23.835521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:23.504801Z","time spent":"330.713715ms","remote":"127.0.0.1:33154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-06T05:07:28.017652Z","caller":"traceutil/trace.go:171","msg":"trace[804924455] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1133; }","duration":"168.729033ms","start":"2026-05-06T05:07:27.848897Z","end":"2026-05-06T05:07:28.017626Z","steps":["trace[804924455] 'read index received' (duration: 168.567439ms)","trace[804924455] 'applied index is now lower than readState.Index' (duration: 160.484µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:07:28.017754Z","caller":"traceutil/trace.go:171","msg":"trace[790516924] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"213.439344ms","start":"2026-05-06T05:07:27.804284Z","end":"2026-05-06T05:07:28.017723Z","steps":["trace[790516924] 'process raft request' (duration: 213.171128ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:28.018123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.279329ms","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-05-06T05:07:28.018142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.417642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-06T05:07:28.018234Z","caller":"traceutil/trace.go:171","msg":"trace[2085891878] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1087; }","duration":"162.413432ms","start":"2026-05-06T05:07:27.855797Z","end":"2026-05-06T05:07:28.018211Z","steps":["trace[2085891878] 'agreement among raft nodes before linearized reading' (duration: 162.121945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:28.017988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.072092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-06T05:07:28.018261Z","caller":"traceutil/trace.go:171","msg":"trace[1828894297] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1087; }","duration":"162.584636ms","start":"2026-05-06T05:07:27.855654Z","end":"2026-05-06T05:07:28.018238Z","steps":["trace[1828894297] 'agreement among raft nodes before linearized reading' (duration: 162.241998ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:28.018306Z","caller":"traceutil/trace.go:171","msg":"trace[1829386960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1087; }","duration":"169.433389ms","start":"2026-05-06T05:07:27.848859Z","end":"2026-05-06T05:07:28.018293Z","steps":["trace[1829386960] 'agreement among raft nodes before linearized reading' (duration: 168.952868ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:28.123716Z","caller":"traceutil/trace.go:171","msg":"trace[1868235184] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"101.39056ms","start":"2026-05-06T05:07:28.022251Z","end":"2026-05-06T05:07:28.123642Z","steps":["trace[1868235184] 'process raft request' (duration: 81.017531ms)","trace[1868235184] 'compare' (duration: 20.222425ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:07:28.16084Z","caller":"traceutil/trace.go:171","msg":"trace[1567431742] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"137.639397ms","start":"2026-05-06T05:07:28.02317Z","end":"2026-05-06T05:07:28.16081Z","steps":["trace[1567431742] 'process raft request' (duration: 137.583496ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:28.160974Z","caller":"traceutil/trace.go:171","msg":"trace[1679471835] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"137.911074ms","start":"2026-05-06T05:07:28.02296Z","end":"2026-05-06T05:07:28.160871Z","steps":["trace[1679471835] 'process raft request' (duration: 137.647657ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:30.136378Z","caller":"traceutil/trace.go:171","msg":"trace[1741688677] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"110.806604ms","start":"2026-05-06T05:07:30.025539Z","end":"2026-05-06T05:07:30.136346Z","steps":["trace[1741688677] 'process raft request' (duration: 110.582049ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:30.324462Z","caller":"traceutil/trace.go:171","msg":"trace[244723670] linearizableReadLoop","detail":"{readStateIndex:1142; appliedIndex:1141; }","duration":"159.774078ms","start":"2026-05-06T05:07:30.164663Z","end":"2026-05-06T05:07:30.324437Z","steps":["trace[244723670] 'read index received' (duration: 79.156757ms)","trace[244723670] 'applied index is now lower than readState.Index' (duration: 80.616511ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:07:30.324513Z","caller":"traceutil/trace.go:171","msg":"trace[631094903] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"184.021409ms","start":"2026-05-06T05:07:30.14046Z","end":"2026-05-06T05:07:30.324482Z","steps":["trace[631094903] 'process raft request' (duration: 103.381817ms)","trace[631094903] 'compare' (duration: 80.482589ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:07:30.324682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.786019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-06T05:07:30.324719Z","caller":"traceutil/trace.go:171","msg":"trace[568436042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1095; }","duration":"159.862171ms","start":"2026-05-06T05:07:30.164844Z","end":"2026-05-06T05:07:30.324707Z","steps":["trace[568436042] 'agreement among raft nodes before linearized reading' (duration: 159.721887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:30.324715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.857646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:07:30.324759Z","caller":"traceutil/trace.go:171","msg":"trace[204061219] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1095; }","duration":"148.944469ms","start":"2026-05-06T05:07:30.175801Z","end":"2026-05-06T05:07:30.324746Z","steps":["trace[204061219] 'agreement among raft nodes before linearized reading' (duration: 148.869287ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:30.325038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.368092ms","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-05-06T05:07:30.32509Z","caller":"traceutil/trace.go:171","msg":"trace[1416730678] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1095; }","duration":"160.441624ms","start":"2026-05-06T05:07:30.164637Z","end":"2026-05-06T05:07:30.325078Z","steps":["trace[1416730678] 'agreement among raft nodes before linearized reading' (duration: 159.879321ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:30.769242Z","caller":"traceutil/trace.go:171","msg":"trace[633156426] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"440.105565ms","start":"2026-05-06T05:07:30.329111Z","end":"2026-05-06T05:07:30.769217Z","steps":["trace[633156426] 'process raft request' (duration: 439.03996ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:30.769597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:30.329086Z","time spent":"440.221668ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:07:30.769788Z","caller":"traceutil/trace.go:171","msg":"trace[1464650952] linearizableReadLoop","detail":"{readStateIndex:1145; appliedIndex:1142; }","duration":"315.030448ms","start":"2026-05-06T05:07:30.454738Z","end":"2026-05-06T05:07:30.769768Z","steps":["trace[1464650952] 'read index received' (duration: 313.436541ms)","trace[1464650952] 'applied index is now lower than readState.Index' (duration: 1.592877ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:07:30.769815Z","caller":"traceutil/trace.go:171","msg":"trace[1669790848] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"440.219089ms","start":"2026-05-06T05:07:30.329565Z","end":"2026-05-06T05:07:30.769784Z","steps":["trace[1669790848] 'process raft request' (duration: 440.008534ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:30.769899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.144201ms","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-05-06T05:07:30.769954Z","caller":"traceutil/trace.go:171","msg":"trace[1236720904] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1098; }","duration":"315.242103ms","start":"2026-05-06T05:07:30.454697Z","end":"2026-05-06T05:07:30.769939Z","steps":["trace[1236720904] 'agreement among raft nodes before linearized reading' (duration: 315.152441ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:30.769963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:30.329543Z","time spent":"440.335171ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:07:30.770002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:30.45468Z","time spent":"315.307214ms","remote":"127.0.0.1:53304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-05-06T05:07:30.770076Z","caller":"traceutil/trace.go:171","msg":"trace[412938040] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"326.425151ms","start":"2026-05-06T05:07:30.443624Z","end":"2026-05-06T05:07:30.770049Z","steps":["trace[412938040] 'process raft request' (duration: 326.070523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:30.770182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:30.443601Z","time spent":"326.530514ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:07:31.790237Z","caller":"traceutil/trace.go:171","msg":"trace[516940488] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"256.724831ms","start":"2026-05-06T05:07:31.533478Z","end":"2026-05-06T05:07:31.790203Z","steps":["trace[516940488] 'process raft request' (duration: 256.541137ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:40.685152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.111756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T05:07:40.685249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.607827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-06T05:07:40.685271Z","caller":"traceutil/trace.go:171","msg":"trace[1361119083] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1187; }","duration":"112.302711ms","start":"2026-05-06T05:07:40.57294Z","end":"2026-05-06T05:07:40.685243Z","steps":["trace[1361119083] 'count revisions from in-memory index tree' (duration: 111.958543ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:40.685288Z","caller":"traceutil/trace.go:171","msg":"trace[1477128731] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1187; }","duration":"316.679199ms","start":"2026-05-06T05:07:40.368599Z","end":"2026-05-06T05:07:40.685278Z","steps":["trace[1477128731] 'range keys from in-memory index tree' (duration: 316.444423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:40.685317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:40.368582Z","time spent":"316.72885ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-06T05:07:41.674382Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2403970005373798950,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-06T05:07:42.470191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.653377ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-06T05:07:42.470395Z","caller":"traceutil/trace.go:171","msg":"trace[1742656332] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1243; }","duration":"1.29659567s","start":"2026-05-06T05:07:41.173782Z","end":"2026-05-06T05:07:42.470378Z","steps":["trace[1742656332] 'read index received' (duration: 830.826349ms)","trace[1742656332] 'applied index is now lower than readState.Index' (duration: 465.767921ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:07:42.47055Z","caller":"traceutil/trace.go:171","msg":"trace[368914087] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"652.066915ms","start":"2026-05-06T05:07:41.818459Z","end":"2026-05-06T05:07:42.470526Z","steps":["trace[368914087] 'process raft request' (duration: 651.831179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:42.470686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:41.818438Z","time spent":"652.173898ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:07:42.638867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.465057457s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T05:07:42.63892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.271557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-06T05:07:42.638951Z","caller":"traceutil/trace.go:171","msg":"trace[1365455860] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1193; }","duration":"1.46520409s","start":"2026-05-06T05:07:41.173726Z","end":"2026-05-06T05:07:42.63893Z","steps":["trace[1365455860] 'agreement among raft nodes before linearized reading' (duration: 1.296715653s)","trace[1365455860] 'range keys from in-memory index tree' (duration: 168.355034ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:07:42.639004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:41.173701Z","time spent":"1.465293942s","remote":"127.0.0.1:33154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-06T05:07:42.639002Z","caller":"traceutil/trace.go:171","msg":"trace[2132130744] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1193; }","duration":"409.395249ms","start":"2026-05-06T05:07:42.229583Z","end":"2026-05-06T05:07:42.638978Z","steps":["trace[2132130744] 'agreement among raft nodes before linearized reading' (duration: 240.922153ms)","trace[2132130744] 'range keys from in-memory index tree' (duration: 168.270512ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:07:42.639052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:42.229565Z","time spent":"409.474072ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-06T05:07:54.627173Z","caller":"traceutil/trace.go:171","msg":"trace[155959479] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"114.031172ms","start":"2026-05-06T05:07:54.513113Z","end":"2026-05-06T05:07:54.627144Z","steps":["trace[155959479] 'process raft request' (duration: 113.894739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:07:55.289624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.465287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:07:55.289699Z","caller":"traceutil/trace.go:171","msg":"trace[1712290464] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1238; }","duration":"115.624471ms","start":"2026-05-06T05:07:55.174055Z","end":"2026-05-06T05:07:55.289679Z","steps":["trace[1712290464] 'range keys from in-memory index tree' (duration: 115.317113ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:56.138222Z","caller":"traceutil/trace.go:171","msg":"trace[393565833] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"123.329446ms","start":"2026-05-06T05:07:56.01486Z","end":"2026-05-06T05:07:56.138189Z","steps":["trace[393565833] 'process raft request' (duration: 123.063339ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:59.510363Z","caller":"traceutil/trace.go:171","msg":"trace[463021151] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"177.172946ms","start":"2026-05-06T05:07:59.333171Z","end":"2026-05-06T05:07:59.510344Z","steps":["trace[463021151] 'process raft request' (duration: 177.040573ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:00.276385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.862737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:08:00.276474Z","caller":"traceutil/trace.go:171","msg":"trace[234757831] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1272; }","duration":"100.97039ms","start":"2026-05-06T05:08:00.175482Z","end":"2026-05-06T05:08:00.276452Z","steps":["trace[234757831] 'range keys from in-memory index tree' (duration: 100.739634ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:00.276624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.503508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:08:00.276698Z","caller":"traceutil/trace.go:171","msg":"trace[2082619340] 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:1272; }","duration":"577.641251ms","start":"2026-05-06T05:07:59.699037Z","end":"2026-05-06T05:08:00.276678Z","steps":["trace[2082619340] 'count revisions from in-memory index tree' (duration: 577.361795ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:00.276741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:59.699013Z","time spent":"577.716473ms","remote":"127.0.0.1:53374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-06T05:08:01.0167Z","caller":"traceutil/trace.go:171","msg":"trace[707692040] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"283.528884ms","start":"2026-05-06T05:08:00.733148Z","end":"2026-05-06T05:08:01.016677Z","steps":["trace[707692040] 'process raft request' (duration: 283.39857ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:01.017388Z","caller":"traceutil/trace.go:171","msg":"trace[308526022] linearizableReadLoop","detail":"{readStateIndex:1328; appliedIndex:1328; }","duration":"235.923784ms","start":"2026-05-06T05:08:00.781447Z","end":"2026-05-06T05:08:01.01737Z","steps":["trace[308526022] 'read index received' (duration: 235.917864ms)","trace[308526022] 'applied index is now lower than readState.Index' (duration: 5.07µs)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:08:01.017503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.034796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:08:01.017535Z","caller":"traceutil/trace.go:171","msg":"trace[1899430670] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1273; }","duration":"236.117699ms","start":"2026-05-06T05:08:00.78141Z","end":"2026-05-06T05:08:01.017528Z","steps":["trace[1899430670] 'agreement among raft nodes before linearized reading' (duration: 236.038377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:01.625451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.601624ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-06T05:08:01.625659Z","caller":"traceutil/trace.go:171","msg":"trace[2016764251] linearizableReadLoop","detail":"{readStateIndex:1329; appliedIndex:1328; }","duration":"608.208694ms","start":"2026-05-06T05:08:01.017431Z","end":"2026-05-06T05:08:01.62564Z","steps":["trace[2016764251] 'read index received' (duration: 423.372836ms)","trace[2016764251] 'applied index is now lower than readState.Index' (duration: 184.834818ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:08:01.625829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.122272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-06T05:08:01.625826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.407303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-06T05:08:01.625902Z","caller":"traceutil/trace.go:171","msg":"trace[1438764017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1273; }","duration":"700.518876ms","start":"2026-05-06T05:08:00.925362Z","end":"2026-05-06T05:08:01.625881Z","steps":["trace[1438764017] 'agreement among raft nodes before linearized reading' (duration: 700.286721ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:01.625935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.273685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-06T05:08:01.625954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:08:00.925348Z","time spent":"700.596488ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-06T05:08:01.625977Z","caller":"traceutil/trace.go:171","msg":"trace[647615384] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1273; }","duration":"762.352627ms","start":"2026-05-06T05:08:00.863615Z","end":"2026-05-06T05:08:01.625968Z","steps":["trace[647615384] 'agreement among raft nodes before linearized reading' (duration: 762.263735ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:01.625854Z","caller":"traceutil/trace.go:171","msg":"trace[598362557] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1273; }","duration":"762.187733ms","start":"2026-05-06T05:08:00.86366Z","end":"2026-05-06T05:08:01.625848Z","steps":["trace[598362557] 'agreement among raft nodes before linearized reading' (duration: 762.0578ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:01.626005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:08:00.863594Z","time spent":"762.404609ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-06T05:08:01.626044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.502412ms","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-05-06T05:08:01.626087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:08:00.863633Z","time spent":"762.407999ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-06T05:08:01.626117Z","caller":"traceutil/trace.go:171","msg":"trace[117948402] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1273; }","duration":"641.632175ms","start":"2026-05-06T05:08:00.984465Z","end":"2026-05-06T05:08:01.626097Z","steps":["trace[117948402] 'agreement among raft nodes before linearized reading' (duration: 641.371179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:01.626168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:08:00.984444Z","time spent":"641.712597ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-06T05:08:01.626233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.800416ms","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-05-06T05:08:01.626292Z","caller":"traceutil/trace.go:171","msg":"trace[1544021365] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"127.440025ms","start":"2026-05-06T05:08:01.498842Z","end":"2026-05-06T05:08:01.626282Z","steps":["trace[1544021365] 'process raft request' (duration: 126.743348ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:01.626326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.386342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-06T05:08:01.626365Z","caller":"traceutil/trace.go:171","msg":"trace[1761409250] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1274; }","duration":"509.822027ms","start":"2026-05-06T05:08:01.116426Z","end":"2026-05-06T05:08:01.626248Z","steps":["trace[1761409250] 'agreement among raft nodes before linearized reading' (duration: 509.751895ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:01.626371Z","caller":"traceutil/trace.go:171","msg":"trace[885343699] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1274; }","duration":"498.452414ms","start":"2026-05-06T05:08:01.127901Z","end":"2026-05-06T05:08:01.626354Z","steps":["trace[885343699] 'agreement among raft nodes before linearized reading' (duration: 498.370682ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:01.626386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:08:01.11637Z","time spent":"510.009821ms","remote":"127.0.0.1:33386","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-05-06T05:08:01.626405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:08:01.127892Z","time spent":"498.503905ms","remote":"127.0.0.1:33478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":31,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"info","ts":"2026-05-06T05:08:01.866353Z","caller":"traceutil/trace.go:171","msg":"trace[1417084181] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"236.338453ms","start":"2026-05-06T05:08:01.629996Z","end":"2026-05-06T05:08:01.866334Z","steps":["trace[1417084181] 'process raft request' (duration: 205.445943ms)","trace[1417084181] 'compare' (duration: 30.709956ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:08:01.921394Z","caller":"traceutil/trace.go:171","msg":"trace[533208528] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"291.158847ms","start":"2026-05-06T05:08:01.630198Z","end":"2026-05-06T05:08:01.921357Z","steps":["trace[533208528] 'process raft request' (duration: 290.933172ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:01.921421Z","caller":"traceutil/trace.go:171","msg":"trace[1454324090] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"291.022664ms","start":"2026-05-06T05:08:01.630369Z","end":"2026-05-06T05:08:01.921391Z","steps":["trace[1454324090] 'process raft request' (duration: 290.896521ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:01.921646Z","caller":"traceutil/trace.go:171","msg":"trace[1770608578] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"289.983917ms","start":"2026-05-06T05:08:01.631649Z","end":"2026-05-06T05:08:01.921633Z","steps":["trace[1770608578] 'process raft request' (duration: 289.68856ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:01.921637Z","caller":"traceutil/trace.go:171","msg":"trace[675995522] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"291.082005ms","start":"2026-05-06T05:08:01.630537Z","end":"2026-05-06T05:08:01.921619Z","steps":["trace[675995522] 'process raft request' (duration: 290.766838ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:03.288077Z","caller":"traceutil/trace.go:171","msg":"trace[19832207] linearizableReadLoop","detail":"{readStateIndex:1336; appliedIndex:1335; }","duration":"112.312811ms","start":"2026-05-06T05:08:03.175748Z","end":"2026-05-06T05:08:03.28806Z","steps":["trace[19832207] 'read index received' (duration: 112.24321ms)","trace[19832207] 'applied index is now lower than readState.Index' (duration: 67.081µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:08:03.288154Z","caller":"traceutil/trace.go:171","msg":"trace[246179732] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"266.967197ms","start":"2026-05-06T05:08:03.021149Z","end":"2026-05-06T05:08:03.288116Z","steps":["trace[246179732] 'process raft request' (duration: 266.795363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:03.288194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.426384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:08:03.288355Z","caller":"traceutil/trace.go:171","msg":"trace[1888637690] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1280; }","duration":"112.639939ms","start":"2026-05-06T05:08:03.175705Z","end":"2026-05-06T05:08:03.288345Z","steps":["trace[1888637690] 'agreement among raft nodes before linearized reading' (duration: 112.420474ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:04.081629Z","caller":"traceutil/trace.go:171","msg":"trace[790124661] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"116.607184ms","start":"2026-05-06T05:08:03.964991Z","end":"2026-05-06T05:08:04.081598Z","steps":["trace[790124661] 'process raft request' (duration: 62.414596ms)","trace[790124661] 'compare' (duration: 54.060775ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:08:04.243648Z","caller":"traceutil/trace.go:171","msg":"trace[1058369565] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"278.449902ms","start":"2026-05-06T05:08:03.965167Z","end":"2026-05-06T05:08:04.243617Z","steps":["trace[1058369565] 'process raft request' (duration: 217.310016ms)","trace[1058369565] 'compare' (duration: 60.91203ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:08:04.243658Z","caller":"traceutil/trace.go:171","msg":"trace[1386516519] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"277.286235ms","start":"2026-05-06T05:08:03.966344Z","end":"2026-05-06T05:08:04.24363Z","steps":["trace[1386516519] 'process raft request' (duration: 277.200323ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:04.24382Z","caller":"traceutil/trace.go:171","msg":"trace[646590765] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"275.790069ms","start":"2026-05-06T05:08:03.968002Z","end":"2026-05-06T05:08:04.243792Z","steps":["trace[646590765] 'process raft request' (duration: 275.588054ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:05.416245Z","caller":"traceutil/trace.go:171","msg":"trace[2071560117] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"121.552313ms","start":"2026-05-06T05:08:05.294666Z","end":"2026-05-06T05:08:05.416218Z","steps":["trace[2071560117] 'process raft request' (duration: 121.389139ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:11.41661Z","caller":"traceutil/trace.go:171","msg":"trace[1995695619] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"290.45264ms","start":"2026-05-06T05:08:11.126117Z","end":"2026-05-06T05:08:11.416569Z","steps":["trace[1995695619] 'process raft request' (duration: 290.324867ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:12.377233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.401591ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-06T05:08:12.377341Z","caller":"traceutil/trace.go:171","msg":"trace[261370671] linearizableReadLoop","detail":"{readStateIndex:1400; appliedIndex:1399; }","duration":"1.202013943s","start":"2026-05-06T05:08:11.175307Z","end":"2026-05-06T05:08:12.377321Z","steps":["trace[261370671] 'read index received' (duration: 241.25047ms)","trace[261370671] 'applied index is now lower than readState.Index' (duration: 960.761742ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:08:12.377461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.202136855s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:08:12.377559Z","caller":"traceutil/trace.go:171","msg":"trace[779474699] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1342; }","duration":"1.202275639s","start":"2026-05-06T05:08:11.175261Z","end":"2026-05-06T05:08:12.377536Z","steps":["trace[779474699] 'agreement among raft nodes before linearized reading' (duration: 1.202130425s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:12.377631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:08:11.175247Z","time spent":"1.202371192s","remote":"127.0.0.1:33154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-06T05:08:12.378422Z","caller":"traceutil/trace.go:171","msg":"trace[18505564] transaction","detail":"{read_only:false; response_revision:1343; number_of_response:1; }","duration":"938.524329ms","start":"2026-05-06T05:08:11.439879Z","end":"2026-05-06T05:08:12.378403Z","steps":["trace[18505564] 'process raft request' (duration: 938.386316ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:12.378536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:08:11.439855Z","time spent":"938.616792ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:08:12.380646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.964485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-05-06T05:08:12.380765Z","caller":"traceutil/trace.go:171","msg":"trace[706923045] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"413.56805ms","start":"2026-05-06T05:08:11.96718Z","end":"2026-05-06T05:08:12.380748Z","steps":["trace[706923045] 'process raft request' (duration: 413.003197ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:12.380804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.49603ms","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-05-06T05:08:12.380815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"960.058596ms","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:528"} {"level":"info","ts":"2026-05-06T05:08:12.38084Z","caller":"traceutil/trace.go:171","msg":"trace[514703724] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1344; }","duration":"103.582652ms","start":"2026-05-06T05:08:12.277245Z","end":"2026-05-06T05:08:12.380828Z","steps":["trace[514703724] 'agreement among raft nodes before linearized reading' (duration: 103.4999ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:12.380842Z","caller":"traceutil/trace.go:171","msg":"trace[842245531] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1344; }","duration":"274.17764ms","start":"2026-05-06T05:08:12.106624Z","end":"2026-05-06T05:08:12.380802Z","steps":["trace[842245531] 'agreement among raft nodes before linearized reading' (duration: 273.831612ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:12.380868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:08:11.967154Z","time spent":"413.663723ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:08:12.380886Z","caller":"traceutil/trace.go:171","msg":"trace[1693715616] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1344; }","duration":"960.142637ms","start":"2026-05-06T05:08:11.420713Z","end":"2026-05-06T05:08:12.380855Z","steps":["trace[1693715616] 'agreement among raft nodes before linearized reading' (duration: 960.042885ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:12.380712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.412224ms","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-05-06T05:08:12.380954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:08:11.42069Z","time spent":"960.24858ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":552,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-05-06T05:08:12.380982Z","caller":"traceutil/trace.go:171","msg":"trace[1911025798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1344; }","duration":"102.722462ms","start":"2026-05-06T05:08:12.278249Z","end":"2026-05-06T05:08:12.380971Z","steps":["trace[1911025798] 'agreement among raft nodes before linearized reading' (duration: 102.381524ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:12.3807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.061835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"info","ts":"2026-05-06T05:08:12.381065Z","caller":"traceutil/trace.go:171","msg":"trace[462692502] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1344; }","duration":"218.459155ms","start":"2026-05-06T05:08:12.162593Z","end":"2026-05-06T05:08:12.381053Z","steps":["trace[462692502] 'agreement among raft nodes before linearized reading' (duration: 217.998154ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:12.380691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.316577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-06T05:08:12.381057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.304383ms","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-05-06T05:08:12.381175Z","caller":"traceutil/trace.go:171","msg":"trace[1377555138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1344; }","duration":"381.892391ms","start":"2026-05-06T05:08:11.999269Z","end":"2026-05-06T05:08:12.381161Z","steps":["trace[1377555138] 'agreement among raft nodes before linearized reading' (duration: 381.182034ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:12.381183Z","caller":"traceutil/trace.go:171","msg":"trace[1159542152] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1344; }","duration":"105.454497ms","start":"2026-05-06T05:08:12.275713Z","end":"2026-05-06T05:08:12.381167Z","steps":["trace[1159542152] 'agreement among raft nodes before linearized reading' (duration: 105.254193ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:12.381229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:08:11.999249Z","time spent":"381.967472ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-06T05:08:12.381772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.452884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-06T05:08:12.381827Z","caller":"traceutil/trace.go:171","msg":"trace[1802020284] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1344; }","duration":"180.620867ms","start":"2026-05-06T05:08:12.201189Z","end":"2026-05-06T05:08:12.38181Z","steps":["trace[1802020284] 'agreement among raft nodes before linearized reading' (duration: 180.343571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:14.555859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.731723ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T05:08:14.556154Z","caller":"traceutil/trace.go:171","msg":"trace[802652751] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"158.694752ms","start":"2026-05-06T05:08:14.397389Z","end":"2026-05-06T05:08:14.556084Z","steps":["trace[802652751] 'process raft request' (duration: 42.634151ms)","trace[802652751] 'compare' (duration: 115.58125ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:08:14.556204Z","caller":"traceutil/trace.go:171","msg":"trace[153480655] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"158.619381ms","start":"2026-05-06T05:08:14.397562Z","end":"2026-05-06T05:08:14.556181Z","steps":["trace[153480655] 'process raft request' (duration: 158.414145ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:14.556443Z","caller":"traceutil/trace.go:171","msg":"trace[2038704660] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"157.827583ms","start":"2026-05-06T05:08:14.398605Z","end":"2026-05-06T05:08:14.556433Z","steps":["trace[2038704660] 'process raft request' (duration: 157.526095ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:14.556575Z","caller":"traceutil/trace.go:171","msg":"trace[2129391121] linearizableReadLoop","detail":"{readStateIndex:1415; appliedIndex:1413; }","duration":"158.495168ms","start":"2026-05-06T05:08:14.39807Z","end":"2026-05-06T05:08:14.556565Z","steps":["trace[2129391121] 'read index received' (duration: 41.939765ms)","trace[2129391121] 'applied index is now lower than readState.Index' (duration: 116.554443ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:08:14.556594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.501918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-05-06T05:08:14.556637Z","caller":"traceutil/trace.go:171","msg":"trace[529227052] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1359; }","duration":"158.573151ms","start":"2026-05-06T05:08:14.398053Z","end":"2026-05-06T05:08:14.556626Z","steps":["trace[529227052] 'agreement among raft nodes before linearized reading' (duration: 158.481969ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:14.556742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.801607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-06T05:08:14.556781Z","caller":"traceutil/trace.go:171","msg":"trace[294084708] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1359; }","duration":"156.853739ms","start":"2026-05-06T05:08:14.399917Z","end":"2026-05-06T05:08:14.556771Z","steps":["trace[294084708] 'agreement among raft nodes before linearized reading' (duration: 156.719716ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:14.556939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.478196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"} {"level":"info","ts":"2026-05-06T05:08:14.557032Z","caller":"traceutil/trace.go:171","msg":"trace[950017740] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1359; }","duration":"155.583399ms","start":"2026-05-06T05:08:14.401424Z","end":"2026-05-06T05:08:14.557007Z","steps":["trace[950017740] 'agreement among raft nodes before linearized reading' (duration: 155.322202ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:14.556384Z","caller":"traceutil/trace.go:171","msg":"trace[392289729] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"158.250332ms","start":"2026-05-06T05:08:14.398068Z","end":"2026-05-06T05:08:14.556318Z","steps":["trace[392289729] 'process raft request' (duration: 157.966305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:14.896461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.403845ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T05:08:14.896621Z","caller":"traceutil/trace.go:171","msg":"trace[1338439026] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"331.599326ms","start":"2026-05-06T05:08:14.565007Z","end":"2026-05-06T05:08:14.896607Z","steps":["trace[1338439026] 'process raft request' (duration: 331.542045ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:08:14.896676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:08:14.564991Z","time spent":"331.663137ms","remote":"127.0.0.1:33238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":606,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:08:14.896789Z","caller":"traceutil/trace.go:171","msg":"trace[163189548] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"333.813689ms","start":"2026-05-06T05:08:14.562945Z","end":"2026-05-06T05:08:14.896759Z","steps":["trace[163189548] 'process raft request' (duration: 145.030605ms)","trace[163189548] 'compare' (duration: 188.281462ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:08:14.896936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:08:14.562904Z","time spent":"333.954612ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:08:15.078004Z","caller":"traceutil/trace.go:171","msg":"trace[984241808] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"174.00722ms","start":"2026-05-06T05:08:14.903969Z","end":"2026-05-06T05:08:15.077976Z","steps":["trace[984241808] 'process raft request' (duration: 132.933745ms)","trace[984241808] 'compare' (duration: 40.954722ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:08:59.205105Z","caller":"traceutil/trace.go:171","msg":"trace[1677184184] transaction","detail":"{read_only:false; response_revision:1584; number_of_response:1; }","duration":"105.433276ms","start":"2026-05-06T05:08:59.099646Z","end":"2026-05-06T05:08:59.20508Z","steps":["trace[1677184184] 'process raft request' (duration: 104.591435ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:59.205345Z","caller":"traceutil/trace.go:171","msg":"trace[1785464349] transaction","detail":"{read_only:false; response_revision:1585; number_of_response:1; }","duration":"105.258542ms","start":"2026-05-06T05:08:59.100061Z","end":"2026-05-06T05:08:59.205319Z","steps":["trace[1785464349] 'process raft request' (duration: 104.976465ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:09:10.774073Z","caller":"traceutil/trace.go:171","msg":"trace[868235234] transaction","detail":"{read_only:false; response_revision:1641; number_of_response:1; }","duration":"115.828395ms","start":"2026-05-06T05:09:10.658214Z","end":"2026-05-06T05:09:10.774042Z","steps":["trace[868235234] 'process raft request' (duration: 115.673661ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:09:11.1043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.388265ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-06T05:09:32.701127Z","caller":"traceutil/trace.go:171","msg":"trace[193732072] transaction","detail":"{read_only:false; response_revision:1752; number_of_response:1; }","duration":"115.532438ms","start":"2026-05-06T05:09:32.58549Z","end":"2026-05-06T05:09:32.701023Z","steps":["trace[193732072] 'process raft request' (duration: 95.711668ms)","trace[193732072] 'compare' (duration: 19.668786ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:09:47.079192Z","caller":"traceutil/trace.go:171","msg":"trace[1294415454] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"121.027899ms","start":"2026-05-06T05:09:46.958132Z","end":"2026-05-06T05:09:47.079159Z","steps":["trace[1294415454] 'process raft request' (duration: 120.840615ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:10:08.350547Z","caller":"traceutil/trace.go:171","msg":"trace[884036855] transaction","detail":"{read_only:false; response_revision:1935; number_of_response:1; }","duration":"122.75732ms","start":"2026-05-06T05:10:08.227733Z","end":"2026-05-06T05:10:08.35049Z","steps":["trace[884036855] 'process raft request' (duration: 74.243996ms)","trace[884036855] 'compare' (duration: 48.170636ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:10:42.109792Z","caller":"traceutil/trace.go:171","msg":"trace[509066807] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"103.531407ms","start":"2026-05-06T05:10:42.006238Z","end":"2026-05-06T05:10:42.109769Z","steps":["trace[509066807] 'process raft request' (duration: 103.379984ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:10:42.111615Z","caller":"traceutil/trace.go:171","msg":"trace[1307677243] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"104.851849ms","start":"2026-05-06T05:10:42.006715Z","end":"2026-05-06T05:10:42.111567Z","steps":["trace[1307677243] 'process raft request' (duration: 104.46362ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:10:42.111907Z","caller":"traceutil/trace.go:171","msg":"trace[1905107271] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"104.402999ms","start":"2026-05-06T05:10:42.007471Z","end":"2026-05-06T05:10:42.111874Z","steps":["trace[1905107271] 'process raft request' (duration: 103.883166ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:11:16.523356Z","caller":"traceutil/trace.go:171","msg":"trace[275606073] transaction","detail":"{read_only:false; response_revision:2302; number_of_response:1; }","duration":"140.728139ms","start":"2026-05-06T05:11:16.382604Z","end":"2026-05-06T05:11:16.523333Z","steps":["trace[275606073] 'process raft request' (duration: 129.185159ms)","trace[275606073] 'compare' (duration: 11.327275ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:11:24.56413Z","caller":"traceutil/trace.go:171","msg":"trace[1693888897] transaction","detail":"{read_only:false; response_revision:2351; number_of_response:1; }","duration":"145.877613ms","start":"2026-05-06T05:11:24.418226Z","end":"2026-05-06T05:11:24.564104Z","steps":["trace[1693888897] 'process raft request' (duration: 54.283274ms)","trace[1693888897] 'compare' (duration: 90.959584ms)"],"step_count":2}