{"level":"warn","ts":"2026-04-28T13:50:39.067316Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-28T13:50:39.067411Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.27:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.27:2380","--initial-cluster=instance=https://199.19.213.27:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.27:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.27:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-28T13:50:39.067496Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-28T13:50:39.067511Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.27:2380"]} {"level":"info","ts":"2026-04-28T13:50:39.067533Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-28T13:50:39.068294Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.27:2379"]} {"level":"info","ts":"2026-04-28T13:50:39.068398Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.27:2380"],"listen-peer-urls":["https://199.19.213.27:2380"],"advertise-client-urls":["https://199.19.213.27:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.27:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.27:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-28T13:50:39.217883Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"149.246184ms"} {"level":"info","ts":"2026-04-28T13:50:39.235675Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d0494904b1be7692","cluster-id":"7c10a1b21fbd6dff"} {"level":"info","ts":"2026-04-28T13:50:39.235781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 switched to configuration voters=()"} {"level":"info","ts":"2026-04-28T13:50:39.235813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became follower at term 0"} {"level":"info","ts":"2026-04-28T13:50:39.235824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d0494904b1be7692 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-28T13:50:39.235838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became follower at term 1"} {"level":"info","ts":"2026-04-28T13:50:39.235888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 switched to configuration voters=(15008607517699634834)"} {"level":"warn","ts":"2026-04-28T13:50:39.244319Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-28T13:50:39.249999Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-28T13:50:39.252711Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-28T13:50:39.255704Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d0494904b1be7692","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-28T13:50:39.25715Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-28T13:50:39.257132Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0494904b1be7692","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-28T13:50:39.258438Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-28T13:50:39.25847Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-28T13:50:39.25906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 switched to configuration voters=(15008607517699634834)"} {"level":"info","ts":"2026-04-28T13:50:39.259239Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7c10a1b21fbd6dff","local-member-id":"d0494904b1be7692","added-peer-id":"d0494904b1be7692","added-peer-peer-urls":["https://199.19.213.27:2380"]} {"level":"info","ts":"2026-04-28T13:50:39.261622Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-28T13:50:39.26185Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d0494904b1be7692","initial-advertise-peer-urls":["https://199.19.213.27:2380"],"listen-peer-urls":["https://199.19.213.27:2380"],"advertise-client-urls":["https://199.19.213.27:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.27:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-28T13:50:39.261882Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-28T13:50:39.261995Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.27:2380"} {"level":"info","ts":"2026-04-28T13:50:39.262054Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.27:2380"} {"level":"info","ts":"2026-04-28T13:50:39.336196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 is starting a new election at term 1"} {"level":"info","ts":"2026-04-28T13:50:39.336256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-28T13:50:39.336309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 received MsgPreVoteResp from d0494904b1be7692 at term 1"} {"level":"info","ts":"2026-04-28T13:50:39.33633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became candidate at term 2"} {"level":"info","ts":"2026-04-28T13:50:39.336376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 received MsgVoteResp from d0494904b1be7692 at term 2"} {"level":"info","ts":"2026-04-28T13:50:39.336392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became leader at term 2"} {"level":"info","ts":"2026-04-28T13:50:39.336413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d0494904b1be7692 elected leader d0494904b1be7692 at term 2"} {"level":"info","ts":"2026-04-28T13:50:39.337447Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:50:39.339114Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T13:50:39.339116Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d0494904b1be7692","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.27:2379]}","request-path":"/0/members/d0494904b1be7692/attributes","cluster-id":"7c10a1b21fbd6dff","publish-timeout":"7s"} {"level":"info","ts":"2026-04-28T13:50:39.339126Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T13:50:39.341664Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.27:2379"} {"level":"info","ts":"2026-04-28T13:50:39.341954Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-28T13:50:39.342003Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-28T13:50:39.342043Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7c10a1b21fbd6dff","local-member-id":"d0494904b1be7692","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:50:39.342144Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:50:39.342172Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:50:39.342248Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-28T13:50:44.280232Z","caller":"traceutil/trace.go:171","msg":"trace[2008993787] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"566.245706ms","start":"2026-04-28T13:50:43.713959Z","end":"2026-04-28T13:50:44.280205Z","steps":["trace[2008993787] 'process raft request' (duration: 566.093262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:44.28082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:43.713933Z","time spent":"566.384908ms","remote":"127.0.0.1:37662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3694,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:50:44.511724Z","caller":"traceutil/trace.go:171","msg":"trace[1555945740] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"223.642356ms","start":"2026-04-28T13:50:44.28806Z","end":"2026-04-28T13:50:44.511703Z","steps":["trace[1555945740] 'process raft request' (duration: 213.027503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:45.61582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.84027ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:50:45.615918Z","caller":"traceutil/trace.go:171","msg":"trace[1070870261] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"1.096213307s","start":"2026-04-28T13:50:44.51969Z","end":"2026-04-28T13:50:45.615903Z","steps":["trace[1070870261] 'process raft request' (duration: 704.135171ms)","trace[1070870261] 'compare' (duration: 391.645407ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:50:45.615965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:44.519654Z","time spent":"1.096292698s","remote":"127.0.0.1:37558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11436,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:50:46.193863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.736347ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-04-28T13:50:46.194137Z","caller":"traceutil/trace.go:171","msg":"trace[2100938680] linearizableReadLoop","detail":"{readStateIndex:215; appliedIndex:213; }","duration":"516.087755ms","start":"2026-04-28T13:50:45.678031Z","end":"2026-04-28T13:50:46.194119Z","steps":["trace[2100938680] 'read index received' (duration: 101.039621ms)","trace[2100938680] 'applied index is now lower than readState.Index' (duration: 415.047274ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:50:46.194221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:45.557315Z","time spent":"636.903174ms","remote":"127.0.0.1:37540","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-28T13:50:46.194455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.726855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:50:46.194458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.425252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:50:46.194514Z","caller":"traceutil/trace.go:171","msg":"trace[1704294349] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:209; }","duration":"450.816377ms","start":"2026-04-28T13:50:45.74368Z","end":"2026-04-28T13:50:46.194496Z","steps":["trace[1704294349] 'agreement among raft nodes before linearized reading' (duration: 450.728276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:46.194573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:45.743665Z","time spent":"450.899018ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-28T13:50:46.194537Z","caller":"traceutil/trace.go:171","msg":"trace[1242732346] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:209; }","duration":"516.554504ms","start":"2026-04-28T13:50:45.677963Z","end":"2026-04-28T13:50:46.194517Z","steps":["trace[1242732346] 'agreement among raft nodes before linearized reading' (duration: 516.392691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:46.194744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:45.677942Z","time spent":"516.791489ms","remote":"127.0.0.1:37764","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":"info","ts":"2026-04-28T13:50:46.195046Z","caller":"traceutil/trace.go:171","msg":"trace[595951976] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"574.338069ms","start":"2026-04-28T13:50:45.620669Z","end":"2026-04-28T13:50:46.195007Z","steps":["trace[595951976] 'process raft request' (duration: 573.343519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:46.195163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:45.620656Z","time spent":"574.45091ms","remote":"127.0.0.1:37836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":324,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:13.28754Z","caller":"traceutil/trace.go:171","msg":"trace[671307569] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"405.328148ms","start":"2026-04-28T13:51:12.882189Z","end":"2026-04-28T13:51:13.287517Z","steps":["trace[671307569] 'process raft request' (duration: 405.204636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:13.287757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:12.882169Z","time spent":"405.525742ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:13.424221Z","caller":"traceutil/trace.go:171","msg":"trace[55153552] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"540.965332ms","start":"2026-04-28T13:51:12.88321Z","end":"2026-04-28T13:51:13.424176Z","steps":["trace[55153552] 'process raft request' (duration: 540.682606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:13.424395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:12.883201Z","time spent":"541.108715ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:13.424489Z","caller":"traceutil/trace.go:171","msg":"trace[673180767] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"521.177792ms","start":"2026-04-28T13:51:12.903238Z","end":"2026-04-28T13:51:13.424415Z","steps":["trace[673180767] 'process raft request' (duration: 520.859847ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:13.424594Z","caller":"traceutil/trace.go:171","msg":"trace[726735021] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"502.360584ms","start":"2026-04-28T13:51:12.922175Z","end":"2026-04-28T13:51:13.424536Z","steps":["trace[726735021] 'process raft request' (duration: 501.998947ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:13.424691Z","caller":"traceutil/trace.go:171","msg":"trace[169452123] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"496.675805ms","start":"2026-04-28T13:51:12.927977Z","end":"2026-04-28T13:51:13.424652Z","steps":["trace[169452123] 'process raft request' (duration: 496.250707ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:13.424489Z","caller":"traceutil/trace.go:171","msg":"trace[939674122] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"531.595982ms","start":"2026-04-28T13:51:12.892865Z","end":"2026-04-28T13:51:13.424461Z","steps":["trace[939674122] 'process raft request' (duration: 531.148154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:13.424797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:12.927965Z","time spent":"496.780948ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:51:13.424804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:12.922162Z","time spent":"502.534128ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:13.424547Z","caller":"traceutil/trace.go:171","msg":"trace[1504467351] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"522.681702ms","start":"2026-04-28T13:51:12.901846Z","end":"2026-04-28T13:51:13.424528Z","steps":["trace[1504467351] 'process raft request' (duration: 522.214063ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:13.42503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:12.901831Z","time spent":"523.16069ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:13.425064Z","caller":"traceutil/trace.go:171","msg":"trace[2038370362] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"509.053731ms","start":"2026-04-28T13:51:12.915928Z","end":"2026-04-28T13:51:13.424982Z","steps":["trace[2038370362] 'process raft request' (duration: 508.208685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:13.425157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:12.915909Z","time spent":"509.210763ms","remote":"127.0.0.1:37512","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-04-28T13:51:13.425083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:12.892846Z","time spent":"532.163553ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:13.425386Z","caller":"traceutil/trace.go:171","msg":"trace[1475451759] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"489.036039ms","start":"2026-04-28T13:51:12.936335Z","end":"2026-04-28T13:51:13.425371Z","steps":["trace[1475451759] 'process raft request' (duration: 487.942218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:13.425456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:12.936317Z","time spent":"489.107401ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:13.425604Z","caller":"traceutil/trace.go:171","msg":"trace[662690939] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"483.251578ms","start":"2026-04-28T13:51:12.942341Z","end":"2026-04-28T13:51:13.425592Z","steps":["trace[662690939] 'process raft request' (duration: 482.972323ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:13.425626Z","caller":"traceutil/trace.go:171","msg":"trace[1407382335] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:529; }","duration":"379.161268ms","start":"2026-04-28T13:51:13.046446Z","end":"2026-04-28T13:51:13.425608Z","steps":["trace[1407382335] 'read index received' (duration: 241.003567ms)","trace[1407382335] 'applied index is now lower than readState.Index' (duration: 138.156821ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:51:13.425681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:12.942328Z","time spent":"483.322159ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:13.425726Z","caller":"traceutil/trace.go:171","msg":"trace[1514740616] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"458.600948ms","start":"2026-04-28T13:51:12.967117Z","end":"2026-04-28T13:51:13.425718Z","steps":["trace[1514740616] 'process raft request' (duration: 458.301192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:13.425783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:12.967109Z","time spent":"458.644598ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:13.425783Z","caller":"traceutil/trace.go:171","msg":"trace[1529158700] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"368.196998ms","start":"2026-04-28T13:51:13.057573Z","end":"2026-04-28T13:51:13.42577Z","steps":["trace[1529158700] 'process raft request' (duration: 367.972754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:13.425851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.057553Z","time spent":"368.26977ms","remote":"127.0.0.1:37512","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-04-28T13:51:13.426056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.601817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.27\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-28T13:51:13.426097Z","caller":"traceutil/trace.go:171","msg":"trace[1407305526] range","detail":"{range_begin:/registry/masterleases/199.19.213.27; range_end:; response_count:1; response_revision:523; }","duration":"379.689418ms","start":"2026-04-28T13:51:13.046398Z","end":"2026-04-28T13:51:13.426087Z","steps":["trace[1407305526] 'agreement among raft nodes before linearized reading' (duration: 379.457114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:13.426126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.04638Z","time spent":"379.739229ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.27\" "} {"level":"warn","ts":"2026-04-28T13:51:13.426195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:12.903213Z","time spent":"521.393207ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:51:13.926307Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544064978463787104,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T13:51:14.449284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.807421ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:51:14.449508Z","caller":"traceutil/trace.go:171","msg":"trace[1206008002] transaction","detail":"{read_only:false; number_of_response:1; response_revision:525; }","duration":"1.153520221s","start":"2026-04-28T13:51:13.295972Z","end":"2026-04-28T13:51:14.449492Z","steps":["trace[1206008002] 'process raft request' (duration: 1.153480181s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.44959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.295966Z","time spent":"1.153583182s","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:51:14.44998Z","caller":"traceutil/trace.go:171","msg":"trace[130195440] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"1.15655721s","start":"2026-04-28T13:51:13.293409Z","end":"2026-04-28T13:51:14.449966Z","steps":["trace[130195440] 'process raft request' (duration: 878.005865ms)","trace[130195440] 'compare' (duration: 277.660279ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:51:14.450039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.293384Z","time spent":"1.156631071s","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:14.450259Z","caller":"traceutil/trace.go:171","msg":"trace[350230670] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"1.154893368s","start":"2026-04-28T13:51:13.295356Z","end":"2026-04-28T13:51:14.450249Z","steps":["trace[350230670] 'process raft request' (duration: 1.154023371s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.450322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.295347Z","time spent":"1.154945249s","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:51:14.452866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.427426Z","time spent":"1.025431242s","remote":"127.0.0.1:37480","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-28T13:51:14.45501Z","caller":"traceutil/trace.go:171","msg":"trace[346579708] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.014649327s","start":"2026-04-28T13:51:13.440316Z","end":"2026-04-28T13:51:14.454965Z","steps":["trace[346579708] 'process raft request' (duration: 1.012566637s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.455287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.440302Z","time spent":"1.014879571s","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:51:14.456496Z","caller":"traceutil/trace.go:171","msg":"trace[610958186] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"1.020076331s","start":"2026-04-28T13:51:13.436342Z","end":"2026-04-28T13:51:14.456418Z","steps":["trace[610958186] 'process raft request' (duration: 1.0163945s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.456566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.436323Z","time spent":"1.020205173s","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:14.45683Z","caller":"traceutil/trace.go:171","msg":"trace[543694103] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"1.020390687s","start":"2026-04-28T13:51:13.43641Z","end":"2026-04-28T13:51:14.456801Z","steps":["trace[543694103] 'process raft request' (duration: 1.016426721s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.456884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.436405Z","time spent":"1.020459058s","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:14.457429Z","caller":"traceutil/trace.go:171","msg":"trace[42436790] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"1.005452431s","start":"2026-04-28T13:51:13.451937Z","end":"2026-04-28T13:51:14.457389Z","steps":["trace[42436790] 'process raft request' (duration: 1.001861982s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.457662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.451924Z","time spent":"1.005604533s","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:51:14.459932Z","caller":"traceutil/trace.go:171","msg":"trace[673528639] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"1.013577167s","start":"2026-04-28T13:51:13.446222Z","end":"2026-04-28T13:51:14.459799Z","steps":["trace[673528639] 'process raft request' (duration: 1.006765287s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.460037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.446207Z","time spent":"1.01377103s","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:14.460457Z","caller":"traceutil/trace.go:171","msg":"trace[731706584] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"1.017627964s","start":"2026-04-28T13:51:13.442804Z","end":"2026-04-28T13:51:14.460432Z","steps":["trace[731706584] 'process raft request' (duration: 1.01014326s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.46052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.442791Z","time spent":"1.017690656s","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:14.460702Z","caller":"traceutil/trace.go:171","msg":"trace[1989736173] linearizableReadLoop","detail":"{readStateIndex:554; appliedIndex:541; }","duration":"1.034965505s","start":"2026-04-28T13:51:13.425686Z","end":"2026-04-28T13:51:14.460652Z","steps":["trace[1989736173] 'read index received' (duration: 745.883108ms)","trace[1989736173] 'applied index is now lower than readState.Index' (duration: 289.019706ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:51:14.462409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.063552641s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:14.462461Z","caller":"traceutil/trace.go:171","msg":"trace[1962204711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:534; }","duration":"1.063626793s","start":"2026-04-28T13:51:13.398816Z","end":"2026-04-28T13:51:14.462442Z","steps":["trace[1962204711] 'agreement among raft nodes before linearized reading' (duration: 1.063551532s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.462492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.398801Z","time spent":"1.063685744s","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-28T13:51:14.462653Z","caller":"traceutil/trace.go:171","msg":"trace[519945963] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"965.095249ms","start":"2026-04-28T13:51:13.49754Z","end":"2026-04-28T13:51:14.462635Z","steps":["trace[519945963] 'process raft request' (duration: 958.970933ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:14.468556Z","caller":"traceutil/trace.go:171","msg":"trace[1354928499] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"1.019108802s","start":"2026-04-28T13:51:13.4494Z","end":"2026-04-28T13:51:14.468508Z","steps":["trace[1354928499] 'process raft request' (duration: 1.003655787s)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:14.468666Z","caller":"traceutil/trace.go:171","msg":"trace[266997820] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"1.019179204s","start":"2026-04-28T13:51:13.449468Z","end":"2026-04-28T13:51:14.468647Z","steps":["trace[266997820] 'process raft request' (duration: 1.003666688s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.468819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.449447Z","time spent":"1.019299296s","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:51:14.468844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.449373Z","time spent":"1.019279625s","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:51:14.469044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.497521Z","time spent":"965.15968ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:51:14.469306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.266877969s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-28T13:51:14.469368Z","caller":"traceutil/trace.go:171","msg":"trace[445807448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:534; }","duration":"1.26696515s","start":"2026-04-28T13:51:13.202389Z","end":"2026-04-28T13:51:14.469354Z","steps":["trace[445807448] 'agreement among raft nodes before linearized reading' (duration: 1.260330173s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.46941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.202379Z","time spent":"1.267023421s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T13:51:14.469466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.280275524s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-28T13:51:14.46949Z","caller":"traceutil/trace.go:171","msg":"trace[1839130479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:534; }","duration":"1.280424087s","start":"2026-04-28T13:51:13.189059Z","end":"2026-04-28T13:51:14.469483Z","steps":["trace[1839130479] 'agreement among raft nodes before linearized reading' (duration: 1.27167424s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.473129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:13.189042Z","time spent":"1.284074227s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T13:51:15.020544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.505103ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:51:15.020829Z","caller":"traceutil/trace.go:171","msg":"trace[43717721] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:555; }","duration":"547.741191ms","start":"2026-04-28T13:51:14.47307Z","end":"2026-04-28T13:51:15.020812Z","steps":["trace[43717721] 'read index received' (duration: 17.28857ms)","trace[43717721] 'applied index is now lower than readState.Index' (duration: 530.451811ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:51:15.02091Z","caller":"traceutil/trace.go:171","msg":"trace[912879399] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"550.438113ms","start":"2026-04-28T13:51:14.470459Z","end":"2026-04-28T13:51:15.020898Z","steps":["trace[912879399] 'process raft request' (duration: 428.471221ms)","trace[912879399] 'compare' (duration: 121.268829ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:51:15.020976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.470444Z","time spent":"550.500644ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:51:15.021434Z","caller":"traceutil/trace.go:171","msg":"trace[1327085136] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"544.866046ms","start":"2026-04-28T13:51:14.476529Z","end":"2026-04-28T13:51:15.021395Z","steps":["trace[1327085136] 'process raft request' (duration: 544.138382ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:15.021517Z","caller":"traceutil/trace.go:171","msg":"trace[2134437757] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"540.189707ms","start":"2026-04-28T13:51:14.481316Z","end":"2026-04-28T13:51:15.021506Z","steps":["trace[2134437757] 'process raft request' (duration: 539.422552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:15.021575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.481292Z","time spent":"540.257049ms","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:51:15.021637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.476514Z","time spent":"545.021839ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:51:15.021702Z","caller":"traceutil/trace.go:171","msg":"trace[1523606291] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"536.369063ms","start":"2026-04-28T13:51:14.485324Z","end":"2026-04-28T13:51:15.021693Z","steps":["trace[1523606291] 'process raft request' (duration: 535.448365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:15.021762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.485315Z","time spent":"536.420724ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:51:15.021995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.923154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-28T13:51:15.022033Z","caller":"traceutil/trace.go:171","msg":"trace[1852594416] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:540; }","duration":"549.007675ms","start":"2026-04-28T13:51:14.473016Z","end":"2026-04-28T13:51:15.022023Z","steps":["trace[1852594416] 'agreement among raft nodes before linearized reading' (duration: 548.832662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:15.022063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.473002Z","time spent":"549.054176ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-28T13:51:15.090802Z","caller":"traceutil/trace.go:171","msg":"trace[1159272613] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"591.646341ms","start":"2026-04-28T13:51:14.49913Z","end":"2026-04-28T13:51:15.090776Z","steps":["trace[1159272613] 'process raft request' (duration: 591.410576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:15.090977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.499111Z","time spent":"591.769162ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:51:15.091078Z","caller":"traceutil/trace.go:171","msg":"trace[1376737959] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"591.828153ms","start":"2026-04-28T13:51:14.499231Z","end":"2026-04-28T13:51:15.091059Z","steps":["trace[1376737959] 'process raft request' (duration: 591.466736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:15.091189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.499224Z","time spent":"591.907614ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:51:15.091316Z","caller":"traceutil/trace.go:171","msg":"trace[1781599261] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"591.950785ms","start":"2026-04-28T13:51:14.499331Z","end":"2026-04-28T13:51:15.091282Z","steps":["trace[1781599261] 'process raft request' (duration: 591.617859ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:15.09142Z","caller":"traceutil/trace.go:171","msg":"trace[1903784177] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"589.824756ms","start":"2026-04-28T13:51:14.501546Z","end":"2026-04-28T13:51:15.091371Z","steps":["trace[1903784177] 'process raft request' (duration: 589.668263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:15.091489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.499323Z","time spent":"592.072948ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:51:15.091584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.501539Z","time spent":"589.954909ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10846,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:51:15.09171Z","caller":"traceutil/trace.go:171","msg":"trace[1495485686] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"537.008427ms","start":"2026-04-28T13:51:14.554688Z","end":"2026-04-28T13:51:15.091696Z","steps":["trace[1495485686] 'process raft request' (duration: 536.919865ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:15.091728Z","caller":"traceutil/trace.go:171","msg":"trace[1754344820] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"567.299365ms","start":"2026-04-28T13:51:14.524422Z","end":"2026-04-28T13:51:15.091721Z","steps":["trace[1754344820] 'process raft request' (duration: 566.904727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:15.091762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.524395Z","time spent":"567.349656ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:51:15.091772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.554649Z","time spent":"537.092877ms","remote":"127.0.0.1:37512","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-04-28T13:51:15.091775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.454564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-04-28T13:51:15.091896Z","caller":"traceutil/trace.go:171","msg":"trace[73337202] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:546; }","duration":"617.600086ms","start":"2026-04-28T13:51:14.474273Z","end":"2026-04-28T13:51:15.091873Z","steps":["trace[73337202] 'agreement among raft nodes before linearized reading' (duration: 617.446663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:15.091788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.591637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:51:15.091929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.474266Z","time spent":"617.655868ms","remote":"127.0.0.1:37656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-04-28T13:51:15.091956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.869661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:51:15.091984Z","caller":"traceutil/trace.go:171","msg":"trace[1636602593] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:546; }","duration":"617.928603ms","start":"2026-04-28T13:51:14.474048Z","end":"2026-04-28T13:51:15.091977Z","steps":["trace[1636602593] 'agreement among raft nodes before linearized reading' (duration: 617.623887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:15.091999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.474031Z","time spent":"617.964963ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-28T13:51:15.091984Z","caller":"traceutil/trace.go:171","msg":"trace[698261728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:546; }","duration":"606.81402ms","start":"2026-04-28T13:51:14.485147Z","end":"2026-04-28T13:51:15.091961Z","steps":["trace[698261728] 'agreement among raft nodes before linearized reading' (duration: 606.563346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:15.092063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.485135Z","time spent":"606.903873ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-28T13:51:20.966262Z","caller":"traceutil/trace.go:171","msg":"trace[361245691] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"223.071735ms","start":"2026-04-28T13:51:20.743157Z","end":"2026-04-28T13:51:20.966229Z","steps":["trace[361245691] 'read index received' (duration: 222.009175ms)","trace[361245691] 'applied index is now lower than readState.Index' (duration: 1.06141ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:51:20.966344Z","caller":"traceutil/trace.go:171","msg":"trace[853976385] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"339.213485ms","start":"2026-04-28T13:51:20.627093Z","end":"2026-04-28T13:51:20.966306Z","steps":["trace[853976385] 'process raft request' (duration: 338.432511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:20.966443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.235438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:51:20.96654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.33058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:51:20.96663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:20.627065Z","time spent":"339.362328ms","remote":"127.0.0.1:37558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:51:20.9667Z","caller":"traceutil/trace.go:171","msg":"trace[1873393734] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:617; }","duration":"223.463222ms","start":"2026-04-28T13:51:20.743119Z","end":"2026-04-28T13:51:20.966583Z","steps":["trace[1873393734] 'agreement among raft nodes before linearized reading' (duration: 223.205746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:20.966981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.989925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:51:20.967018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.77076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:20.967068Z","caller":"traceutil/trace.go:171","msg":"trace[1965852073] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:617; }","duration":"119.24377ms","start":"2026-04-28T13:51:20.847808Z","end":"2026-04-28T13:51:20.967052Z","steps":["trace[1965852073] 'agreement among raft nodes before linearized reading' (duration: 118.999845ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:20.967085Z","caller":"traceutil/trace.go:171","msg":"trace[1536319460] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:617; }","duration":"164.850472ms","start":"2026-04-28T13:51:20.802211Z","end":"2026-04-28T13:51:20.967062Z","steps":["trace[1536319460] 'agreement among raft nodes before linearized reading' (duration: 164.704889ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:20.96674Z","caller":"traceutil/trace.go:171","msg":"trace[1329368980] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:617; }","duration":"223.514693ms","start":"2026-04-28T13:51:20.74312Z","end":"2026-04-28T13:51:20.966634Z","steps":["trace[1329368980] 'agreement among raft nodes before linearized reading' (duration: 223.285068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:20.967297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.044845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:51:20.96739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.550275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:20.967438Z","caller":"traceutil/trace.go:171","msg":"trace[540673969] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:617; }","duration":"119.635047ms","start":"2026-04-28T13:51:20.84779Z","end":"2026-04-28T13:51:20.967425Z","steps":["trace[540673969] 'agreement among raft nodes before linearized reading' (duration: 119.566075ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:20.967479Z","caller":"traceutil/trace.go:171","msg":"trace[430383871] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:617; }","duration":"165.184938ms","start":"2026-04-28T13:51:20.802158Z","end":"2026-04-28T13:51:20.967343Z","steps":["trace[430383871] 'agreement among raft nodes before linearized reading' (duration: 165.045095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:20.966564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.845551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:20.967705Z","caller":"traceutil/trace.go:171","msg":"trace[508268884] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:617; }","duration":"223.977652ms","start":"2026-04-28T13:51:20.743679Z","end":"2026-04-28T13:51:20.967656Z","steps":["trace[508268884] 'agreement among raft nodes before linearized reading' (duration: 222.79654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:20.967919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.102638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:20.968019Z","caller":"traceutil/trace.go:171","msg":"trace[1108513789] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:617; }","duration":"119.25276ms","start":"2026-04-28T13:51:20.848741Z","end":"2026-04-28T13:51:20.967993Z","steps":["trace[1108513789] 'agreement among raft nodes before linearized reading' (duration: 119.015925ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.548268Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544064978463787261,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T13:51:21.612506Z","caller":"traceutil/trace.go:171","msg":"trace[763492688] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"564.260107ms","start":"2026-04-28T13:51:21.048221Z","end":"2026-04-28T13:51:21.612481Z","steps":["trace[763492688] 'read index received' (duration: 564.037103ms)","trace[763492688] 'applied index is now lower than readState.Index' (duration: 222.084µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:51:21.612672Z","caller":"traceutil/trace.go:171","msg":"trace[1548587598] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"582.098728ms","start":"2026-04-28T13:51:21.030519Z","end":"2026-04-28T13:51:21.612618Z","steps":["trace[1548587598] 'process raft request' (duration: 581.799482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.612824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.209116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:51:21.612886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.338799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.612919Z","caller":"traceutil/trace.go:171","msg":"trace[162984805] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:618; }","duration":"382.354139ms","start":"2026-04-28T13:51:21.230551Z","end":"2026-04-28T13:51:21.612905Z","steps":["trace[162984805] 'agreement among raft nodes before linearized reading' (duration: 382.186516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.612892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.030497Z","time spent":"582.269321ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:21.612956Z","caller":"traceutil/trace.go:171","msg":"trace[2034600853] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:618; }","duration":"382.45073ms","start":"2026-04-28T13:51:21.230485Z","end":"2026-04-28T13:51:21.612936Z","steps":["trace[2034600853] 'agreement among raft nodes before linearized reading' (duration: 382.339578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.612951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.230549Z","time spent":"382.39305ms","remote":"127.0.0.1:36478","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":"warn","ts":"2026-04-28T13:51:21.612988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.1953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:51:21.613007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.23047Z","time spent":"382.521682ms","remote":"127.0.0.1:36478","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":"warn","ts":"2026-04-28T13:51:21.613013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.988506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.613087Z","caller":"traceutil/trace.go:171","msg":"trace[1101539231] 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:618; }","duration":"422.134689ms","start":"2026-04-28T13:51:21.190935Z","end":"2026-04-28T13:51:21.61307Z","steps":["trace[1101539231] 'agreement among raft nodes before linearized reading' (duration: 422.034007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.613152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.455085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:51:21.613147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.587403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.613185Z","caller":"traceutil/trace.go:171","msg":"trace[703617899] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:618; }","duration":"286.576328ms","start":"2026-04-28T13:51:21.326601Z","end":"2026-04-28T13:51:21.613177Z","steps":["trace[703617899] 'agreement among raft nodes before linearized reading' (duration: 286.453206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.612936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.330759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.6132Z","caller":"traceutil/trace.go:171","msg":"trace[619390858] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:618; }","duration":"382.647984ms","start":"2026-04-28T13:51:21.230538Z","end":"2026-04-28T13:51:21.613186Z","steps":["trace[619390858] 'agreement among raft nodes before linearized reading' (duration: 382.562612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.613232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.622325ms","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":"warn","ts":"2026-04-28T13:51:21.613242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.230535Z","time spent":"382.694345ms","remote":"127.0.0.1:36478","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-04-28T13:51:21.61326Z","caller":"traceutil/trace.go:171","msg":"trace[98919812] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:618; }","duration":"347.696766ms","start":"2026-04-28T13:51:21.265555Z","end":"2026-04-28T13:51:21.613252Z","steps":["trace[98919812] 'agreement among raft nodes before linearized reading' (duration: 347.634265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.613282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.265546Z","time spent":"347.728887ms","remote":"127.0.0.1:36498","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":"info","ts":"2026-04-28T13:51:21.613295Z","caller":"traceutil/trace.go:171","msg":"trace[1674519435] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:618; }","duration":"347.755117ms","start":"2026-04-28T13:51:21.2655Z","end":"2026-04-28T13:51:21.613255Z","steps":["trace[1674519435] 'agreement among raft nodes before linearized reading' (duration: 347.399621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.613478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.260253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.613507Z","caller":"traceutil/trace.go:171","msg":"trace[482298456] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:618; }","duration":"365.339214ms","start":"2026-04-28T13:51:21.24816Z","end":"2026-04-28T13:51:21.613499Z","steps":["trace[482298456] 'agreement among raft nodes before linearized reading' (duration: 365.262022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.613518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.972575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:51:21.61353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.248155Z","time spent":"365.366814ms","remote":"127.0.0.1:36482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-28T13:51:21.613549Z","caller":"traceutil/trace.go:171","msg":"trace[1509300066] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:618; }","duration":"345.049016ms","start":"2026-04-28T13:51:21.26849Z","end":"2026-04-28T13:51:21.613539Z","steps":["trace[1509300066] 'agreement among raft nodes before linearized reading' (duration: 345.005256ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.613512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.346678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:51:21.613582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.268467Z","time spent":"345.104518ms","remote":"127.0.0.1:36498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:51:21.613521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.265466Z","time spent":"348.030084ms","remote":"127.0.0.1:36498","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-04-28T13:51:21.613588Z","caller":"traceutil/trace.go:171","msg":"trace[996110245] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:618; }","duration":"101.44992ms","start":"2026-04-28T13:51:21.512126Z","end":"2026-04-28T13:51:21.613576Z","steps":["trace[996110245] 'agreement among raft nodes before linearized reading' (duration: 101.344888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.613757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.844593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.613799Z","caller":"traceutil/trace.go:171","msg":"trace[823279558] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:618; }","duration":"365.868204ms","start":"2026-04-28T13:51:21.247906Z","end":"2026-04-28T13:51:21.613775Z","steps":["trace[823279558] 'agreement among raft nodes before linearized reading' (duration: 365.834223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.613835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.24785Z","time spent":"365.969516ms","remote":"127.0.0.1:36482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:51:21.612839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.958226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:51:21.612941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.529578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:51:21.613953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.775667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-28T13:51:21.614086Z","caller":"traceutil/trace.go:171","msg":"trace[168626444] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:618; }","duration":"553.043572ms","start":"2026-04-28T13:51:21.061025Z","end":"2026-04-28T13:51:21.614069Z","steps":["trace[168626444] 'agreement among raft nodes before linearized reading' (duration: 551.676576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.61418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.061001Z","time spent":"553.158174ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T13:51:21.614258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.930993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.614303Z","caller":"traceutil/trace.go:171","msg":"trace[412206242] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:618; }","duration":"152.008855ms","start":"2026-04-28T13:51:21.462285Z","end":"2026-04-28T13:51:21.614294Z","steps":["trace[412206242] 'agreement among raft nodes before linearized reading' (duration: 151.942984ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:21.613033Z","caller":"traceutil/trace.go:171","msg":"trace[1025914634] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:618; }","duration":"286.279422ms","start":"2026-04-28T13:51:21.32674Z","end":"2026-04-28T13:51:21.613019Z","steps":["trace[1025914634] 'agreement among raft nodes before linearized reading' (duration: 286.226881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.614462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.319746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.614506Z","caller":"traceutil/trace.go:171","msg":"trace[208046536] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:618; }","duration":"102.379817ms","start":"2026-04-28T13:51:21.512111Z","end":"2026-04-28T13:51:21.61449Z","steps":["trace[208046536] 'agreement among raft nodes before linearized reading' (duration: 102.323066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.61452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.570651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.6146Z","caller":"traceutil/trace.go:171","msg":"trace[925820124] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:618; }","duration":"101.670303ms","start":"2026-04-28T13:51:21.512917Z","end":"2026-04-28T13:51:21.614587Z","steps":["trace[925820124] 'agreement among raft nodes before linearized reading' (duration: 101.52809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.614668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.200427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.614702Z","caller":"traceutil/trace.go:171","msg":"trace[625611839] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:618; }","duration":"120.27586ms","start":"2026-04-28T13:51:21.494418Z","end":"2026-04-28T13:51:21.614694Z","steps":["trace[625611839] 'agreement among raft nodes before linearized reading' (duration: 120.231578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.61474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.202509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-28T13:51:21.614773Z","caller":"traceutil/trace.go:171","msg":"trace[1537855865] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"470.322931ms","start":"2026-04-28T13:51:21.144443Z","end":"2026-04-28T13:51:21.614766Z","steps":["trace[1537855865] 'agreement among raft nodes before linearized reading' (duration: 470.228628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.614632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.121985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:51:21.614795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.144414Z","time spent":"470.375112ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T13:51:21.61484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.624766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.614833Z","caller":"traceutil/trace.go:171","msg":"trace[160862593] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:618; }","duration":"120.3099ms","start":"2026-04-28T13:51:21.494485Z","end":"2026-04-28T13:51:21.614795Z","steps":["trace[160862593] 'agreement among raft nodes before linearized reading' (duration: 120.122485ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:21.61487Z","caller":"traceutil/trace.go:171","msg":"trace[1520246173] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:618; }","duration":"120.688008ms","start":"2026-04-28T13:51:21.494175Z","end":"2026-04-28T13:51:21.614863Z","steps":["trace[1520246173] 'agreement among raft nodes before linearized reading' (duration: 120.642457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.614758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.615237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.61498Z","caller":"traceutil/trace.go:171","msg":"trace[1528437112] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:618; }","duration":"448.888502ms","start":"2026-04-28T13:51:21.166075Z","end":"2026-04-28T13:51:21.614964Z","steps":["trace[1528437112] 'agreement among raft nodes before linearized reading' (duration: 448.547124ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:21.614012Z","caller":"traceutil/trace.go:171","msg":"trace[1884451600] 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:618; }","duration":"422.64749ms","start":"2026-04-28T13:51:21.191349Z","end":"2026-04-28T13:51:21.613997Z","steps":["trace[1884451600] 'agreement among raft nodes before linearized reading' (duration: 421.544409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.615119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.166046Z","time spent":"449.007353ms","remote":"127.0.0.1:36462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:51:21.613184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.190924Z","time spent":"422.243251ms","remote":"127.0.0.1:36476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"info","ts":"2026-04-28T13:51:21.614012Z","caller":"traceutil/trace.go:171","msg":"trace[193819132] 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:618; }","duration":"423.19544ms","start":"2026-04-28T13:51:21.190806Z","end":"2026-04-28T13:51:21.614002Z","steps":["trace[193819132] 'agreement among raft nodes before linearized reading' (duration: 421.957146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.615509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.190781Z","time spent":"424.713249ms","remote":"127.0.0.1:36476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:51:21.613724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.698751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.615559Z","caller":"traceutil/trace.go:171","msg":"trace[573084905] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:618; }","duration":"367.537985ms","start":"2026-04-28T13:51:21.248007Z","end":"2026-04-28T13:51:21.615545Z","steps":["trace[573084905] 'agreement among raft nodes before linearized reading' (duration: 365.67071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.615581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.248004Z","time spent":"367.571166ms","remote":"127.0.0.1:36482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:51:21.61502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.064919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-28T13:51:21.615604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.296791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.615616Z","caller":"traceutil/trace.go:171","msg":"trace[1045341317] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:618; }","duration":"467.700821ms","start":"2026-04-28T13:51:21.147905Z","end":"2026-04-28T13:51:21.615605Z","steps":["trace[1045341317] 'agreement among raft nodes before linearized reading' (duration: 467.051659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.613475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.399374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xkxj4\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-04-28T13:51:21.615647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.147879Z","time spent":"467.759512ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-28T13:51:21.615663Z","caller":"traceutil/trace.go:171","msg":"trace[1777488630] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xkxj4; range_end:; response_count:1; response_revision:618; }","duration":"324.627606ms","start":"2026-04-28T13:51:21.29103Z","end":"2026-04-28T13:51:21.615658Z","steps":["trace[1777488630] 'agreement among raft nodes before linearized reading' (duration: 322.340402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.615683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.29101Z","time spent":"324.667727ms","remote":"127.0.0.1:37672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-xkxj4\" "} {"level":"warn","ts":"2026-04-28T13:51:21.615126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.191329Z","time spent":"423.751531ms","remote":"127.0.0.1:36476","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":"info","ts":"2026-04-28T13:51:21.615945Z","caller":"traceutil/trace.go:171","msg":"trace[1972071854] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:618; }","duration":"186.351052ms","start":"2026-04-28T13:51:21.429277Z","end":"2026-04-28T13:51:21.615628Z","steps":["trace[1972071854] 'agreement among raft nodes before linearized reading' (duration: 186.298441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.616153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.055025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.61619Z","caller":"traceutil/trace.go:171","msg":"trace[1718802117] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:618; }","duration":"154.139817ms","start":"2026-04-28T13:51:21.462043Z","end":"2026-04-28T13:51:21.616183Z","steps":["trace[1718802117] 'agreement among raft nodes before linearized reading' (duration: 154.085576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.616776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.750639ms","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-04-28T13:51:21.620307Z","caller":"traceutil/trace.go:171","msg":"trace[1373609586] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:618; }","duration":"191.312917ms","start":"2026-04-28T13:51:21.42897Z","end":"2026-04-28T13:51:21.620283Z","steps":["trace[1373609586] 'agreement among raft nodes before linearized reading' (duration: 187.753339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.614941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.81572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.622098Z","caller":"traceutil/trace.go:171","msg":"trace[489739912] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:618; }","duration":"455.968907ms","start":"2026-04-28T13:51:21.166116Z","end":"2026-04-28T13:51:21.622085Z","steps":["trace[489739912] 'agreement among raft nodes before linearized reading' (duration: 448.80296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.62217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.166036Z","time spent":"456.112069ms","remote":"127.0.0.1:36462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:51:21.619152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.151925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.622438Z","caller":"traceutil/trace.go:171","msg":"trace[717650162] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:618; }","duration":"193.519909ms","start":"2026-04-28T13:51:21.428909Z","end":"2026-04-28T13:51:21.622429Z","steps":["trace[717650162] 'agreement among raft nodes before linearized reading' (duration: 190.192846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.619416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.19226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-28T13:51:21.612809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.551828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:21.622571Z","caller":"traceutil/trace.go:171","msg":"trace[1181318124] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:618; }","duration":"295.351056ms","start":"2026-04-28T13:51:21.327209Z","end":"2026-04-28T13:51:21.622561Z","steps":["trace[1181318124] 'agreement among raft nodes before linearized reading' (duration: 285.495277ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:21.622712Z","caller":"traceutil/trace.go:171","msg":"trace[2065589001] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:618; }","duration":"574.539643ms","start":"2026-04-28T13:51:21.048164Z","end":"2026-04-28T13:51:21.622704Z","steps":["trace[2065589001] 'agreement among raft nodes before linearized reading' (duration: 564.44631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:21.622765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.04814Z","time spent":"574.615574ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T13:51:22.183441Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544064978463787271,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T13:51:22.237875Z","caller":"traceutil/trace.go:171","msg":"trace[1725383338] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"607.79766ms","start":"2026-04-28T13:51:21.63005Z","end":"2026-04-28T13:51:22.237848Z","steps":["trace[1725383338] 'process raft request' (duration: 607.590575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:22.239056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.630042Z","time spent":"608.032415ms","remote":"127.0.0.1:37672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:51:23.055401Z","caller":"traceutil/trace.go:171","msg":"trace[647641214] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"1.372378155s","start":"2026-04-28T13:51:21.682986Z","end":"2026-04-28T13:51:23.055364Z","steps":["trace[647641214] 'read index received' (duration: 555.256945ms)","trace[647641214] 'applied index is now lower than readState.Index' (duration: 817.12024ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:51:23.055539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.372516378s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:23.055576Z","caller":"traceutil/trace.go:171","msg":"trace[280278043] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:624; }","duration":"1.372604761s","start":"2026-04-28T13:51:21.682959Z","end":"2026-04-28T13:51:23.055564Z","steps":["trace[280278043] 'agreement among raft nodes before linearized reading' (duration: 1.372513859s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.055632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.682943Z","time spent":"1.372678522s","remote":"127.0.0.1:36580","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":"info","ts":"2026-04-28T13:51:23.055553Z","caller":"traceutil/trace.go:171","msg":"trace[1590352641] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"1.019987329s","start":"2026-04-28T13:51:22.035453Z","end":"2026-04-28T13:51:23.05544Z","steps":["trace[1590352641] 'process raft request' (duration: 1.019384727s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.055963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:22.035428Z","time spent":"1.020366166s","remote":"127.0.0.1:37558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:51:23.058078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.375041197s","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":"warn","ts":"2026-04-28T13:51:23.058525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.375246811s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:23.058569Z","caller":"traceutil/trace.go:171","msg":"trace[2047823189] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:625; }","duration":"1.375293122s","start":"2026-04-28T13:51:21.683261Z","end":"2026-04-28T13:51:23.058554Z","steps":["trace[2047823189] 'agreement among raft nodes before linearized reading' (duration: 1.375249631s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.0586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.683255Z","time spent":"1.375338702s","remote":"127.0.0.1:36580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:51:23.058216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.133262594s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:23.058609Z","caller":"traceutil/trace.go:171","msg":"trace[1103629168] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:625; }","duration":"1.375542347s","start":"2026-04-28T13:51:21.682998Z","end":"2026-04-28T13:51:23.05854Z","steps":["trace[1103629168] 'agreement among raft nodes before linearized reading' (duration: 1.375013376s)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:23.058717Z","caller":"traceutil/trace.go:171","msg":"trace[1378343056] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:625; }","duration":"1.133762194s","start":"2026-04-28T13:51:21.924927Z","end":"2026-04-28T13:51:23.058689Z","steps":["trace[1378343056] 'agreement among raft nodes before linearized reading' (duration: 1.133246094s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.058735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.682987Z","time spent":"1.37572945s","remote":"127.0.0.1:36580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:51:23.058783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.924921Z","time spent":"1.133842776s","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:51:23.0583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.133989209s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:23.058917Z","caller":"traceutil/trace.go:171","msg":"trace[1928684189] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:625; }","duration":"1.13461962s","start":"2026-04-28T13:51:21.924268Z","end":"2026-04-28T13:51:23.058887Z","steps":["trace[1928684189] 'agreement among raft nodes before linearized reading' (duration: 1.133974728s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.05831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.18584232s","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-04-28T13:51:23.059009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.924257Z","time spent":"1.134721862s","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-04-28T13:51:23.05902Z","caller":"traceutil/trace.go:171","msg":"trace[1110278167] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:625; }","duration":"1.186600564s","start":"2026-04-28T13:51:21.872405Z","end":"2026-04-28T13:51:23.059006Z","steps":["trace[1110278167] 'agreement among raft nodes before linearized reading' (duration: 1.18582219s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.059054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.872388Z","time spent":"1.186655365s","remote":"127.0.0.1:36596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:51:23.058331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155338477s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:23.05931Z","caller":"traceutil/trace.go:171","msg":"trace[1091961583] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"1.156225183s","start":"2026-04-28T13:51:21.902959Z","end":"2026-04-28T13:51:23.059184Z","steps":["trace[1091961583] 'agreement among raft nodes before linearized reading' (duration: 1.155156273s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.058357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.134042989s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:23.059403Z","caller":"traceutil/trace.go:171","msg":"trace[1309394514] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:625; }","duration":"1.135092639s","start":"2026-04-28T13:51:21.924299Z","end":"2026-04-28T13:51:23.059391Z","steps":["trace[1309394514] 'agreement among raft nodes before linearized reading' (duration: 1.13404108s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.059514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.924295Z","time spent":"1.13515934s","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:51:23.059563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.902952Z","time spent":"1.156466859s","remote":"127.0.0.1:36620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:51:23.058375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.589929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:23.059688Z","caller":"traceutil/trace.go:171","msg":"trace[687451269] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"660.946386ms","start":"2026-04-28T13:51:22.398732Z","end":"2026-04-28T13:51:23.059679Z","steps":["trace[687451269] 'agreement among raft nodes before linearized reading' (duration: 659.619231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.059728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:22.398708Z","time spent":"661.012907ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:51:23.058383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.169471187s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:23.05984Z","caller":"traceutil/trace.go:171","msg":"trace[616761530] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"1.170934405s","start":"2026-04-28T13:51:21.888898Z","end":"2026-04-28T13:51:23.059832Z","steps":["trace[616761530] 'agreement among raft nodes before linearized reading' (duration: 1.169451177s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.059869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.888886Z","time spent":"1.170974626s","remote":"127.0.0.1:36604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:51:23.058402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155393709s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:23.05992Z","caller":"traceutil/trace.go:171","msg":"trace[1670003404] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"1.156915028s","start":"2026-04-28T13:51:21.902989Z","end":"2026-04-28T13:51:23.059904Z","steps":["trace[1670003404] 'agreement among raft nodes before linearized reading' (duration: 1.155391199s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.059986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.902985Z","time spent":"1.156982169s","remote":"127.0.0.1:36620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:51:23.058406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155070952s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:23.060213Z","caller":"traceutil/trace.go:171","msg":"trace[2145370930] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"1.156887056s","start":"2026-04-28T13:51:21.903313Z","end":"2026-04-28T13:51:23.0602Z","steps":["trace[2145370930] 'agreement among raft nodes before linearized reading' (duration: 1.155061371s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.060368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.903308Z","time spent":"1.157040989s","remote":"127.0.0.1:36604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:51:23.058419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.18586413s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:23.060629Z","caller":"traceutil/trace.go:171","msg":"trace[648105012] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:625; }","duration":"1.188078112s","start":"2026-04-28T13:51:21.872532Z","end":"2026-04-28T13:51:23.06061Z","steps":["trace[648105012] 'agreement among raft nodes before linearized reading' (duration: 1.18586674s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.060678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.872525Z","time spent":"1.188138412s","remote":"127.0.0.1:36596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:51:23.058433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.185910431s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:51:23.060991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.356498541s","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-04-28T13:51:23.058442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.16956072s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:23.06103Z","caller":"traceutil/trace.go:171","msg":"trace[117884157] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:625; }","duration":"1.356543652s","start":"2026-04-28T13:51:21.704477Z","end":"2026-04-28T13:51:23.061021Z","steps":["trace[117884157] 'agreement among raft nodes before linearized reading' (duration: 1.356473551s)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:23.06104Z","caller":"traceutil/trace.go:171","msg":"trace[432827191] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"1.172161999s","start":"2026-04-28T13:51:21.888866Z","end":"2026-04-28T13:51:23.061028Z","steps":["trace[432827191] 'agreement among raft nodes before linearized reading' (duration: 1.169560249s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.061062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.704434Z","time spent":"1.356620665s","remote":"127.0.0.1:36586","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-04-28T13:51:23.061084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.88886Z","time spent":"1.17220724s","remote":"127.0.0.1:36604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:51:23.058489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.353052706s","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":"info","ts":"2026-04-28T13:51:23.060993Z","caller":"traceutil/trace.go:171","msg":"trace[1494419442] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:625; }","duration":"1.188488159s","start":"2026-04-28T13:51:21.87249Z","end":"2026-04-28T13:51:23.060978Z","steps":["trace[1494419442] 'agreement among raft nodes before linearized reading' (duration: 1.185916901s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.0612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.872478Z","time spent":"1.188709764s","remote":"127.0.0.1:36596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:51:23.058499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.354037375s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:23.061296Z","caller":"traceutil/trace.go:171","msg":"trace[1375520044] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:625; }","duration":"1.356858029s","start":"2026-04-28T13:51:21.704425Z","end":"2026-04-28T13:51:23.061283Z","steps":["trace[1375520044] 'agreement among raft nodes before linearized reading' (duration: 1.354049385s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.061339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.704407Z","time spent":"1.35692042s","remote":"127.0.0.1:36586","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-04-28T13:51:23.061156Z","caller":"traceutil/trace.go:171","msg":"trace[80205915] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:625; }","duration":"1.355725688s","start":"2026-04-28T13:51:21.705417Z","end":"2026-04-28T13:51:23.061143Z","steps":["trace[80205915] 'agreement among raft nodes before linearized reading' (duration: 1.353055947s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.061516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:21.705411Z","time spent":"1.356091395s","remote":"127.0.0.1:36586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"info","ts":"2026-04-28T13:51:23.058469Z","caller":"traceutil/trace.go:171","msg":"trace[1019187376] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"549.698589ms","start":"2026-04-28T13:51:22.508759Z","end":"2026-04-28T13:51:23.058457Z","steps":["trace[1019187376] 'process raft request' (duration: 549.132948ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:23.061696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:22.508733Z","time spent":"552.90697ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:51:24.785238Z","caller":"traceutil/trace.go:171","msg":"trace[698034402] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"330.636271ms","start":"2026-04-28T13:51:24.454579Z","end":"2026-04-28T13:51:24.785216Z","steps":["trace[698034402] 'process raft request' (duration: 330.500848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:24.78536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:24.454547Z","time spent":"330.756923ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:51:30.709232Z","caller":"traceutil/trace.go:171","msg":"trace[79446659] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"202.766978ms","start":"2026-04-28T13:51:30.506443Z","end":"2026-04-28T13:51:30.70921Z","steps":["trace[79446659] 'process raft request' (duration: 202.622595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:30.866324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.458681ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-04-28T13:51:30.866474Z","caller":"traceutil/trace.go:171","msg":"trace[1921615144] linearizableReadLoop","detail":"{readStateIndex:758; appliedIndex:757; }","duration":"152.727754ms","start":"2026-04-28T13:51:30.713706Z","end":"2026-04-28T13:51:30.866434Z","steps":["trace[1921615144] 'read index received' (duration: 46.003148ms)","trace[1921615144] 'applied index is now lower than readState.Index' (duration: 106.723346ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:51:30.866594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.886676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:1492"} {"level":"info","ts":"2026-04-28T13:51:30.866626Z","caller":"traceutil/trace.go:171","msg":"trace[707441161] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:734; }","duration":"152.957968ms","start":"2026-04-28T13:51:30.713656Z","end":"2026-04-28T13:51:30.866614Z","steps":["trace[707441161] 'agreement among raft nodes before linearized reading' (duration: 152.870796ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:30.866533Z","caller":"traceutil/trace.go:171","msg":"trace[1931906680] transaction","detail":"{read_only:false; number_of_response:0; response_revision:734; }","duration":"359.748362ms","start":"2026-04-28T13:51:30.506752Z","end":"2026-04-28T13:51:30.866501Z","steps":["trace[1931906680] 'process raft request' (duration: 253.017136ms)","trace[1931906680] 'compare' (duration: 106.40615ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:51:30.866813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:30.506728Z","time spent":"360.017247ms","remote":"127.0.0.1:38956","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:51:38.890705Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544064978463787582,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T13:51:39.00013Z","caller":"traceutil/trace.go:171","msg":"trace[784607237] linearizableReadLoop","detail":"{readStateIndex:816; appliedIndex:814; }","duration":"609.500286ms","start":"2026-04-28T13:51:38.390608Z","end":"2026-04-28T13:51:39.000108Z","steps":["trace[784607237] 'read index received' (duration: 598.932915ms)","trace[784607237] 'applied index is now lower than readState.Index' (duration: 10.566521ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:51:39.000148Z","caller":"traceutil/trace.go:171","msg":"trace[1228521900] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"636.252627ms","start":"2026-04-28T13:51:38.363881Z","end":"2026-04-28T13:51:39.000133Z","steps":["trace[1228521900] 'process raft request' (duration: 636.113094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:39.000293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:38.363845Z","time spent":"636.3714ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:51:39.000308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.459962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:39.00038Z","caller":"traceutil/trace.go:171","msg":"trace[8172407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:790; }","duration":"603.560323ms","start":"2026-04-28T13:51:38.396805Z","end":"2026-04-28T13:51:39.000365Z","steps":["trace[8172407] 'agreement among raft nodes before linearized reading' (duration: 603.456221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:39.000376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.767172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9zqdj\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-04-28T13:51:39.000415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:38.396794Z","time spent":"603.612744ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-28T13:51:39.000433Z","caller":"traceutil/trace.go:171","msg":"trace[53751315] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9zqdj; range_end:; response_count:1; response_revision:790; }","duration":"609.855694ms","start":"2026-04-28T13:51:38.390558Z","end":"2026-04-28T13:51:39.000414Z","steps":["trace[53751315] 'agreement among raft nodes before linearized reading' (duration: 609.680521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:39.000526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:38.390535Z","time spent":"609.976917ms","remote":"127.0.0.1:37672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9zqdj\" "} {"level":"info","ts":"2026-04-28T13:51:53.468397Z","caller":"traceutil/trace.go:171","msg":"trace[1265189953] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"176.512577ms","start":"2026-04-28T13:51:53.29186Z","end":"2026-04-28T13:51:53.468372Z","steps":["trace[1265189953] 'process raft request' (duration: 173.413308ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:53.647476Z","caller":"traceutil/trace.go:171","msg":"trace[1555484611] transaction","detail":"{read_only:false; number_of_response:1; response_revision:931; }","duration":"106.810127ms","start":"2026-04-28T13:51:53.540612Z","end":"2026-04-28T13:51:53.647423Z","steps":["trace[1555484611] 'process raft request' (duration: 35.932345ms)","trace[1555484611] 'compare' (duration: 70.605027ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:51:53.968057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.504078ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T13:51:53.968201Z","caller":"traceutil/trace.go:171","msg":"trace[1723471024] transaction","detail":"{read_only:false; number_of_response:1; response_revision:933; }","duration":"318.469736ms","start":"2026-04-28T13:51:53.64971Z","end":"2026-04-28T13:51:53.96818Z","steps":["trace[1723471024] 'process raft request' (duration: 208.661602ms)","trace[1723471024] 'compare' (duration: 109.365286ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:51:53.968334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:53.649692Z","time spent":"318.611278ms","remote":"127.0.0.1:37672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":55,"response count":0,"response size":41,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-04-28T13:51:53.984037Z","caller":"traceutil/trace.go:171","msg":"trace[1361974164] linearizableReadLoop","detail":"{readStateIndex:965; appliedIndex:963; }","duration":"172.306697ms","start":"2026-04-28T13:51:53.811703Z","end":"2026-04-28T13:51:53.98401Z","steps":["trace[1361974164] 'read index received' (duration: 46.667381ms)","trace[1361974164] 'applied index is now lower than readState.Index' (duration: 125.636036ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:51:53.984134Z","caller":"traceutil/trace.go:171","msg":"trace[354597800] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"173.760215ms","start":"2026-04-28T13:51:53.810355Z","end":"2026-04-28T13:51:53.984116Z","steps":["trace[354597800] 'process raft request' (duration: 173.477809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:53.984479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.744716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-28T13:51:53.984584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.638562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T13:51:53.984598Z","caller":"traceutil/trace.go:171","msg":"trace[1991492850] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:934; }","duration":"172.899309ms","start":"2026-04-28T13:51:53.811672Z","end":"2026-04-28T13:51:53.984571Z","steps":["trace[1991492850] 'agreement among raft nodes before linearized reading' (duration: 172.498991ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:53.98462Z","caller":"traceutil/trace.go:171","msg":"trace[1751206081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:934; }","duration":"152.688733ms","start":"2026-04-28T13:51:53.831922Z","end":"2026-04-28T13:51:53.98461Z","steps":["trace[1751206081] 'agreement among raft nodes before linearized reading' (duration: 152.621491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:53.984521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.643866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:51:53.984704Z","caller":"traceutil/trace.go:171","msg":"trace[1364592174] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:934; }","duration":"169.891381ms","start":"2026-04-28T13:51:53.814806Z","end":"2026-04-28T13:51:53.984698Z","steps":["trace[1364592174] 'agreement among raft nodes before linearized reading' (duration: 169.576265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:53.984967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.17401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:51:53.985063Z","caller":"traceutil/trace.go:171","msg":"trace[1098360381] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:934; }","duration":"156.310392ms","start":"2026-04-28T13:51:53.828739Z","end":"2026-04-28T13:51:53.98505Z","steps":["trace[1098360381] 'agreement among raft nodes before linearized reading' (duration: 155.888864ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:14.307316Z","caller":"traceutil/trace.go:171","msg":"trace[749898005] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"306.814272ms","start":"2026-04-28T13:52:14.000483Z","end":"2026-04-28T13:52:14.307297Z","steps":["trace[749898005] 'process raft request' (duration: 306.6859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:14.307437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:14.000463Z","time spent":"306.905555ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:52:16.354236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.804669ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:16.354352Z","caller":"traceutil/trace.go:171","msg":"trace[811261562] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1003; }","duration":"276.946433ms","start":"2026-04-28T13:52:16.077387Z","end":"2026-04-28T13:52:16.354333Z","steps":["trace[811261562] 'range keys from in-memory index tree' (duration: 276.774469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:16.354687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.284024304s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:52:16.35478Z","caller":"traceutil/trace.go:171","msg":"trace[1794470566] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1038; }","duration":"2.069207592s","start":"2026-04-28T13:52:14.285556Z","end":"2026-04-28T13:52:16.354763Z","steps":["trace[1794470566] 'read index received' (duration: 21.597802ms)","trace[1794470566] 'applied index is now lower than readState.Index' (duration: 2.04760835s)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:16.355022Z","caller":"traceutil/trace.go:171","msg":"trace[945385023] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"2.076348027s","start":"2026-04-28T13:52:14.27866Z","end":"2026-04-28T13:52:16.355008Z","steps":["trace[945385023] 'process raft request' (duration: 791.913657ms)","trace[945385023] 'compare' (duration: 1.283822889s)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:16.35509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:14.278637Z","time spent":"2.076415839s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:52:16.355377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.069822683s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-28T13:52:16.35543Z","caller":"traceutil/trace.go:171","msg":"trace[2123936381] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1004; }","duration":"2.069913505s","start":"2026-04-28T13:52:14.285504Z","end":"2026-04-28T13:52:16.355418Z","steps":["trace[2123936381] 'agreement among raft nodes before linearized reading' (duration: 2.069748942s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:16.355462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:14.285485Z","time spent":"2.069969565s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T13:52:16.355593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.434295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:52:16.355595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.702587727s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T13:52:16.35563Z","caller":"traceutil/trace.go:171","msg":"trace[1965553865] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1004; }","duration":"956.499926ms","start":"2026-04-28T13:52:15.399119Z","end":"2026-04-28T13:52:16.355619Z","steps":["trace[1965553865] 'agreement among raft nodes before linearized reading' (duration: 956.439454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:16.355636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.064571713s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-28T13:52:16.35567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:15.399086Z","time spent":"956.578187ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-28T13:52:16.355684Z","caller":"traceutil/trace.go:171","msg":"trace[2028442617] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1004; }","duration":"2.064641703s","start":"2026-04-28T13:52:14.29103Z","end":"2026-04-28T13:52:16.355672Z","steps":["trace[2028442617] 'agreement among raft nodes before linearized reading' (duration: 2.0644761s)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:16.355682Z","caller":"traceutil/trace.go:171","msg":"trace[1922262221] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1004; }","duration":"1.70271755s","start":"2026-04-28T13:52:14.652941Z","end":"2026-04-28T13:52:16.355658Z","steps":["trace[1922262221] 'agreement among raft nodes before linearized reading' (duration: 1.702569698s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:16.355724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:14.291021Z","time spent":"2.064691725s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T13:52:16.355745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:14.652923Z","time spent":"1.702805933s","remote":"127.0.0.1:37578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:52:16.355891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.108297861s","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-04-28T13:52:16.355901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.928403887s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:16.355935Z","caller":"traceutil/trace.go:171","msg":"trace[1211459185] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1004; }","duration":"1.108430274s","start":"2026-04-28T13:52:15.247491Z","end":"2026-04-28T13:52:16.355921Z","steps":["trace[1211459185] 'agreement among raft nodes before linearized reading' (duration: 1.108247141s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:16.355968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:15.24746Z","time spent":"1.108498876s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-28T13:52:16.355937Z","caller":"traceutil/trace.go:171","msg":"trace[1728364715] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1004; }","duration":"1.928518488s","start":"2026-04-28T13:52:14.427407Z","end":"2026-04-28T13:52:16.355926Z","steps":["trace[1728364715] 'agreement among raft nodes before linearized reading' (duration: 1.928408536s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:16.356012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.064020473s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-28T13:52:16.356038Z","caller":"traceutil/trace.go:171","msg":"trace[51607260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1004; }","duration":"2.064059613s","start":"2026-04-28T13:52:14.291971Z","end":"2026-04-28T13:52:16.35603Z","steps":["trace[51607260] 'agreement among raft nodes before linearized reading' (duration: 2.063983792s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:16.35604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:14.427391Z","time spent":"1.92863231s","remote":"127.0.0.1:37920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:52:16.356064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:14.291951Z","time spent":"2.064107554s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T13:52:16.356088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.064108984s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T13:52:16.35613Z","caller":"traceutil/trace.go:171","msg":"trace[1155003495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1004; }","duration":"2.064167595s","start":"2026-04-28T13:52:14.29195Z","end":"2026-04-28T13:52:16.356117Z","steps":["trace[1155003495] 'agreement among raft nodes before linearized reading' (duration: 2.064063403s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:16.356159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:14.291941Z","time spent":"2.064211415s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T13:52:29.360473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.9763ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-28T13:52:29.360897Z","caller":"traceutil/trace.go:171","msg":"trace[561578740] linearizableReadLoop","detail":"{readStateIndex:1082; appliedIndex:1080; }","duration":"877.693452ms","start":"2026-04-28T13:52:28.483163Z","end":"2026-04-28T13:52:29.360857Z","steps":["trace[561578740] 'read index received' (duration: 23.413097ms)","trace[561578740] 'applied index is now lower than readState.Index' (duration: 854.278725ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:29.360946Z","caller":"traceutil/trace.go:171","msg":"trace[532259297] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"950.550252ms","start":"2026-04-28T13:52:28.410375Z","end":"2026-04-28T13:52:29.360925Z","steps":["trace[532259297] 'process raft request' (duration: 950.224086ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:29.361056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:28.410357Z","time spent":"950.631764ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:52:29.796415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.313257111s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-28T13:52:29.796503Z","caller":"traceutil/trace.go:171","msg":"trace[1052076535] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1043; }","duration":"1.313377554s","start":"2026-04-28T13:52:28.483091Z","end":"2026-04-28T13:52:29.796469Z","steps":["trace[1052076535] 'agreement among raft nodes before linearized reading' (duration: 878.023299ms)","trace[1052076535] 'range keys from in-memory index tree' (duration: 435.192952ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:29.796555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:28.483066Z","time spent":"1.313479455s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T13:52:29.796751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.235437027s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:52:29.796784Z","caller":"traceutil/trace.go:171","msg":"trace[429956420] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1043; }","duration":"1.235500807s","start":"2026-04-28T13:52:28.561274Z","end":"2026-04-28T13:52:29.796774Z","steps":["trace[429956420] 'agreement among raft nodes before linearized reading' (duration: 800.311797ms)","trace[429956420] 'range keys from in-memory index tree' (duration: 435.112479ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:29.796809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:28.561254Z","time spent":"1.235547879s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T13:52:29.796878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"788.913819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:29.796911Z","caller":"traceutil/trace.go:171","msg":"trace[650439940] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1043; }","duration":"788.978479ms","start":"2026-04-28T13:52:29.007923Z","end":"2026-04-28T13:52:29.796902Z","steps":["trace[650439940] 'agreement among raft nodes before linearized reading' (duration: 353.685167ms)","trace[650439940] 'range keys from in-memory index tree' (duration: 435.250532ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:29.79694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:29.007903Z","time spent":"789.031091ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:52:29.797089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.006188224s","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-04-28T13:52:29.79712Z","caller":"traceutil/trace.go:171","msg":"trace[982245047] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1043; }","duration":"1.006263835s","start":"2026-04-28T13:52:28.790847Z","end":"2026-04-28T13:52:29.797111Z","steps":["trace[982245047] 'agreement among raft nodes before linearized reading' (duration: 570.773678ms)","trace[982245047] 'count revisions from in-memory index tree' (duration: 435.447777ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:29.797148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:28.790826Z","time spent":"1.006313346s","remote":"127.0.0.1:37996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:52:29.797276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.952732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:29.797343Z","caller":"traceutil/trace.go:171","msg":"trace[1855616784] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1043; }","duration":"398.062744ms","start":"2026-04-28T13:52:29.399263Z","end":"2026-04-28T13:52:29.797326Z","steps":["trace[1855616784] 'range keys from in-memory index tree' (duration: 397.88569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:29.797387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:29.399246Z","time spent":"398.131565ms","remote":"127.0.0.1:37454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:52:29.79768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.17684021s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:52:29.797716Z","caller":"traceutil/trace.go:171","msg":"trace[378759904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1043; }","duration":"1.17690094s","start":"2026-04-28T13:52:28.620802Z","end":"2026-04-28T13:52:29.797702Z","steps":["trace[378759904] 'agreement among raft nodes before linearized reading' (duration: 740.826512ms)","trace[378759904] 'range keys from in-memory index tree' (duration: 435.964186ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:29.797746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:28.620784Z","time spent":"1.176955521s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T13:52:29.797853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.177482761s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-28T13:52:29.797879Z","caller":"traceutil/trace.go:171","msg":"trace[126491824] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1043; }","duration":"1.177540712s","start":"2026-04-28T13:52:28.620329Z","end":"2026-04-28T13:52:29.797869Z","steps":["trace[126491824] 'agreement among raft nodes before linearized reading' (duration: 741.306551ms)","trace[126491824] 'range keys from in-memory index tree' (duration: 436.168709ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:29.797944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:28.620297Z","time spent":"1.177640303s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-28T13:52:29.798139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.223974128s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T13:52:29.79821Z","caller":"traceutil/trace.go:171","msg":"trace[274827802] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1043; }","duration":"1.22408004s","start":"2026-04-28T13:52:28.57411Z","end":"2026-04-28T13:52:29.79819Z","steps":["trace[274827802] 'agreement among raft nodes before linearized reading' (duration: 787.532134ms)","trace[274827802] 'range keys from in-memory index tree' (duration: 436.348763ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:29.798253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:28.574094Z","time spent":"1.224150361s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-28T13:52:37.725407Z","caller":"traceutil/trace.go:171","msg":"trace[845273747] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"296.341812ms","start":"2026-04-28T13:52:37.429026Z","end":"2026-04-28T13:52:37.725368Z","steps":["trace[845273747] 'process raft request' (duration: 296.126518ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:38.034959Z","caller":"traceutil/trace.go:171","msg":"trace[358755945] linearizableReadLoop","detail":"{readStateIndex:1112; appliedIndex:1111; }","duration":"122.487819ms","start":"2026-04-28T13:52:37.912445Z","end":"2026-04-28T13:52:38.034933Z","steps":["trace[358755945] 'read index received' (duration: 75.922927ms)","trace[358755945] 'applied index is now lower than readState.Index' (duration: 46.563612ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:38.035092Z","caller":"traceutil/trace.go:171","msg":"trace[1512996085] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"138.002844ms","start":"2026-04-28T13:52:37.897073Z","end":"2026-04-28T13:52:38.035076Z","steps":["trace[1512996085] 'process raft request' (duration: 104.285665ms)","trace[1512996085] 'compare' (duration: 33.449014ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:38.035402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.938728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-28T13:52:38.035407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.23406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T13:52:38.035443Z","caller":"traceutil/trace.go:171","msg":"trace[107548449] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1072; }","duration":"123.01586ms","start":"2026-04-28T13:52:37.912415Z","end":"2026-04-28T13:52:38.035431Z","steps":["trace[107548449] 'agreement among raft nodes before linearized reading' (duration: 122.800545ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:38.035462Z","caller":"traceutil/trace.go:171","msg":"trace[361669665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1072; }","duration":"109.340502ms","start":"2026-04-28T13:52:37.926105Z","end":"2026-04-28T13:52:38.035445Z","steps":["trace[361669665] 'agreement among raft nodes before linearized reading' (duration: 109.198909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:38.035485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.805649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:52:38.035582Z","caller":"traceutil/trace.go:171","msg":"trace[541896607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1072; }","duration":"110.941972ms","start":"2026-04-28T13:52:37.924603Z","end":"2026-04-28T13:52:38.035545Z","steps":["trace[541896607] 'agreement among raft nodes before linearized reading' (duration: 110.684496ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:38.320052Z","caller":"traceutil/trace.go:171","msg":"trace[1680542570] linearizableReadLoop","detail":"{readStateIndex:1115; appliedIndex:1112; }","duration":"247.991096ms","start":"2026-04-28T13:52:38.07204Z","end":"2026-04-28T13:52:38.320031Z","steps":["trace[1680542570] 'read index received' (duration: 26.012922ms)","trace[1680542570] 'applied index is now lower than readState.Index' (duration: 221.977274ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:38.320182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.126499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:38.320215Z","caller":"traceutil/trace.go:171","msg":"trace[1063561902] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1075; }","duration":"248.247611ms","start":"2026-04-28T13:52:38.071957Z","end":"2026-04-28T13:52:38.320205Z","steps":["trace[1063561902] 'agreement among raft nodes before linearized reading' (duration: 248.15893ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:38.320493Z","caller":"traceutil/trace.go:171","msg":"trace[649982579] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"280.159075ms","start":"2026-04-28T13:52:38.04031Z","end":"2026-04-28T13:52:38.320469Z","steps":["trace[649982579] 'process raft request' (duration: 279.680406ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:38.320506Z","caller":"traceutil/trace.go:171","msg":"trace[1659306222] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"280.374479ms","start":"2026-04-28T13:52:38.040099Z","end":"2026-04-28T13:52:38.320473Z","steps":["trace[1659306222] 'process raft request' (duration: 185.342099ms)","trace[1659306222] 'compare' (duration: 94.434079ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:39.9857Z","caller":"traceutil/trace.go:171","msg":"trace[9757987] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"255.186052ms","start":"2026-04-28T13:52:39.730491Z","end":"2026-04-28T13:52:39.985677Z","steps":["trace[9757987] 'process raft request' (duration: 255.015768ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:40.274925Z","caller":"traceutil/trace.go:171","msg":"trace[1135940875] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"279.726537ms","start":"2026-04-28T13:52:39.99518Z","end":"2026-04-28T13:52:40.274906Z","steps":["trace[1135940875] 'process raft request' (duration: 279.490833ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:40.274914Z","caller":"traceutil/trace.go:171","msg":"trace[601224354] linearizableReadLoop","detail":"{readStateIndex:1118; appliedIndex:1117; }","duration":"235.636102ms","start":"2026-04-28T13:52:40.039226Z","end":"2026-04-28T13:52:40.274862Z","steps":["trace[601224354] 'read index received' (duration: 235.50308ms)","trace[601224354] 'applied index is now lower than readState.Index' (duration: 131.742µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:40.275105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.870856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-28T13:52:40.275262Z","caller":"traceutil/trace.go:171","msg":"trace[1248748918] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1077; }","duration":"236.05471ms","start":"2026-04-28T13:52:40.039164Z","end":"2026-04-28T13:52:40.275219Z","steps":["trace[1248748918] 'agreement among raft nodes before linearized reading' (duration: 235.799135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:40.275492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.919734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T13:52:40.275563Z","caller":"traceutil/trace.go:171","msg":"trace[749536451] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1077; }","duration":"173.005426ms","start":"2026-04-28T13:52:40.10254Z","end":"2026-04-28T13:52:40.275545Z","steps":["trace[749536451] 'agreement among raft nodes before linearized reading' (duration: 172.67875ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:40.557334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.279083ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:52:40.55747Z","caller":"traceutil/trace.go:171","msg":"trace[2135970963] linearizableReadLoop","detail":"{readStateIndex:1120; appliedIndex:1118; }","duration":"233.659785ms","start":"2026-04-28T13:52:40.323796Z","end":"2026-04-28T13:52:40.557456Z","steps":["trace[2135970963] 'read index received' (duration: 197.254615ms)","trace[2135970963] 'applied index is now lower than readState.Index' (duration: 36.40421ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:40.557565Z","caller":"traceutil/trace.go:171","msg":"trace[2035391671] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"277.432703ms","start":"2026-04-28T13:52:40.280104Z","end":"2026-04-28T13:52:40.557537Z","steps":["trace[2035391671] 'process raft request' (duration: 277.310761ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:40.55757Z","caller":"traceutil/trace.go:171","msg":"trace[1370674430] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"277.892823ms","start":"2026-04-28T13:52:40.279636Z","end":"2026-04-28T13:52:40.557529Z","steps":["trace[1370674430] 'process raft request' (duration: 30.339755ms)","trace[1370674430] 'compare' (duration: 246.987237ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:40.557737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.573433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:40.557815Z","caller":"traceutil/trace.go:171","msg":"trace[1482777157] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1079; }","duration":"158.695795ms","start":"2026-04-28T13:52:40.399102Z","end":"2026-04-28T13:52:40.557797Z","steps":["trace[1482777157] 'agreement among raft nodes before linearized reading' (duration: 158.551803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:40.557852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.553223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:52:40.557971Z","caller":"traceutil/trace.go:171","msg":"trace[119157769] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1079; }","duration":"233.712126ms","start":"2026-04-28T13:52:40.32424Z","end":"2026-04-28T13:52:40.557953Z","steps":["trace[119157769] 'agreement among raft nodes before linearized reading' (duration: 233.4091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:40.558172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.371798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-28T13:52:40.55816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.667321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:40.558218Z","caller":"traceutil/trace.go:171","msg":"trace[2011860710] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1079; }","duration":"234.436569ms","start":"2026-04-28T13:52:40.323762Z","end":"2026-04-28T13:52:40.558199Z","steps":["trace[2011860710] 'agreement among raft nodes before linearized reading' (duration: 233.768297ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:40.558394Z","caller":"traceutil/trace.go:171","msg":"trace[923551033] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1079; }","duration":"208.924746ms","start":"2026-04-28T13:52:40.349404Z","end":"2026-04-28T13:52:40.558329Z","steps":["trace[923551033] 'agreement among raft nodes before linearized reading' (duration: 208.378826ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:40.74449Z","caller":"traceutil/trace.go:171","msg":"trace[1457872203] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"101.534893ms","start":"2026-04-28T13:52:40.64293Z","end":"2026-04-28T13:52:40.744465Z","steps":["trace[1457872203] 'process raft request' (duration: 37.032831ms)","trace[1457872203] 'compare' (duration: 64.102985ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:42.770442Z","caller":"traceutil/trace.go:171","msg":"trace[944807678] linearizableReadLoop","detail":"{readStateIndex:1124; appliedIndex:1123; }","duration":"491.467127ms","start":"2026-04-28T13:52:42.278958Z","end":"2026-04-28T13:52:42.770425Z","steps":["trace[944807678] 'read index received' (duration: 491.312514ms)","trace[944807678] 'applied index is now lower than readState.Index' (duration: 154.033µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:42.770556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.23309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:42.77058Z","caller":"traceutil/trace.go:171","msg":"trace[106204123] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1083; }","duration":"371.305331ms","start":"2026-04-28T13:52:42.399268Z","end":"2026-04-28T13:52:42.770573Z","steps":["trace[106204123] 'agreement among raft nodes before linearized reading' (duration: 371.25246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:42.770607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:42.399247Z","time spent":"371.352382ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-28T13:52:42.770559Z","caller":"traceutil/trace.go:171","msg":"trace[910976516] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"779.039222ms","start":"2026-04-28T13:52:41.991465Z","end":"2026-04-28T13:52:42.770505Z","steps":["trace[910976516] 'process raft request' (duration: 778.855599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:42.770727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.044029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-28T13:52:42.770755Z","caller":"traceutil/trace.go:171","msg":"trace[1220894002] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1083; }","duration":"209.100721ms","start":"2026-04-28T13:52:42.561648Z","end":"2026-04-28T13:52:42.770749Z","steps":["trace[1220894002] 'agreement among raft nodes before linearized reading' (duration: 209.001919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:42.770811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:41.991445Z","time spent":"779.220176ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:52:42.770802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.161817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:52:42.770878Z","caller":"traceutil/trace.go:171","msg":"trace[1388991003] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1083; }","duration":"128.247709ms","start":"2026-04-28T13:52:42.642611Z","end":"2026-04-28T13:52:42.770859Z","steps":["trace[1388991003] 'agreement among raft nodes before linearized reading' (duration: 128.050335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:42.770848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.139531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-28T13:52:42.77091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.017147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:52:42.770953Z","caller":"traceutil/trace.go:171","msg":"trace[85310876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1083; }","duration":"209.275524ms","start":"2026-04-28T13:52:42.561653Z","end":"2026-04-28T13:52:42.770928Z","steps":["trace[85310876] 'agreement among raft nodes before linearized reading' (duration: 209.004199ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:42.771025Z","caller":"traceutil/trace.go:171","msg":"trace[1893279092] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1083; }","duration":"173.18987ms","start":"2026-04-28T13:52:42.597804Z","end":"2026-04-28T13:52:42.770994Z","steps":["trace[1893279092] 'agreement among raft nodes before linearized reading' (duration: 172.810382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:42.771301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.347644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-28T13:52:42.771352Z","caller":"traceutil/trace.go:171","msg":"trace[1208831457] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1083; }","duration":"492.437366ms","start":"2026-04-28T13:52:42.278903Z","end":"2026-04-28T13:52:42.77134Z","steps":["trace[1208831457] 'agreement among raft nodes before linearized reading' (duration: 491.62665ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:42.771387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:42.27888Z","time spent":"492.499426ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-28T13:52:42.963917Z","caller":"traceutil/trace.go:171","msg":"trace[265880563] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"188.152113ms","start":"2026-04-28T13:52:42.775736Z","end":"2026-04-28T13:52:42.963888Z","steps":["trace[265880563] 'process raft request' (duration: 181.784992ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:43.015718Z","caller":"traceutil/trace.go:171","msg":"trace[997559689] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"239.862563ms","start":"2026-04-28T13:52:42.775843Z","end":"2026-04-28T13:52:43.015706Z","steps":["trace[997559689] 'process raft request' (duration: 239.688698ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:43.015754Z","caller":"traceutil/trace.go:171","msg":"trace[183701334] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"239.958965ms","start":"2026-04-28T13:52:42.775759Z","end":"2026-04-28T13:52:43.015718Z","steps":["trace[183701334] 'process raft request' (duration: 239.645598ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:43.015835Z","caller":"traceutil/trace.go:171","msg":"trace[1578999574] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"238.236702ms","start":"2026-04-28T13:52:42.777573Z","end":"2026-04-28T13:52:43.01581Z","steps":["trace[1578999574] 'process raft request' (duration: 238.018238ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:43.015668Z","caller":"traceutil/trace.go:171","msg":"trace[1325159097] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"239.72183ms","start":"2026-04-28T13:52:42.77592Z","end":"2026-04-28T13:52:43.015642Z","steps":["trace[1325159097] 'process raft request' (duration: 239.643638ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:55.522928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.666963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-28T13:52:55.523011Z","caller":"traceutil/trace.go:171","msg":"trace[1666346610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1175; }","duration":"338.786145ms","start":"2026-04-28T13:52:55.184208Z","end":"2026-04-28T13:52:55.522994Z","steps":["trace[1666346610] 'range keys from in-memory index tree' (duration: 338.53004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:55.523052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:55.184196Z","time spent":"338.848028ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T13:52:55.523106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.729671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-28T13:52:55.523149Z","caller":"traceutil/trace.go:171","msg":"trace[559299713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1175; }","duration":"342.803702ms","start":"2026-04-28T13:52:55.180333Z","end":"2026-04-28T13:52:55.523137Z","steps":["trace[559299713] 'range keys from in-memory index tree' (duration: 342.374763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:55.523186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:55.180316Z","time spent":"342.862003ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T13:52:55.523048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.475252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-28T13:52:55.523312Z","caller":"traceutil/trace.go:171","msg":"trace[1610866580] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1175; }","duration":"337.754257ms","start":"2026-04-28T13:52:55.185545Z","end":"2026-04-28T13:52:55.523299Z","steps":["trace[1610866580] 'range keys from in-memory index tree' (duration: 337.222806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:55.523351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:55.185537Z","time spent":"337.803728ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-28T13:52:55.522929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.216074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-28T13:52:55.523413Z","caller":"traceutil/trace.go:171","msg":"trace[1144311535] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1175; }","duration":"338.744825ms","start":"2026-04-28T13:52:55.18466Z","end":"2026-04-28T13:52:55.523405Z","steps":["trace[1144311535] 'range keys from in-memory index tree' (duration: 338.103163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:55.523437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:55.184621Z","time spent":"338.809747ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-28T13:52:55.524261Z","caller":"traceutil/trace.go:171","msg":"trace[343685850] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"234.610663ms","start":"2026-04-28T13:52:55.289634Z","end":"2026-04-28T13:52:55.524244Z","steps":["trace[343685850] 'process raft request' (duration: 234.48779ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:55.526129Z","caller":"traceutil/trace.go:171","msg":"trace[981377345] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1222; }","duration":"123.281135ms","start":"2026-04-28T13:52:55.402832Z","end":"2026-04-28T13:52:55.526113Z","steps":["trace[981377345] 'read index received' (duration: 123.271694ms)","trace[981377345] 'applied index is now lower than readState.Index' (duration: 4.251µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:52:55.526247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.385046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:55.526281Z","caller":"traceutil/trace.go:171","msg":"trace[1611589760] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1176; }","duration":"123.483659ms","start":"2026-04-28T13:52:55.402787Z","end":"2026-04-28T13:52:55.526271Z","steps":["trace[1611589760] 'agreement among raft nodes before linearized reading' (duration: 123.392217ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:57.524119Z","caller":"traceutil/trace.go:171","msg":"trace[1537342480] linearizableReadLoop","detail":"{readStateIndex:1227; appliedIndex:1226; }","duration":"391.109207ms","start":"2026-04-28T13:52:57.132993Z","end":"2026-04-28T13:52:57.524102Z","steps":["trace[1537342480] 'read index received' (duration: 390.918174ms)","trace[1537342480] 'applied index is now lower than readState.Index' (duration: 190.233µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:57.524162Z","caller":"traceutil/trace.go:171","msg":"trace[2132551254] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"650.55197ms","start":"2026-04-28T13:52:56.873592Z","end":"2026-04-28T13:52:57.524144Z","steps":["trace[2132551254] 'process raft request' (duration: 650.397347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:57.52425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.241259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:52:57.524277Z","caller":"traceutil/trace.go:171","msg":"trace[1389563222] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1181; }","duration":"391.30418ms","start":"2026-04-28T13:52:57.132964Z","end":"2026-04-28T13:52:57.524269Z","steps":["trace[1389563222] 'agreement among raft nodes before linearized reading' (duration: 391.240929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:57.52428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.74999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:52:57.5243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:57.132951Z","time spent":"391.342241ms","remote":"127.0.0.1:36482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-28T13:52:57.524308Z","caller":"traceutil/trace.go:171","msg":"trace[833504636] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1181; }","duration":"126.814332ms","start":"2026-04-28T13:52:57.397484Z","end":"2026-04-28T13:52:57.524299Z","steps":["trace[833504636] 'agreement among raft nodes before linearized reading' (duration: 126.767531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:57.5243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:56.873572Z","time spent":"650.637431ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:52:57.52432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.942664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-28T13:52:57.524345Z","caller":"traceutil/trace.go:171","msg":"trace[1064810405] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1181; }","duration":"380.995374ms","start":"2026-04-28T13:52:57.143342Z","end":"2026-04-28T13:52:57.524337Z","steps":["trace[1064810405] 'agreement among raft nodes before linearized reading' (duration: 380.894353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:57.524362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:57.143328Z","time spent":"381.028856ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T13:52:58.036578Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544064978463788451,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T13:52:58.279274Z","caller":"traceutil/trace.go:171","msg":"trace[1953505562] linearizableReadLoop","detail":"{readStateIndex:1228; appliedIndex:1227; }","duration":"743.594071ms","start":"2026-04-28T13:52:57.535661Z","end":"2026-04-28T13:52:58.279255Z","steps":["trace[1953505562] 'read index received' (duration: 743.378347ms)","trace[1953505562] 'applied index is now lower than readState.Index' (duration: 211.324µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:52:58.279334Z","caller":"traceutil/trace.go:171","msg":"trace[534313604] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"751.799327ms","start":"2026-04-28T13:52:57.527517Z","end":"2026-04-28T13:52:58.279316Z","steps":["trace[534313604] 'process raft request' (duration: 751.581213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:58.27946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.229526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-28T13:52:58.279465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:57.527487Z","time spent":"751.911289ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:52:58.279498Z","caller":"traceutil/trace.go:171","msg":"trace[384144053] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1182; }","duration":"742.270676ms","start":"2026-04-28T13:52:57.537219Z","end":"2026-04-28T13:52:58.27949Z","steps":["trace[384144053] 'agreement among raft nodes before linearized reading' (duration: 742.160494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:58.27952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:57.537187Z","time spent":"742.327547ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T13:52:58.279547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.867456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-28T13:52:58.279584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.403149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-28T13:52:58.279617Z","caller":"traceutil/trace.go:171","msg":"trace[1913827207] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1182; }","duration":"743.974898ms","start":"2026-04-28T13:52:57.535623Z","end":"2026-04-28T13:52:58.279598Z","steps":["trace[1913827207] 'agreement among raft nodes before linearized reading' (duration: 743.730524ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:52:58.279633Z","caller":"traceutil/trace.go:171","msg":"trace[1436739791] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1182; }","duration":"742.48323ms","start":"2026-04-28T13:52:57.537136Z","end":"2026-04-28T13:52:58.279619Z","steps":["trace[1436739791] 'agreement among raft nodes before linearized reading' (duration: 742.317837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:58.279656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:57.535611Z","time spent":"744.036669ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T13:52:58.27967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:57.537122Z","time spent":"742.535822ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-28T13:52:58.280036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.030051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-28T13:52:58.28011Z","caller":"traceutil/trace.go:171","msg":"trace[594519337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1182; }","duration":"743.709674ms","start":"2026-04-28T13:52:57.53638Z","end":"2026-04-28T13:52:58.28009Z","steps":["trace[594519337] 'agreement among raft nodes before linearized reading' (duration: 742.98447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:52:58.280173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:52:57.536357Z","time spent":"743.796407ms","remote":"127.0.0.1:37764","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-04-28T13:53:10.531216Z","caller":"traceutil/trace.go:171","msg":"trace[2110910713] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"151.50301ms","start":"2026-04-28T13:53:10.379677Z","end":"2026-04-28T13:53:10.53118Z","steps":["trace[2110910713] 'process raft request' (duration: 151.332266ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:10.531221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.033109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:10.531718Z","caller":"traceutil/trace.go:171","msg":"trace[2058632835] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1224; }","duration":"133.484898ms","start":"2026-04-28T13:53:10.398127Z","end":"2026-04-28T13:53:10.531612Z","steps":["trace[2058632835] 'agreement among raft nodes before linearized reading' (duration: 133.015469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:12.955605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.84071ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:53:12.955748Z","caller":"traceutil/trace.go:171","msg":"trace[1515849083] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"166.727658ms","start":"2026-04-28T13:53:12.788997Z","end":"2026-04-28T13:53:12.955725Z","steps":["trace[1515849083] 'process raft request' (duration: 18.681725ms)","trace[1515849083] 'compare' (duration: 147.705076ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:53:12.975692Z","caller":"traceutil/trace.go:171","msg":"trace[458010496] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"184.879201ms","start":"2026-04-28T13:53:12.790792Z","end":"2026-04-28T13:53:12.975671Z","steps":["trace[458010496] 'process raft request' (duration: 184.653537ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:12.975715Z","caller":"traceutil/trace.go:171","msg":"trace[1355590326] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"182.140769ms","start":"2026-04-28T13:53:12.793543Z","end":"2026-04-28T13:53:12.975683Z","steps":["trace[1355590326] 'process raft request' (duration: 182.057118ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:14.042667Z","caller":"traceutil/trace.go:171","msg":"trace[1609383198] linearizableReadLoop","detail":"{readStateIndex:1304; appliedIndex:1303; }","duration":"185.430822ms","start":"2026-04-28T13:53:13.857217Z","end":"2026-04-28T13:53:14.042647Z","steps":["trace[1609383198] 'read index received' (duration: 185.253428ms)","trace[1609383198] 'applied index is now lower than readState.Index' (duration: 176.404µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:53:14.042766Z","caller":"traceutil/trace.go:171","msg":"trace[1331229453] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"415.649702ms","start":"2026-04-28T13:53:13.627082Z","end":"2026-04-28T13:53:14.042731Z","steps":["trace[1331229453] 'process raft request' (duration: 415.444657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:14.042832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.588265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:14.042875Z","caller":"traceutil/trace.go:171","msg":"trace[2035579428] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1254; }","duration":"185.692667ms","start":"2026-04-28T13:53:13.857172Z","end":"2026-04-28T13:53:14.042865Z","steps":["trace[2035579428] 'agreement among raft nodes before linearized reading' (duration: 185.583275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:14.042907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:13.627058Z","time spent":"415.778174ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:53:14.581548Z","caller":"traceutil/trace.go:171","msg":"trace[37848911] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"157.973491ms","start":"2026-04-28T13:53:14.423531Z","end":"2026-04-28T13:53:14.581505Z","steps":["trace[37848911] 'process raft request' (duration: 157.801127ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:14.599375Z","caller":"traceutil/trace.go:171","msg":"trace[1965896369] linearizableReadLoop","detail":"{readStateIndex:1306; appliedIndex:1304; }","duration":"125.334073ms","start":"2026-04-28T13:53:14.47402Z","end":"2026-04-28T13:53:14.599354Z","steps":["trace[1965896369] 'read index received' (duration: 107.406083ms)","trace[1965896369] 'applied index is now lower than readState.Index' (duration: 17.92713ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:53:14.599493Z","caller":"traceutil/trace.go:171","msg":"trace[308862890] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"175.899941ms","start":"2026-04-28T13:53:14.423572Z","end":"2026-04-28T13:53:14.599472Z","steps":["trace[308862890] 'process raft request' (duration: 175.666487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:14.599573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.540597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:53:14.59965Z","caller":"traceutil/trace.go:171","msg":"trace[869523488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1256; }","duration":"125.669519ms","start":"2026-04-28T13:53:14.47397Z","end":"2026-04-28T13:53:14.599639Z","steps":["trace[869523488] 'agreement among raft nodes before linearized reading' (duration: 125.498986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:15.626626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.808548ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:53:15.62687Z","caller":"traceutil/trace.go:171","msg":"trace[216764655] linearizableReadLoop","detail":"{readStateIndex:1316; appliedIndex:1314; }","duration":"228.782842ms","start":"2026-04-28T13:53:15.398064Z","end":"2026-04-28T13:53:15.626847Z","steps":["trace[216764655] 'read index received' (duration: 125.669448ms)","trace[216764655] 'applied index is now lower than readState.Index' (duration: 103.112034ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:53:15.626873Z","caller":"traceutil/trace.go:171","msg":"trace[185809485] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"437.060456ms","start":"2026-04-28T13:53:15.189774Z","end":"2026-04-28T13:53:15.626834Z","steps":["trace[185809485] 'process raft request' (duration: 333.971374ms)","trace[185809485] 'compare' (duration: 102.628554ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:53:15.626976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.900654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:15.627015Z","caller":"traceutil/trace.go:171","msg":"trace[1409063219] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"228.971975ms","start":"2026-04-28T13:53:15.39803Z","end":"2026-04-28T13:53:15.627002Z","steps":["trace[1409063219] 'agreement among raft nodes before linearized reading' (duration: 228.905364ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:15.626998Z","caller":"traceutil/trace.go:171","msg":"trace[377598945] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"422.96721ms","start":"2026-04-28T13:53:15.203989Z","end":"2026-04-28T13:53:15.626957Z","steps":["trace[377598945] 'process raft request' (duration: 422.766756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:15.627058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:15.189749Z","time spent":"437.236739ms","remote":"127.0.0.1:37540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:53:15.627161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:15.203967Z","time spent":"423.114943ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:53:16.503855Z","caller":"traceutil/trace.go:171","msg":"trace[666864369] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"452.273835ms","start":"2026-04-28T13:53:16.051559Z","end":"2026-04-28T13:53:16.503832Z","steps":["trace[666864369] 'process raft request' (duration: 452.132712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:16.504026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:16.051514Z","time spent":"452.431858ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:53:16.661226Z","caller":"traceutil/trace.go:171","msg":"trace[225773119] linearizableReadLoop","detail":"{readStateIndex:1318; appliedIndex:1317; }","duration":"256.826644ms","start":"2026-04-28T13:53:16.404363Z","end":"2026-04-28T13:53:16.66119Z","steps":["trace[225773119] 'read index received' (duration: 99.547685ms)","trace[225773119] 'applied index is now lower than readState.Index' (duration: 157.277369ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:53:16.661299Z","caller":"traceutil/trace.go:171","msg":"trace[406457605] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"570.2811ms","start":"2026-04-28T13:53:16.090979Z","end":"2026-04-28T13:53:16.66126Z","steps":["trace[406457605] 'process raft request' (duration: 494.873742ms)","trace[406457605] 'compare' (duration: 75.172904ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:53:16.661461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:16.090953Z","time spent":"570.418732ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:53:16.662292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.904324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:53:16.662396Z","caller":"traceutil/trace.go:171","msg":"trace[1763603287] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1268; }","duration":"258.059447ms","start":"2026-04-28T13:53:16.404312Z","end":"2026-04-28T13:53:16.662371Z","steps":["trace[1763603287] 'agreement among raft nodes before linearized reading' (duration: 257.060418ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:16.782637Z","caller":"traceutil/trace.go:171","msg":"trace[1188794407] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"113.609982ms","start":"2026-04-28T13:53:16.669002Z","end":"2026-04-28T13:53:16.782612Z","steps":["trace[1188794407] 'process raft request' (duration: 113.5279ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:16.783186Z","caller":"traceutil/trace.go:171","msg":"trace[619381961] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"116.236621ms","start":"2026-04-28T13:53:16.666933Z","end":"2026-04-28T13:53:16.783169Z","steps":["trace[619381961] 'process raft request' (duration: 94.112002ms)","trace[619381961] 'compare' (duration: 21.264742ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:53:16.78337Z","caller":"traceutil/trace.go:171","msg":"trace[1440874934] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"115.793153ms","start":"2026-04-28T13:53:16.667562Z","end":"2026-04-28T13:53:16.783355Z","steps":["trace[1440874934] 'process raft request' (duration: 114.871445ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:16.783509Z","caller":"traceutil/trace.go:171","msg":"trace[471970444] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"114.768284ms","start":"2026-04-28T13:53:16.668732Z","end":"2026-04-28T13:53:16.7835Z","steps":["trace[471970444] 'process raft request' (duration: 113.753544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:18.861433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.750234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:53:18.861508Z","caller":"traceutil/trace.go:171","msg":"trace[1308647283] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1274; }","duration":"160.833715ms","start":"2026-04-28T13:53:18.700658Z","end":"2026-04-28T13:53:18.861492Z","steps":["trace[1308647283] 'range keys from in-memory index tree' (duration: 160.656152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:29.241675Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544064978463788789,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T13:53:29.358186Z","caller":"traceutil/trace.go:171","msg":"trace[1854592565] linearizableReadLoop","detail":"{readStateIndex:1401; appliedIndex:1399; }","duration":"616.81673ms","start":"2026-04-28T13:53:28.741349Z","end":"2026-04-28T13:53:29.358166Z","steps":["trace[1854592565] 'read index received' (duration: 603.165241ms)","trace[1854592565] 'applied index is now lower than readState.Index' (duration: 13.650299ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:53:29.358297Z","caller":"traceutil/trace.go:171","msg":"trace[886180817] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"746.271942ms","start":"2026-04-28T13:53:28.612016Z","end":"2026-04-28T13:53:29.358288Z","steps":["trace[886180817] 'process raft request' (duration: 746.028477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:29.358392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:28.611943Z","time spent":"746.377923ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:53:29.358584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.080973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-28T13:53:29.358642Z","caller":"traceutil/trace.go:171","msg":"trace[1620539735] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1348; }","duration":"449.181615ms","start":"2026-04-28T13:53:28.909445Z","end":"2026-04-28T13:53:29.358627Z","steps":["trace[1620539735] 'agreement among raft nodes before linearized reading' (duration: 449.023392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:29.358673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:28.909428Z","time spent":"449.239917ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T13:53:29.358778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.440463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-28T13:53:29.358799Z","caller":"traceutil/trace.go:171","msg":"trace[941543597] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1348; }","duration":"617.504733ms","start":"2026-04-28T13:53:28.741289Z","end":"2026-04-28T13:53:29.358794Z","steps":["trace[941543597] 'agreement among raft nodes before linearized reading' (duration: 617.453022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:29.358816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:28.741267Z","time spent":"617.545244ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-28T13:53:29.358898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.301214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:53:29.358926Z","caller":"traceutil/trace.go:171","msg":"trace[635267603] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1348; }","duration":"444.367515ms","start":"2026-04-28T13:53:28.914554Z","end":"2026-04-28T13:53:29.358921Z","steps":["trace[635267603] 'agreement among raft nodes before linearized reading' (duration: 444.309504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:29.358943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:28.914532Z","time spent":"444.406796ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T13:53:29.359005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.676652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T13:53:29.359092Z","caller":"traceutil/trace.go:171","msg":"trace[2142858273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1348; }","duration":"442.806445ms","start":"2026-04-28T13:53:28.916266Z","end":"2026-04-28T13:53:29.359072Z","steps":["trace[2142858273] 'agreement among raft nodes before linearized reading' (duration: 442.553821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:29.359148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:28.916254Z","time spent":"442.883686ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T13:53:29.359253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.425391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-28T13:53:29.359301Z","caller":"traceutil/trace.go:171","msg":"trace[2129132920] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1348; }","duration":"439.507833ms","start":"2026-04-28T13:53:28.919785Z","end":"2026-04-28T13:53:29.359293Z","steps":["trace[2129132920] 'agreement among raft nodes before linearized reading' (duration: 439.377251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:29.359325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:28.91977Z","time spent":"439.550394ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-28T13:53:29.359574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.177712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:53:29.35976Z","caller":"traceutil/trace.go:171","msg":"trace[1399681934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1348; }","duration":"443.403876ms","start":"2026-04-28T13:53:28.91628Z","end":"2026-04-28T13:53:29.359684Z","steps":["trace[1399681934] 'agreement among raft nodes before linearized reading' (duration: 442.770535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:53:29.359872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:53:28.916259Z","time spent":"443.599729ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-28T13:53:55.620718Z","caller":"traceutil/trace.go:171","msg":"trace[838997993] linearizableReadLoop","detail":"{readStateIndex:1529; appliedIndex:1527; }","duration":"102.338287ms","start":"2026-04-28T13:53:55.518339Z","end":"2026-04-28T13:53:55.620677Z","steps":["trace[838997993] 'read index received' (duration: 7.253591ms)","trace[838997993] 'applied index is now lower than readState.Index' (duration: 95.083126ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:53:55.620854Z","caller":"traceutil/trace.go:171","msg":"trace[1262428154] transaction","detail":"{read_only:false; response_revision:1471; number_of_response:1; }","duration":"103.24686ms","start":"2026-04-28T13:53:55.51756Z","end":"2026-04-28T13:53:55.620807Z","steps":["trace[1262428154] 'process raft request' (duration: 40.978625ms)","trace[1262428154] 'compare' (duration: 61.975991ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:53:55.621054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.597718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-28T13:53:55.6211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.725973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:53:55.621188Z","caller":"traceutil/trace.go:171","msg":"trace[630202286] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1471; }","duration":"102.847576ms","start":"2026-04-28T13:53:55.51832Z","end":"2026-04-28T13:53:55.621167Z","steps":["trace[630202286] 'agreement among raft nodes before linearized reading' (duration: 102.583262ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:55.621118Z","caller":"traceutil/trace.go:171","msg":"trace[23084729] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1471; }","duration":"101.688689ms","start":"2026-04-28T13:53:55.519415Z","end":"2026-04-28T13:53:55.621104Z","steps":["trace[23084729] 'agreement among raft nodes before linearized reading' (duration: 101.503576ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:55.731233Z","caller":"traceutil/trace.go:171","msg":"trace[276219219] transaction","detail":"{read_only:false; response_revision:1473; number_of_response:1; }","duration":"102.798553ms","start":"2026-04-28T13:53:55.628407Z","end":"2026-04-28T13:53:55.731205Z","steps":["trace[276219219] 'process raft request' (duration: 93.373362ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:55.73126Z","caller":"traceutil/trace.go:171","msg":"trace[801260734] transaction","detail":"{read_only:false; response_revision:1474; number_of_response:1; }","duration":"102.49939ms","start":"2026-04-28T13:53:55.628725Z","end":"2026-04-28T13:53:55.731224Z","steps":["trace[801260734] 'process raft request' (duration: 102.389438ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:55.731323Z","caller":"traceutil/trace.go:171","msg":"trace[698319101] transaction","detail":"{read_only:false; response_revision:1475; number_of_response:1; }","duration":"102.493069ms","start":"2026-04-28T13:53:55.628787Z","end":"2026-04-28T13:53:55.73128Z","steps":["trace[698319101] 'process raft request' (duration: 102.378358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:56:04.656441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.507036ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:56:04.656702Z","caller":"traceutil/trace.go:171","msg":"trace[1394841656] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"247.150328ms","start":"2026-04-28T13:56:04.409498Z","end":"2026-04-28T13:56:04.656648Z","steps":["trace[1394841656] 'process raft request' (duration: 37.324456ms)","trace[1394841656] 'compare' (duration: 209.299792ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:56:04.656924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.373102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-28T13:56:04.657Z","caller":"traceutil/trace.go:171","msg":"trace[1767539429] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2063; }","duration":"247.457574ms","start":"2026-04-28T13:56:04.409522Z","end":"2026-04-28T13:56:04.656979Z","steps":["trace[1767539429] 'agreement among raft nodes before linearized reading' (duration: 247.208319ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:56:04.656687Z","caller":"traceutil/trace.go:171","msg":"trace[898793431] linearizableReadLoop","detail":"{readStateIndex:2147; appliedIndex:2146; }","duration":"247.078877ms","start":"2026-04-28T13:56:04.409537Z","end":"2026-04-28T13:56:04.656616Z","steps":["trace[898793431] 'read index received' (duration: 40.811µs)","trace[898793431] 'applied index is now lower than readState.Index' (duration: 247.036846ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:56:04.686386Z","caller":"traceutil/trace.go:171","msg":"trace[1207504914] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"275.556813ms","start":"2026-04-28T13:56:04.410805Z","end":"2026-04-28T13:56:04.686362Z","steps":["trace[1207504914] 'process raft request' (duration: 275.431551ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:56:45.215993Z","caller":"traceutil/trace.go:171","msg":"trace[1176714935] linearizableReadLoop","detail":"{readStateIndex:2371; appliedIndex:2370; }","duration":"176.587642ms","start":"2026-04-28T13:56:45.039384Z","end":"2026-04-28T13:56:45.215972Z","steps":["trace[1176714935] 'read index received' (duration: 176.366198ms)","trace[1176714935] 'applied index is now lower than readState.Index' (duration: 220.574µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:56:45.216245Z","caller":"traceutil/trace.go:171","msg":"trace[1537903714] transaction","detail":"{read_only:false; response_revision:2278; number_of_response:1; }","duration":"311.734889ms","start":"2026-04-28T13:56:44.904499Z","end":"2026-04-28T13:56:45.216233Z","steps":["trace[1537903714] 'process raft request' (duration: 311.335551ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:56:45.216358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:56:44.90448Z","time spent":"311.811111ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:56:45.216587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.980479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:56:45.216665Z","caller":"traceutil/trace.go:171","msg":"trace[213747299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2278; }","duration":"140.102792ms","start":"2026-04-28T13:56:45.076544Z","end":"2026-04-28T13:56:45.216647Z","steps":["trace[213747299] 'agreement among raft nodes before linearized reading' (duration: 139.889778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:56:45.217452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.979659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-28T13:56:45.21765Z","caller":"traceutil/trace.go:171","msg":"trace[715189863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2278; }","duration":"178.286096ms","start":"2026-04-28T13:56:45.039345Z","end":"2026-04-28T13:56:45.217631Z","steps":["trace[715189863] 'agreement among raft nodes before linearized reading' (duration: 177.166834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:57:13.097495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.457161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system::leader-locking-kube-controller-manager\" ","response":"range_response_count:1 size:853"} {"level":"info","ts":"2026-04-28T13:57:13.097602Z","caller":"traceutil/trace.go:171","msg":"trace[387020052] range","detail":"{range_begin:/registry/rolebindings/kube-system/system::leader-locking-kube-controller-manager; range_end:; response_count:1; response_revision:2413; }","duration":"134.621285ms","start":"2026-04-28T13:57:12.962959Z","end":"2026-04-28T13:57:13.09758Z","steps":["trace[387020052] 'range keys from in-memory index tree' (duration: 134.291298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:57:13.097624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.81285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system::extension-apiserver-authentication-reader\" ","response":"range_response_count:1 size:856"} {"level":"info","ts":"2026-04-28T13:57:13.0977Z","caller":"traceutil/trace.go:171","msg":"trace[466591275] range","detail":"{range_begin:/registry/rolebindings/kube-system/system::extension-apiserver-authentication-reader; range_end:; response_count:1; response_revision:2413; }","duration":"101.918842ms","start":"2026-04-28T13:57:12.995761Z","end":"2026-04-28T13:57:13.09768Z","steps":["trace[466591275] 'range keys from in-memory index tree' (duration: 101.737629ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:57:15.570399Z","caller":"traceutil/trace.go:171","msg":"trace[115385751] transaction","detail":"{read_only:false; response_revision:2424; number_of_response:1; }","duration":"110.381773ms","start":"2026-04-28T13:57:15.459989Z","end":"2026-04-28T13:57:15.570371Z","steps":["trace[115385751] 'process raft request' (duration: 96.919676ms)","trace[115385751] 'compare' (duration: 13.336425ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:57:15.575388Z","caller":"traceutil/trace.go:171","msg":"trace[727486098] transaction","detail":"{read_only:false; response_revision:2425; number_of_response:1; }","duration":"115.362889ms","start":"2026-04-28T13:57:15.459992Z","end":"2026-04-28T13:57:15.575355Z","steps":["trace[727486098] 'process raft request' (duration: 115.135573ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:57:15.575559Z","caller":"traceutil/trace.go:171","msg":"trace[1240683316] linearizableReadLoop","detail":"{readStateIndex:2526; appliedIndex:2523; }","duration":"115.102394ms","start":"2026-04-28T13:57:15.460426Z","end":"2026-04-28T13:57:15.575529Z","steps":["trace[1240683316] 'read index received' (duration: 96.500838ms)","trace[1240683316] 'applied index is now lower than readState.Index' (duration: 18.600466ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:57:15.575782Z","caller":"traceutil/trace.go:171","msg":"trace[1752817735] transaction","detail":"{read_only:false; response_revision:2426; number_of_response:1; }","duration":"115.711055ms","start":"2026-04-28T13:57:15.460055Z","end":"2026-04-28T13:57:15.575766Z","steps":["trace[1752817735] 'process raft request' (duration: 115.243025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:57:15.576067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.616533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-04-28T13:57:15.576172Z","caller":"traceutil/trace.go:171","msg":"trace[1200890401] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin; range_end:; response_count:1; response_revision:2426; }","duration":"115.760856ms","start":"2026-04-28T13:57:15.460384Z","end":"2026-04-28T13:57:15.576145Z","steps":["trace[1200890401] 'agreement among raft nodes before linearized reading' (duration: 115.465961ms)"],"step_count":1}