{"level":"warn","ts":"2026-03-26T01:55:25.791543Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-26T01:55:25.791675Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.110: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://162.253.55.110:2380","--initial-cluster=instance=https://162.253.55.110:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.110:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.110: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-03-26T01:55:25.791785Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-26T01:55:25.791808Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.110:2380"]} {"level":"info","ts":"2026-03-26T01:55:25.79184Z","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-03-26T01:55:25.793105Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"]} {"level":"info","ts":"2026-03-26T01:55:25.793315Z","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://162.253.55.110:2380"],"listen-peer-urls":["https://162.253.55.110:2380"],"advertise-client-urls":["https://162.253.55.110:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.110: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-03-26T01:55:25.801601Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.852887ms"} {"level":"info","ts":"2026-03-26T01:55:25.812496Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f52f30d5714009d5","cluster-id":"650981a7a383c714"} {"level":"info","ts":"2026-03-26T01:55:25.812661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=()"} {"level":"info","ts":"2026-03-26T01:55:25.812694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became follower at term 0"} {"level":"info","ts":"2026-03-26T01:55:25.812713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f52f30d5714009d5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-26T01:55:25.812728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became follower at term 1"} {"level":"info","ts":"2026-03-26T01:55:25.812773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=(17667393556483934677)"} {"level":"warn","ts":"2026-03-26T01:55:25.818728Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-26T01:55:25.820317Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-26T01:55:25.821955Z","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-03-26T01:55:25.825417Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f52f30d5714009d5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-26T01:55:25.825806Z","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-03-26T01:55:25.825873Z","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-03-26T01:55:25.825695Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f52f30d5714009d5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-26T01:55:25.825956Z","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-03-26T01:55:25.828185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=(17667393556483934677)"} {"level":"info","ts":"2026-03-26T01:55:25.828535Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"650981a7a383c714","local-member-id":"f52f30d5714009d5","added-peer-id":"f52f30d5714009d5","added-peer-peer-urls":["https://162.253.55.110:2380"]} {"level":"info","ts":"2026-03-26T01:55:25.830249Z","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-03-26T01:55:25.830435Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f52f30d5714009d5","initial-advertise-peer-urls":["https://162.253.55.110:2380"],"listen-peer-urls":["https://162.253.55.110:2380"],"advertise-client-urls":["https://162.253.55.110:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-26T01:55:25.830468Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-26T01:55:25.830561Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.110:2380"} {"level":"info","ts":"2026-03-26T01:55:25.830577Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.110:2380"} {"level":"info","ts":"2026-03-26T01:55:26.51408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 is starting a new election at term 1"} {"level":"info","ts":"2026-03-26T01:55:26.514144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-26T01:55:26.514191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 received MsgPreVoteResp from f52f30d5714009d5 at term 1"} {"level":"info","ts":"2026-03-26T01:55:26.514211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became candidate at term 2"} {"level":"info","ts":"2026-03-26T01:55:26.514224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 received MsgVoteResp from f52f30d5714009d5 at term 2"} {"level":"info","ts":"2026-03-26T01:55:26.514241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became leader at term 2"} {"level":"info","ts":"2026-03-26T01:55:26.514328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f52f30d5714009d5 elected leader f52f30d5714009d5 at term 2"} {"level":"info","ts":"2026-03-26T01:55:26.515397Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T01:55:26.51642Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f52f30d5714009d5","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.110:2379]}","request-path":"/0/members/f52f30d5714009d5/attributes","cluster-id":"650981a7a383c714","publish-timeout":"7s"} {"level":"info","ts":"2026-03-26T01:55:26.51659Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-26T01:55:26.516775Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-26T01:55:26.51683Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-26T01:55:26.516629Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-26T01:55:26.520368Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"650981a7a383c714","local-member-id":"f52f30d5714009d5","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T01:55:26.520562Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T01:55:26.52062Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T01:55:26.520862Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-26T01:55:26.521505Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.110:2379"} {"level":"info","ts":"2026-03-26T01:55:29.290908Z","caller":"traceutil/trace.go:171","msg":"trace[1946797518] transaction","detail":"{read_only:false; response_revision:130; number_of_response:1; }","duration":"208.690312ms","start":"2026-03-26T01:55:29.082191Z","end":"2026-03-26T01:55:29.290882Z","steps":["trace[1946797518] 'process raft request' (duration: 198.922611ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:31.181481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.504796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3492"} {"level":"info","ts":"2026-03-26T01:55:31.181589Z","caller":"traceutil/trace.go:171","msg":"trace[959969388] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:203; }","duration":"641.674781ms","start":"2026-03-26T01:55:30.539896Z","end":"2026-03-26T01:55:31.181571Z","steps":["trace[959969388] 'range keys from in-memory index tree' (duration: 641.29783ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:31.181631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:30.539876Z","time spent":"641.745862ms","remote":"127.0.0.1:38526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3515,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-03-26T01:55:31.510705Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645310876218865,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T01:55:32.011856Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645310876218865,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T01:55:32.105745Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.444729731s","expected-duration":"1s"} {"level":"info","ts":"2026-03-26T01:55:32.106413Z","caller":"traceutil/trace.go:171","msg":"trace[35262965] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"1.445481099s","start":"2026-03-26T01:55:30.660892Z","end":"2026-03-26T01:55:32.106373Z","steps":["trace[35262965] 'process raft request' (duration: 1.445284535s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:32.108168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:30.660868Z","time spent":"1.446353988s","remote":"127.0.0.1:38532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T01:55:32.123018Z","caller":"traceutil/trace.go:171","msg":"trace[2024701087] linearizableReadLoop","detail":"{readStateIndex:210; appliedIndex:208; }","duration":"1.112672454s","start":"2026-03-26T01:55:31.010315Z","end":"2026-03-26T01:55:32.122988Z","steps":["trace[2024701087] 'read index received' (duration: 1.095747771s)","trace[2024701087] 'applied index is now lower than readState.Index' (duration: 16.923473ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:55:32.123185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.877143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T01:55:32.123176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.112835877s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:55:32.123241Z","caller":"traceutil/trace.go:171","msg":"trace[2134170912] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:205; }","duration":"1.11296081s","start":"2026-03-26T01:55:31.010267Z","end":"2026-03-26T01:55:32.123228Z","steps":["trace[2134170912] 'agreement among raft nodes before linearized reading' (duration: 1.112814247s)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:55:32.123276Z","caller":"traceutil/trace.go:171","msg":"trace[405476488] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:205; }","duration":"526.021377ms","start":"2026-03-26T01:55:31.59724Z","end":"2026-03-26T01:55:32.123261Z","steps":["trace[405476488] 'agreement among raft nodes before linearized reading' (duration: 525.891544ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:32.123294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:31.010246Z","time spent":"1.113037792s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-26T01:55:32.12332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:31.597212Z","time spent":"526.096999ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-26T01:55:32.123422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.766615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:55:32.123548Z","caller":"traceutil/trace.go:171","msg":"trace[1510368456] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:205; }","duration":"309.938378ms","start":"2026-03-26T01:55:31.813585Z","end":"2026-03-26T01:55:32.123523Z","steps":["trace[1510368456] 'agreement among raft nodes before linearized reading' (duration: 309.768575ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:32.1236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:31.813554Z","time spent":"310.03906ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-26T01:55:32.123752Z","caller":"traceutil/trace.go:171","msg":"trace[1121757683] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"930.769588ms","start":"2026-03-26T01:55:31.192263Z","end":"2026-03-26T01:55:32.123033Z","steps":["trace[1121757683] 'process raft request' (duration: 930.588394ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:32.12423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:31.192237Z","time spent":"931.570445ms","remote":"127.0.0.1:38526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:55:57.977815Z","caller":"traceutil/trace.go:171","msg":"trace[47079382] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"882.342274ms","start":"2026-03-26T01:55:57.095454Z","end":"2026-03-26T01:55:57.977796Z","steps":["trace[47079382] 'process raft request' (duration: 882.246261ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:57.977949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:57.095437Z","time spent":"882.450926ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T01:55:57.994646Z","caller":"traceutil/trace.go:171","msg":"trace[528690932] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"886.382165ms","start":"2026-03-26T01:55:57.108248Z","end":"2026-03-26T01:55:57.99463Z","steps":["trace[528690932] 'process raft request' (duration: 886.271802ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:55:57.994649Z","caller":"traceutil/trace.go:171","msg":"trace[990870043] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"889.814773ms","start":"2026-03-26T01:55:57.104799Z","end":"2026-03-26T01:55:57.994614Z","steps":["trace[990870043] 'process raft request' (duration: 889.63697ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:57.994761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:57.108231Z","time spent":"886.489387ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T01:55:57.994792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:57.104795Z","time spent":"889.908645ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T01:55:57.994816Z","caller":"traceutil/trace.go:171","msg":"trace[1069222604] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"892.563665ms","start":"2026-03-26T01:55:57.102232Z","end":"2026-03-26T01:55:57.994796Z","steps":["trace[1069222604] 'process raft request' (duration: 892.059833ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:55:57.994876Z","caller":"traceutil/trace.go:171","msg":"trace[732665055] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"890.095039ms","start":"2026-03-26T01:55:57.104765Z","end":"2026-03-26T01:55:57.99486Z","steps":["trace[732665055] 'process raft request' (duration: 889.627329ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:57.994918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:57.104757Z","time spent":"890.14222ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T01:55:57.994885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:57.102215Z","time spent":"892.638457ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T01:55:57.99499Z","caller":"traceutil/trace.go:171","msg":"trace[485059591] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"874.793543ms","start":"2026-03-26T01:55:57.120184Z","end":"2026-03-26T01:55:57.994978Z","steps":["trace[485059591] 'process raft request' (duration: 874.402044ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:57.995034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:57.120166Z","time spent":"874.843854ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T01:55:57.995057Z","caller":"traceutil/trace.go:171","msg":"trace[618128890] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"889.189318ms","start":"2026-03-26T01:55:57.105799Z","end":"2026-03-26T01:55:57.994988Z","steps":["trace[618128890] 'process raft request' (duration: 888.679006ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:55:57.995136Z","caller":"traceutil/trace.go:171","msg":"trace[86113670] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"884.766789ms","start":"2026-03-26T01:55:57.110364Z","end":"2026-03-26T01:55:57.995131Z","steps":["trace[86113670] 'process raft request' (duration: 884.189756ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:55:57.99513Z","caller":"traceutil/trace.go:171","msg":"trace[692796091] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"841.075382ms","start":"2026-03-26T01:55:57.154043Z","end":"2026-03-26T01:55:57.995118Z","steps":["trace[692796091] 'process raft request' (duration: 840.632832ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:57.995164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:57.110343Z","time spent":"884.809279ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T01:55:57.995174Z","caller":"traceutil/trace.go:171","msg":"trace[172628582] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"862.526016ms","start":"2026-03-26T01:55:57.132615Z","end":"2026-03-26T01:55:57.995141Z","steps":["trace[172628582] 'process raft request' (duration: 862.011525ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:57.995185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:57.154027Z","time spent":"841.134143ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T01:55:57.995221Z","caller":"traceutil/trace.go:171","msg":"trace[966167126] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"837.394519ms","start":"2026-03-26T01:55:57.157823Z","end":"2026-03-26T01:55:57.995217Z","steps":["trace[966167126] 'process raft request' (duration: 836.97604ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:57.995248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:57.1578Z","time spent":"837.43721ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T01:55:57.995206Z","caller":"traceutil/trace.go:171","msg":"trace[1130027247] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"724.458628ms","start":"2026-03-26T01:55:57.270742Z","end":"2026-03-26T01:55:57.995201Z","steps":["trace[1130027247] 'process raft request' (duration: 724.197822ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:57.995238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:57.105793Z","time spent":"889.356742ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T01:55:57.995248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:57.132598Z","time spent":"862.619939ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T01:55:57.995288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:57.270709Z","time spent":"724.56094ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T01:55:58.533814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.782027ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:55:58.53403Z","caller":"traceutil/trace.go:171","msg":"trace[1516380423] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"376.063611ms","start":"2026-03-26T01:55:58.157931Z","end":"2026-03-26T01:55:58.533994Z","steps":["trace[1516380423] 'process raft request' (duration: 161.907466ms)","trace[1516380423] 'compare' (duration: 213.47094ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:55:58.53411Z","caller":"traceutil/trace.go:171","msg":"trace[1851537307] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"372.152384ms","start":"2026-03-26T01:55:58.161936Z","end":"2026-03-26T01:55:58.534088Z","steps":["trace[1851537307] 'process raft request' (duration: 371.987179ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:58.534174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:58.157907Z","time spent":"376.200395ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T01:55:58.534204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:58.161926Z","time spent":"372.235675ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:55:58.615838Z","caller":"traceutil/trace.go:171","msg":"trace[435220145] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:528; }","duration":"342.298339ms","start":"2026-03-26T01:55:58.273518Z","end":"2026-03-26T01:55:58.615816Z","steps":["trace[435220145] 'read index received' (duration: 46.189512ms)","trace[435220145] 'applied index is now lower than readState.Index' (duration: 296.107837ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:55:58.615949Z","caller":"traceutil/trace.go:171","msg":"trace[1682776753] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"426.280136ms","start":"2026-03-26T01:55:58.189626Z","end":"2026-03-26T01:55:58.615906Z","steps":["trace[1682776753] 'process raft request' (duration: 426.040321ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:58.616063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.534606ms","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-03-26T01:55:58.6161Z","caller":"traceutil/trace.go:171","msg":"trace[8862129] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:504; }","duration":"342.618337ms","start":"2026-03-26T01:55:58.273473Z","end":"2026-03-26T01:55:58.616091Z","steps":["trace[8862129] 'agreement among raft nodes before linearized reading' (duration: 342.448753ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:58.616113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:58.189614Z","time spent":"426.412899ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:55:58.616132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:58.273461Z","time spent":"342.663349ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-26T01:55:58.616232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.671839ms","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-03-26T01:55:58.616337Z","caller":"traceutil/trace.go:171","msg":"trace[241361591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:504; }","duration":"342.829042ms","start":"2026-03-26T01:55:58.273465Z","end":"2026-03-26T01:55:58.616294Z","steps":["trace[241361591] 'agreement among raft nodes before linearized reading' (duration: 342.490964ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:58.616416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:58.273446Z","time spent":"342.957565ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-26T01:55:59.046104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.127593ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:55:59.046369Z","caller":"traceutil/trace.go:171","msg":"trace[1313644641] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:531; }","duration":"430.451909ms","start":"2026-03-26T01:55:58.615899Z","end":"2026-03-26T01:55:59.046351Z","steps":["trace[1313644641] 'read index received' (duration: 151.04194ms)","trace[1313644641] 'applied index is now lower than readState.Index' (duration: 279.408659ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:55:59.046368Z","caller":"traceutil/trace.go:171","msg":"trace[1044774306] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"488.446589ms","start":"2026-03-26T01:55:58.55789Z","end":"2026-03-26T01:55:59.046337Z","steps":["trace[1044774306] 'process raft request' (duration: 208.991319ms)","trace[1044774306] 'compare' (duration: 278.943829ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:55:59.046394Z","caller":"traceutil/trace.go:171","msg":"trace[1745431118] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"464.409176ms","start":"2026-03-26T01:55:58.581958Z","end":"2026-03-26T01:55:59.046367Z","steps":["trace[1745431118] 'process raft request' (duration: 464.293853ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:59.046508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.227805ms","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-03-26T01:55:59.046528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.426607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-03-26T01:55:59.046529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:58.557873Z","time spent":"488.572002ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:55:59.046563Z","caller":"traceutil/trace.go:171","msg":"trace[1319518437] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:506; }","duration":"601.322528ms","start":"2026-03-26T01:55:58.44523Z","end":"2026-03-26T01:55:59.046552Z","steps":["trace[1319518437] 'agreement among raft nodes before linearized reading' (duration: 601.155114ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:55:59.046567Z","caller":"traceutil/trace.go:171","msg":"trace[1242301463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:506; }","duration":"770.467018ms","start":"2026-03-26T01:55:58.27609Z","end":"2026-03-26T01:55:59.046557Z","steps":["trace[1242301463] 'agreement among raft nodes before linearized reading' (duration: 770.342795ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:59.046572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:58.58194Z","time spent":"464.551459ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T01:55:59.046592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:58.445212Z","time spent":"601.375449ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-26T01:55:59.046605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:58.276051Z","time spent":"770.5467ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-26T01:55:59.066471Z","caller":"traceutil/trace.go:171","msg":"trace[1066883219] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"437.023628ms","start":"2026-03-26T01:55:58.629427Z","end":"2026-03-26T01:55:59.066451Z","steps":["trace[1066883219] 'process raft request' (duration: 436.916475ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:59.066641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:58.629409Z","time spent":"437.147971ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:55:59.066779Z","caller":"traceutil/trace.go:171","msg":"trace[55762150] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"444.922617ms","start":"2026-03-26T01:55:58.621851Z","end":"2026-03-26T01:55:59.066773Z","steps":["trace[55762150] 'process raft request' (duration: 444.419355ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:59.066858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:58.621832Z","time spent":"444.976418ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:55:59.066482Z","caller":"traceutil/trace.go:171","msg":"trace[169286577] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"445.998102ms","start":"2026-03-26T01:55:58.620466Z","end":"2026-03-26T01:55:59.066464Z","steps":["trace[169286577] 'process raft request' (duration: 445.685064ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:59.066912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:58.620451Z","time spent":"446.437352ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:55:59.067155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.216364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:55:59.067188Z","caller":"traceutil/trace.go:171","msg":"trace[1586769764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:509; }","duration":"166.270655ms","start":"2026-03-26T01:55:58.900904Z","end":"2026-03-26T01:55:59.067174Z","steps":["trace[1586769764] 'agreement among raft nodes before linearized reading' (duration: 166.234994ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:55:59.339279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.498634ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:55:59.339484Z","caller":"traceutil/trace.go:171","msg":"trace[1369817628] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"231.093878ms","start":"2026-03-26T01:55:59.108373Z","end":"2026-03-26T01:55:59.339467Z","steps":["trace[1369817628] 'process raft request' (duration: 231.024297ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:55:59.339547Z","caller":"traceutil/trace.go:171","msg":"trace[1869434061] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"260.497963ms","start":"2026-03-26T01:55:59.078986Z","end":"2026-03-26T01:55:59.339484Z","steps":["trace[1869434061] 'process raft request' (duration: 99.694312ms)","trace[1869434061] 'compare' (duration: 160.292289ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:55:59.372426Z","caller":"traceutil/trace.go:171","msg":"trace[1196491467] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"211.733441ms","start":"2026-03-26T01:55:59.160665Z","end":"2026-03-26T01:55:59.372398Z","steps":["trace[1196491467] 'process raft request' (duration: 211.616788ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:55:59.479317Z","caller":"traceutil/trace.go:171","msg":"trace[1924118763] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"120.544893ms","start":"2026-03-26T01:55:59.358559Z","end":"2026-03-26T01:55:59.479104Z","steps":["trace[1924118763] 'process raft request' (duration: 119.628002ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:55:59.479456Z","caller":"traceutil/trace.go:171","msg":"trace[1632675458] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"115.12706ms","start":"2026-03-26T01:55:59.364293Z","end":"2026-03-26T01:55:59.47942Z","steps":["trace[1632675458] 'process raft request' (duration: 114.751161ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:55:59.560979Z","caller":"traceutil/trace.go:171","msg":"trace[1087278697] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"176.402673ms","start":"2026-03-26T01:55:59.384546Z","end":"2026-03-26T01:55:59.560948Z","steps":["trace[1087278697] 'process raft request' (duration: 175.902102ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:55:59.631292Z","caller":"traceutil/trace.go:171","msg":"trace[2124310793] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"125.894453ms","start":"2026-03-26T01:55:59.505363Z","end":"2026-03-26T01:55:59.631257Z","steps":["trace[2124310793] 'process raft request' (duration: 105.893521ms)","trace[2124310793] 'compare' (duration: 19.391529ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:55:59.938797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.232988ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:55:59.939143Z","caller":"traceutil/trace.go:171","msg":"trace[1850587728] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"243.694553ms","start":"2026-03-26T01:55:59.695428Z","end":"2026-03-26T01:55:59.939122Z","steps":["trace[1850587728] 'process raft request' (duration: 243.506509ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:55:59.93929Z","caller":"traceutil/trace.go:171","msg":"trace[362280039] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"248.02591ms","start":"2026-03-26T01:55:59.691253Z","end":"2026-03-26T01:55:59.939279Z","steps":["trace[362280039] 'process raft request' (duration: 91.210889ms)","trace[362280039] 'compare' (duration: 155.881211ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:56:00.49525Z","caller":"traceutil/trace.go:171","msg":"trace[1561331275] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"797.1418ms","start":"2026-03-26T01:55:59.698056Z","end":"2026-03-26T01:56:00.495198Z","steps":["trace[1561331275] 'process raft request' (duration: 726.079335ms)","trace[1561331275] 'compare' (duration: 70.803368ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:56:00.495427Z","caller":"traceutil/trace.go:171","msg":"trace[1970111432] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"720.192743ms","start":"2026-03-26T01:55:59.775215Z","end":"2026-03-26T01:56:00.495408Z","steps":["trace[1970111432] 'process raft request' (duration: 719.992908ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:00.495453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:59.69804Z","time spent":"797.312585ms","remote":"127.0.0.1:38352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:56:00.49554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:59.775194Z","time spent":"720.290785ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T01:56:00.518706Z","caller":"traceutil/trace.go:171","msg":"trace[352045597] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"547.868542ms","start":"2026-03-26T01:55:59.9708Z","end":"2026-03-26T01:56:00.518669Z","steps":["trace[352045597] 'process raft request' (duration: 547.453992ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:00.518882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:55:59.970778Z","time spent":"548.012565ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:56:00.51892Z","caller":"traceutil/trace.go:171","msg":"trace[1690065096] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"511.574822ms","start":"2026-03-26T01:56:00.007282Z","end":"2026-03-26T01:56:00.518857Z","steps":["trace[1690065096] 'process raft request' (duration: 511.212984ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:00.519714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:00.007252Z","time spent":"512.403291ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:56:04.038657Z","caller":"traceutil/trace.go:171","msg":"trace[684096152] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"172.860403ms","start":"2026-03-26T01:56:03.86578Z","end":"2026-03-26T01:56:04.03864Z","steps":["trace[684096152] 'process raft request' (duration: 171.771279ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:04.361454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.308104ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:56:04.361576Z","caller":"traceutil/trace.go:171","msg":"trace[567914] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"241.632637ms","start":"2026-03-26T01:56:04.119924Z","end":"2026-03-26T01:56:04.361557Z","steps":["trace[567914] 'process raft request' (duration: 95.135549ms)","trace[567914] 'compare' (duration: 146.1465ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:56:05.400483Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645310876219598,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-26T01:56:05.406115Z","caller":"traceutil/trace.go:171","msg":"trace[1537142430] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"634.754834ms","start":"2026-03-26T01:56:04.771335Z","end":"2026-03-26T01:56:05.40609Z","steps":["trace[1537142430] 'process raft request' (duration: 634.106799ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:05.406275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:04.771286Z","time spent":"634.906747ms","remote":"127.0.0.1:38414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036197,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:56:06.084035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.229219ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-26T01:56:06.084247Z","caller":"traceutil/trace.go:171","msg":"trace[1620516930] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"619.589901ms","start":"2026-03-26T01:56:05.464643Z","end":"2026-03-26T01:56:06.084233Z","steps":["trace[1620516930] 'process raft request' (duration: 619.495139ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:06.08424Z","caller":"traceutil/trace.go:171","msg":"trace[86773298] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:596; }","duration":"1.18414846s","start":"2026-03-26T01:56:04.900066Z","end":"2026-03-26T01:56:06.084215Z","steps":["trace[86773298] 'read index received' (duration: 505.170587ms)","trace[86773298] 'applied index is now lower than readState.Index' (duration: 678.975253ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:56:06.084333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:05.46462Z","time spent":"619.669274ms","remote":"127.0.0.1:38686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T01:56:06.084404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.184331764s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:06.084444Z","caller":"traceutil/trace.go:171","msg":"trace[1993436484] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:570; }","duration":"1.184414046s","start":"2026-03-26T01:56:04.900019Z","end":"2026-03-26T01:56:06.084433Z","steps":["trace[1993436484] 'agreement among raft nodes before linearized reading' (duration: 1.184322584s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:06.084474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:04.9Z","time spent":"1.184468256s","remote":"127.0.0.1:38336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-26T01:56:06.084757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"858.092656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-h9qmc\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-03-26T01:56:06.084814Z","caller":"traceutil/trace.go:171","msg":"trace[1243328476] range","detail":"{range_begin:/registry/pods/kube-system/cilium-h9qmc; range_end:; response_count:1; response_revision:570; }","duration":"858.170948ms","start":"2026-03-26T01:56:05.226618Z","end":"2026-03-26T01:56:06.084789Z","steps":["trace[1243328476] 'agreement among raft nodes before linearized reading' (duration: 858.043315ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:06.084845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:05.226602Z","time spent":"858.23574ms","remote":"127.0.0.1:38532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-h9qmc\" "} {"level":"warn","ts":"2026-03-26T01:56:06.085129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.381075ms","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-03-26T01:56:06.085174Z","caller":"traceutil/trace.go:171","msg":"trace[1962998129] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:570; }","duration":"975.443257ms","start":"2026-03-26T01:56:05.109716Z","end":"2026-03-26T01:56:06.085159Z","steps":["trace[1962998129] 'agreement among raft nodes before linearized reading' (duration: 975.315844ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:06.085161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"976.317277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-03-26T01:56:06.085208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:05.109707Z","time spent":"975.493978ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-26T01:56:06.085235Z","caller":"traceutil/trace.go:171","msg":"trace[1665221620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:570; }","duration":"976.424479ms","start":"2026-03-26T01:56:05.10879Z","end":"2026-03-26T01:56:06.085215Z","steps":["trace[1665221620] 'agreement among raft nodes before linearized reading' (duration: 976.191894ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:06.085279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:05.108779Z","time spent":"976.49219ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-26T01:56:06.085228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.35994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-03-26T01:56:06.085384Z","caller":"traceutil/trace.go:171","msg":"trace[319545131] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:570; }","duration":"977.547934ms","start":"2026-03-26T01:56:05.107819Z","end":"2026-03-26T01:56:06.085367Z","steps":["trace[319545131] 'agreement among raft nodes before linearized reading' (duration: 977.256628ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:06.085431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:05.107807Z","time spent":"977.613276ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-26T01:56:06.085744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"979.14351ms","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-03-26T01:56:06.085786Z","caller":"traceutil/trace.go:171","msg":"trace[1549447380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:570; }","duration":"979.257952ms","start":"2026-03-26T01:56:05.106518Z","end":"2026-03-26T01:56:06.085776Z","steps":["trace[1549447380] 'agreement among raft nodes before linearized reading' (duration: 978.118756ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:06.085848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:05.106495Z","time spent":"979.343834ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-26T01:56:06.260972Z","caller":"traceutil/trace.go:171","msg":"trace[1918225531] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"170.043629ms","start":"2026-03-26T01:56:06.090902Z","end":"2026-03-26T01:56:06.260946Z","steps":["trace[1918225531] 'process raft request' (duration: 109.933822ms)","trace[1918225531] 'compare' (duration: 59.980425ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:56:06.275823Z","caller":"traceutil/trace.go:171","msg":"trace[901273418] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"184.848454ms","start":"2026-03-26T01:56:06.090959Z","end":"2026-03-26T01:56:06.275807Z","steps":["trace[901273418] 'process raft request' (duration: 184.722211ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:06.276019Z","caller":"traceutil/trace.go:171","msg":"trace[540848177] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"184.973646ms","start":"2026-03-26T01:56:06.091035Z","end":"2026-03-26T01:56:06.276009Z","steps":["trace[540848177] 'process raft request' (duration: 184.738351ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:06.276313Z","caller":"traceutil/trace.go:171","msg":"trace[392839869] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:599; }","duration":"181.604991ms","start":"2026-03-26T01:56:06.094684Z","end":"2026-03-26T01:56:06.276289Z","steps":["trace[392839869] 'read index received' (duration: 106.168907ms)","trace[392839869] 'applied index is now lower than readState.Index' (duration: 75.434964ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:56:06.276366Z","caller":"traceutil/trace.go:171","msg":"trace[278143612] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"176.976016ms","start":"2026-03-26T01:56:06.09936Z","end":"2026-03-26T01:56:06.276336Z","steps":["trace[278143612] 'process raft request' (duration: 176.838813ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:06.276455Z","caller":"traceutil/trace.go:171","msg":"trace[975789658] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"184.309002ms","start":"2026-03-26T01:56:06.09213Z","end":"2026-03-26T01:56:06.276439Z","steps":["trace[975789658] 'process raft request' (duration: 183.832661ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:06.276508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.385805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:06.276536Z","caller":"traceutil/trace.go:171","msg":"trace[1061611393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:575; }","duration":"181.423676ms","start":"2026-03-26T01:56:06.095102Z","end":"2026-03-26T01:56:06.276526Z","steps":["trace[1061611393] 'agreement among raft nodes before linearized reading' (duration: 181.390265ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:06.276464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.768235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:06.276625Z","caller":"traceutil/trace.go:171","msg":"trace[1465808352] range","detail":"{range_begin:/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:575; }","duration":"181.937449ms","start":"2026-03-26T01:56:06.094672Z","end":"2026-03-26T01:56:06.27661Z","steps":["trace[1465808352] 'agreement among raft nodes before linearized reading' (duration: 181.747264ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.019439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.644769ms","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-03-26T01:56:07.019504Z","caller":"traceutil/trace.go:171","msg":"trace[1057934454] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:575; }","duration":"424.763892ms","start":"2026-03-26T01:56:06.594726Z","end":"2026-03-26T01:56:07.01949Z","steps":["trace[1057934454] 'count revisions from in-memory index tree' (duration: 424.506106ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.019554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.577651ms","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-03-26T01:56:07.019584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.797288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:07.019616Z","caller":"traceutil/trace.go:171","msg":"trace[1873939551] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:575; }","duration":"492.87383ms","start":"2026-03-26T01:56:06.526732Z","end":"2026-03-26T01:56:07.019606Z","steps":["trace[1873939551] 'range keys from in-memory index tree' (duration: 492.727906ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.019616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.877514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:07.019658Z","caller":"traceutil/trace.go:171","msg":"trace[1003883891] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:575; }","duration":"385.934555ms","start":"2026-03-26T01:56:06.633718Z","end":"2026-03-26T01:56:07.019652Z","steps":["trace[1003883891] 'count revisions from in-memory index tree' (duration: 385.773952ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.019607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.123928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T01:56:07.01972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.26806ms","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-03-26T01:56:07.019794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.904205ms","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":"warn","ts":"2026-03-26T01:56:07.019794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.196352ms","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-03-26T01:56:07.019813Z","caller":"traceutil/trace.go:171","msg":"trace[1538164172] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:575; }","duration":"397.943296ms","start":"2026-03-26T01:56:06.621863Z","end":"2026-03-26T01:56:07.019807Z","steps":["trace[1538164172] 'range keys from in-memory index tree' (duration: 397.845404ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.019826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.872531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:07.019846Z","caller":"traceutil/trace.go:171","msg":"trace[1452894455] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:575; }","duration":"481.929862ms","start":"2026-03-26T01:56:06.53791Z","end":"2026-03-26T01:56:07.01984Z","steps":["trace[1452894455] 'range keys from in-memory index tree' (duration: 481.773659ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.019873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.53789Z","time spent":"481.975534ms","remote":"127.0.0.1:41194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-03-26T01:56:07.019893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.621683Z","time spent":"398.150891ms","remote":"127.0.0.1:41220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-03-26T01:56:07.019882Z","caller":"traceutil/trace.go:171","msg":"trace[2076915893] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:575; }","duration":"425.223222ms","start":"2026-03-26T01:56:06.594589Z","end":"2026-03-26T01:56:07.019812Z","steps":["trace[2076915893] 'range keys from in-memory index tree' (duration: 425.13398ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.019929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.59454Z","time spent":"425.378956ms","remote":"127.0.0.1:41220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T01:56:07.019652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.526711Z","time spent":"492.931381ms","remote":"127.0.0.1:41194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"info","ts":"2026-03-26T01:56:07.019812Z","caller":"traceutil/trace.go:171","msg":"trace[329229671] 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:575; }","duration":"459.372973ms","start":"2026-03-26T01:56:06.560397Z","end":"2026-03-26T01:56:07.01977Z","steps":["trace[329229671] 'range keys from in-memory index tree' (duration: 459.005045ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:07.019798Z","caller":"traceutil/trace.go:171","msg":"trace[265359053] 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:575; }","duration":"459.453675ms","start":"2026-03-26T01:56:06.560334Z","end":"2026-03-26T01:56:07.019787Z","steps":["trace[265359053] 'count revisions from in-memory index tree' (duration: 459.134307ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.020105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.560322Z","time spent":"459.772132ms","remote":"127.0.0.1:41206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-03-26T01:56:07.020101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.326524ms","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-03-26T01:56:07.020113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.56031Z","time spent":"459.774781ms","remote":"127.0.0.1:41206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"info","ts":"2026-03-26T01:56:07.020202Z","caller":"traceutil/trace.go:171","msg":"trace[735190399] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:575; }","duration":"386.520038ms","start":"2026-03-26T01:56:06.633663Z","end":"2026-03-26T01:56:07.020183Z","steps":["trace[735190399] 'range keys from in-memory index tree' (duration: 385.628529ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.019725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.888404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T01:56:07.020263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.633639Z","time spent":"386.59609ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T01:56:07.019686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.63371Z","time spent":"385.968895ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-03-26T01:56:07.019589Z","caller":"traceutil/trace.go:171","msg":"trace[2087003768] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:575; }","duration":"383.642023ms","start":"2026-03-26T01:56:06.635939Z","end":"2026-03-26T01:56:07.019581Z","steps":["trace[2087003768] 'range keys from in-memory index tree' (duration: 383.474719ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:07.020313Z","caller":"traceutil/trace.go:171","msg":"trace[1774060295] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:575; }","duration":"398.445967ms","start":"2026-03-26T01:56:06.621814Z","end":"2026-03-26T01:56:07.02026Z","steps":["trace[1774060295] 'count revisions from in-memory index tree' (duration: 397.861744ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.019686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.944722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:07.020446Z","caller":"traceutil/trace.go:171","msg":"trace[812626762] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:575; }","duration":"493.722488ms","start":"2026-03-26T01:56:06.526712Z","end":"2026-03-26T01:56:07.020435Z","steps":["trace[812626762] 'count revisions from in-memory index tree' (duration: 492.860889ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.019747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.992277ms","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-03-26T01:56:07.020443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.621809Z","time spent":"398.58826ms","remote":"127.0.0.1:41234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-03-26T01:56:07.020484Z","caller":"traceutil/trace.go:171","msg":"trace[1898415092] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:575; }","duration":"398.722363ms","start":"2026-03-26T01:56:06.621749Z","end":"2026-03-26T01:56:07.020472Z","steps":["trace[1898415092] 'range keys from in-memory index tree' (duration: 397.955046ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.019741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.594629Z","time spent":"425.052709ms","remote":"127.0.0.1:41220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-26T01:56:07.020456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.635925Z","time spent":"384.470531ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-03-26T01:56:07.02052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.621728Z","time spent":"398.778345ms","remote":"127.0.0.1:41234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T01:56:07.020533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.526698Z","time spent":"493.789329ms","remote":"127.0.0.1:41194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-26T01:56:07.01977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.339422ms","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-03-26T01:56:07.020575Z","caller":"traceutil/trace.go:171","msg":"trace[1386513695] 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:575; }","duration":"460.15669ms","start":"2026-03-26T01:56:06.560409Z","end":"2026-03-26T01:56:07.020566Z","steps":["trace[1386513695] 'range keys from in-memory index tree' (duration: 459.223259ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.020608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.560402Z","time spent":"460.195471ms","remote":"127.0.0.1:41206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-03-26T01:56:07.290842Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645310876219624,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-26T01:56:07.460713Z","caller":"traceutil/trace.go:171","msg":"trace[936509999] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"669.912288ms","start":"2026-03-26T01:56:06.790779Z","end":"2026-03-26T01:56:07.460692Z","steps":["trace[936509999] 'read index received' (duration: 669.048998ms)","trace[936509999] 'applied index is now lower than readState.Index' (duration: 862.07µs)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:56:07.460948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.146273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:07.460798Z","caller":"traceutil/trace.go:171","msg":"trace[1858064224] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"785.308093ms","start":"2026-03-26T01:56:06.675477Z","end":"2026-03-26T01:56:07.460785Z","steps":["trace[1858064224] 'process raft request' (duration: 784.641428ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:07.461426Z","caller":"traceutil/trace.go:171","msg":"trace[1770781248] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:576; }","duration":"670.241365ms","start":"2026-03-26T01:56:06.790738Z","end":"2026-03-26T01:56:07.46098Z","steps":["trace[1770781248] 'agreement among raft nodes before linearized reading' (duration: 670.156163ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.461421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.675446Z","time spent":"785.832545ms","remote":"127.0.0.1:38414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:56:07.46151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.790717Z","time spent":"670.774446ms","remote":"127.0.0.1:41248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T01:56:07.461572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.948391ms","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-03-26T01:56:07.461646Z","caller":"traceutil/trace.go:171","msg":"trace[2030190320] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:576; }","duration":"214.086044ms","start":"2026-03-26T01:56:07.247547Z","end":"2026-03-26T01:56:07.461633Z","steps":["trace[2030190320] 'agreement among raft nodes before linearized reading' (duration: 213.95014ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.461743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.757856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T01:56:07.461843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.186051ms","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-03-26T01:56:07.461842Z","caller":"traceutil/trace.go:171","msg":"trace[277020344] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:576; }","duration":"671.014021ms","start":"2026-03-26T01:56:06.790796Z","end":"2026-03-26T01:56:07.46181Z","steps":["trace[277020344] 'agreement among raft nodes before linearized reading' (duration: 670.690874ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:07.461886Z","caller":"traceutil/trace.go:171","msg":"trace[1621179868] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:576; }","duration":"394.264432ms","start":"2026-03-26T01:56:07.06761Z","end":"2026-03-26T01:56:07.461874Z","steps":["trace[1621179868] 'agreement among raft nodes before linearized reading' (duration: 394.201901ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.461918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:07.067402Z","time spent":"394.507198ms","remote":"127.0.0.1:41298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-26T01:56:07.461896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.477429ms","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-03-26T01:56:07.461995Z","caller":"traceutil/trace.go:171","msg":"trace[246413775] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:576; }","duration":"100.013458ms","start":"2026-03-26T01:56:07.361947Z","end":"2026-03-26T01:56:07.461961Z","steps":["trace[246413775] 'agreement among raft nodes before linearized reading' (duration: 100.003658ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.461923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.790763Z","time spent":"671.145025ms","remote":"127.0.0.1:41248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-03-26T01:56:07.462006Z","caller":"traceutil/trace.go:171","msg":"trace[997000820] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:576; }","duration":"437.601822ms","start":"2026-03-26T01:56:07.024354Z","end":"2026-03-26T01:56:07.461956Z","steps":["trace[997000820] 'agreement among raft nodes before linearized reading' (duration: 437.441138ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.462056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:07.024343Z","time spent":"437.701575ms","remote":"127.0.0.1:41296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T01:56:07.462104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.115378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:07.46214Z","caller":"traceutil/trace.go:171","msg":"trace[1114599856] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:576; }","duration":"246.18413ms","start":"2026-03-26T01:56:07.215947Z","end":"2026-03-26T01:56:07.462131Z","steps":["trace[1114599856] 'agreement among raft nodes before linearized reading' (duration: 246.130158ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.462179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.75815ms","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-03-26T01:56:07.462199Z","caller":"traceutil/trace.go:171","msg":"trace[316043204] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:576; }","duration":"140.78681ms","start":"2026-03-26T01:56:07.321407Z","end":"2026-03-26T01:56:07.462194Z","steps":["trace[316043204] 'agreement among raft nodes before linearized reading' (duration: 140.756869ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.462283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.792366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:07.462316Z","caller":"traceutil/trace.go:171","msg":"trace[2020238297] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:576; }","duration":"247.849508ms","start":"2026-03-26T01:56:07.214459Z","end":"2026-03-26T01:56:07.462308Z","steps":["trace[2020238297] 'agreement among raft nodes before linearized reading' (duration: 247.801466ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.462347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.958553ms","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-03-26T01:56:07.462345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.926488ms","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-03-26T01:56:07.462369Z","caller":"traceutil/trace.go:171","msg":"trace[743305268] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:576; }","duration":"140.997295ms","start":"2026-03-26T01:56:07.321366Z","end":"2026-03-26T01:56:07.462364Z","steps":["trace[743305268] 'agreement among raft nodes before linearized reading' (duration: 140.962554ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:07.462378Z","caller":"traceutil/trace.go:171","msg":"trace[709625999] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:576; }","duration":"394.959429ms","start":"2026-03-26T01:56:07.067408Z","end":"2026-03-26T01:56:07.462368Z","steps":["trace[709625999] 'agreement among raft nodes before linearized reading' (duration: 394.908458ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.462417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:07.067403Z","time spent":"395.00551ms","remote":"127.0.0.1:41298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-03-26T01:56:07.462498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.881503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T01:56:07.462485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.036581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T01:56:07.462571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.560238ms","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-03-26T01:56:07.46259Z","caller":"traceutil/trace.go:171","msg":"trace[1730625728] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:576; }","duration":"184.593099ms","start":"2026-03-26T01:56:07.277992Z","end":"2026-03-26T01:56:07.462585Z","steps":["trace[1730625728] 'agreement among raft nodes before linearized reading' (duration: 184.538007ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.462581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.663495ms","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-03-26T01:56:07.462655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.290836ms","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-03-26T01:56:07.462772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.096718ms","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-03-26T01:56:07.462788Z","caller":"traceutil/trace.go:171","msg":"trace[1416859577] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:576; }","duration":"395.433589ms","start":"2026-03-26T01:56:07.067339Z","end":"2026-03-26T01:56:07.462773Z","steps":["trace[1416859577] 'agreement among raft nodes before linearized reading' (duration: 395.295296ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:07.46281Z","caller":"traceutil/trace.go:171","msg":"trace[2001700581] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:576; }","duration":"215.17865ms","start":"2026-03-26T01:56:07.247626Z","end":"2026-03-26T01:56:07.462804Z","steps":["trace[2001700581] 'agreement among raft nodes before linearized reading' (duration: 215.133499ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.462834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:07.067292Z","time spent":"395.527971ms","remote":"127.0.0.1:41298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T01:56:07.462768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.529134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:07.463084Z","caller":"traceutil/trace.go:171","msg":"trace[1018598436] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:576; }","duration":"493.880241ms","start":"2026-03-26T01:56:06.969192Z","end":"2026-03-26T01:56:07.463072Z","steps":["trace[1018598436] 'agreement among raft nodes before linearized reading' (duration: 493.549274ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.463106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.654606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T01:56:07.463135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.969158Z","time spent":"493.963994ms","remote":"127.0.0.1:41280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-03-26T01:56:07.463143Z","caller":"traceutil/trace.go:171","msg":"trace[1597818558] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:576; }","duration":"438.715677ms","start":"2026-03-26T01:56:07.024417Z","end":"2026-03-26T01:56:07.463132Z","steps":["trace[1597818558] 'agreement among raft nodes before linearized reading' (duration: 438.658276ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.463176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:07.024406Z","time spent":"438.762428ms","remote":"127.0.0.1:41296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-03-26T01:56:07.462658Z","caller":"traceutil/trace.go:171","msg":"trace[539976586] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:576; }","duration":"492.763437ms","start":"2026-03-26T01:56:06.969877Z","end":"2026-03-26T01:56:07.46264Z","steps":["trace[539976586] 'agreement among raft nodes before linearized reading' (duration: 492.618634ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.462604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.145625ms","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-03-26T01:56:07.463394Z","caller":"traceutil/trace.go:171","msg":"trace[836236230] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:576; }","duration":"438.954152ms","start":"2026-03-26T01:56:07.024423Z","end":"2026-03-26T01:56:07.463377Z","steps":["trace[836236230] 'agreement among raft nodes before linearized reading' (duration: 438.126614ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.463581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:07.024418Z","time spent":"439.147746ms","remote":"127.0.0.1:41296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-03-26T01:56:07.463669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.506255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T01:56:07.46336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.96987Z","time spent":"493.479343ms","remote":"127.0.0.1:41280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-03-26T01:56:07.463719Z","caller":"traceutil/trace.go:171","msg":"trace[2112823536] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:576; }","duration":"552.623489ms","start":"2026-03-26T01:56:06.911084Z","end":"2026-03-26T01:56:07.463707Z","steps":["trace[2112823536] 'agreement among raft nodes before linearized reading' (duration: 552.552027ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.463754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.911056Z","time spent":"552.6892ms","remote":"127.0.0.1:41248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-03-26T01:56:07.462738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.770842ms","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-03-26T01:56:07.463862Z","caller":"traceutil/trace.go:171","msg":"trace[432677909] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:576; }","duration":"185.891207ms","start":"2026-03-26T01:56:07.27796Z","end":"2026-03-26T01:56:07.463851Z","steps":["trace[432677909] 'agreement among raft nodes before linearized reading' (duration: 184.742241ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.463882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.900158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:07.46391Z","caller":"traceutil/trace.go:171","msg":"trace[1888326876] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:576; }","duration":"526.952709ms","start":"2026-03-26T01:56:06.936949Z","end":"2026-03-26T01:56:07.463902Z","steps":["trace[1888326876] 'agreement among raft nodes before linearized reading' (duration: 526.909968ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.463945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.936939Z","time spent":"526.9988ms","remote":"127.0.0.1:41270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-03-26T01:56:07.464091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.89177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:07.464125Z","caller":"traceutil/trace.go:171","msg":"trace[1557771079] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:576; }","duration":"527.956002ms","start":"2026-03-26T01:56:06.936161Z","end":"2026-03-26T01:56:07.464117Z","steps":["trace[1557771079] 'agreement among raft nodes before linearized reading' (duration: 527.905611ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.464157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.936142Z","time spent":"528.008142ms","remote":"127.0.0.1:41270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-03-26T01:56:07.462148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.284874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T01:56:07.464279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.171276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:07.464279Z","caller":"traceutil/trace.go:171","msg":"trace[788707028] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:576; }","duration":"102.451263ms","start":"2026-03-26T01:56:07.361806Z","end":"2026-03-26T01:56:07.464257Z","steps":["trace[788707028] 'agreement among raft nodes before linearized reading' (duration: 100.292345ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:07.464312Z","caller":"traceutil/trace.go:171","msg":"trace[293878434] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:576; }","duration":"528.222537ms","start":"2026-03-26T01:56:06.93608Z","end":"2026-03-26T01:56:07.464303Z","steps":["trace[293878434] 'agreement among raft nodes before linearized reading' (duration: 528.175376ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.464345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.936067Z","time spent":"528.270749ms","remote":"127.0.0.1:41270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T01:56:07.464708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.546371ms","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-03-26T01:56:07.464752Z","caller":"traceutil/trace.go:171","msg":"trace[1229684779] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:576; }","duration":"554.626074ms","start":"2026-03-26T01:56:06.910115Z","end":"2026-03-26T01:56:07.464741Z","steps":["trace[1229684779] 'agreement among raft nodes before linearized reading' (duration: 554.550103ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.464783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.910099Z","time spent":"554.675945ms","remote":"127.0.0.1:41254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-03-26T01:56:07.464933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.704106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:07.464969Z","caller":"traceutil/trace.go:171","msg":"trace[362336317] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:576; }","duration":"554.778477ms","start":"2026-03-26T01:56:06.910181Z","end":"2026-03-26T01:56:07.46496Z","steps":["trace[362336317] 'agreement among raft nodes before linearized reading' (duration: 554.725416ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.464997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.910157Z","time spent":"554.832359ms","remote":"127.0.0.1:41254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-03-26T01:56:07.462519Z","caller":"traceutil/trace.go:171","msg":"trace[493839886] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:576; }","duration":"183.942384ms","start":"2026-03-26T01:56:07.27857Z","end":"2026-03-26T01:56:07.462512Z","steps":["trace[493839886] 'agreement among raft nodes before linearized reading' (duration: 183.889793ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:07.467761Z","caller":"traceutil/trace.go:171","msg":"trace[965553650] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:576; }","duration":"248.140044ms","start":"2026-03-26T01:56:07.214393Z","end":"2026-03-26T01:56:07.462533Z","steps":["trace[965553650] 'agreement among raft nodes before linearized reading' (duration: 248.015561ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.462814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.667558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:07.469004Z","caller":"traceutil/trace.go:171","msg":"trace[303456883] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:576; }","duration":"499.844547ms","start":"2026-03-26T01:56:06.969138Z","end":"2026-03-26T01:56:07.468983Z","steps":["trace[303456883] 'agreement among raft nodes before linearized reading' (duration: 493.653477ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:07.469059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:06.969101Z","time spent":"499.938648ms","remote":"127.0.0.1:41280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-03-26T01:56:08.740419Z","caller":"traceutil/trace.go:171","msg":"trace[644982804] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"320.62185ms","start":"2026-03-26T01:56:08.419772Z","end":"2026-03-26T01:56:08.740394Z","steps":["trace[644982804] 'process raft request' (duration: 319.144757ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:08.7431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:08.419689Z","time spent":"323.329222ms","remote":"127.0.0.1:38414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:56:09.916231Z","caller":"traceutil/trace.go:171","msg":"trace[589892701] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"147.653004ms","start":"2026-03-26T01:56:09.768552Z","end":"2026-03-26T01:56:09.916205Z","steps":["trace[589892701] 'process raft request' (duration: 146.691642ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:09.921127Z","caller":"traceutil/trace.go:171","msg":"trace[1299773836] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"111.564889ms","start":"2026-03-26T01:56:09.809537Z","end":"2026-03-26T01:56:09.921102Z","steps":["trace[1299773836] 'process raft request' (duration: 111.349134ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:12.588628Z","caller":"traceutil/trace.go:171","msg":"trace[279253832] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"130.443406ms","start":"2026-03-26T01:56:12.458146Z","end":"2026-03-26T01:56:12.588589Z","steps":["trace[279253832] 'process raft request' (duration: 130.24742ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:20.502389Z","caller":"traceutil/trace.go:171","msg":"trace[798626046] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"122.311421ms","start":"2026-03-26T01:56:20.380048Z","end":"2026-03-26T01:56:20.50236Z","steps":["trace[798626046] 'process raft request' (duration: 122.182998ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:20.502636Z","caller":"traceutil/trace.go:171","msg":"trace[1659870045] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"122.445074ms","start":"2026-03-26T01:56:20.379897Z","end":"2026-03-26T01:56:20.502342Z","steps":["trace[1659870045] 'process raft request' (duration: 120.851589ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:20.546749Z","caller":"traceutil/trace.go:171","msg":"trace[1602027827] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"162.770556ms","start":"2026-03-26T01:56:20.383855Z","end":"2026-03-26T01:56:20.546626Z","steps":["trace[1602027827] 'process raft request' (duration: 162.653533ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:20.762889Z","caller":"traceutil/trace.go:171","msg":"trace[150466334] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"206.443021ms","start":"2026-03-26T01:56:20.556422Z","end":"2026-03-26T01:56:20.762865Z","steps":["trace[150466334] 'process raft request' (duration: 206.290258ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:21.348877Z","caller":"traceutil/trace.go:171","msg":"trace[756050018] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"257.488954ms","start":"2026-03-26T01:56:21.091358Z","end":"2026-03-26T01:56:21.348847Z","steps":["trace[756050018] 'process raft request' (duration: 257.30247ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:22.868026Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645310876219943,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-26T01:56:23.259725Z","caller":"traceutil/trace.go:171","msg":"trace[1764341572] linearizableReadLoop","detail":"{readStateIndex:765; appliedIndex:764; }","duration":"892.707099ms","start":"2026-03-26T01:56:22.366994Z","end":"2026-03-26T01:56:23.259701Z","steps":["trace[1764341572] 'read index received' (duration: 892.570366ms)","trace[1764341572] 'applied index is now lower than readState.Index' (duration: 135.733µs)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:56:23.259877Z","caller":"traceutil/trace.go:171","msg":"trace[1343476664] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"902.393507ms","start":"2026-03-26T01:56:22.357356Z","end":"2026-03-26T01:56:23.259749Z","steps":["trace[1343476664] 'process raft request' (duration: 902.187932ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:23.259936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.604157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:23.26003Z","caller":"traceutil/trace.go:171","msg":"trace[1399685425] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:732; }","duration":"358.749831ms","start":"2026-03-26T01:56:22.901271Z","end":"2026-03-26T01:56:23.26002Z","steps":["trace[1399685425] 'agreement among raft nodes before linearized reading' (duration: 358.618238ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:23.260059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:22.901254Z","time spent":"358.797911ms","remote":"127.0.0.1:38328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-26T01:56:23.260138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:22.357338Z","time spent":"902.631852ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:56:23.260201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.871905ms","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-03-26T01:56:23.260303Z","caller":"traceutil/trace.go:171","msg":"trace[1652255828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:732; }","duration":"751.042969ms","start":"2026-03-26T01:56:22.509236Z","end":"2026-03-26T01:56:23.260279Z","steps":["trace[1652255828] 'agreement among raft nodes before linearized reading' (duration: 750.732163ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:23.260371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:22.509199Z","time spent":"751.162702ms","remote":"127.0.0.1:38618","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-03-26T01:56:23.260426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.859656ms","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-03-26T01:56:23.26046Z","caller":"traceutil/trace.go:171","msg":"trace[2076786446] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:732; }","duration":"878.920046ms","start":"2026-03-26T01:56:22.381532Z","end":"2026-03-26T01:56:23.260452Z","steps":["trace[2076786446] 'agreement among raft nodes before linearized reading' (duration: 878.324253ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:23.260479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:22.38152Z","time spent":"878.955768ms","remote":"127.0.0.1:38618","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-03-26T01:56:23.260179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.166569ms","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-03-26T01:56:23.26105Z","caller":"traceutil/trace.go:171","msg":"trace[1449731664] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:732; }","duration":"894.067309ms","start":"2026-03-26T01:56:22.36695Z","end":"2026-03-26T01:56:23.261018Z","steps":["trace[1449731664] 'agreement among raft nodes before linearized reading' (duration: 892.837852ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:23.261114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:22.366933Z","time spent":"894.15745ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-03-26T01:56:23.618594Z","caller":"traceutil/trace.go:171","msg":"trace[1798665821] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"353.536743ms","start":"2026-03-26T01:56:23.265025Z","end":"2026-03-26T01:56:23.618562Z","steps":["trace[1798665821] 'process raft request' (duration: 352.304455ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:23.618776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:23.264984Z","time spent":"353.685476ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:56:23.965626Z","caller":"traceutil/trace.go:171","msg":"trace[2107476402] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"699.983267ms","start":"2026-03-26T01:56:23.265583Z","end":"2026-03-26T01:56:23.965566Z","steps":["trace[2107476402] 'process raft request' (duration: 699.606838ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:23.965808Z","caller":"traceutil/trace.go:171","msg":"trace[278105048] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:765; }","duration":"612.329677ms","start":"2026-03-26T01:56:23.353445Z","end":"2026-03-26T01:56:23.965774Z","steps":["trace[278105048] 'read index received' (duration: 263.783586ms)","trace[278105048] 'applied index is now lower than readState.Index' (duration: 348.541131ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:56:23.966113Z","caller":"traceutil/trace.go:171","msg":"trace[736167211] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"700.416275ms","start":"2026-03-26T01:56:23.265674Z","end":"2026-03-26T01:56:23.96609Z","steps":["trace[736167211] 'process raft request' (duration: 699.72287ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:23.966144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:23.265563Z","time spent":"700.322274ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:56:23.966417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.968721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-03-26T01:56:23.966283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:23.265664Z","time spent":"700.498608ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:56:23.966459Z","caller":"traceutil/trace.go:171","msg":"trace[257862913] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:735; }","duration":"613.053503ms","start":"2026-03-26T01:56:23.353395Z","end":"2026-03-26T01:56:23.966449Z","steps":["trace[257862913] 'agreement among raft nodes before linearized reading' (duration: 612.522171ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:23.966521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:23.353371Z","time spent":"613.142156ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-26T01:56:24.271418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.991869ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:56:24.271593Z","caller":"traceutil/trace.go:171","msg":"trace[6901082] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"299.038353ms","start":"2026-03-26T01:56:23.972527Z","end":"2026-03-26T01:56:24.271565Z","steps":["trace[6901082] 'process raft request' (duration: 97.767569ms)","trace[6901082] 'compare' (duration: 200.61232ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:56:28.857057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.570209ms","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-03-26T01:56:28.857134Z","caller":"traceutil/trace.go:171","msg":"trace[735312173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:753; }","duration":"874.697632ms","start":"2026-03-26T01:56:27.982418Z","end":"2026-03-26T01:56:28.857116Z","steps":["trace[735312173] 'range keys from in-memory index tree' (duration: 874.404296ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:28.857149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.932925ms","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-03-26T01:56:28.857174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:27.982397Z","time spent":"874.768433ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-26T01:56:28.857216Z","caller":"traceutil/trace.go:171","msg":"trace[2125719068] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:753; }","duration":"874.042188ms","start":"2026-03-26T01:56:27.983156Z","end":"2026-03-26T01:56:28.857198Z","steps":["trace[2125719068] 'range keys from in-memory index tree' (duration: 873.753681ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:28.857263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:27.983136Z","time spent":"874.116789ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-26T01:56:28.857369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.635052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-26T01:56:28.857446Z","caller":"traceutil/trace.go:171","msg":"trace[1719012359] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:753; }","duration":"664.765845ms","start":"2026-03-26T01:56:28.192658Z","end":"2026-03-26T01:56:28.857424Z","steps":["trace[1719012359] 'count revisions from in-memory index tree' (duration: 664.56792ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:28.857498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:28.192638Z","time spent":"664.845006ms","remote":"127.0.0.1:38544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":42,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-03-26T01:56:28.857506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.263672ms","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-03-26T01:56:28.857535Z","caller":"traceutil/trace.go:171","msg":"trace[85734003] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:753; }","duration":"573.337963ms","start":"2026-03-26T01:56:28.28419Z","end":"2026-03-26T01:56:28.857528Z","steps":["trace[85734003] 'range keys from in-memory index tree' (duration: 573.126899ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:28.857558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:28.284162Z","time spent":"573.391455ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-03-26T01:56:28.875891Z","caller":"traceutil/trace.go:171","msg":"trace[1674274111] linearizableReadLoop","detail":"{readStateIndex:788; appliedIndex:787; }","duration":"357.682916ms","start":"2026-03-26T01:56:28.518191Z","end":"2026-03-26T01:56:28.875874Z","steps":["trace[1674274111] 'read index received' (duration: 357.534973ms)","trace[1674274111] 'applied index is now lower than readState.Index' (duration: 145.043µs)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:56:28.876028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.830659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:56:28.876071Z","caller":"traceutil/trace.go:171","msg":"trace[702779022] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:754; }","duration":"357.941791ms","start":"2026-03-26T01:56:28.518113Z","end":"2026-03-26T01:56:28.876054Z","steps":["trace[702779022] 'agreement among raft nodes before linearized reading' (duration: 357.843069ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:28.876049Z","caller":"traceutil/trace.go:171","msg":"trace[1182997458] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"514.716615ms","start":"2026-03-26T01:56:28.361297Z","end":"2026-03-26T01:56:28.876013Z","steps":["trace[1182997458] 'process raft request' (duration: 514.475809ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:56:28.876188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:28.518092Z","time spent":"358.073655ms","remote":"127.0.0.1:38328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-26T01:56:28.876251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:56:28.361267Z","time spent":"514.881409ms","remote":"127.0.0.1:38582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:56:35.095664Z","caller":"traceutil/trace.go:171","msg":"trace[1344079694] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"143.478911ms","start":"2026-03-26T01:56:34.95216Z","end":"2026-03-26T01:56:35.095639Z","steps":["trace[1344079694] 'process raft request' (duration: 143.42453ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:56:35.095714Z","caller":"traceutil/trace.go:171","msg":"trace[1148257637] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"143.781438ms","start":"2026-03-26T01:56:34.951901Z","end":"2026-03-26T01:56:35.095683Z","steps":["trace[1148257637] 'process raft request' (duration: 105.672084ms)","trace[1148257637] 'compare' (duration: 37.848848ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:56:51.594744Z","caller":"traceutil/trace.go:171","msg":"trace[221027012] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"111.368634ms","start":"2026-03-26T01:56:51.483351Z","end":"2026-03-26T01:56:51.59472Z","steps":["trace[221027012] 'process raft request' (duration: 83.3887ms)","trace[221027012] 'compare' (duration: 27.887231ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:56:57.632303Z","caller":"traceutil/trace.go:171","msg":"trace[1748665981] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"141.886586ms","start":"2026-03-26T01:56:57.490395Z","end":"2026-03-26T01:56:57.632281Z","steps":["trace[1748665981] 'process raft request' (duration: 141.22038ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:03.607265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.525838ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:57:03.60741Z","caller":"traceutil/trace.go:171","msg":"trace[1221364515] linearizableReadLoop","detail":"{readStateIndex:1016; appliedIndex:1015; }","duration":"254.688172ms","start":"2026-03-26T01:57:03.352704Z","end":"2026-03-26T01:57:03.607392Z","steps":["trace[1221364515] 'read index received' (duration: 116.896768ms)","trace[1221364515] 'applied index is now lower than readState.Index' (duration: 137.789913ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:57:03.607541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.833695ms","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-03-26T01:57:03.607569Z","caller":"traceutil/trace.go:171","msg":"trace[2144367883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:972; }","duration":"254.882136ms","start":"2026-03-26T01:57:03.352677Z","end":"2026-03-26T01:57:03.607559Z","steps":["trace[2144367883] 'agreement among raft nodes before linearized reading' (duration: 254.760254ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:57:03.60776Z","caller":"traceutil/trace.go:171","msg":"trace[204277339] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"296.396107ms","start":"2026-03-26T01:57:03.311332Z","end":"2026-03-26T01:57:03.607728Z","steps":["trace[204277339] 'process raft request' (duration: 158.321167ms)","trace[204277339] 'compare' (duration: 137.391664ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:57:04.792985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.290574ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:57:04.793101Z","caller":"traceutil/trace.go:171","msg":"trace[35555696] linearizableReadLoop","detail":"{readStateIndex:1017; appliedIndex:1016; }","duration":"1.139345781s","start":"2026-03-26T01:57:03.653738Z","end":"2026-03-26T01:57:04.793084Z","steps":["trace[35555696] 'read index received' (duration: 478.848952ms)","trace[35555696] 'applied index is now lower than readState.Index' (duration: 660.494849ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:57:04.793131Z","caller":"traceutil/trace.go:171","msg":"trace[1407974481] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"1.18170842s","start":"2026-03-26T01:57:03.611385Z","end":"2026-03-26T01:57:04.793094Z","steps":["trace[1407974481] 'process raft request' (duration: 521.185351ms)","trace[1407974481] 'compare' (duration: 659.829704ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:57:04.793272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.139532735s","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-03-26T01:57:04.79327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:03.611315Z","time spent":"1.181880064s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:57:04.793306Z","caller":"traceutil/trace.go:171","msg":"trace[1226586162] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:973; }","duration":"1.139603506s","start":"2026-03-26T01:57:03.65369Z","end":"2026-03-26T01:57:04.793294Z","steps":["trace[1226586162] 'agreement among raft nodes before linearized reading' (duration: 1.139465973s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:04.793344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:03.65367Z","time spent":"1.139663197s","remote":"127.0.0.1:38618","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-03-26T01:57:05.293654Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645310876220466,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T01:57:05.794581Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645310876220466,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T01:57:06.124071Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.991524092s","expected-duration":"1s"} {"level":"info","ts":"2026-03-26T01:57:06.12442Z","caller":"traceutil/trace.go:171","msg":"trace[733717219] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"2.459768023s","start":"2026-03-26T01:57:03.664623Z","end":"2026-03-26T01:57:06.124391Z","steps":["trace[733717219] 'process raft request' (duration: 2.45960634s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:06.124599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:03.664605Z","time spent":"2.459886276s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:57:06.125935Z","caller":"traceutil/trace.go:171","msg":"trace[1984319283] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"1.328718682s","start":"2026-03-26T01:57:04.7972Z","end":"2026-03-26T01:57:06.125919Z","steps":["trace[1984319283] 'process raft request' (duration: 1.328521657s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:06.12615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:04.797184Z","time spent":"1.328921157s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:57:06.127428Z","caller":"traceutil/trace.go:171","msg":"trace[1368312918] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1017; }","duration":"1.334281097s","start":"2026-03-26T01:57:04.793128Z","end":"2026-03-26T01:57:06.127409Z","steps":["trace[1368312918] 'read index received' (duration: 1.331122015s)","trace[1368312918] 'applied index is now lower than readState.Index' (duration: 3.157782ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:57:06.127438Z","caller":"traceutil/trace.go:171","msg":"trace[2071198343] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"1.058721353s","start":"2026-03-26T01:57:05.068698Z","end":"2026-03-26T01:57:06.127419Z","steps":["trace[2071198343] 'process raft request' (duration: 1.058564169s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:06.127545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:05.068676Z","time spent":"1.058813006s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:57:06.12759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.227100699s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:57:06.127628Z","caller":"traceutil/trace.go:171","msg":"trace[1145080105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:976; }","duration":"1.22717891s","start":"2026-03-26T01:57:04.900439Z","end":"2026-03-26T01:57:06.127618Z","steps":["trace[1145080105] 'agreement among raft nodes before linearized reading' (duration: 1.227114249s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:06.127655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:04.900418Z","time spent":"1.227231551s","remote":"127.0.0.1:38328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-26T01:57:06.127679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.204697ms","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":"warn","ts":"2026-03-26T01:57:06.12767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.836796965s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-26T01:57:06.127789Z","caller":"traceutil/trace.go:171","msg":"trace[1699039528] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:976; }","duration":"1.836963189s","start":"2026-03-26T01:57:04.290801Z","end":"2026-03-26T01:57:06.127765Z","steps":["trace[1699039528] 'agreement among raft nodes before linearized reading' (duration: 1.836649692s)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:57:06.127728Z","caller":"traceutil/trace.go:171","msg":"trace[1258301096] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:976; }","duration":"516.3088ms","start":"2026-03-26T01:57:05.611408Z","end":"2026-03-26T01:57:06.127717Z","steps":["trace[1258301096] 'agreement among raft nodes before linearized reading' (duration: 516.165836ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:06.127842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:04.29076Z","time spent":"1.837072791s","remote":"127.0.0.1:38512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-03-26T01:57:06.127879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:05.611386Z","time spent":"516.484294ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-26T01:57:06.127694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.049244ms","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-03-26T01:57:06.128021Z","caller":"traceutil/trace.go:171","msg":"trace[1390899561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:976; }","duration":"839.346901ms","start":"2026-03-26T01:57:05.288599Z","end":"2026-03-26T01:57:06.127945Z","steps":["trace[1390899561] 'agreement among raft nodes before linearized reading' (duration: 839.026974ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:06.128087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:05.288575Z","time spent":"839.491373ms","remote":"127.0.0.1:38618","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-03-26T01:57:06.128949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.268397406s","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-03-26T01:57:06.129047Z","caller":"traceutil/trace.go:171","msg":"trace[203575884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:976; }","duration":"2.269200945s","start":"2026-03-26T01:57:03.859813Z","end":"2026-03-26T01:57:06.129014Z","steps":["trace[203575884] 'agreement among raft nodes before linearized reading' (duration: 2.26770213s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:06.129095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:03.859735Z","time spent":"2.269343378s","remote":"127.0.0.1:38618","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-03-26T01:57:15.099607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.929203ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-26T01:57:29.151164Z","caller":"traceutil/trace.go:171","msg":"trace[310088083] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"158.005171ms","start":"2026-03-26T01:57:28.993131Z","end":"2026-03-26T01:57:29.151136Z","steps":["trace[310088083] 'process raft request' (duration: 157.835167ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:30.086399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.1099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:57:30.086495Z","caller":"traceutil/trace.go:171","msg":"trace[1849185295] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1052; }","duration":"186.290863ms","start":"2026-03-26T01:57:29.900184Z","end":"2026-03-26T01:57:30.086475Z","steps":["trace[1849185295] 'range keys from in-memory index tree' (duration: 185.954407ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:30.086547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.333493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-26T01:57:30.086617Z","caller":"traceutil/trace.go:171","msg":"trace[154583087] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1052; }","duration":"575.476296ms","start":"2026-03-26T01:57:29.511123Z","end":"2026-03-26T01:57:30.0866Z","steps":["trace[154583087] 'count revisions from in-memory index tree' (duration: 575.259581ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:30.086657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:29.511104Z","time spent":"575.542877ms","remote":"127.0.0.1:38686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":16,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-03-26T01:57:30.086807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.211072ms","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-03-26T01:57:30.086915Z","caller":"traceutil/trace.go:171","msg":"trace[33441310] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1052; }","duration":"201.330185ms","start":"2026-03-26T01:57:29.885568Z","end":"2026-03-26T01:57:30.086899Z","steps":["trace[33441310] 'range keys from in-memory index tree' (duration: 201.201581ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:30.087602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.54584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.110\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-26T01:57:30.087708Z","caller":"traceutil/trace.go:171","msg":"trace[1799383431] range","detail":"{range_begin:/registry/masterleases/162.253.55.110; range_end:; response_count:1; response_revision:1052; }","duration":"416.47827ms","start":"2026-03-26T01:57:29.67121Z","end":"2026-03-26T01:57:30.087688Z","steps":["trace[1799383431] 'range keys from in-memory index tree' (duration: 415.345445ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:30.087798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:29.67118Z","time spent":"416.562753ms","remote":"127.0.0.1:38352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.110\" "} {"level":"info","ts":"2026-03-26T01:57:30.335789Z","caller":"traceutil/trace.go:171","msg":"trace[7783410] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"102.111256ms","start":"2026-03-26T01:57:30.233653Z","end":"2026-03-26T01:57:30.335764Z","steps":["trace[7783410] 'process raft request' (duration: 101.995904ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:57:30.336115Z","caller":"traceutil/trace.go:171","msg":"trace[552832812] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"199.675407ms","start":"2026-03-26T01:57:30.136379Z","end":"2026-03-26T01:57:30.336055Z","steps":["trace[552832812] 'process raft request' (duration: 185.144287ms)","trace[552832812] 'compare' (duration: 13.863645ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:57:30.508535Z","caller":"traceutil/trace.go:171","msg":"trace[303763797] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"132.122045ms","start":"2026-03-26T01:57:30.376375Z","end":"2026-03-26T01:57:30.508497Z","steps":["trace[303763797] 'process raft request' (duration: 131.89307ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:57:30.50854Z","caller":"traceutil/trace.go:171","msg":"trace[1932199072] linearizableReadLoop","detail":"{readStateIndex:1105; appliedIndex:1104; }","duration":"105.802198ms","start":"2026-03-26T01:57:30.402682Z","end":"2026-03-26T01:57:30.508484Z","steps":["trace[1932199072] 'read index received' (duration: 105.778777ms)","trace[1932199072] 'applied index is now lower than readState.Index' (duration: 20.011µs)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:57:30.508865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.645985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-26T01:57:30.508923Z","caller":"traceutil/trace.go:171","msg":"trace[2032687629] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1055; }","duration":"101.767037ms","start":"2026-03-26T01:57:30.407143Z","end":"2026-03-26T01:57:30.50891Z","steps":["trace[2032687629] 'agreement among raft nodes before linearized reading' (duration: 101.591013ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:30.509418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.682498ms","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-03-26T01:57:30.509685Z","caller":"traceutil/trace.go:171","msg":"trace[29049045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1055; }","duration":"106.893753ms","start":"2026-03-26T01:57:30.402619Z","end":"2026-03-26T01:57:30.509513Z","steps":["trace[29049045] 'agreement among raft nodes before linearized reading' (duration: 106.34162ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:31.657226Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645310876220695,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T01:57:32.126161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.834821ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:57:32.12642Z","caller":"traceutil/trace.go:171","msg":"trace[92526970] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"1.448062187s","start":"2026-03-26T01:57:30.678332Z","end":"2026-03-26T01:57:32.126394Z","steps":["trace[92526970] 'process raft request' (duration: 1.183871308s)","trace[92526970] 'compare' (duration: 263.226778ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:57:32.126311Z","caller":"traceutil/trace.go:171","msg":"trace[1033913479] linearizableReadLoop","detail":"{readStateIndex:1109; appliedIndex:1108; }","duration":"970.093802ms","start":"2026-03-26T01:57:31.156194Z","end":"2026-03-26T01:57:32.126288Z","steps":["trace[1033913479] 'read index received' (duration: 705.927644ms)","trace[1033913479] 'applied index is now lower than readState.Index' (duration: 264.164828ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:57:32.12658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:30.678301Z","time spent":"1.448191911s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:57:32.126639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.309758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:57:32.126665Z","caller":"traceutil/trace.go:171","msg":"trace[839785564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1059; }","duration":"225.378739ms","start":"2026-03-26T01:57:31.901277Z","end":"2026-03-26T01:57:32.126656Z","steps":["trace[839785564] 'agreement among raft nodes before linearized reading' (duration: 225.288567ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:32.126753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.530801ms","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-03-26T01:57:32.126833Z","caller":"traceutil/trace.go:171","msg":"trace[104654691] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1059; }","duration":"970.679294ms","start":"2026-03-26T01:57:31.156121Z","end":"2026-03-26T01:57:32.126801Z","steps":["trace[104654691] 'agreement among raft nodes before linearized reading' (duration: 970.393178ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:32.126875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:31.156093Z","time spent":"970.772727ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-03-26T01:57:32.270367Z","caller":"traceutil/trace.go:171","msg":"trace[856219395] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"139.351848ms","start":"2026-03-26T01:57:32.130966Z","end":"2026-03-26T01:57:32.270318Z","steps":["trace[856219395] 'process raft request' (duration: 111.506547ms)","trace[856219395] 'compare' (duration: 27.685777ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:57:34.498647Z","caller":"traceutil/trace.go:171","msg":"trace[84063507] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"219.403464ms","start":"2026-03-26T01:57:34.279219Z","end":"2026-03-26T01:57:34.498623Z","steps":["trace[84063507] 'process raft request' (duration: 219.277331ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:57:34.566488Z","caller":"traceutil/trace.go:171","msg":"trace[164057321] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"151.752199ms","start":"2026-03-26T01:57:34.414698Z","end":"2026-03-26T01:57:34.56645Z","steps":["trace[164057321] 'process raft request' (duration: 151.486994ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:57:34.793889Z","caller":"traceutil/trace.go:171","msg":"trace[1589522363] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"121.788641ms","start":"2026-03-26T01:57:34.67207Z","end":"2026-03-26T01:57:34.793859Z","steps":["trace[1589522363] 'process raft request' (duration: 65.828202ms)","trace[1589522363] 'compare' (duration: 55.703353ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:57:36.623475Z","caller":"traceutil/trace.go:171","msg":"trace[857360341] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"116.533731ms","start":"2026-03-26T01:57:36.506912Z","end":"2026-03-26T01:57:36.623446Z","steps":["trace[857360341] 'process raft request' (duration: 116.371397ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:57:36.680926Z","caller":"traceutil/trace.go:171","msg":"trace[1662957224] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"108.846248ms","start":"2026-03-26T01:57:36.572058Z","end":"2026-03-26T01:57:36.680904Z","steps":["trace[1662957224] 'process raft request' (duration: 108.695795ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:36.905186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.564375ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:57:36.905359Z","caller":"traceutil/trace.go:171","msg":"trace[222715118] linearizableReadLoop","detail":"{readStateIndex:1125; appliedIndex:1124; }","duration":"208.268671ms","start":"2026-03-26T01:57:36.697047Z","end":"2026-03-26T01:57:36.905316Z","steps":["trace[222715118] 'read index received' (duration: 34.314108ms)","trace[222715118] 'applied index is now lower than readState.Index' (duration: 173.952883ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:57:36.905392Z","caller":"traceutil/trace.go:171","msg":"trace[1921276840] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"220.501289ms","start":"2026-03-26T01:57:36.684862Z","end":"2026-03-26T01:57:36.905364Z","steps":["trace[1921276840] 'process raft request' (duration: 46.618977ms)","trace[1921276840] 'compare' (duration: 173.394642ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:57:36.905568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.487836ms","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-03-26T01:57:36.905667Z","caller":"traceutil/trace.go:171","msg":"trace[160818629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1074; }","duration":"208.636999ms","start":"2026-03-26T01:57:36.696996Z","end":"2026-03-26T01:57:36.905633Z","steps":["trace[160818629] 'agreement among raft nodes before linearized reading' (duration: 208.406864ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:37.406241Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645310876220739,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T01:57:37.906789Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645310876220739,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T01:57:38.094844Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.210137565s","expected-duration":"1s"} {"level":"warn","ts":"2026-03-26T01:57:38.350842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.730386ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:57:38.351368Z","caller":"traceutil/trace.go:171","msg":"trace[1887368787] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"1.466716501s","start":"2026-03-26T01:57:36.884595Z","end":"2026-03-26T01:57:38.351312Z","steps":["trace[1887368787] 'process raft request' (duration: 1.210417112s)","trace[1887368787] 'compare' (duration: 255.081292ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:57:38.351445Z","caller":"traceutil/trace.go:171","msg":"trace[1862118872] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1125; }","duration":"1.446020612s","start":"2026-03-26T01:57:36.905406Z","end":"2026-03-26T01:57:38.351426Z","steps":["trace[1862118872] 'read index received' (duration: 1.18962338s)","trace[1862118872] 'applied index is now lower than readState.Index' (duration: 256.396132ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:57:38.351551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:36.884573Z","time spent":"1.466878854s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:57:38.351723Z","caller":"traceutil/trace.go:171","msg":"trace[703469898] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"1.441823656s","start":"2026-03-26T01:57:36.909876Z","end":"2026-03-26T01:57:38.3517Z","steps":["trace[703469898] 'process raft request' (duration: 1.441068899s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:38.351728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.552653279s","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-03-26T01:57:38.351798Z","caller":"traceutil/trace.go:171","msg":"trace[1125782685] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1076; }","duration":"1.552766022s","start":"2026-03-26T01:57:36.799014Z","end":"2026-03-26T01:57:38.35178Z","steps":["trace[1125782685] 'agreement among raft nodes before linearized reading' (duration: 1.552560257s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:38.351837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:36.798996Z","time spent":"1.552833273s","remote":"127.0.0.1:38618","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-03-26T01:57:38.351827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:36.909858Z","time spent":"1.441910568s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:57:38.351898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.310855247s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-03-26T01:57:38.351838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.552883344s","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-03-26T01:57:38.351937Z","caller":"traceutil/trace.go:171","msg":"trace[2129208323] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1076; }","duration":"1.310890618s","start":"2026-03-26T01:57:37.041033Z","end":"2026-03-26T01:57:38.351923Z","steps":["trace[2129208323] 'agreement among raft nodes before linearized reading' (duration: 1.310838457s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:38.351958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.45121458s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:57:38.35197Z","caller":"traceutil/trace.go:171","msg":"trace[311690777] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1076; }","duration":"1.553051468s","start":"2026-03-26T01:57:36.798901Z","end":"2026-03-26T01:57:38.351952Z","steps":["trace[311690777] 'agreement among raft nodes before linearized reading' (duration: 1.552803822s)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:57:38.351987Z","caller":"traceutil/trace.go:171","msg":"trace[938947055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1076; }","duration":"1.451282481s","start":"2026-03-26T01:57:36.900696Z","end":"2026-03-26T01:57:38.351978Z","steps":["trace[938947055] 'agreement among raft nodes before linearized reading' (duration: 1.45123971s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:38.352015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:36.900663Z","time spent":"1.451347412s","remote":"127.0.0.1:38328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-26T01:57:38.352025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:36.798873Z","time spent":"1.55313655s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-26T01:57:38.352025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:37.040974Z","time spent":"1.311008061s","remote":"127.0.0.1:41478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-03-26T01:57:38.644957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.844319ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:57:38.64505Z","caller":"traceutil/trace.go:171","msg":"trace[2063929976] linearizableReadLoop","detail":"{readStateIndex:1129; appliedIndex:1128; }","duration":"284.648433ms","start":"2026-03-26T01:57:38.360386Z","end":"2026-03-26T01:57:38.645034Z","steps":["trace[2063929976] 'read index received' (duration: 39.28522ms)","trace[2063929976] 'applied index is now lower than readState.Index' (duration: 245.362073ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:57:38.645135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.752035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:57:38.645178Z","caller":"traceutil/trace.go:171","msg":"trace[1660796185] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1078; }","duration":"284.821357ms","start":"2026-03-26T01:57:38.360346Z","end":"2026-03-26T01:57:38.645168Z","steps":["trace[1660796185] 'agreement among raft nodes before linearized reading' (duration: 284.760086ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:57:38.645158Z","caller":"traceutil/trace.go:171","msg":"trace[1985999661] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"288.374128ms","start":"2026-03-26T01:57:38.356735Z","end":"2026-03-26T01:57:38.645109Z","steps":["trace[1985999661] 'process raft request' (duration: 96.288893ms)","trace[1985999661] 'compare' (duration: 191.750287ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:57:39.986001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.873267ms","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-03-26T01:57:39.986105Z","caller":"traceutil/trace.go:171","msg":"trace[678782589] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1082; }","duration":"101.01118ms","start":"2026-03-26T01:57:39.885079Z","end":"2026-03-26T01:57:39.986091Z","steps":["trace[678782589] 'range keys from in-memory index tree' (duration: 100.853687ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:57:51.385296Z","caller":"traceutil/trace.go:171","msg":"trace[1931303544] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"303.644015ms","start":"2026-03-26T01:57:51.081612Z","end":"2026-03-26T01:57:51.385256Z","steps":["trace[1931303544] 'process raft request' (duration: 303.389979ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:57:51.385407Z","caller":"traceutil/trace.go:171","msg":"trace[600050507] linearizableReadLoop","detail":"{readStateIndex:1228; appliedIndex:1227; }","duration":"129.782563ms","start":"2026-03-26T01:57:51.255582Z","end":"2026-03-26T01:57:51.385365Z","steps":["trace[600050507] 'read index received' (duration: 129.343483ms)","trace[600050507] 'applied index is now lower than readState.Index' (duration: 436.15µs)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:57:51.385532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:51.081594Z","time spent":"303.804598ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:57:51.385641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.012618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:57:51.385741Z","caller":"traceutil/trace.go:171","msg":"trace[754332772] 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:1172; }","duration":"130.197922ms","start":"2026-03-26T01:57:51.255519Z","end":"2026-03-26T01:57:51.385717Z","steps":["trace[754332772] 'agreement among raft nodes before linearized reading' (duration: 129.982337ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:52.941734Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645310876220958,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T01:57:53.442365Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645310876220958,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T01:57:53.718293Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.293636417s","expected-duration":"1s"} {"level":"info","ts":"2026-03-26T01:57:53.718578Z","caller":"traceutil/trace.go:171","msg":"trace[1926508348] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"1.293999465s","start":"2026-03-26T01:57:52.424558Z","end":"2026-03-26T01:57:53.718557Z","steps":["trace[1926508348] 'process raft request' (duration: 1.293858342s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:53.718703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:52.424541Z","time spent":"1.294091747s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:57:54.276438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.166431ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:57:54.27657Z","caller":"traceutil/trace.go:171","msg":"trace[994955454] linearizableReadLoop","detail":"{readStateIndex:1231; appliedIndex:1228; }","duration":"1.835223754s","start":"2026-03-26T01:57:52.441335Z","end":"2026-03-26T01:57:54.276558Z","steps":["trace[994955454] 'read index received' (duration: 1.277165454s)","trace[994955454] 'applied index is now lower than readState.Index' (duration: 558.05738ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:57:54.276632Z","caller":"traceutil/trace.go:171","msg":"trace[1138544427] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"1.48698074s","start":"2026-03-26T01:57:52.789646Z","end":"2026-03-26T01:57:54.276627Z","steps":["trace[1138544427] 'process raft request' (duration: 1.486874287s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:54.276666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:52.789625Z","time spent":"1.487023481s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:57:54.276728Z","caller":"traceutil/trace.go:171","msg":"trace[1530046940] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"1.674222374s","start":"2026-03-26T01:57:52.602478Z","end":"2026-03-26T01:57:54.276701Z","steps":["trace[1530046940] 'process raft request' (duration: 1.573713816s)","trace[1530046940] 'compare' (duration: 100.049528ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:57:54.276902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.835574962s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:57:54.276922Z","caller":"traceutil/trace.go:171","msg":"trace[1550108719] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1175; }","duration":"1.835634063s","start":"2026-03-26T01:57:52.44128Z","end":"2026-03-26T01:57:54.276914Z","steps":["trace[1550108719] 'agreement among raft nodes before linearized reading' (duration: 1.835601352s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:54.276938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:52.441258Z","time spent":"1.835677064s","remote":"127.0.0.1:47302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-03-26T01:57:54.277069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.82001643s","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-03-26T01:57:54.27709Z","caller":"traceutil/trace.go:171","msg":"trace[1673417270] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1175; }","duration":"1.820080111s","start":"2026-03-26T01:57:52.457006Z","end":"2026-03-26T01:57:54.277086Z","steps":["trace[1673417270] 'agreement among raft nodes before linearized reading' (duration: 1.820010529s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:54.277103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:52.456986Z","time spent":"1.820114492s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-26T01:57:54.277131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.420319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T01:57:54.277171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"887.113161ms","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-03-26T01:57:54.277181Z","caller":"traceutil/trace.go:171","msg":"trace[55372729] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1175; }","duration":"554.50568ms","start":"2026-03-26T01:57:53.722667Z","end":"2026-03-26T01:57:54.277173Z","steps":["trace[55372729] 'agreement among raft nodes before linearized reading' (duration: 554.429238ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:57:54.277187Z","caller":"traceutil/trace.go:171","msg":"trace[449213747] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1175; }","duration":"887.174982ms","start":"2026-03-26T01:57:53.390007Z","end":"2026-03-26T01:57:54.277182Z","steps":["trace[449213747] 'agreement among raft nodes before linearized reading' (duration: 887.133671ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:54.277202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:53.389984Z","time spent":"887.215304ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-26T01:57:54.277203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:53.722651Z","time spent":"554.547022ms","remote":"127.0.0.1:41466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-26T01:57:54.277273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.37627545s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:57:54.277291Z","caller":"traceutil/trace.go:171","msg":"trace[441930601] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1175; }","duration":"1.376347632s","start":"2026-03-26T01:57:52.900939Z","end":"2026-03-26T01:57:54.277287Z","steps":["trace[441930601] 'agreement among raft nodes before linearized reading' (duration: 1.376323721s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:54.277302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:52.900893Z","time spent":"1.376406433s","remote":"127.0.0.1:38328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-26T01:57:54.277393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.531698774s","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-03-26T01:57:54.277411Z","caller":"traceutil/trace.go:171","msg":"trace[423989254] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1175; }","duration":"1.531752155s","start":"2026-03-26T01:57:52.745655Z","end":"2026-03-26T01:57:54.277407Z","steps":["trace[423989254] 'agreement among raft nodes before linearized reading' (duration: 1.531709584s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:54.277424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:52.745615Z","time spent":"1.531805907s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-26T01:57:54.277282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:52.602452Z","time spent":"1.674334737s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:57:54.277566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.574043674s","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-03-26T01:57:54.277592Z","caller":"traceutil/trace.go:171","msg":"trace[1821155178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1175; }","duration":"1.574118985s","start":"2026-03-26T01:57:52.703468Z","end":"2026-03-26T01:57:54.277587Z","steps":["trace[1821155178] 'agreement among raft nodes before linearized reading' (duration: 1.574034633s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:54.277607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:57:52.703438Z","time spent":"1.574165987s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-26T01:57:54.421702Z","caller":"traceutil/trace.go:171","msg":"trace[1942564410] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"138.221694ms","start":"2026-03-26T01:57:54.283457Z","end":"2026-03-26T01:57:54.421679Z","steps":["trace[1942564410] 'process raft request' (duration: 138.025339ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:57:54.421701Z","caller":"traceutil/trace.go:171","msg":"trace[325908088] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"138.129922ms","start":"2026-03-26T01:57:54.283556Z","end":"2026-03-26T01:57:54.421686Z","steps":["trace[325908088] 'process raft request' (duration: 138.06933ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:57:54.421781Z","caller":"traceutil/trace.go:171","msg":"trace[1461708438] linearizableReadLoop","detail":"{readStateIndex:1235; appliedIndex:1232; }","duration":"133.16672ms","start":"2026-03-26T01:57:54.288604Z","end":"2026-03-26T01:57:54.42177Z","steps":["trace[1461708438] 'read index received' (duration: 74.154502ms)","trace[1461708438] 'applied index is now lower than readState.Index' (duration: 59.011228ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:57:54.421836Z","caller":"traceutil/trace.go:171","msg":"trace[2029069972] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"137.472937ms","start":"2026-03-26T01:57:54.284345Z","end":"2026-03-26T01:57:54.421818Z","steps":["trace[2029069972] 'process raft request' (duration: 137.308413ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:57:54.421865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.253371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:57:54.4223Z","caller":"traceutil/trace.go:171","msg":"trace[997040485] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1179; }","duration":"133.713611ms","start":"2026-03-26T01:57:54.288575Z","end":"2026-03-26T01:57:54.422289Z","steps":["trace[997040485] 'agreement among raft nodes before linearized reading' (duration: 133.22861ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:58:07.988426Z","caller":"traceutil/trace.go:171","msg":"trace[1360798691] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"152.520799ms","start":"2026-03-26T01:58:07.835879Z","end":"2026-03-26T01:58:07.9884Z","steps":["trace[1360798691] 'process raft request' (duration: 152.423727ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:58:08.827062Z","caller":"traceutil/trace.go:171","msg":"trace[719992882] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"463.276172ms","start":"2026-03-26T01:58:08.363756Z","end":"2026-03-26T01:58:08.827032Z","steps":["trace[719992882] 'process raft request' (duration: 463.103168ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:58:08.827176Z","caller":"traceutil/trace.go:171","msg":"trace[334059173] linearizableReadLoop","detail":"{readStateIndex:1279; appliedIndex:1279; }","duration":"389.346146ms","start":"2026-03-26T01:58:08.437793Z","end":"2026-03-26T01:58:08.827139Z","steps":["trace[334059173] 'read index received' (duration: 389.311366ms)","trace[334059173] 'applied index is now lower than readState.Index' (duration: 17.04µs)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:58:08.827226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:08.363726Z","time spent":"463.410505ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:58:08.827492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.669493ms","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-03-26T01:58:08.827557Z","caller":"traceutil/trace.go:171","msg":"trace[274371737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1220; }","duration":"389.768896ms","start":"2026-03-26T01:58:08.437747Z","end":"2026-03-26T01:58:08.827516Z","steps":["trace[274371737] 'agreement among raft nodes before linearized reading' (duration: 389.552121ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:08.827605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:08.437728Z","time spent":"389.864678ms","remote":"127.0.0.1:38618","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-03-26T01:58:09.64218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.836888ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:58:09.642375Z","caller":"traceutil/trace.go:171","msg":"trace[1619350261] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"810.104194ms","start":"2026-03-26T01:58:08.832249Z","end":"2026-03-26T01:58:09.642353Z","steps":["trace[1619350261] 'process raft request' (duration: 810.037723ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:58:09.642365Z","caller":"traceutil/trace.go:171","msg":"trace[27872806] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"834.749283ms","start":"2026-03-26T01:58:08.807566Z","end":"2026-03-26T01:58:09.642315Z","steps":["trace[27872806] 'process raft request' (duration: 313.697441ms)","trace[27872806] 'compare' (duration: 520.739976ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:58:09.642446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:08.832223Z","time spent":"810.187907ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:58:09.642426Z","caller":"traceutil/trace.go:171","msg":"trace[818466261] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1279; }","duration":"815.142899ms","start":"2026-03-26T01:58:08.827249Z","end":"2026-03-26T01:58:09.642392Z","steps":["trace[818466261] 'read index received' (duration: 294.029436ms)","trace[818466261] 'applied index is now lower than readState.Index' (duration: 521.109233ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:58:09.642514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124396839s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:58:09.642585Z","caller":"traceutil/trace.go:171","msg":"trace[42964125] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1222; }","duration":"1.124521872s","start":"2026-03-26T01:58:08.518043Z","end":"2026-03-26T01:58:09.642565Z","steps":["trace[42964125] 'agreement among raft nodes before linearized reading' (duration: 1.12441503s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:09.642603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:08.807509Z","time spent":"834.961208ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:58:09.642625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:08.51802Z","time spent":"1.124596874s","remote":"127.0.0.1:38328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-26T01:58:09.64271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.154338668s","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-03-26T01:58:09.642748Z","caller":"traceutil/trace.go:171","msg":"trace[1793735348] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1222; }","duration":"1.154458082s","start":"2026-03-26T01:58:08.48828Z","end":"2026-03-26T01:58:09.642738Z","steps":["trace[1793735348] 'agreement among raft nodes before linearized reading' (duration: 1.154266728s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:09.642791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:08.488258Z","time spent":"1.154519633s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-26T01:58:09.642826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.15878799s","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-03-26T01:58:09.642861Z","caller":"traceutil/trace.go:171","msg":"trace[89412793] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1222; }","duration":"1.158854341s","start":"2026-03-26T01:58:08.483996Z","end":"2026-03-26T01:58:09.642851Z","steps":["trace[89412793] 'agreement among raft nodes before linearized reading' (duration: 1.158723859s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:09.642872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.114341453s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-03-26T01:58:09.642891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:08.48398Z","time spent":"1.158904392s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-03-26T01:58:09.642924Z","caller":"traceutil/trace.go:171","msg":"trace[1576717249] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1222; }","duration":"1.114429565s","start":"2026-03-26T01:58:08.528476Z","end":"2026-03-26T01:58:09.642906Z","steps":["trace[1576717249] 'agreement among raft nodes before linearized reading' (duration: 1.114341813s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:09.642957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:08.52845Z","time spent":"1.114498216s","remote":"127.0.0.1:41458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-03-26T01:58:09.642965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.414891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:58:09.642998Z","caller":"traceutil/trace.go:171","msg":"trace[1603568483] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1222; }","duration":"742.448072ms","start":"2026-03-26T01:58:08.900542Z","end":"2026-03-26T01:58:09.64299Z","steps":["trace[1603568483] 'agreement among raft nodes before linearized reading' (duration: 742.39787ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:09.643023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:08.900495Z","time spent":"742.522583ms","remote":"127.0.0.1:38336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-26T01:58:09.643033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155125976s","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-03-26T01:58:09.64306Z","caller":"traceutil/trace.go:171","msg":"trace[920759019] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1222; }","duration":"1.155206298s","start":"2026-03-26T01:58:08.487844Z","end":"2026-03-26T01:58:09.64305Z","steps":["trace[920759019] 'agreement among raft nodes before linearized reading' (duration: 1.155130886s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:09.643087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:08.487811Z","time spent":"1.15526929s","remote":"127.0.0.1:38618","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-03-26T01:58:09.794939Z","caller":"traceutil/trace.go:171","msg":"trace[664873239] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"147.81695ms","start":"2026-03-26T01:58:09.647087Z","end":"2026-03-26T01:58:09.794904Z","steps":["trace[664873239] 'process raft request' (duration: 96.053977ms)","trace[664873239] 'compare' (duration: 51.6353ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:58:09.803381Z","caller":"traceutil/trace.go:171","msg":"trace[1244768473] linearizableReadLoop","detail":"{readStateIndex:1284; appliedIndex:1281; }","duration":"130.106979ms","start":"2026-03-26T01:58:09.673249Z","end":"2026-03-26T01:58:09.803356Z","steps":["trace[1244768473] 'read index received' (duration: 69.922895ms)","trace[1244768473] 'applied index is now lower than readState.Index' (duration: 60.182904ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:58:09.80361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.336915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.110\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-26T01:58:09.803651Z","caller":"traceutil/trace.go:171","msg":"trace[1276589901] range","detail":"{range_begin:/registry/masterleases/162.253.55.110; range_end:; response_count:1; response_revision:1225; }","duration":"130.430148ms","start":"2026-03-26T01:58:09.67321Z","end":"2026-03-26T01:58:09.80364Z","steps":["trace[1276589901] 'agreement among raft nodes before linearized reading' (duration: 130.239282ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:58:09.803591Z","caller":"traceutil/trace.go:171","msg":"trace[2093853387] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"155.010104ms","start":"2026-03-26T01:58:09.648511Z","end":"2026-03-26T01:58:09.803521Z","steps":["trace[2093853387] 'process raft request' (duration: 154.687887ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:58:09.804061Z","caller":"traceutil/trace.go:171","msg":"trace[67763930] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"155.430255ms","start":"2026-03-26T01:58:09.648615Z","end":"2026-03-26T01:58:09.804046Z","steps":["trace[67763930] 'process raft request' (duration: 154.700817ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:11.238316Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645310876221096,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-26T01:58:11.296895Z","caller":"traceutil/trace.go:171","msg":"trace[1435721531] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"660.200897ms","start":"2026-03-26T01:58:10.636671Z","end":"2026-03-26T01:58:11.296872Z","steps":["trace[1435721531] 'process raft request' (duration: 660.073874ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:11.297029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:10.636651Z","time spent":"660.3123ms","remote":"127.0.0.1:38398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T01:58:11.83317Z","caller":"traceutil/trace.go:171","msg":"trace[539370250] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1288; }","duration":"1.095777641s","start":"2026-03-26T01:58:10.737377Z","end":"2026-03-26T01:58:11.833154Z","steps":["trace[539370250] 'read index received' (duration: 559.347491ms)","trace[539370250] 'applied index is now lower than readState.Index' (duration: 536.4289ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:58:11.833258Z","caller":"traceutil/trace.go:171","msg":"trace[135234116] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"1.000074531s","start":"2026-03-26T01:58:10.83315Z","end":"2026-03-26T01:58:11.833225Z","steps":["trace[135234116] 'process raft request' (duration: 999.902837ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:11.833304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.095919444s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"info","ts":"2026-03-26T01:58:11.833331Z","caller":"traceutil/trace.go:171","msg":"trace[19103281] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1230; }","duration":"1.095997825s","start":"2026-03-26T01:58:10.737327Z","end":"2026-03-26T01:58:11.833325Z","steps":["trace[19103281] 'agreement among raft nodes before linearized reading' (duration: 1.095898923s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:11.833353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:10.737314Z","time spent":"1.096034146s","remote":"127.0.0.1:38526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5354,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-03-26T01:58:11.83342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:10.833126Z","time spent":"1.000210055s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:58:12.040988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.579685ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:58:12.041097Z","caller":"traceutil/trace.go:171","msg":"trace[1930207257] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1290; }","duration":"207.867093ms","start":"2026-03-26T01:58:11.833213Z","end":"2026-03-26T01:58:12.04108Z","steps":["trace[1930207257] 'read index received' (duration: 94.143345ms)","trace[1930207257] 'applied index is now lower than readState.Index' (duration: 113.722418ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:58:12.041175Z","caller":"traceutil/trace.go:171","msg":"trace[226263327] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"337.801318ms","start":"2026-03-26T01:58:11.703344Z","end":"2026-03-26T01:58:12.041145Z","steps":["trace[226263327] 'process raft request' (duration: 223.999428ms)","trace[226263327] 'compare' (duration: 113.450172ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:58:12.041275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.256648ms","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-03-26T01:58:12.041291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.116155ms","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-03-26T01:58:12.041312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:11.703325Z","time spent":"337.925831ms","remote":"127.0.0.1:38398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T01:58:12.041319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.887525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:58:12.041341Z","caller":"traceutil/trace.go:171","msg":"trace[1239352188] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1231; }","duration":"233.219717ms","start":"2026-03-26T01:58:11.808108Z","end":"2026-03-26T01:58:12.041328Z","steps":["trace[1239352188] 'agreement among raft nodes before linearized reading' (duration: 233.000522ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:12.04134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.931945ms","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-03-26T01:58:12.041386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.710728ms","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-03-26T01:58:12.041414Z","caller":"traceutil/trace.go:171","msg":"trace[635014545] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1231; }","duration":"233.77996ms","start":"2026-03-26T01:58:11.807627Z","end":"2026-03-26T01:58:12.041407Z","steps":["trace[635014545] 'agreement among raft nodes before linearized reading' (duration: 233.707488ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:58:12.041416Z","caller":"traceutil/trace.go:171","msg":"trace[485631227] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1231; }","duration":"242.062808ms","start":"2026-03-26T01:58:11.799335Z","end":"2026-03-26T01:58:12.041398Z","steps":["trace[485631227] 'agreement among raft nodes before linearized reading' (duration: 241.825793ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:58:12.041305Z","caller":"traceutil/trace.go:171","msg":"trace[1342012052] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1231; }","duration":"394.32895ms","start":"2026-03-26T01:58:11.646967Z","end":"2026-03-26T01:58:12.041296Z","steps":["trace[1342012052] 'agreement among raft nodes before linearized reading' (duration: 394.196857ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:12.041516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:11.64695Z","time spent":"394.555354ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-26T01:58:12.041373Z","caller":"traceutil/trace.go:171","msg":"trace[253733632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1231; }","duration":"140.996007ms","start":"2026-03-26T01:58:11.900364Z","end":"2026-03-26T01:58:12.04136Z","steps":["trace[253733632] 'agreement among raft nodes before linearized reading' (duration: 140.892965ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:12.454674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.542162ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:58:12.454777Z","caller":"traceutil/trace.go:171","msg":"trace[1592852067] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"408.863279ms","start":"2026-03-26T01:58:12.045894Z","end":"2026-03-26T01:58:12.454758Z","steps":["trace[1592852067] 'process raft request' (duration: 161.158153ms)","trace[1592852067] 'compare' (duration: 247.44813ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:58:12.454836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:12.045876Z","time spent":"408.93026ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:58:12.779879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.82847ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:58:12.780191Z","caller":"traceutil/trace.go:171","msg":"trace[2103177185] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"733.814305ms","start":"2026-03-26T01:58:12.046366Z","end":"2026-03-26T01:58:12.78018Z","steps":["trace[2103177185] 'process raft request' (duration: 733.58473ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:12.780249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:12.04634Z","time spent":"733.879807ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:58:12.780237Z","caller":"traceutil/trace.go:171","msg":"trace[1516130324] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"734.306397ms","start":"2026-03-26T01:58:12.045902Z","end":"2026-03-26T01:58:12.780208Z","steps":["trace[1516130324] 'process raft request' (duration: 594.101618ms)","trace[1516130324] 'compare' (duration: 139.478033ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:58:12.780348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:12.045883Z","time spent":"734.411269ms","remote":"127.0.0.1:38398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":822,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T01:58:12.780588Z","caller":"traceutil/trace.go:171","msg":"trace[947463022] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"733.507649ms","start":"2026-03-26T01:58:12.047074Z","end":"2026-03-26T01:58:12.780581Z","steps":["trace[947463022] 'process raft request' (duration: 732.937707ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:58:12.780603Z","caller":"traceutil/trace.go:171","msg":"trace[1590829186] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"733.407677ms","start":"2026-03-26T01:58:12.047186Z","end":"2026-03-26T01:58:12.780594Z","steps":["trace[1590829186] 'process raft request' (duration: 732.839814ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:12.780624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:12.047064Z","time spent":"733.5426ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:58:12.780653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:12.047181Z","time spent":"733.441457ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:58:12.78069Z","caller":"traceutil/trace.go:171","msg":"trace[1867855846] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"733.620892ms","start":"2026-03-26T01:58:12.047063Z","end":"2026-03-26T01:58:12.780684Z","steps":["trace[1867855846] 'process raft request' (duration: 732.928446ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:12.780727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:12.047052Z","time spent":"733.655302ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:58:12.780837Z","caller":"traceutil/trace.go:171","msg":"trace[758131179] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1292; }","duration":"199.128964ms","start":"2026-03-26T01:58:12.580921Z","end":"2026-03-26T01:58:12.78005Z","steps":["trace[758131179] 'read index received' (duration: 59.073019ms)","trace[758131179] 'applied index is now lower than readState.Index' (duration: 140.055255ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T01:58:12.780977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.060265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:58:12.781Z","caller":"traceutil/trace.go:171","msg":"trace[1737537956] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1237; }","duration":"200.127296ms","start":"2026-03-26T01:58:12.580866Z","end":"2026-03-26T01:58:12.780993Z","steps":["trace[1737537956] 'agreement among raft nodes before linearized reading' (duration: 199.984053ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:13.666772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.914382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:58:13.668021Z","caller":"traceutil/trace.go:171","msg":"trace[1943279900] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1237; }","duration":"463.226581ms","start":"2026-03-26T01:58:13.204776Z","end":"2026-03-26T01:58:13.668002Z","steps":["trace[1943279900] 'count revisions from in-memory index tree' (duration: 461.683057ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:13.66807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:13.204753Z","time spent":"463.298503ms","remote":"127.0.0.1:38654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"info","ts":"2026-03-26T01:58:14.030196Z","caller":"traceutil/trace.go:171","msg":"trace[1307830920] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"191.43381ms","start":"2026-03-26T01:58:13.838736Z","end":"2026-03-26T01:58:14.03017Z","steps":["trace[1307830920] 'process raft request' (duration: 191.180884ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:14.03031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.880595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:58:14.030379Z","caller":"traceutil/trace.go:171","msg":"trace[579654956] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1238; }","duration":"129.968047ms","start":"2026-03-26T01:58:13.900396Z","end":"2026-03-26T01:58:14.030364Z","steps":["trace[579654956] 'agreement among raft nodes before linearized reading' (duration: 129.828284ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:58:14.030326Z","caller":"traceutil/trace.go:171","msg":"trace[355628013] linearizableReadLoop","detail":"{readStateIndex:1298; appliedIndex:1297; }","duration":"129.68555ms","start":"2026-03-26T01:58:13.900412Z","end":"2026-03-26T01:58:14.030098Z","steps":["trace[355628013] 'read index received' (duration: 129.481896ms)","trace[355628013] 'applied index is now lower than readState.Index' (duration: 202.474µs)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:58:14.573757Z","caller":"traceutil/trace.go:171","msg":"trace[1054676403] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"111.257191ms","start":"2026-03-26T01:58:14.46246Z","end":"2026-03-26T01:58:14.573717Z","steps":["trace[1054676403] 'process raft request' (duration: 110.978825ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:58:16.436946Z","caller":"traceutil/trace.go:171","msg":"trace[1895114498] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"111.013386ms","start":"2026-03-26T01:58:16.325899Z","end":"2026-03-26T01:58:16.436912Z","steps":["trace[1895114498] 'process raft request' (duration: 110.7576ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:24.401757Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645310876221246,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-26T01:58:24.63387Z","caller":"traceutil/trace.go:171","msg":"trace[112681716] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"865.44649ms","start":"2026-03-26T01:58:23.768398Z","end":"2026-03-26T01:58:24.633844Z","steps":["trace[112681716] 'process raft request' (duration: 865.302807ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:24.63429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:23.768377Z","time spent":"865.569232ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T01:58:24.69845Z","caller":"traceutil/trace.go:171","msg":"trace[2025156913] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1370; }","duration":"797.289354ms","start":"2026-03-26T01:58:23.901137Z","end":"2026-03-26T01:58:24.698426Z","steps":["trace[2025156913] 'read index received' (duration: 732.571987ms)","trace[2025156913] 'applied index is now lower than readState.Index' (duration: 64.716257ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:58:24.698539Z","caller":"traceutil/trace.go:171","msg":"trace[260029245] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"481.448274ms","start":"2026-03-26T01:58:24.217039Z","end":"2026-03-26T01:58:24.698487Z","steps":["trace[260029245] 'process raft request' (duration: 481.248089ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:24.698624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.47345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T01:58:24.698695Z","caller":"traceutil/trace.go:171","msg":"trace[970715857] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1310; }","duration":"797.592753ms","start":"2026-03-26T01:58:23.901086Z","end":"2026-03-26T01:58:24.698679Z","steps":["trace[970715857] 'agreement among raft nodes before linearized reading' (duration: 797.46019ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:24.698733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:23.901066Z","time spent":"797.660084ms","remote":"127.0.0.1:38328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-26T01:58:24.698731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:24.216832Z","time spent":"481.785912ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T01:58:24.698641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.183019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-26T01:58:24.698835Z","caller":"traceutil/trace.go:171","msg":"trace[1581304425] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1310; }","duration":"522.440735ms","start":"2026-03-26T01:58:24.17637Z","end":"2026-03-26T01:58:24.69881Z","steps":["trace[1581304425] 'agreement among raft nodes before linearized reading' (duration: 522.204049ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:58:24.699102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T01:58:24.176343Z","time spent":"522.612008ms","remote":"127.0.0.1:38816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":5,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"info","ts":"2026-03-26T01:58:37.089014Z","caller":"traceutil/trace.go:171","msg":"trace[6788418] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"114.98068ms","start":"2026-03-26T01:58:36.974009Z","end":"2026-03-26T01:58:37.08899Z","steps":["trace[6788418] 'process raft request' (duration: 114.825075ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:58:37.089245Z","caller":"traceutil/trace.go:171","msg":"trace[770794151] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"114.916137ms","start":"2026-03-26T01:58:36.974287Z","end":"2026-03-26T01:58:37.089203Z","steps":["trace[770794151] 'process raft request' (duration: 114.665491ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:58:37.633292Z","caller":"traceutil/trace.go:171","msg":"trace[21656732] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"105.871456ms","start":"2026-03-26T01:58:37.527394Z","end":"2026-03-26T01:58:37.633265Z","steps":["trace[21656732] 'process raft request' (duration: 105.59517ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:59:01.356898Z","caller":"traceutil/trace.go:171","msg":"trace[841778047] linearizableReadLoop","detail":"{readStateIndex:1564; appliedIndex:1563; }","duration":"164.654069ms","start":"2026-03-26T01:59:01.192217Z","end":"2026-03-26T01:59:01.356871Z","steps":["trace[841778047] 'read index received' (duration: 164.400283ms)","trace[841778047] 'applied index is now lower than readState.Index' (duration: 252.516µs)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:59:01.35698Z","caller":"traceutil/trace.go:171","msg":"trace[203928430] transaction","detail":"{read_only:false; response_revision:1494; number_of_response:1; }","duration":"173.925287ms","start":"2026-03-26T01:59:01.183025Z","end":"2026-03-26T01:59:01.35695Z","steps":["trace[203928430] 'process raft request' (duration: 173.685242ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:59:01.357186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.943747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-03-26T01:59:01.357221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.404917ms","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-03-26T01:59:01.357289Z","caller":"traceutil/trace.go:171","msg":"trace[237600556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1494; }","duration":"150.508521ms","start":"2026-03-26T01:59:01.206763Z","end":"2026-03-26T01:59:01.357271Z","steps":["trace[237600556] 'agreement among raft nodes before linearized reading' (duration: 150.299145ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T01:59:01.357235Z","caller":"traceutil/trace.go:171","msg":"trace[483027371] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1494; }","duration":"165.039698ms","start":"2026-03-26T01:59:01.192183Z","end":"2026-03-26T01:59:01.357223Z","steps":["trace[483027371] 'agreement among raft nodes before linearized reading' (duration: 164.849434ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T01:59:40.449844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.904102ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T01:59:40.450282Z","caller":"traceutil/trace.go:171","msg":"trace[879540427] transaction","detail":"{read_only:false; response_revision:1673; number_of_response:1; }","duration":"196.681612ms","start":"2026-03-26T01:59:40.253577Z","end":"2026-03-26T01:59:40.450258Z","steps":["trace[879540427] 'process raft request' (duration: 77.036544ms)","trace[879540427] 'compare' (duration: 118.734838ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T01:59:47.444839Z","caller":"traceutil/trace.go:171","msg":"trace[1347778780] transaction","detail":"{read_only:false; response_revision:1703; number_of_response:1; }","duration":"125.893891ms","start":"2026-03-26T01:59:47.318914Z","end":"2026-03-26T01:59:47.444807Z","steps":["trace[1347778780] 'process raft request' (duration: 125.703456ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T02:00:39.86696Z","caller":"traceutil/trace.go:171","msg":"trace[1959697818] linearizableReadLoop","detail":"{readStateIndex:2030; appliedIndex:2029; }","duration":"186.756248ms","start":"2026-03-26T02:00:39.680184Z","end":"2026-03-26T02:00:39.86694Z","steps":["trace[1959697818] 'read index received' (duration: 186.584944ms)","trace[1959697818] 'applied index is now lower than readState.Index' (duration: 170.584µs)"],"step_count":2} {"level":"warn","ts":"2026-03-26T02:00:39.867139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.947092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.110\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-26T02:00:39.867102Z","caller":"traceutil/trace.go:171","msg":"trace[615282115] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"341.172005ms","start":"2026-03-26T02:00:39.525894Z","end":"2026-03-26T02:00:39.867066Z","steps":["trace[615282115] 'process raft request' (duration: 340.925619ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T02:00:39.867163Z","caller":"traceutil/trace.go:171","msg":"trace[1834945548] range","detail":"{range_begin:/registry/masterleases/162.253.55.110; range_end:; response_count:1; response_revision:1941; }","duration":"187.019154ms","start":"2026-03-26T02:00:39.680137Z","end":"2026-03-26T02:00:39.867156Z","steps":["trace[1834945548] 'agreement among raft nodes before linearized reading' (duration: 186.900891ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T02:00:39.867196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.708999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-03-26T02:00:39.867262Z","caller":"traceutil/trace.go:171","msg":"trace[1547503446] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1941; }","duration":"156.781211ms","start":"2026-03-26T02:00:39.710465Z","end":"2026-03-26T02:00:39.867246Z","steps":["trace[1547503446] 'agreement among raft nodes before linearized reading' (duration: 156.616527ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T02:00:39.867283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T02:00:39.525871Z","time spent":"341.319668ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T02:01:13.076766Z","caller":"traceutil/trace.go:171","msg":"trace[441049275] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"149.912482ms","start":"2026-03-26T02:01:12.926828Z","end":"2026-03-26T02:01:13.07674Z","steps":["trace[441049275] 'process raft request' (duration: 149.779249ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T02:01:13.098531Z","caller":"traceutil/trace.go:171","msg":"trace[317666893] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"145.466085ms","start":"2026-03-26T02:01:12.953048Z","end":"2026-03-26T02:01:13.098514Z","steps":["trace[317666893] 'process raft request' (duration: 145.374313ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T02:01:39.18884Z","caller":"traceutil/trace.go:171","msg":"trace[296270839] transaction","detail":"{read_only:false; response_revision:2244; number_of_response:1; }","duration":"199.052394ms","start":"2026-03-26T02:01:38.989761Z","end":"2026-03-26T02:01:39.188813Z","steps":["trace[296270839] 'process raft request' (duration: 198.87331ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T02:01:39.190904Z","caller":"traceutil/trace.go:171","msg":"trace[1366138622] transaction","detail":"{read_only:false; response_revision:2245; number_of_response:1; }","duration":"200.441366ms","start":"2026-03-26T02:01:38.990441Z","end":"2026-03-26T02:01:39.190883Z","steps":["trace[1366138622] 'process raft request' (duration: 200.328333ms)"],"step_count":1}