{"level":"warn","ts":"2026-08-24T15:14:08.464007Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-24T15:14:08.464148Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.147: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.147:2380","--initial-cluster=instance=https://199.19.213.147:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.147:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.147: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-08-24T15:14:08.464273Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-24T15:14:08.464293Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.147:2380"]} {"level":"info","ts":"2026-08-24T15:14:08.464325Z","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-08-24T15:14:08.465294Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"]} {"level":"info","ts":"2026-08-24T15:14:08.465407Z","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.147:2380"],"listen-peer-urls":["https://199.19.213.147:2380"],"advertise-client-urls":["https://199.19.213.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.147: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-08-24T15:14:08.471049Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.062157ms"} {"level":"info","ts":"2026-08-24T15:14:08.479163Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6244e483e416226f","cluster-id":"68a374eab3e2de92"} {"level":"info","ts":"2026-08-24T15:14:08.479254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=()"} {"level":"info","ts":"2026-08-24T15:14:08.479281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became follower at term 0"} {"level":"info","ts":"2026-08-24T15:14:08.479296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6244e483e416226f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-24T15:14:08.479309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became follower at term 1"} {"level":"info","ts":"2026-08-24T15:14:08.479356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=(7081035769251766895)"} {"level":"warn","ts":"2026-08-24T15:14:08.486512Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-24T15:14:08.487748Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-24T15:14:08.488903Z","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-08-24T15:14:08.491281Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6244e483e416226f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-24T15:14:08.493631Z","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-08-24T15:14:08.493693Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6244e483e416226f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-24T15:14:08.493756Z","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-08-24T15:14:08.493782Z","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-08-24T15:14:08.494479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=(7081035769251766895)"} {"level":"info","ts":"2026-08-24T15:14:08.494593Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"68a374eab3e2de92","local-member-id":"6244e483e416226f","added-peer-id":"6244e483e416226f","added-peer-peer-urls":["https://199.19.213.147:2380"]} {"level":"info","ts":"2026-08-24T15:14:08.497461Z","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-08-24T15:14:08.497619Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.147:2380"} {"level":"info","ts":"2026-08-24T15:14:08.497645Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.147:2380"} {"level":"info","ts":"2026-08-24T15:14:08.497879Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6244e483e416226f","initial-advertise-peer-urls":["https://199.19.213.147:2380"],"listen-peer-urls":["https://199.19.213.147:2380"],"advertise-client-urls":["https://199.19.213.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-24T15:14:08.49793Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-24T15:14:09.480218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f is starting a new election at term 1"} {"level":"info","ts":"2026-08-24T15:14:09.480294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became pre-candidate at term 1"} {"level":"info","ts":"2026-08-24T15:14:09.480334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f received MsgPreVoteResp from 6244e483e416226f at term 1"} {"level":"info","ts":"2026-08-24T15:14:09.480357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became candidate at term 2"} {"level":"info","ts":"2026-08-24T15:14:09.480367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f received MsgVoteResp from 6244e483e416226f at term 2"} {"level":"info","ts":"2026-08-24T15:14:09.480382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became leader at term 2"} {"level":"info","ts":"2026-08-24T15:14:09.4804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6244e483e416226f elected leader 6244e483e416226f at term 2"} {"level":"info","ts":"2026-08-24T15:14:09.481673Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:14:09.481884Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6244e483e416226f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.147:2379]}","request-path":"/0/members/6244e483e416226f/attributes","cluster-id":"68a374eab3e2de92","publish-timeout":"7s"} {"level":"info","ts":"2026-08-24T15:14:09.481888Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T15:14:09.48192Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T15:14:09.482205Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-24T15:14:09.482243Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-24T15:14:09.482675Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"68a374eab3e2de92","local-member-id":"6244e483e416226f","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:14:09.482832Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:14:09.48287Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:14:09.484997Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-24T15:14:09.486985Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.147:2379"} {"level":"warn","ts":"2026-08-24T15:14:12.738632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.098909ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-24T15:14:12.738894Z","caller":"traceutil/trace.go:171","msg":"trace[1550730622] linearizableReadLoop","detail":"{readStateIndex:125; appliedIndex:124; }","duration":"200.181111ms","start":"2026-08-24T15:14:12.538655Z","end":"2026-08-24T15:14:12.738836Z","steps":["trace[1550730622] 'read index received' (duration: 78.021µs)","trace[1550730622] 'applied index is now lower than readState.Index' (duration: 200.10106ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:12.739108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.452824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-24T15:14:12.739083Z","caller":"traceutil/trace.go:171","msg":"trace[1683489879] transaction","detail":"{read_only:false; response_revision:121; number_of_response:1; }","duration":"656.26909ms","start":"2026-08-24T15:14:12.082767Z","end":"2026-08-24T15:14:12.739036Z","steps":["trace[1683489879] 'process raft request' (duration: 123.724112ms)","trace[1683489879] 'compare' (duration: 530.919317ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:12.739222Z","caller":"traceutil/trace.go:171","msg":"trace[1374186255] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:121; }","duration":"200.622946ms","start":"2026-08-24T15:14:12.538582Z","end":"2026-08-24T15:14:12.739205Z","steps":["trace[1374186255] 'agreement among raft nodes before linearized reading' (duration: 200.366903ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:12.739398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:12.082747Z","time spent":"656.506293ms","remote":"127.0.0.1:32912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":767,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:12.888263Z","caller":"traceutil/trace.go:171","msg":"trace[861613815] transaction","detail":"{read_only:false; response_revision:122; number_of_response:1; }","duration":"142.943753ms","start":"2026-08-24T15:14:12.745289Z","end":"2026-08-24T15:14:12.888232Z","steps":["trace[861613815] 'process raft request' (duration: 141.418172ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:12.888686Z","caller":"traceutil/trace.go:171","msg":"trace[1200225175] transaction","detail":"{read_only:false; response_revision:123; number_of_response:1; }","duration":"141.554215ms","start":"2026-08-24T15:14:12.747114Z","end":"2026-08-24T15:14:12.888668Z","steps":["trace[1200225175] 'process raft request' (duration: 141.467393ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:47.838105Z","caller":"traceutil/trace.go:171","msg":"trace[685768126] linearizableReadLoop","detail":"{readStateIndex:518; appliedIndex:517; }","duration":"108.167663ms","start":"2026-08-24T15:14:47.729913Z","end":"2026-08-24T15:14:47.838081Z","steps":["trace[685768126] 'read index received' (duration: 107.292148ms)","trace[685768126] 'applied index is now lower than readState.Index' (duration: 874.545µs)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:47.838361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.410708ms","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-08-24T15:14:47.83843Z","caller":"traceutil/trace.go:171","msg":"trace[23213248] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:500; }","duration":"108.54275ms","start":"2026-08-24T15:14:47.729852Z","end":"2026-08-24T15:14:47.838394Z","steps":["trace[23213248] 'agreement among raft nodes before linearized reading' (duration: 108.335056ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:47.838554Z","caller":"traceutil/trace.go:171","msg":"trace[652974282] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"442.761475ms","start":"2026-08-24T15:14:47.395707Z","end":"2026-08-24T15:14:47.838468Z","steps":["trace[652974282] 'process raft request' (duration: 441.784318ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:47.838919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:47.395688Z","time spent":"443.051179ms","remote":"127.0.0.1:60904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317296,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:48.143695Z","caller":"traceutil/trace.go:171","msg":"trace[711874292] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"300.761365ms","start":"2026-08-24T15:14:47.842887Z","end":"2026-08-24T15:14:48.143648Z","steps":["trace[711874292] 'process raft request' (duration: 231.851766ms)","trace[711874292] 'compare' (duration: 68.657355ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:48.143831Z","caller":"traceutil/trace.go:171","msg":"trace[1558386963] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"281.669741ms","start":"2026-08-24T15:14:47.862131Z","end":"2026-08-24T15:14:48.143801Z","steps":["trace[1558386963] 'process raft request' (duration: 281.418437ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:48.143914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.851717ms","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-08-24T15:14:48.143977Z","caller":"traceutil/trace.go:171","msg":"trace[141770086] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:503; }","duration":"266.99485ms","start":"2026-08-24T15:14:47.876967Z","end":"2026-08-24T15:14:48.143962Z","steps":["trace[141770086] 'agreement among raft nodes before linearized reading' (duration: 266.800986ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:48.144024Z","caller":"traceutil/trace.go:171","msg":"trace[1148935853] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"281.706391ms","start":"2026-08-24T15:14:47.862264Z","end":"2026-08-24T15:14:48.14397Z","steps":["trace[1148935853] 'process raft request' (duration: 281.345735ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:48.143703Z","caller":"traceutil/trace.go:171","msg":"trace[790719947] linearizableReadLoop","detail":"{readStateIndex:521; appliedIndex:518; }","duration":"266.649644ms","start":"2026-08-24T15:14:47.877017Z","end":"2026-08-24T15:14:48.143666Z","steps":["trace[790719947] 'read index received' (duration: 197.691693ms)","trace[790719947] 'applied index is now lower than readState.Index' (duration: 68.956831ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:48.144462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:47.84286Z","time spent":"300.99105ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:48.435822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.468546ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:14:48.436003Z","caller":"traceutil/trace.go:171","msg":"trace[281587972] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"225.64883ms","start":"2026-08-24T15:14:48.210331Z","end":"2026-08-24T15:14:48.435979Z","steps":["trace[281587972] 'process raft request' (duration: 92.91729ms)","trace[281587972] 'compare' (duration: 132.10283ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:48.729434Z","caller":"traceutil/trace.go:171","msg":"trace[1944454046] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"124.911888ms","start":"2026-08-24T15:14:48.604499Z","end":"2026-08-24T15:14:48.729411Z","steps":["trace[1944454046] 'process raft request' (duration: 124.749995ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:48.955739Z","caller":"traceutil/trace.go:171","msg":"trace[264077307] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:532; }","duration":"218.595611ms","start":"2026-08-24T15:14:48.737111Z","end":"2026-08-24T15:14:48.955707Z","steps":["trace[264077307] 'read index received' (duration: 157.028777ms)","trace[264077307] 'applied index is now lower than readState.Index' (duration: 61.565524ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:48.955794Z","caller":"traceutil/trace.go:171","msg":"trace[445876568] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"265.232229ms","start":"2026-08-24T15:14:48.690527Z","end":"2026-08-24T15:14:48.955759Z","steps":["trace[445876568] 'process raft request' (duration: 203.532353ms)","trace[445876568] 'compare' (duration: 61.459541ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:48.955976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.825874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:14:48.956121Z","caller":"traceutil/trace.go:171","msg":"trace[1225033467] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:515; }","duration":"219.030198ms","start":"2026-08-24T15:14:48.73706Z","end":"2026-08-24T15:14:48.95609Z","steps":["trace[1225033467] 'agreement among raft nodes before linearized reading' (duration: 218.751843ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:49.01981Z","caller":"traceutil/trace.go:171","msg":"trace[999770711] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"267.190424ms","start":"2026-08-24T15:14:48.752596Z","end":"2026-08-24T15:14:49.019787Z","steps":["trace[999770711] 'process raft request' (duration: 266.891659ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:49.252659Z","caller":"traceutil/trace.go:171","msg":"trace[1889070775] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"292.033097ms","start":"2026-08-24T15:14:48.960586Z","end":"2026-08-24T15:14:49.252619Z","steps":["trace[1889070775] 'process raft request' (duration: 195.500658ms)","trace[1889070775] 'compare' (duration: 96.209192ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:49.252693Z","caller":"traceutil/trace.go:171","msg":"trace[1118977959] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"291.505466ms","start":"2026-08-24T15:14:48.961141Z","end":"2026-08-24T15:14:49.252646Z","steps":["trace[1118977959] 'process raft request' (duration: 291.369964ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:49.252917Z","caller":"traceutil/trace.go:171","msg":"trace[1667344669] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"289.263839ms","start":"2026-08-24T15:14:48.963641Z","end":"2026-08-24T15:14:49.252905Z","steps":["trace[1667344669] 'process raft request' (duration: 288.925613ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:49.253042Z","caller":"traceutil/trace.go:171","msg":"trace[1985277924] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"289.146346ms","start":"2026-08-24T15:14:48.963858Z","end":"2026-08-24T15:14:49.253005Z","steps":["trace[1985277924] 'process raft request' (duration: 288.74861ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:49.508394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.701673ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-24T15:14:49.508614Z","caller":"traceutil/trace.go:171","msg":"trace[575966301] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:534; }","duration":"414.729547ms","start":"2026-08-24T15:14:49.093861Z","end":"2026-08-24T15:14:49.508591Z","steps":["trace[575966301] 'read index received' (duration: 62.310311ms)","trace[575966301] 'applied index is now lower than readState.Index' (duration: 352.417566ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:49.509221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.351147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329944"} {"level":"info","ts":"2026-08-24T15:14:49.50927Z","caller":"traceutil/trace.go:171","msg":"trace[721703596] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:520; }","duration":"415.453119ms","start":"2026-08-24T15:14:49.093802Z","end":"2026-08-24T15:14:49.509255Z","steps":["trace[721703596] 'agreement among raft nodes before linearized reading' (duration: 414.88671ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:49.509324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:49.093779Z","time spent":"415.52301ms","remote":"127.0.0.1:60904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":329966,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"info","ts":"2026-08-24T15:14:49.531401Z","caller":"traceutil/trace.go:171","msg":"trace[2127084507] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"272.728977ms","start":"2026-08-24T15:14:49.25865Z","end":"2026-08-24T15:14:49.531379Z","steps":["trace[2127084507] 'process raft request' (duration: 272.541774ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:49.670734Z","caller":"traceutil/trace.go:171","msg":"trace[1486090248] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"411.666724ms","start":"2026-08-24T15:14:49.259026Z","end":"2026-08-24T15:14:49.670692Z","steps":["trace[1486090248] 'process raft request' (duration: 394.53362ms)","trace[1486090248] 'compare' (duration: 16.793358ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:49.670799Z","caller":"traceutil/trace.go:171","msg":"trace[163351362] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"411.264327ms","start":"2026-08-24T15:14:49.259463Z","end":"2026-08-24T15:14:49.670727Z","steps":["trace[163351362] 'process raft request' (duration: 411.059424ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:49.670889Z","caller":"traceutil/trace.go:171","msg":"trace[822688467] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"410.861791ms","start":"2026-08-24T15:14:49.259997Z","end":"2026-08-24T15:14:49.670858Z","steps":["trace[822688467] 'process raft request' (duration: 410.634577ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:49.670935Z","caller":"traceutil/trace.go:171","msg":"trace[1983023791] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:539; }","duration":"162.269499ms","start":"2026-08-24T15:14:49.508646Z","end":"2026-08-24T15:14:49.670915Z","steps":["trace[1983023791] 'read index received' (duration: 22.630839ms)","trace[1983023791] 'applied index is now lower than readState.Index' (duration: 139.63716ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:49.670944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:49.259008Z","time spent":"411.827487ms","remote":"127.0.0.1:60998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15061,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:49.671028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:49.259451Z","time spent":"411.45034ms","remote":"127.0.0.1:60876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":653,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:14:49.671061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:49.259987Z","time spent":"410.979152ms","remote":"127.0.0.1:60998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3622,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:49.671114Z","caller":"traceutil/trace.go:171","msg":"trace[902677050] transaction","detail":"{read_only:false; number_of_response:1; response_revision:525; }","duration":"410.660188ms","start":"2026-08-24T15:14:49.260439Z","end":"2026-08-24T15:14:49.671099Z","steps":["trace[902677050] 'process raft request' (duration: 410.324972ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:49.672847Z","caller":"traceutil/trace.go:171","msg":"trace[2013809985] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"408.008422ms","start":"2026-08-24T15:14:49.264806Z","end":"2026-08-24T15:14:49.672815Z","steps":["trace[2013809985] 'process raft request' (duration: 406.018777ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:49.673054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:49.264796Z","time spent":"408.189115ms","remote":"127.0.0.1:33032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14448,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:49.673703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.750571ms","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-08-24T15:14:49.673803Z","caller":"traceutil/trace.go:171","msg":"trace[2014021671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:526; }","duration":"416.864234ms","start":"2026-08-24T15:14:49.256892Z","end":"2026-08-24T15:14:49.673756Z","steps":["trace[2014021671] 'agreement among raft nodes before linearized reading' (duration: 416.725481ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:49.673865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:49.256867Z","time spent":"416.979866ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-24T15:14:49.674962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.250208ms","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-08-24T15:14:49.675491Z","caller":"traceutil/trace.go:171","msg":"trace[532086171] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"414.9124ms","start":"2026-08-24T15:14:49.260241Z","end":"2026-08-24T15:14:49.675153Z","steps":["trace[532086171] 'process raft request' (duration: 410.458294ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:49.675681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:49.260218Z","time spent":"415.359488ms","remote":"127.0.0.1:33044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4294,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:49.675865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:49.260433Z","time spent":"410.730109ms","remote":"127.0.0.1:33010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":53,"response count":0,"response size":4368,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:49.675066Z","caller":"traceutil/trace.go:171","msg":"trace[1590305203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:526; }","duration":"446.413011ms","start":"2026-08-24T15:14:49.22863Z","end":"2026-08-24T15:14:49.675043Z","steps":["trace[1590305203] 'agreement among raft nodes before linearized reading' (duration: 445.999284ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:49.680458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:49.228603Z","time spent":"451.831434ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-24T15:14:49.852356Z","caller":"traceutil/trace.go:171","msg":"trace[487535632] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"168.028458ms","start":"2026-08-24T15:14:49.684307Z","end":"2026-08-24T15:14:49.852335Z","steps":["trace[487535632] 'process raft request' (duration: 162.304209ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:49.852669Z","caller":"traceutil/trace.go:171","msg":"trace[752268440] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"167.667322ms","start":"2026-08-24T15:14:49.684967Z","end":"2026-08-24T15:14:49.852635Z","steps":["trace[752268440] 'process raft request' (duration: 167.333996ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:49.853036Z","caller":"traceutil/trace.go:171","msg":"trace[692555611] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"167.854074ms","start":"2026-08-24T15:14:49.685166Z","end":"2026-08-24T15:14:49.85302Z","steps":["trace[692555611] 'process raft request' (duration: 167.365826ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:49.853344Z","caller":"traceutil/trace.go:171","msg":"trace[1069319182] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"166.45332ms","start":"2026-08-24T15:14:49.686876Z","end":"2026-08-24T15:14:49.853329Z","steps":["trace[1069319182] 'process raft request' (duration: 165.985963ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:49.853359Z","caller":"traceutil/trace.go:171","msg":"trace[13159638] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"159.948529ms","start":"2026-08-24T15:14:49.6934Z","end":"2026-08-24T15:14:49.853348Z","steps":["trace[13159638] 'process raft request' (duration: 159.742635ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:49.882702Z","caller":"traceutil/trace.go:171","msg":"trace[1028696828] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"171.515968ms","start":"2026-08-24T15:14:49.711158Z","end":"2026-08-24T15:14:49.882674Z","steps":["trace[1028696828] 'process raft request' (duration: 171.376475ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:50.107941Z","caller":"traceutil/trace.go:171","msg":"trace[181312874] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"244.746122ms","start":"2026-08-24T15:14:49.863163Z","end":"2026-08-24T15:14:50.107909Z","steps":["trace[181312874] 'process raft request' (duration: 233.970246ms)","trace[181312874] 'compare' (duration: 10.611604ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:50.17432Z","caller":"traceutil/trace.go:171","msg":"trace[759557807] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:553; }","duration":"251.496164ms","start":"2026-08-24T15:14:49.922795Z","end":"2026-08-24T15:14:50.174291Z","steps":["trace[759557807] 'read index received' (duration: 174.361183ms)","trace[759557807] 'applied index is now lower than readState.Index' (duration: 77.133661ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:50.174602Z","caller":"traceutil/trace.go:171","msg":"trace[31996005] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"284.890779ms","start":"2026-08-24T15:14:49.889658Z","end":"2026-08-24T15:14:50.174549Z","steps":["trace[31996005] 'process raft request' (duration: 284.40748ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:50.174626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.791069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"warn","ts":"2026-08-24T15:14:50.174662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.788774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-08-24T15:14:50.174739Z","caller":"traceutil/trace.go:171","msg":"trace[2110330258] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:535; }","duration":"251.947841ms","start":"2026-08-24T15:14:49.922764Z","end":"2026-08-24T15:14:50.174711Z","steps":["trace[2110330258] 'agreement among raft nodes before linearized reading' (duration: 251.722218ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:50.174751Z","caller":"traceutil/trace.go:171","msg":"trace[1290486344] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:535; }","duration":"249.927407ms","start":"2026-08-24T15:14:49.9248Z","end":"2026-08-24T15:14:50.174727Z","steps":["trace[1290486344] 'agreement among raft nodes before linearized reading' (duration: 249.768894ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:51.13977Z","caller":"traceutil/trace.go:171","msg":"trace[302600938] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"160.789854ms","start":"2026-08-24T15:14:50.97895Z","end":"2026-08-24T15:14:51.13974Z","steps":["trace[302600938] 'process raft request' (duration: 160.640931ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.420204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.941684ms","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-08-24T15:14:51.42058Z","caller":"traceutil/trace.go:171","msg":"trace[855848407] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"429.011002ms","start":"2026-08-24T15:14:50.991547Z","end":"2026-08-24T15:14:51.420558Z","steps":["trace[855848407] 'process raft request' (duration: 428.804729ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:51.420666Z","caller":"traceutil/trace.go:171","msg":"trace[2059457501] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"437.738814ms","start":"2026-08-24T15:14:50.98289Z","end":"2026-08-24T15:14:51.420628Z","steps":["trace[2059457501] 'process raft request' (duration: 416.988283ms)","trace[2059457501] 'compare' (duration: 20.252271ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:51.420875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:50.991522Z","time spent":"429.153375ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:14:51.420886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:50.982863Z","time spent":"437.922156ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:51.420904Z","caller":"traceutil/trace.go:171","msg":"trace[1672713310] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"373.110615ms","start":"2026-08-24T15:14:51.047738Z","end":"2026-08-24T15:14:51.420848Z","steps":["trace[1672713310] 'process raft request' (duration: 373.054194ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:51.420942Z","caller":"traceutil/trace.go:171","msg":"trace[35231050] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"424.635957ms","start":"2026-08-24T15:14:50.996295Z","end":"2026-08-24T15:14:51.420931Z","steps":["trace[35231050] 'process raft request' (duration: 424.27501ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.421029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:50.996289Z","time spent":"424.698238ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:51.420901Z","caller":"traceutil/trace.go:171","msg":"trace[583800284] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"429.252448ms","start":"2026-08-24T15:14:50.991606Z","end":"2026-08-24T15:14:51.420858Z","steps":["trace[583800284] 'process raft request' (duration: 428.819579ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.421063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.047709Z","time spent":"373.272628ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:51.420587Z","caller":"traceutil/trace.go:171","msg":"trace[28182745] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"436.46071ms","start":"2026-08-24T15:14:50.984063Z","end":"2026-08-24T15:14:51.420524Z","steps":["trace[28182745] 'process raft request' (duration: 436.223876ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:51.420888Z","caller":"traceutil/trace.go:171","msg":"trace[394217311] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"420.221781ms","start":"2026-08-24T15:14:51.000632Z","end":"2026-08-24T15:14:51.420854Z","steps":["trace[394217311] 'process raft request' (duration: 419.980576ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.421224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.00061Z","time spent":"420.550937ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:51.421268Z","caller":"traceutil/trace.go:171","msg":"trace[172101053] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"405.927343ms","start":"2026-08-24T15:14:51.015332Z","end":"2026-08-24T15:14:51.421259Z","steps":["trace[172101053] 'process raft request' (duration: 405.401614ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.421224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:50.984054Z","time spent":"437.076991ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:14:51.421273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:50.991582Z","time spent":"429.511302ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:14:51.421327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.015327Z","time spent":"405.972404ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:51.421238Z","caller":"traceutil/trace.go:171","msg":"trace[249470169] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"405.979564ms","start":"2026-08-24T15:14:51.015248Z","end":"2026-08-24T15:14:51.421227Z","steps":["trace[249470169] 'process raft request' (duration: 405.438165ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.421497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.015219Z","time spent":"406.200628ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:51.420435Z","caller":"traceutil/trace.go:171","msg":"trace[1587470186] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:538; }","duration":"125.183748ms","start":"2026-08-24T15:14:51.295222Z","end":"2026-08-24T15:14:51.420406Z","steps":["trace[1587470186] 'range keys from in-memory index tree' (duration: 124.924644ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:51.421724Z","caller":"traceutil/trace.go:171","msg":"trace[862562377] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"425.288988ms","start":"2026-08-24T15:14:50.996256Z","end":"2026-08-24T15:14:51.421545Z","steps":["trace[862562377] 'process raft request' (duration: 424.214749ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.422035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:50.996246Z","time spent":"425.588683ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:51.498781Z","caller":"traceutil/trace.go:171","msg":"trace[1577153083] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"351.981407ms","start":"2026-08-24T15:14:51.146778Z","end":"2026-08-24T15:14:51.498759Z","steps":["trace[1577153083] 'process raft request' (duration: 351.728283ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:51.498867Z","caller":"traceutil/trace.go:171","msg":"trace[1507642219] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"351.835545ms","start":"2026-08-24T15:14:51.146985Z","end":"2026-08-24T15:14:51.498821Z","steps":["trace[1507642219] 'process raft request' (duration: 351.679983ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.49975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.146754Z","time spent":"352.081659ms","remote":"127.0.0.1:33100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:14:51.50006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.146975Z","time spent":"352.888904ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:51.501164Z","caller":"traceutil/trace.go:171","msg":"trace[261192553] transaction","detail":"{read_only:false; number_of_response:1; response_revision:550; }","duration":"353.603456ms","start":"2026-08-24T15:14:51.147531Z","end":"2026-08-24T15:14:51.501134Z","steps":["trace[261192553] 'process raft request' (duration: 351.237124ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.501338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.147522Z","time spent":"353.693658ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7365,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:51.503969Z","caller":"traceutil/trace.go:171","msg":"trace[1028514860] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"338.687167ms","start":"2026-08-24T15:14:51.165262Z","end":"2026-08-24T15:14:51.50395Z","steps":["trace[1028514860] 'process raft request' (duration: 335.442111ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.504076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.16524Z","time spent":"338.77353ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:51.819937Z","caller":"traceutil/trace.go:171","msg":"trace[1650076842] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"376.831388ms","start":"2026-08-24T15:14:51.44308Z","end":"2026-08-24T15:14:51.819911Z","steps":["trace[1650076842] 'process raft request' (duration: 376.705796ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:51.820025Z","caller":"traceutil/trace.go:171","msg":"trace[2071423841] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"375.502675ms","start":"2026-08-24T15:14:51.444489Z","end":"2026-08-24T15:14:51.819991Z","steps":["trace[2071423841] 'process raft request' (duration: 375.366463ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.820107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.443055Z","time spent":"376.961941ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:51.820226Z","caller":"traceutil/trace.go:171","msg":"trace[676485914] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"381.393338ms","start":"2026-08-24T15:14:51.43881Z","end":"2026-08-24T15:14:51.820203Z","steps":["trace[676485914] 'process raft request' (duration: 380.836298ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.820366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.444473Z","time spent":"375.638098ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:51.820502Z","caller":"traceutil/trace.go:171","msg":"trace[723400480] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"381.835655ms","start":"2026-08-24T15:14:51.438555Z","end":"2026-08-24T15:14:51.820391Z","steps":["trace[723400480] 'process raft request' (duration: 381.038241ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.820569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.438786Z","time spent":"381.624831ms","remote":"127.0.0.1:33100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:14:51.820777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.438524Z","time spent":"382.081359ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:51.820257Z","caller":"traceutil/trace.go:171","msg":"trace[1840595959] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"378.204362ms","start":"2026-08-24T15:14:51.442025Z","end":"2026-08-24T15:14:51.820229Z","steps":["trace[1840595959] 'process raft request' (duration: 377.694773ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.821476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.442012Z","time spent":"379.401063ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:51.82025Z","caller":"traceutil/trace.go:171","msg":"trace[2029746231] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"380.91197ms","start":"2026-08-24T15:14:51.439296Z","end":"2026-08-24T15:14:51.820208Z","steps":["trace[2029746231] 'process raft request' (duration: 380.375831ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.821871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.439286Z","time spent":"382.499317ms","remote":"127.0.0.1:33100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:51.820319Z","caller":"traceutil/trace.go:171","msg":"trace[1954935683] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"383.061737ms","start":"2026-08-24T15:14:51.437248Z","end":"2026-08-24T15:14:51.820309Z","steps":["trace[1954935683] 'process raft request' (duration: 382.285624ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.822319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.437241Z","time spent":"384.973671ms","remote":"127.0.0.1:33100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:51.820344Z","caller":"traceutil/trace.go:171","msg":"trace[1823854300] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"383.166749ms","start":"2026-08-24T15:14:51.437163Z","end":"2026-08-24T15:14:51.82033Z","steps":["trace[1823854300] 'process raft request' (duration: 319.353593ms)","trace[1823854300] 'compare' (duration: 62.771908ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:51.822647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.437124Z","time spent":"385.429598ms","remote":"127.0.0.1:33100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:51.900794Z","caller":"traceutil/trace.go:171","msg":"trace[729194598] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"393.244933ms","start":"2026-08-24T15:14:51.507523Z","end":"2026-08-24T15:14:51.900768Z","steps":["trace[729194598] 'process raft request' (duration: 392.915567ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.90097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.507503Z","time spent":"393.373525ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7326,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:51.901336Z","caller":"traceutil/trace.go:171","msg":"trace[670310318] transaction","detail":"{read_only:false; number_of_response:1; response_revision:560; }","duration":"391.85652ms","start":"2026-08-24T15:14:51.509269Z","end":"2026-08-24T15:14:51.901126Z","steps":["trace[670310318] 'process raft request' (duration: 391.376882ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:51.90146Z","caller":"traceutil/trace.go:171","msg":"trace[1637654782] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"371.956575ms","start":"2026-08-24T15:14:51.529475Z","end":"2026-08-24T15:14:51.901431Z","steps":["trace[1637654782] 'process raft request' (duration: 371.622329ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.901597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.509253Z","time spent":"392.173705ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10111,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:51.901562Z","caller":"traceutil/trace.go:171","msg":"trace[625132204] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"337.473847ms","start":"2026-08-24T15:14:51.564001Z","end":"2026-08-24T15:14:51.901475Z","steps":["trace[625132204] 'process raft request' (duration: 337.343495ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:51.901679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.529452Z","time spent":"372.068257ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:51.901833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.563964Z","time spent":"337.71549ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:52.265253Z","caller":"traceutil/trace.go:171","msg":"trace[176926064] transaction","detail":"{read_only:false; number_of_response:1; response_revision:562; }","duration":"434.864782ms","start":"2026-08-24T15:14:51.830346Z","end":"2026-08-24T15:14:52.26521Z","steps":["trace[176926064] 'process raft request' (duration: 346.607216ms)","trace[176926064] 'compare' (duration: 88.052602ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:52.265512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.830323Z","time spent":"435.031815ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7374,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:52.265523Z","caller":"traceutil/trace.go:171","msg":"trace[95310425] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"429.534239ms","start":"2026-08-24T15:14:51.835956Z","end":"2026-08-24T15:14:52.265491Z","steps":["trace[95310425] 'process raft request' (duration: 429.204294ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:52.265703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.835929Z","time spent":"429.676101ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:52.265931Z","caller":"traceutil/trace.go:171","msg":"trace[1350218338] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"424.580803ms","start":"2026-08-24T15:14:51.841304Z","end":"2026-08-24T15:14:52.265885Z","steps":["trace[1350218338] 'process raft request' (duration: 424.057134ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:52.266063Z","caller":"traceutil/trace.go:171","msg":"trace[1008078779] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:580; }","duration":"408.126008ms","start":"2026-08-24T15:14:51.85792Z","end":"2026-08-24T15:14:52.266046Z","steps":["trace[1008078779] 'read index received' (duration: 42.591247ms)","trace[1008078779] 'applied index is now lower than readState.Index' (duration: 365.533711ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:52.26614Z","caller":"traceutil/trace.go:171","msg":"trace[1841959798] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"398.223867ms","start":"2026-08-24T15:14:51.867895Z","end":"2026-08-24T15:14:52.266119Z","steps":["trace[1841959798] 'process raft request' (duration: 397.853001ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:52.266171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.841288Z","time spent":"424.751196ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:52.266205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.281141ms","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-08-24T15:14:52.266241Z","caller":"traceutil/trace.go:171","msg":"trace[785473630] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:565; }","duration":"408.353372ms","start":"2026-08-24T15:14:51.857876Z","end":"2026-08-24T15:14:52.26623Z","steps":["trace[785473630] 'agreement among raft nodes before linearized reading' (duration: 408.2554ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:52.266262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.867875Z","time spent":"398.313538ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:52.266276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.857829Z","time spent":"408.439524ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-24T15:14:52.363286Z","caller":"traceutil/trace.go:171","msg":"trace[440772582] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"451.10923ms","start":"2026-08-24T15:14:51.912143Z","end":"2026-08-24T15:14:52.363253Z","steps":["trace[440772582] 'process raft request' (duration: 450.780384ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:52.363396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.912126Z","time spent":"451.217812ms","remote":"127.0.0.1:33100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:52.363471Z","caller":"traceutil/trace.go:171","msg":"trace[375902350] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"449.94082ms","start":"2026-08-24T15:14:51.913511Z","end":"2026-08-24T15:14:52.363451Z","steps":["trace[375902350] 'process raft request' (duration: 449.608075ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:52.363592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.913503Z","time spent":"450.020402ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:52.363642Z","caller":"traceutil/trace.go:171","msg":"trace[1572068135] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"373.593436ms","start":"2026-08-24T15:14:51.990041Z","end":"2026-08-24T15:14:52.363635Z","steps":["trace[1572068135] 'process raft request' (duration: 373.286111ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:52.36368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.989988Z","time spent":"373.673448ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:14:52.70496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.629399ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:14:52.705165Z","caller":"traceutil/trace.go:171","msg":"trace[1125467561] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"510.782745ms","start":"2026-08-24T15:14:52.194351Z","end":"2026-08-24T15:14:52.705133Z","steps":["trace[1125467561] 'process raft request' (duration: 278.84763ms)","trace[1125467561] 'compare' (duration: 231.372895ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:52.705292Z","caller":"traceutil/trace.go:171","msg":"trace[1787327842] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:590; }","duration":"439.168299ms","start":"2026-08-24T15:14:52.266103Z","end":"2026-08-24T15:14:52.705271Z","steps":["trace[1787327842] 'read index received' (duration: 97.12914ms)","trace[1787327842] 'applied index is now lower than readState.Index' (duration: 342.038289ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:52.705325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.194336Z","time spent":"510.894276ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:52.705466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"847.275377ms","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-08-24T15:14:52.705475Z","caller":"traceutil/trace.go:171","msg":"trace[649713123] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"430.319234ms","start":"2026-08-24T15:14:52.275128Z","end":"2026-08-24T15:14:52.705447Z","steps":["trace[649713123] 'process raft request' (duration: 430.07876ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:52.705537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.653817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:14:52.705566Z","caller":"traceutil/trace.go:171","msg":"trace[1135364407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:571; }","duration":"512.720409ms","start":"2026-08-24T15:14:52.192837Z","end":"2026-08-24T15:14:52.705558Z","steps":["trace[1135364407] 'agreement among raft nodes before linearized reading' (duration: 512.678518ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:52.705539Z","caller":"traceutil/trace.go:171","msg":"trace[22243321] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"435.169069ms","start":"2026-08-24T15:14:52.270342Z","end":"2026-08-24T15:14:52.705511Z","steps":["trace[22243321] 'process raft request' (duration: 434.743402ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:52.705583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.275114Z","time spent":"430.411686ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7693,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:52.705607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.192818Z","time spent":"512.781319ms","remote":"127.0.0.1:60786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:14:52.705643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.670027ms","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-08-24T15:14:52.705696Z","caller":"traceutil/trace.go:171","msg":"trace[1569017632] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:571; }","duration":"470.756419ms","start":"2026-08-24T15:14:52.234922Z","end":"2026-08-24T15:14:52.705678Z","steps":["trace[1569017632] 'agreement among raft nodes before linearized reading' (duration: 470.665717ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:52.705698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.270314Z","time spent":"435.291601ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:52.705497Z","caller":"traceutil/trace.go:171","msg":"trace[1016687670] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:571; }","duration":"847.354489ms","start":"2026-08-24T15:14:51.858131Z","end":"2026-08-24T15:14:52.705486Z","steps":["trace[1016687670] 'agreement among raft nodes before linearized reading' (duration: 847.201386ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:52.7058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:51.858112Z","time spent":"847.676044ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-24T15:14:52.705548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.057543ms","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-08-24T15:14:52.705883Z","caller":"traceutil/trace.go:171","msg":"trace[274901547] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:571; }","duration":"471.481671ms","start":"2026-08-24T15:14:52.234389Z","end":"2026-08-24T15:14:52.705871Z","steps":["trace[274901547] 'agreement among raft nodes before linearized reading' (duration: 471.079814ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:52.70592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.234361Z","time spent":"471.548662ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-24T15:14:52.705742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.234898Z","time spent":"470.83338ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-24T15:14:52.746115Z","caller":"traceutil/trace.go:171","msg":"trace[1665657997] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"374.426143ms","start":"2026-08-24T15:14:52.37166Z","end":"2026-08-24T15:14:52.746086Z","steps":["trace[1665657997] 'process raft request' (duration: 371.601354ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:52.746285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.371633Z","time spent":"374.564865ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:52.746477Z","caller":"traceutil/trace.go:171","msg":"trace[1727306633] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"332.245319ms","start":"2026-08-24T15:14:52.414145Z","end":"2026-08-24T15:14:52.74639Z","steps":["trace[1727306633] 'process raft request' (duration: 330.174843ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:52.74666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.41412Z","time spent":"332.435192ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:52.747017Z","caller":"traceutil/trace.go:171","msg":"trace[1958195591] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"367.632434ms","start":"2026-08-24T15:14:52.379366Z","end":"2026-08-24T15:14:52.746998Z","steps":["trace[1958195591] 'process raft request' (duration: 364.55539ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:52.74712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.379338Z","time spent":"367.719646ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:53.775449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.211365ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:14:53.775717Z","caller":"traceutil/trace.go:171","msg":"trace[304910747] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"1.065360244s","start":"2026-08-24T15:14:52.710339Z","end":"2026-08-24T15:14:53.775699Z","steps":["trace[304910747] 'process raft request' (duration: 1.065222931s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:53.77579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.710325Z","time spent":"1.065433395s","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:53.776069Z","caller":"traceutil/trace.go:171","msg":"trace[1668465444] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"1.065663258s","start":"2026-08-24T15:14:52.710369Z","end":"2026-08-24T15:14:53.776032Z","steps":["trace[1668465444] 'process raft request' (duration: 1.065279742s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:53.776253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.710353Z","time spent":"1.06579508s","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:53.776709Z","caller":"traceutil/trace.go:171","msg":"trace[501588692] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"1.066510824s","start":"2026-08-24T15:14:52.710173Z","end":"2026-08-24T15:14:53.776684Z","steps":["trace[501588692] 'process raft request' (duration: 219.972826ms)","trace[501588692] 'compare' (duration: 844.95019ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:53.776829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.710135Z","time spent":"1.066646676s","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:53.995382Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2481378066346533825,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:14:54.357032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.197127ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:14:54.357407Z","caller":"traceutil/trace.go:171","msg":"trace[1047069479] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"1.600626907s","start":"2026-08-24T15:14:52.756728Z","end":"2026-08-24T15:14:54.357355Z","steps":["trace[1047069479] 'process raft request' (duration: 1.306003643s)","trace[1047069479] 'compare' (duration: 294.018964ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:54.35746Z","caller":"traceutil/trace.go:171","msg":"trace[241638851] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"1.594103184s","start":"2026-08-24T15:14:52.763336Z","end":"2026-08-24T15:14:54.357439Z","steps":["trace[241638851] 'process raft request' (duration: 1.59387527s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:54.357581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.763324Z","time spent":"1.594194345s","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:54.357642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.756704Z","time spent":"1.600814761s","remote":"127.0.0.1:60876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":807,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:14:54.357848Z","caller":"traceutil/trace.go:171","msg":"trace[192026233] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"1.593083417s","start":"2026-08-24T15:14:52.764749Z","end":"2026-08-24T15:14:54.357833Z","steps":["trace[192026233] 'process raft request' (duration: 1.592601888s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:54.357908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.764742Z","time spent":"1.593133687s","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29461,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:54.357888Z","caller":"traceutil/trace.go:171","msg":"trace[598650654] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:600; }","duration":"863.284618ms","start":"2026-08-24T15:14:53.494574Z","end":"2026-08-24T15:14:54.357859Z","steps":["trace[598650654] 'read index received' (duration: 568.076704ms)","trace[598650654] 'applied index is now lower than readState.Index' (duration: 295.206384ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:54.358055Z","caller":"traceutil/trace.go:171","msg":"trace[907361332] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"1.545293125s","start":"2026-08-24T15:14:52.812746Z","end":"2026-08-24T15:14:54.358039Z","steps":["trace[907361332] 'process raft request' (duration: 1.544951589s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:54.358179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:52.812722Z","time spent":"1.545373046s","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:14:54.358229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.838132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.147\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-08-24T15:14:54.358272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"863.700765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:14:54.358318Z","caller":"traceutil/trace.go:171","msg":"trace[1832906942] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"863.787957ms","start":"2026-08-24T15:14:53.494519Z","end":"2026-08-24T15:14:54.358307Z","steps":["trace[1832906942] 'agreement among raft nodes before linearized reading' (duration: 863.708305ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:54.358323Z","caller":"traceutil/trace.go:171","msg":"trace[185039454] range","detail":"{range_begin:/registry/masterleases/199.19.213.147; range_end:; response_count:1; response_revision:581; }","duration":"629.971955ms","start":"2026-08-24T15:14:53.728328Z","end":"2026-08-24T15:14:54.3583Z","steps":["trace[185039454] 'agreement among raft nodes before linearized reading' (duration: 629.800212ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:54.358352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:53.494494Z","time spent":"863.852597ms","remote":"127.0.0.1:60786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:14:54.35837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:53.728311Z","time spent":"630.050426ms","remote":"127.0.0.1:60804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.147\" "} {"level":"warn","ts":"2026-08-24T15:14:54.358381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.58858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:14:54.358451Z","caller":"traceutil/trace.go:171","msg":"trace[503043565] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"166.702902ms","start":"2026-08-24T15:14:54.191737Z","end":"2026-08-24T15:14:54.35844Z","steps":["trace[503043565] 'agreement among raft nodes before linearized reading' (duration: 166.60282ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:55.212327Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2481378066346533831,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:14:55.611461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096091352s","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-08-24T15:14:55.61196Z","caller":"traceutil/trace.go:171","msg":"trace[894023900] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:604; }","duration":"899.991676ms","start":"2026-08-24T15:14:54.711949Z","end":"2026-08-24T15:14:55.611941Z","steps":["trace[894023900] 'read index received' (duration: 741.436896ms)","trace[894023900] 'applied index is now lower than readState.Index' (duration: 158.55383ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:55.61199Z","caller":"traceutil/trace.go:171","msg":"trace[1552711362] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"1.236899082s","start":"2026-08-24T15:14:54.375071Z","end":"2026-08-24T15:14:55.61197Z","steps":["trace[1552711362] 'process raft request' (duration: 1.236753239s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:55.612073Z","caller":"traceutil/trace.go:171","msg":"trace[759718238] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"1.228323061s","start":"2026-08-24T15:14:54.383713Z","end":"2026-08-24T15:14:55.612036Z","steps":["trace[759718238] 'process raft request' (duration: 1.228192579s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:55.612133Z","caller":"traceutil/trace.go:171","msg":"trace[1880013207] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"1.237107235s","start":"2026-08-24T15:14:54.37499Z","end":"2026-08-24T15:14:55.612097Z","steps":["trace[1880013207] 'process raft request' (duration: 1.236754959s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:55.612236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.641856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:14:55.612277Z","caller":"traceutil/trace.go:171","msg":"trace[691224651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"418.730938ms","start":"2026-08-24T15:14:55.193532Z","end":"2026-08-24T15:14:55.612263Z","steps":["trace[691224651] 'agreement among raft nodes before linearized reading' (duration: 418.682597ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:55.612212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:54.359853Z","time spent":"1.252347832s","remote":"127.0.0.1:60804","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-24T15:14:55.612267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:54.383704Z","time spent":"1.228455283s","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:14:55.612316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:55.193505Z","time spent":"418.804999ms","remote":"127.0.0.1:60786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:14:55.612248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:54.375065Z","time spent":"1.237029304s","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:55.612181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"900.21243ms","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-08-24T15:14:55.612426Z","caller":"traceutil/trace.go:171","msg":"trace[828385615] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:585; }","duration":"900.521915ms","start":"2026-08-24T15:14:54.711883Z","end":"2026-08-24T15:14:55.612405Z","steps":["trace[828385615] 'agreement among raft nodes before linearized reading' (duration: 900.150539ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:55.612471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:54.711849Z","time spent":"900.610417ms","remote":"127.0.0.1:32840","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-08-24T15:14:55.612351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:54.374965Z","time spent":"1.237262357s","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:55.612331Z","caller":"traceutil/trace.go:171","msg":"trace[129666654] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"1.249140396s","start":"2026-08-24T15:14:54.36316Z","end":"2026-08-24T15:14:55.612301Z","steps":["trace[129666654] 'process raft request' (duration: 1.248430863s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:55.61293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:54.363131Z","time spent":"1.249705225s","remote":"127.0.0.1:60876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":731,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:14:57.535873Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.822110321s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-24T15:14:57.614169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999149755s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-24T15:14:57.614262Z","caller":"traceutil/trace.go:171","msg":"trace[922099896] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999324478s","start":"2026-08-24T15:14:55.614918Z","end":"2026-08-24T15:14:57.614242Z","steps":["trace[922099896] 'agreement among raft nodes before linearized reading' (duration: 1.999195516s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:57.614318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:55.614891Z","time spent":"1.99941684s","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/24 15:14:57 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-24T15:14:57.677035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.963237923s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:14:57.677385Z","caller":"traceutil/trace.go:171","msg":"trace[450329576] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"2.046753682s","start":"2026-08-24T15:14:55.630608Z","end":"2026-08-24T15:14:57.677361Z","steps":["trace[450329576] 'process raft request' (duration: 2.046690541s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:57.677463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:55.630582Z","time spent":"2.046848613s","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:57.67769Z","caller":"traceutil/trace.go:171","msg":"trace[1703200519] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"2.064355692s","start":"2026-08-24T15:14:55.613322Z","end":"2026-08-24T15:14:57.677678Z","steps":["trace[1703200519] 'process raft request' (duration: 100.377356ms)","trace[1703200519] 'compare' (duration: 1.9630991s)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:57.677747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:55.613295Z","time spent":"2.064419082s","remote":"127.0.0.1:60804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:57.677882Z","caller":"traceutil/trace.go:171","msg":"trace[465631346] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"2.062896345s","start":"2026-08-24T15:14:55.614975Z","end":"2026-08-24T15:14:57.677872Z","steps":["trace[465631346] 'read index received' (duration: 98.779127ms)","trace[465631346] 'applied index is now lower than readState.Index' (duration: 1.964116238s)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:57.677956Z","caller":"traceutil/trace.go:171","msg":"trace[567585503] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"2.051366163s","start":"2026-08-24T15:14:55.626582Z","end":"2026-08-24T15:14:57.677948Z","steps":["trace[567585503] 'process raft request' (duration: 2.050636271s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:57.678005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:55.626561Z","time spent":"2.051415944s","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:57.678473Z","caller":"traceutil/trace.go:171","msg":"trace[745247491] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"2.056451303s","start":"2026-08-24T15:14:55.621985Z","end":"2026-08-24T15:14:57.678436Z","steps":["trace[745247491] 'process raft request' (duration: 2.05516718s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:57.678686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:55.621962Z","time spent":"2.056589925s","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:58.178674Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2481378066346533847,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-24T15:14:58.430906Z","caller":"traceutil/trace.go:171","msg":"trace[240627330] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"1.727202259s","start":"2026-08-24T15:14:56.703655Z","end":"2026-08-24T15:14:58.430858Z","steps":["trace[240627330] 'process raft request' (duration: 1.724521581s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:58.43116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:56.703622Z","time spent":"1.727413772s","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:58.431177Z","caller":"traceutil/trace.go:171","msg":"trace[200125932] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"2.510016745s","start":"2026-08-24T15:14:55.918299Z","end":"2026-08-24T15:14:58.428316Z","steps":["trace[200125932] 'process raft request' (duration: 2.509343504s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:58.431422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:55.918266Z","time spent":"2.513026199s","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:14:58.703784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.488629ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:14:58.704209Z","caller":"traceutil/trace.go:171","msg":"trace[1996139907] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"1.086067012s","start":"2026-08-24T15:14:57.618108Z","end":"2026-08-24T15:14:58.704175Z","steps":["trace[1996139907] 'process raft request' (duration: 977.076803ms)","trace[1996139907] 'compare' (duration: 108.220604ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:58.70427Z","caller":"traceutil/trace.go:171","msg":"trace[868029573] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"1.011068963s","start":"2026-08-24T15:14:57.693173Z","end":"2026-08-24T15:14:58.704242Z","steps":["trace[868029573] 'process raft request' (duration: 1.010839578s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:58.704403Z","caller":"traceutil/trace.go:171","msg":"trace[111954322] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:613; }","duration":"1.026413414s","start":"2026-08-24T15:14:57.677911Z","end":"2026-08-24T15:14:58.704324Z","steps":["trace[111954322] 'read index received' (duration: 749.255805ms)","trace[111954322] 'applied index is now lower than readState.Index' (duration: 277.154279ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:58.704424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:57.693151Z","time spent":"1.011173274s","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31102,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:58.704524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:57.618073Z","time spent":"1.086220064s","remote":"127.0.0.1:60876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:14:58.704618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.92335199s","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-08-24T15:14:58.704333Z","caller":"traceutil/trace.go:171","msg":"trace[307672084] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.007647772s","start":"2026-08-24T15:14:57.696626Z","end":"2026-08-24T15:14:58.704274Z","steps":["trace[307672084] 'process raft request' (duration: 1.0075213s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:58.704726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.923575404s","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-08-24T15:14:58.704766Z","caller":"traceutil/trace.go:171","msg":"trace[1222219641] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:594; }","duration":"2.923617085s","start":"2026-08-24T15:14:55.781139Z","end":"2026-08-24T15:14:58.704756Z","steps":["trace[1222219641] 'agreement among raft nodes before linearized reading' (duration: 2.923553474s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:58.704669Z","caller":"traceutil/trace.go:171","msg":"trace[30690168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:594; }","duration":"2.923432622s","start":"2026-08-24T15:14:55.781221Z","end":"2026-08-24T15:14:58.704654Z","steps":["trace[30690168] 'agreement among raft nodes before linearized reading' (duration: 2.92329861s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:58.704799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:55.781013Z","time spent":"2.923779758s","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-24T15:14:58.705127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:57.696613Z","time spent":"1.008293913s","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:58.70463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.082664532s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:14:58.70531Z","caller":"traceutil/trace.go:171","msg":"trace[742984014] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"1.083412805s","start":"2026-08-24T15:14:57.621876Z","end":"2026-08-24T15:14:58.705289Z","steps":["trace[742984014] 'agreement among raft nodes before linearized reading' (duration: 1.082581471s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:58.704624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.921337054s","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-08-24T15:14:58.705395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:57.621863Z","time spent":"1.083516767s","remote":"127.0.0.1:60786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-24T15:14:58.705399Z","caller":"traceutil/trace.go:171","msg":"trace[410441550] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:594; }","duration":"2.922135919s","start":"2026-08-24T15:14:55.783248Z","end":"2026-08-24T15:14:58.705384Z","steps":["trace[410441550] 'agreement among raft nodes before linearized reading' (duration: 2.921109671s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:58.705443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:55.783239Z","time spent":"2.92219062s","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-24T15:14:58.706473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:55.781212Z","time spent":"2.925241133s","remote":"127.0.0.1:32840","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-08-24T15:14:58.707069Z","caller":"traceutil/trace.go:171","msg":"trace[1293426214] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"185.300227ms","start":"2026-08-24T15:14:58.521749Z","end":"2026-08-24T15:14:58.707049Z","steps":["trace[1293426214] 'process raft request' (duration: 182.468636ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:58.70797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.026829453s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-08-24T15:14:58.708025Z","caller":"traceutil/trace.go:171","msg":"trace[1832259638] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:595; }","duration":"1.026946895s","start":"2026-08-24T15:14:57.681064Z","end":"2026-08-24T15:14:58.708011Z","steps":["trace[1832259638] 'agreement among raft nodes before linearized reading' (duration: 1.02612153s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:58.70806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:57.681005Z","time spent":"1.027046976s","remote":"127.0.0.1:60976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-08-24T15:14:59.059456Z","caller":"traceutil/trace.go:171","msg":"trace[1384289208] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"345.6146ms","start":"2026-08-24T15:14:58.713776Z","end":"2026-08-24T15:14:59.059391Z","steps":["trace[1384289208] 'process raft request' (duration: 317.291554ms)","trace[1384289208] 'compare' (duration: 28.057231ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:59.059646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:58.713759Z","time spent":"345.789582ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:59.059913Z","caller":"traceutil/trace.go:171","msg":"trace[1207393941] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"345.553908ms","start":"2026-08-24T15:14:58.714322Z","end":"2026-08-24T15:14:59.059876Z","steps":["trace[1207393941] 'process raft request' (duration: 344.989468ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:59.060205Z","caller":"traceutil/trace.go:171","msg":"trace[299618621] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:620; }","duration":"257.029225ms","start":"2026-08-24T15:14:58.803136Z","end":"2026-08-24T15:14:59.060165Z","steps":["trace[299618621] 'read index received' (duration: 227.951056ms)","trace[299618621] 'applied index is now lower than readState.Index' (duration: 29.077259ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:59.060414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:58.714305Z","time spent":"345.696251ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:59.06049Z","caller":"traceutil/trace.go:171","msg":"trace[59089570] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"340.273575ms","start":"2026-08-24T15:14:58.720134Z","end":"2026-08-24T15:14:59.060407Z","steps":["trace[59089570] 'process raft request' (duration: 339.728175ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:59.060635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.52844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:14:59.060731Z","caller":"traceutil/trace.go:171","msg":"trace[222306269] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:600; }","duration":"340.678403ms","start":"2026-08-24T15:14:58.72003Z","end":"2026-08-24T15:14:59.060709Z","steps":["trace[222306269] 'agreement among raft nodes before linearized reading' (duration: 340.466709ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:59.060801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:58.72002Z","time spent":"340.772414ms","remote":"127.0.0.1:60786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-24T15:14:59.060485Z","caller":"traceutil/trace.go:171","msg":"trace[82157491] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"327.00841ms","start":"2026-08-24T15:14:58.733464Z","end":"2026-08-24T15:14:59.060472Z","steps":["trace[82157491] 'process raft request' (duration: 326.619033ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:59.061032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:58.720126Z","time spent":"340.493659ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:14:59.061143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:58.733449Z","time spent":"327.549789ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:59.114677Z","caller":"traceutil/trace.go:171","msg":"trace[476394919] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"237.748515ms","start":"2026-08-24T15:14:58.876903Z","end":"2026-08-24T15:14:59.114651Z","steps":["trace[476394919] 'process raft request' (duration: 237.516621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:59.115083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.337899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-08-24T15:14:59.115185Z","caller":"traceutil/trace.go:171","msg":"trace[1701577563] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:601; }","duration":"304.494551ms","start":"2026-08-24T15:14:58.810668Z","end":"2026-08-24T15:14:59.115163Z","steps":["trace[1701577563] 'agreement among raft nodes before linearized reading' (duration: 304.020833ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:59.115376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:58.810647Z","time spent":"304.701315ms","remote":"127.0.0.1:32856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-08-24T15:14:59.330956Z","caller":"traceutil/trace.go:171","msg":"trace[290830235] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"250.507691ms","start":"2026-08-24T15:14:59.080411Z","end":"2026-08-24T15:14:59.330919Z","steps":["trace[290830235] 'process raft request' (duration: 166.826197ms)","trace[290830235] 'compare' (duration: 83.376558ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:59.33132Z","caller":"traceutil/trace.go:171","msg":"trace[220409424] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"242.917324ms","start":"2026-08-24T15:14:59.08838Z","end":"2026-08-24T15:14:59.331297Z","steps":["trace[220409424] 'process raft request' (duration: 242.430336ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:59.611205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.951046ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-24T15:14:59.611794Z","caller":"traceutil/trace.go:171","msg":"trace[1940357049] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:625; }","duration":"455.048131ms","start":"2026-08-24T15:14:59.156344Z","end":"2026-08-24T15:14:59.611392Z","steps":["trace[1940357049] 'read index received' (duration: 90.75726ms)","trace[1940357049] 'applied index is now lower than readState.Index' (duration: 364.280101ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:59.611903Z","caller":"traceutil/trace.go:171","msg":"trace[1298571981] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"258.547185ms","start":"2026-08-24T15:14:59.353296Z","end":"2026-08-24T15:14:59.611843Z","steps":["trace[1298571981] 'process raft request' (duration: 258.209508ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:59.612494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.122111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-08-24T15:14:59.612556Z","caller":"traceutil/trace.go:171","msg":"trace[804545169] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:604; }","duration":"456.250553ms","start":"2026-08-24T15:14:59.156287Z","end":"2026-08-24T15:14:59.612537Z","steps":["trace[804545169] 'agreement among raft nodes before linearized reading' (duration: 455.675623ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:59.612597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:59.156259Z","time spent":"456.327364ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":29592,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-08-24T15:14:59.657489Z","caller":"traceutil/trace.go:171","msg":"trace[1895095930] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"299.386273ms","start":"2026-08-24T15:14:59.35808Z","end":"2026-08-24T15:14:59.657466Z","steps":["trace[1895095930] 'process raft request' (duration: 299.026636ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:00.04457Z","caller":"traceutil/trace.go:171","msg":"trace[972558962] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"298.340148ms","start":"2026-08-24T15:14:59.746201Z","end":"2026-08-24T15:15:00.044541Z","steps":["trace[972558962] 'process raft request' (duration: 298.028233ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:00.234271Z","caller":"traceutil/trace.go:171","msg":"trace[155065757] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"168.485917ms","start":"2026-08-24T15:15:00.065752Z","end":"2026-08-24T15:15:00.234238Z","steps":["trace[155065757] 'process raft request' (duration: 159.138779ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:00.531775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.886087ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:00.531897Z","caller":"traceutil/trace.go:171","msg":"trace[1047740529] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:633; }","duration":"338.771817ms","start":"2026-08-24T15:15:00.193104Z","end":"2026-08-24T15:15:00.531876Z","steps":["trace[1047740529] 'read index received' (duration: 31.877631ms)","trace[1047740529] 'applied index is now lower than readState.Index' (duration: 306.893126ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:00.531979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.883479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:15:00.531967Z","caller":"traceutil/trace.go:171","msg":"trace[1484018171] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"411.841175ms","start":"2026-08-24T15:15:00.120089Z","end":"2026-08-24T15:15:00.531931Z","steps":["trace[1484018171] 'process raft request' (duration: 243.683104ms)","trace[1484018171] 'compare' (duration: 167.682813ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:00.532011Z","caller":"traceutil/trace.go:171","msg":"trace[755952013] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"338.96056ms","start":"2026-08-24T15:15:00.193037Z","end":"2026-08-24T15:15:00.531998Z","steps":["trace[755952013] 'agreement among raft nodes before linearized reading' (duration: 338.900169ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:00.532192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:00.193009Z","time spent":"339.172553ms","remote":"127.0.0.1:60786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:15:00.532185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:00.120057Z","time spent":"412.018308ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:00.589206Z","caller":"traceutil/trace.go:171","msg":"trace[1917852440] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"342.904029ms","start":"2026-08-24T15:15:00.246275Z","end":"2026-08-24T15:15:00.589179Z","steps":["trace[1917852440] 'process raft request' (duration: 342.37047ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:00.589438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:00.246241Z","time spent":"343.082403ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:00.907406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.971891ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:00.907584Z","caller":"traceutil/trace.go:171","msg":"trace[187602918] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"348.718874ms","start":"2026-08-24T15:15:00.558833Z","end":"2026-08-24T15:15:00.907552Z","steps":["trace[187602918] 'process raft request' (duration: 134.416417ms)","trace[187602918] 'compare' (duration: 213.632245ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:00.907676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:00.558791Z","time spent":"348.847357ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:00.952299Z","caller":"traceutil/trace.go:171","msg":"trace[1802350578] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"142.4015ms","start":"2026-08-24T15:15:00.809877Z","end":"2026-08-24T15:15:00.952278Z","steps":["trace[1802350578] 'read index received' (duration: 142.145485ms)","trace[1802350578] 'applied index is now lower than readState.Index' (duration: 254.465µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:00.952416Z","caller":"traceutil/trace.go:171","msg":"trace[744612264] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"311.01388ms","start":"2026-08-24T15:15:00.64131Z","end":"2026-08-24T15:15:00.952323Z","steps":["trace[744612264] 'process raft request' (duration: 310.773815ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:00.952453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.573854ms","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-08-24T15:15:00.952527Z","caller":"traceutil/trace.go:171","msg":"trace[294647707] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:613; }","duration":"142.699485ms","start":"2026-08-24T15:15:00.809817Z","end":"2026-08-24T15:15:00.952516Z","steps":["trace[294647707] 'agreement among raft nodes before linearized reading' (duration: 142.537622ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:00.952692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:00.641277Z","time spent":"311.232483ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:01.173908Z","caller":"traceutil/trace.go:171","msg":"trace[1507676855] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"255.19397ms","start":"2026-08-24T15:15:00.918688Z","end":"2026-08-24T15:15:01.173882Z","steps":["trace[1507676855] 'process raft request' (duration: 255.012197ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:01.28223Z","caller":"traceutil/trace.go:171","msg":"trace[2009622407] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"324.859813ms","start":"2026-08-24T15:15:00.957335Z","end":"2026-08-24T15:15:01.282195Z","steps":["trace[2009622407] 'process raft request' (duration: 324.475827ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:01.282272Z","caller":"traceutil/trace.go:171","msg":"trace[383241044] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:638; }","duration":"216.944828ms","start":"2026-08-24T15:15:01.065292Z","end":"2026-08-24T15:15:01.282237Z","steps":["trace[383241044] 'read index received' (duration: 108.443599ms)","trace[383241044] 'applied index is now lower than readState.Index' (duration: 108.500079ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:01.282439Z","caller":"traceutil/trace.go:171","msg":"trace[1104655865] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"301.321543ms","start":"2026-08-24T15:15:00.981054Z","end":"2026-08-24T15:15:01.282376Z","steps":["trace[1104655865] 'process raft request' (duration: 301.078708ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:01.282484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:00.957312Z","time spent":"325.010067ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:01.282561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.241323ms","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-08-24T15:15:01.282612Z","caller":"traceutil/trace.go:171","msg":"trace[1622308045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"217.348886ms","start":"2026-08-24T15:15:01.065253Z","end":"2026-08-24T15:15:01.282602Z","steps":["trace[1622308045] 'agreement among raft nodes before linearized reading' (duration: 217.122622ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:01.282631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:00.981025Z","time spent":"301.490656ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65412,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:01.682007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.635565ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:01.682264Z","caller":"traceutil/trace.go:171","msg":"trace[805366600] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"399.831924ms","start":"2026-08-24T15:15:01.282345Z","end":"2026-08-24T15:15:01.682177Z","steps":["trace[805366600] 'read index received' (duration: 105.893233ms)","trace[805366600] 'applied index is now lower than readState.Index' (duration: 293.936631ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:01.68226Z","caller":"traceutil/trace.go:171","msg":"trace[1551043632] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"478.343424ms","start":"2026-08-24T15:15:01.203852Z","end":"2026-08-24T15:15:01.682195Z","steps":["trace[1551043632] 'process raft request' (duration: 184.369743ms)","trace[1551043632] 'compare' (duration: 293.326079ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:01.68251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:01.203816Z","time spent":"478.548608ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:01.682477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.937295ms","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-08-24T15:15:01.682828Z","caller":"traceutil/trace.go:171","msg":"trace[1944158947] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:617; }","duration":"617.304562ms","start":"2026-08-24T15:15:01.065503Z","end":"2026-08-24T15:15:01.682808Z","steps":["trace[1944158947] 'agreement among raft nodes before linearized reading' (duration: 616.769182ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:01.682886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:01.065498Z","time spent":"617.374133ms","remote":"127.0.0.1:32840","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-08-24T15:15:01.684949Z","caller":"traceutil/trace.go:171","msg":"trace[1732438418] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"397.266178ms","start":"2026-08-24T15:15:01.287629Z","end":"2026-08-24T15:15:01.684895Z","steps":["trace[1732438418] 'process raft request' (duration: 396.995392ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:01.685246Z","caller":"traceutil/trace.go:171","msg":"trace[1065080305] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"377.433192ms","start":"2026-08-24T15:15:01.307796Z","end":"2026-08-24T15:15:01.68523Z","steps":["trace[1065080305] 'process raft request' (duration: 376.987693ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:01.685252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:01.287603Z","time spent":"397.475811ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:01.685341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:01.30778Z","time spent":"377.511403ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74745,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:01.941576Z","caller":"traceutil/trace.go:171","msg":"trace[831432139] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"226.566731ms","start":"2026-08-24T15:15:01.714968Z","end":"2026-08-24T15:15:01.941535Z","steps":["trace[831432139] 'process raft request' (duration: 216.183754ms)","trace[831432139] 'compare' (duration: 10.025181ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:01.9422Z","caller":"traceutil/trace.go:171","msg":"trace[2105597182] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:645; }","duration":"196.880767ms","start":"2026-08-24T15:15:01.745288Z","end":"2026-08-24T15:15:01.942169Z","steps":["trace[2105597182] 'read index received' (duration: 185.792228ms)","trace[2105597182] 'applied index is now lower than readState.Index' (duration: 11.087329ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:01.944359Z","caller":"traceutil/trace.go:171","msg":"trace[1179444635] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"219.234788ms","start":"2026-08-24T15:15:01.725051Z","end":"2026-08-24T15:15:01.944286Z","steps":["trace[1179444635] 'process raft request' (duration: 216.951857ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:01.944531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.0514ms","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-08-24T15:15:01.945035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.723548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:59631"} {"level":"info","ts":"2026-08-24T15:15:01.945092Z","caller":"traceutil/trace.go:171","msg":"trace[1032640139] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:622; }","duration":"199.795609ms","start":"2026-08-24T15:15:01.745276Z","end":"2026-08-24T15:15:01.945071Z","steps":["trace[1032640139] 'agreement among raft nodes before linearized reading' (duration: 199.29617ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:01.94524Z","caller":"traceutil/trace.go:171","msg":"trace[143439170] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:622; }","duration":"173.674951ms","start":"2026-08-24T15:15:01.771355Z","end":"2026-08-24T15:15:01.945029Z","steps":["trace[143439170] 'agreement among raft nodes before linearized reading' (duration: 172.949138ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:02.193374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.800727ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:02.193502Z","caller":"traceutil/trace.go:171","msg":"trace[418153271] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"223.890794ms","start":"2026-08-24T15:15:01.969594Z","end":"2026-08-24T15:15:02.193484Z","steps":["trace[418153271] 'read index received' (duration: 97.795231ms)","trace[418153271] 'applied index is now lower than readState.Index' (duration: 126.093983ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:02.193573Z","caller":"traceutil/trace.go:171","msg":"trace[400524108] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"240.459172ms","start":"2026-08-24T15:15:01.953068Z","end":"2026-08-24T15:15:02.193527Z","steps":["trace[400524108] 'process raft request' (duration: 114.40961ms)","trace[400524108] 'compare' (duration: 125.668795ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:02.193848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.24346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:80703"} {"level":"info","ts":"2026-08-24T15:15:02.19391Z","caller":"traceutil/trace.go:171","msg":"trace[170695216] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:623; }","duration":"224.326881ms","start":"2026-08-24T15:15:01.969565Z","end":"2026-08-24T15:15:02.193892Z","steps":["trace[170695216] 'agreement among raft nodes before linearized reading' (duration: 224.031926ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:02.414902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.105295ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:02.415059Z","caller":"traceutil/trace.go:171","msg":"trace[963064251] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"433.121966ms","start":"2026-08-24T15:15:01.981916Z","end":"2026-08-24T15:15:02.415038Z","steps":["trace[963064251] 'process raft request' (duration: 312.749646ms)","trace[963064251] 'compare' (duration: 119.925632ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:02.415135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:01.981849Z","time spent":"433.248838ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74754,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:02.475345Z","caller":"traceutil/trace.go:171","msg":"trace[801665727] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:648; }","duration":"281.740359ms","start":"2026-08-24T15:15:02.193574Z","end":"2026-08-24T15:15:02.475315Z","steps":["trace[801665727] 'read index received' (duration: 101.076232ms)","trace[801665727] 'applied index is now lower than readState.Index' (duration: 180.663387ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:02.475438Z","caller":"traceutil/trace.go:171","msg":"trace[1742859901] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"402.145459ms","start":"2026-08-24T15:15:02.073286Z","end":"2026-08-24T15:15:02.475431Z","steps":["trace[1742859901] 'process raft request' (duration: 401.265242ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:02.475535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:02.073255Z","time spent":"402.20104ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:02.475699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.971611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:15:02.475814Z","caller":"traceutil/trace.go:171","msg":"trace[1429173461] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"283.157394ms","start":"2026-08-24T15:15:02.192609Z","end":"2026-08-24T15:15:02.475766Z","steps":["trace[1429173461] 'agreement among raft nodes before linearized reading' (duration: 282.96048ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:02.885294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.859439ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:02.885436Z","caller":"traceutil/trace.go:171","msg":"trace[1498583307] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"410.01016ms","start":"2026-08-24T15:15:02.475403Z","end":"2026-08-24T15:15:02.885413Z","steps":["trace[1498583307] 'read index received' (duration: 202.974198ms)","trace[1498583307] 'applied index is now lower than readState.Index' (duration: 207.034272ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:02.885629Z","caller":"traceutil/trace.go:171","msg":"trace[678050931] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"438.638596ms","start":"2026-08-24T15:15:02.446935Z","end":"2026-08-24T15:15:02.885574Z","steps":["trace[678050931] 'process raft request' (duration: 231.37824ms)","trace[678050931] 'compare' (duration: 206.679346ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:02.885839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.305424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:151236"} {"level":"warn","ts":"2026-08-24T15:15:02.885875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:02.446908Z","time spent":"438.833179ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20851,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:02.885924Z","caller":"traceutil/trace.go:171","msg":"trace[104184680] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:626; }","duration":"664.467477ms","start":"2026-08-24T15:15:02.221433Z","end":"2026-08-24T15:15:02.8859Z","steps":["trace[104184680] 'agreement among raft nodes before linearized reading' (duration: 664.141901ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:02.885973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:02.221407Z","time spent":"664.557258ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":1,"response size":151258,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-08-24T15:15:02.901691Z","caller":"traceutil/trace.go:171","msg":"trace[1814444892] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"373.473332ms","start":"2026-08-24T15:15:02.528198Z","end":"2026-08-24T15:15:02.901671Z","steps":["trace[1814444892] 'process raft request' (duration: 373.317579ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:02.901826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:02.528171Z","time spent":"373.577883ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15664,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:03.077722Z","caller":"traceutil/trace.go:171","msg":"trace[376922708] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"310.837047ms","start":"2026-08-24T15:15:02.766842Z","end":"2026-08-24T15:15:03.077679Z","steps":["trace[376922708] 'process raft request' (duration: 245.735539ms)","trace[376922708] 'compare' (duration: 64.802733ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:03.077757Z","caller":"traceutil/trace.go:171","msg":"trace[1173154903] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"105.256422ms","start":"2026-08-24T15:15:02.972482Z","end":"2026-08-24T15:15:03.077739Z","steps":["trace[1173154903] 'process raft request' (duration: 105.084139ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:03.077794Z","caller":"traceutil/trace.go:171","msg":"trace[1120047820] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:651; }","duration":"192.281881ms","start":"2026-08-24T15:15:02.885466Z","end":"2026-08-24T15:15:03.077748Z","steps":["trace[1120047820] 'read index received' (duration: 16.164492ms)","trace[1120047820] 'applied index is now lower than readState.Index' (duration: 176.112459ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:03.077895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:02.76681Z","time spent":"310.99362ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:03.079051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.965065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:15:03.079149Z","caller":"traceutil/trace.go:171","msg":"trace[370444101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"602.153529ms","start":"2026-08-24T15:15:02.476976Z","end":"2026-08-24T15:15:03.07913Z","steps":["trace[370444101] 'agreement among raft nodes before linearized reading' (duration: 601.923655ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:03.07925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:02.476957Z","time spent":"602.28134ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:15:03.079746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.143582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-08-24T15:15:03.07981Z","caller":"traceutil/trace.go:171","msg":"trace[549839610] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:629; }","duration":"144.250434ms","start":"2026-08-24T15:15:02.935531Z","end":"2026-08-24T15:15:03.079781Z","steps":["trace[549839610] 'agreement among raft nodes before linearized reading' (duration: 144.092771ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:03.491223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.314733ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:03.491368Z","caller":"traceutil/trace.go:171","msg":"trace[328976523] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"401.945157ms","start":"2026-08-24T15:15:03.089399Z","end":"2026-08-24T15:15:03.491344Z","steps":["trace[328976523] 'read index received' (duration: 243.089745ms)","trace[328976523] 'applied index is now lower than readState.Index' (duration: 158.853852ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:03.491797Z","caller":"traceutil/trace.go:171","msg":"trace[1443013850] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"405.437062ms","start":"2026-08-24T15:15:03.086305Z","end":"2026-08-24T15:15:03.491742Z","steps":["trace[1443013850] 'process raft request' (duration: 246.464216ms)","trace[1443013850] 'compare' (duration: 157.852375ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:03.49197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:03.086264Z","time spent":"405.609105ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:03.491947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.505099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31145"} {"level":"warn","ts":"2026-08-24T15:15:03.492056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.628912ms","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-08-24T15:15:03.492154Z","caller":"traceutil/trace.go:171","msg":"trace[438549436] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:630; }","duration":"203.752174ms","start":"2026-08-24T15:15:03.288379Z","end":"2026-08-24T15:15:03.492131Z","steps":["trace[438549436] 'agreement among raft nodes before linearized reading' (duration: 203.457579ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:03.492154Z","caller":"traceutil/trace.go:171","msg":"trace[1758529821] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:630; }","duration":"402.755763ms","start":"2026-08-24T15:15:03.089369Z","end":"2026-08-24T15:15:03.492125Z","steps":["trace[1758529821] 'agreement among raft nodes before linearized reading' (duration: 402.263114ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:03.492215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:03.089359Z","time spent":"402.842705ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":31167,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-08-24T15:15:03.851473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.012136ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:03.851601Z","caller":"traceutil/trace.go:171","msg":"trace[144057632] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"291.548732ms","start":"2026-08-24T15:15:03.560031Z","end":"2026-08-24T15:15:03.85158Z","steps":["trace[144057632] 'read index received' (duration: 174.19397ms)","trace[144057632] 'applied index is now lower than readState.Index' (duration: 117.353052ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:03.85198Z","caller":"traceutil/trace.go:171","msg":"trace[1340153769] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"316.603695ms","start":"2026-08-24T15:15:03.535361Z","end":"2026-08-24T15:15:03.851965Z","steps":["trace[1340153769] 'process raft request' (duration: 198.973498ms)","trace[1340153769] 'compare' (duration: 116.837413ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:03.852068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:03.535336Z","time spent":"316.692367ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:03.852077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.475529ms","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-08-24T15:15:03.852158Z","caller":"traceutil/trace.go:171","msg":"trace[1601438737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"161.627913ms","start":"2026-08-24T15:15:03.690507Z","end":"2026-08-24T15:15:03.852135Z","steps":["trace[1601438737] 'agreement among raft nodes before linearized reading' (duration: 161.373939ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:03.85254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.3267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.147\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-24T15:15:03.852649Z","caller":"traceutil/trace.go:171","msg":"trace[527896979] range","detail":"{range_begin:/registry/masterleases/199.19.213.147; range_end:; response_count:1; response_revision:632; }","duration":"123.499544ms","start":"2026-08-24T15:15:03.729125Z","end":"2026-08-24T15:15:03.852624Z","steps":["trace[527896979] 'agreement among raft nodes before linearized reading' (duration: 123.245509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:03.852552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.858623ms","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-08-24T15:15:03.852915Z","caller":"traceutil/trace.go:171","msg":"trace[1433485418] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"112.225219ms","start":"2026-08-24T15:15:03.740658Z","end":"2026-08-24T15:15:03.852883Z","steps":["trace[1433485418] 'agreement among raft nodes before linearized reading' (duration: 111.755661ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:03.85222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.105162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31126"} {"level":"info","ts":"2026-08-24T15:15:03.85338Z","caller":"traceutil/trace.go:171","msg":"trace[806917428] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:632; }","duration":"293.362416ms","start":"2026-08-24T15:15:03.559992Z","end":"2026-08-24T15:15:03.853355Z","steps":["trace[806917428] 'agreement among raft nodes before linearized reading' (duration: 291.835968ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:04.340951Z","caller":"traceutil/trace.go:171","msg":"trace[1316764079] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:657; }","duration":"474.704434ms","start":"2026-08-24T15:15:03.866218Z","end":"2026-08-24T15:15:04.340922Z","steps":["trace[1316764079] 'read index received' (duration: 58.804893ms)","trace[1316764079] 'applied index is now lower than readState.Index' (duration: 415.898521ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:04.340992Z","caller":"traceutil/trace.go:171","msg":"trace[436586532] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"480.732453ms","start":"2026-08-24T15:15:03.860232Z","end":"2026-08-24T15:15:04.340964Z","steps":["trace[436586532] 'process raft request' (duration: 480.354547ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:04.34114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:03.860196Z","time spent":"480.857355ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:04.341233Z","caller":"traceutil/trace.go:171","msg":"trace[1411072163] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"480.991757ms","start":"2026-08-24T15:15:03.86019Z","end":"2026-08-24T15:15:04.341181Z","steps":["trace[1411072163] 'process raft request' (duration: 480.189122ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:04.341406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.181633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:23081"} {"level":"info","ts":"2026-08-24T15:15:04.341476Z","caller":"traceutil/trace.go:171","msg":"trace[1943079030] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:635; }","duration":"475.278404ms","start":"2026-08-24T15:15:03.866179Z","end":"2026-08-24T15:15:04.341458Z","steps":["trace[1943079030] 'agreement among raft nodes before linearized reading' (duration: 475.06102ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:04.341521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:03.866162Z","time spent":"475.349375ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":1,"response size":23103,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" "} {"level":"warn","ts":"2026-08-24T15:15:04.341515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:03.860159Z","time spent":"481.198961ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:04.341299Z","caller":"traceutil/trace.go:171","msg":"trace[1436523214] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"439.872354ms","start":"2026-08-24T15:15:03.901383Z","end":"2026-08-24T15:15:04.341256Z","steps":["trace[1436523214] 'process raft request' (duration: 439.309944ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:04.3423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:03.901361Z","time spent":"440.78404ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208470,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:04.580311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.199528ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:04.580431Z","caller":"traceutil/trace.go:171","msg":"trace[1788279910] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"239.382832ms","start":"2026-08-24T15:15:04.341032Z","end":"2026-08-24T15:15:04.580415Z","steps":["trace[1788279910] 'read index received' (duration: 79.900199ms)","trace[1788279910] 'applied index is now lower than readState.Index' (duration: 159.481533ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:04.580568Z","caller":"traceutil/trace.go:171","msg":"trace[769548957] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"654.468238ms","start":"2026-08-24T15:15:03.926073Z","end":"2026-08-24T15:15:04.580541Z","steps":["trace[769548957] 'process raft request' (duration: 494.950194ms)","trace[769548957] 'compare' (duration: 159.026295ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:04.58071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.025075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:29476"} {"level":"info","ts":"2026-08-24T15:15:04.580737Z","caller":"traceutil/trace.go:171","msg":"trace[684786742] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:636; }","duration":"229.081855ms","start":"2026-08-24T15:15:04.351646Z","end":"2026-08-24T15:15:04.580728Z","steps":["trace[684786742] 'agreement among raft nodes before linearized reading' (duration: 228.857791ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:04.580797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.303655ms","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-08-24T15:15:04.580889Z","caller":"traceutil/trace.go:171","msg":"trace[706658568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"382.492308ms","start":"2026-08-24T15:15:04.198378Z","end":"2026-08-24T15:15:04.58087Z","steps":["trace[706658568] 'agreement among raft nodes before linearized reading' (duration: 382.210253ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:04.580836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:03.926059Z","time spent":"654.5924ms","remote":"127.0.0.1:60804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:04.580943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:04.198347Z","time spent":"382.58665ms","remote":"127.0.0.1:32840","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-08-24T15:15:04.581244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.512046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:15:04.581291Z","caller":"traceutil/trace.go:171","msg":"trace[2075647949] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"389.599517ms","start":"2026-08-24T15:15:04.191679Z","end":"2026-08-24T15:15:04.581279Z","steps":["trace[2075647949] 'agreement among raft nodes before linearized reading' (duration: 388.829893ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:04.581319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:04.191656Z","time spent":"389.656879ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:15:04.825563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.096956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:98713"} {"level":"info","ts":"2026-08-24T15:15:04.825641Z","caller":"traceutil/trace.go:171","msg":"trace[770486374] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:637; }","duration":"143.195147ms","start":"2026-08-24T15:15:04.68243Z","end":"2026-08-24T15:15:04.825626Z","steps":["trace[770486374] 'range keys from in-memory index tree' (duration: 142.969853ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:06.519994Z","caller":"traceutil/trace.go:171","msg":"trace[439760179] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"174.23738ms","start":"2026-08-24T15:15:06.345725Z","end":"2026-08-24T15:15:06.519962Z","steps":["trace[439760179] 'read index received' (duration: 174.023396ms)","trace[439760179] 'applied index is now lower than readState.Index' (duration: 212.514µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:06.520089Z","caller":"traceutil/trace.go:171","msg":"trace[879356364] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"214.951224ms","start":"2026-08-24T15:15:06.305087Z","end":"2026-08-24T15:15:06.520038Z","steps":["trace[879356364] 'process raft request' (duration: 214.562496ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:06.520347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.577656ms","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-08-24T15:15:06.520446Z","caller":"traceutil/trace.go:171","msg":"trace[996496536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:639; }","duration":"174.73187ms","start":"2026-08-24T15:15:06.345686Z","end":"2026-08-24T15:15:06.520418Z","steps":["trace[996496536] 'agreement among raft nodes before linearized reading' (duration: 174.462255ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:06.520738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.361523ms","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-08-24T15:15:06.520791Z","caller":"traceutil/trace.go:171","msg":"trace[1840973348] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:639; }","duration":"174.868642ms","start":"2026-08-24T15:15:06.345905Z","end":"2026-08-24T15:15:06.520773Z","steps":["trace[1840973348] 'agreement among raft nodes before linearized reading' (duration: 174.244271ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:06.696596Z","caller":"traceutil/trace.go:171","msg":"trace[1879828333] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"170.671335ms","start":"2026-08-24T15:15:06.525871Z","end":"2026-08-24T15:15:06.696542Z","steps":["trace[1879828333] 'process raft request' (duration: 122.949234ms)","trace[1879828333] 'compare' (duration: 47.375904ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:06.696781Z","caller":"traceutil/trace.go:171","msg":"trace[1247257374] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"170.303538ms","start":"2026-08-24T15:15:06.526451Z","end":"2026-08-24T15:15:06.696754Z","steps":["trace[1247257374] 'process raft request' (duration: 169.971371ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:06.697263Z","caller":"traceutil/trace.go:171","msg":"trace[984213984] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"165.46194ms","start":"2026-08-24T15:15:06.531777Z","end":"2026-08-24T15:15:06.697239Z","steps":["trace[984213984] 'process raft request' (duration: 165.022392ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:06.697794Z","caller":"traceutil/trace.go:171","msg":"trace[1160979881] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"171.239255ms","start":"2026-08-24T15:15:06.526533Z","end":"2026-08-24T15:15:06.697772Z","steps":["trace[1160979881] 'process raft request' (duration: 170.160226ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:06.875872Z","caller":"traceutil/trace.go:171","msg":"trace[932300607] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"173.291623ms","start":"2026-08-24T15:15:06.702546Z","end":"2026-08-24T15:15:06.875838Z","steps":["trace[932300607] 'process raft request' (duration: 112.992242ms)","trace[932300607] 'compare' (duration: 60.136557ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:07.079853Z","caller":"traceutil/trace.go:171","msg":"trace[308531752] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"187.092838ms","start":"2026-08-24T15:15:06.892731Z","end":"2026-08-24T15:15:07.079824Z","steps":["trace[308531752] 'process raft request' (duration: 157.1312ms)","trace[308531752] 'compare' (duration: 29.219235ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:07.380188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.352505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:15:07.380255Z","caller":"traceutil/trace.go:171","msg":"trace[1372241884] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"190.491977ms","start":"2026-08-24T15:15:07.18975Z","end":"2026-08-24T15:15:07.380242Z","steps":["trace[1372241884] 'range keys from in-memory index tree' (duration: 190.224212ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:07.858431Z","caller":"traceutil/trace.go:171","msg":"trace[2115430985] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"191.377923ms","start":"2026-08-24T15:15:07.666998Z","end":"2026-08-24T15:15:07.858376Z","steps":["trace[2115430985] 'read index received' (duration: 190.441696ms)","trace[2115430985] 'applied index is now lower than readState.Index' (duration: 934.927µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:07.858508Z","caller":"traceutil/trace.go:171","msg":"trace[1241969277] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"313.161271ms","start":"2026-08-24T15:15:07.545293Z","end":"2026-08-24T15:15:07.858455Z","steps":["trace[1241969277] 'process raft request' (duration: 312.481139ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:07.858664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.642508ms","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-08-24T15:15:07.858714Z","caller":"traceutil/trace.go:171","msg":"trace[1489965596] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"191.77653ms","start":"2026-08-24T15:15:07.666923Z","end":"2026-08-24T15:15:07.8587Z","steps":["trace[1489965596] 'agreement among raft nodes before linearized reading' (duration: 191.589707ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:07.858917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:07.545245Z","time spent":"313.499528ms","remote":"127.0.0.1:60904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:08.283857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.982565ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:08.284053Z","caller":"traceutil/trace.go:171","msg":"trace[449316425] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"419.481864ms","start":"2026-08-24T15:15:07.864551Z","end":"2026-08-24T15:15:08.284033Z","steps":["trace[449316425] 'process raft request' (duration: 47.224664ms)","trace[449316425] 'compare' (duration: 371.800342ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:08.284129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:07.864528Z","time spent":"419.571197ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:08.284581Z","caller":"traceutil/trace.go:171","msg":"trace[453236832] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"373.673775ms","start":"2026-08-24T15:15:07.910854Z","end":"2026-08-24T15:15:08.284527Z","steps":["trace[453236832] 'process raft request' (duration: 373.141486ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:08.284952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:07.910824Z","time spent":"373.994522ms","remote":"127.0.0.1:32788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:15:08.655728Z","caller":"traceutil/trace.go:171","msg":"trace[10844085] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"135.219642ms","start":"2026-08-24T15:15:08.520476Z","end":"2026-08-24T15:15:08.655695Z","steps":["trace[10844085] 'process raft request' (duration: 78.886038ms)","trace[10844085] 'compare' (duration: 56.091589ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:08.987358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.463564ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:08.987503Z","caller":"traceutil/trace.go:171","msg":"trace[951927314] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"277.733939ms","start":"2026-08-24T15:15:08.709746Z","end":"2026-08-24T15:15:08.987479Z","steps":["trace[951927314] 'read index received' (duration: 152.845637ms)","trace[951927314] 'applied index is now lower than readState.Index' (duration: 124.886742ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:08.987616Z","caller":"traceutil/trace.go:171","msg":"trace[1970589026] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"294.719591ms","start":"2026-08-24T15:15:08.692883Z","end":"2026-08-24T15:15:08.987602Z","steps":["trace[1970589026] 'process raft request' (duration: 169.88434ms)","trace[1970589026] 'compare' (duration: 123.738881ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:08.987833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.049084ms","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-08-24T15:15:08.987893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.948453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-24T15:15:08.987898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.130796ms","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-08-24T15:15:08.987955Z","caller":"traceutil/trace.go:171","msg":"trace[898295056] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:650; }","duration":"278.060816ms","start":"2026-08-24T15:15:08.709876Z","end":"2026-08-24T15:15:08.987937Z","steps":["trace[898295056] 'agreement among raft nodes before linearized reading' (duration: 277.809661ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:08.987984Z","caller":"traceutil/trace.go:171","msg":"trace[2072901051] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:650; }","duration":"278.25442ms","start":"2026-08-24T15:15:08.709707Z","end":"2026-08-24T15:15:08.987961Z","steps":["trace[2072901051] 'agreement among raft nodes before linearized reading' (duration: 277.981974ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:08.987935Z","caller":"traceutil/trace.go:171","msg":"trace[58793807] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:650; }","duration":"108.206916ms","start":"2026-08-24T15:15:08.879708Z","end":"2026-08-24T15:15:08.987915Z","steps":["trace[58793807] 'agreement among raft nodes before linearized reading' (duration: 108.013402ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:09.265222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.747485ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:09.265364Z","caller":"traceutil/trace.go:171","msg":"trace[1909535840] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"273.001116ms","start":"2026-08-24T15:15:08.992339Z","end":"2026-08-24T15:15:09.26534Z","steps":["trace[1909535840] 'process raft request' (duration: 146.885925ms)","trace[1909535840] 'compare' (duration: 125.612441ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:09.283643Z","caller":"traceutil/trace.go:171","msg":"trace[1372618261] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"290.684482ms","start":"2026-08-24T15:15:08.992937Z","end":"2026-08-24T15:15:09.283621Z","steps":["trace[1372618261] 'process raft request' (duration: 290.559859ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:09.283705Z","caller":"traceutil/trace.go:171","msg":"trace[2027749585] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"290.851644ms","start":"2026-08-24T15:15:08.992813Z","end":"2026-08-24T15:15:09.283665Z","steps":["trace[2027749585] 'process raft request' (duration: 290.546919ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:09.283787Z","caller":"traceutil/trace.go:171","msg":"trace[1934711371] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"233.099951ms","start":"2026-08-24T15:15:09.050674Z","end":"2026-08-24T15:15:09.283774Z","steps":["trace[1934711371] 'process raft request' (duration: 232.866207ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:09.795466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.982432ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-24T15:15:09.815043Z","caller":"traceutil/trace.go:171","msg":"trace[418838537] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"142.152948ms","start":"2026-08-24T15:15:09.672772Z","end":"2026-08-24T15:15:09.814925Z","steps":["trace[418838537] 'process raft request' (duration: 137.017973ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:10.190299Z","caller":"traceutil/trace.go:171","msg":"trace[2111493813] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"209.11388ms","start":"2026-08-24T15:15:09.981149Z","end":"2026-08-24T15:15:10.190263Z","steps":["trace[2111493813] 'process raft request' (duration: 208.768014ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:10.518067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.065937ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:10.518189Z","caller":"traceutil/trace.go:171","msg":"trace[1054067539] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"226.393081ms","start":"2026-08-24T15:15:10.291776Z","end":"2026-08-24T15:15:10.518169Z","steps":["trace[1054067539] 'process raft request' (duration: 54.111909ms)","trace[1054067539] 'compare' (duration: 171.928495ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:10.705466Z","caller":"traceutil/trace.go:171","msg":"trace[523349313] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"348.907983ms","start":"2026-08-24T15:15:10.356522Z","end":"2026-08-24T15:15:10.70543Z","steps":["trace[523349313] 'process raft request' (duration: 281.941037ms)","trace[523349313] 'compare' (duration: 66.600739ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:10.705727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:10.356474Z","time spent":"349.078515ms","remote":"127.0.0.1:60904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:10.984031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.256943ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:10.984569Z","caller":"traceutil/trace.go:171","msg":"trace[1924961792] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"222.469518ms","start":"2026-08-24T15:15:10.761674Z","end":"2026-08-24T15:15:10.984144Z","steps":["trace[1924961792] 'process raft request' (duration: 116.98939ms)","trace[1924961792] 'compare' (duration: 105.07586ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:11.363538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.41548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:15:11.363633Z","caller":"traceutil/trace.go:171","msg":"trace[126748927] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:660; }","duration":"221.559143ms","start":"2026-08-24T15:15:11.14205Z","end":"2026-08-24T15:15:11.363609Z","steps":["trace[126748927] 'count revisions from in-memory index tree' (duration: 221.348379ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:11.36363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.420364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:15:11.363816Z","caller":"traceutil/trace.go:171","msg":"trace[1756301968] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:660; }","duration":"171.598338ms","start":"2026-08-24T15:15:11.192118Z","end":"2026-08-24T15:15:11.363717Z","steps":["trace[1756301968] 'range keys from in-memory index tree' (duration: 171.332013ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:11.657304Z","caller":"traceutil/trace.go:171","msg":"trace[604851003] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"288.918489ms","start":"2026-08-24T15:15:11.368358Z","end":"2026-08-24T15:15:11.657276Z","steps":["trace[604851003] 'process raft request' (duration: 288.865809ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:11.657383Z","caller":"traceutil/trace.go:171","msg":"trace[1038060168] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"289.063071ms","start":"2026-08-24T15:15:11.368265Z","end":"2026-08-24T15:15:11.657328Z","steps":["trace[1038060168] 'process raft request' (duration: 225.498205ms)","trace[1038060168] 'compare' (duration: 63.298062ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:11.748884Z","caller":"traceutil/trace.go:171","msg":"trace[678036180] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"330.150952ms","start":"2026-08-24T15:15:11.418712Z","end":"2026-08-24T15:15:11.748863Z","steps":["trace[678036180] 'process raft request' (duration: 329.576572ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:11.749039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:11.418672Z","time spent":"330.277615ms","remote":"127.0.0.1:60904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036269,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:12.184022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.854013ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:12.184224Z","caller":"traceutil/trace.go:171","msg":"trace[743092943] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:691; }","duration":"172.994391ms","start":"2026-08-24T15:15:12.011212Z","end":"2026-08-24T15:15:12.184206Z","steps":["trace[743092943] 'read index received' (duration: 6.896358ms)","trace[743092943] 'applied index is now lower than readState.Index' (duration: 166.097033ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:12.184276Z","caller":"traceutil/trace.go:171","msg":"trace[1284650321] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"285.227669ms","start":"2026-08-24T15:15:11.899016Z","end":"2026-08-24T15:15:12.184244Z","steps":["trace[1284650321] 'process raft request' (duration: 285.129237ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:12.184341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.132744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-24T15:15:12.184346Z","caller":"traceutil/trace.go:171","msg":"trace[899276285] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"375.275796ms","start":"2026-08-24T15:15:11.808963Z","end":"2026-08-24T15:15:12.184238Z","steps":["trace[899276285] 'process raft request' (duration: 124.124708ms)","trace[899276285] 'compare' (duration: 250.694889ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:12.1844Z","caller":"traceutil/trace.go:171","msg":"trace[551945619] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:666; }","duration":"173.214716ms","start":"2026-08-24T15:15:12.011149Z","end":"2026-08-24T15:15:12.184364Z","steps":["trace[551945619] 'agreement among raft nodes before linearized reading' (duration: 173.114193ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:12.184655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:11.80894Z","time spent":"375.570813ms","remote":"127.0.0.1:32926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:15:12.547562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.448307ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:12.547907Z","caller":"traceutil/trace.go:171","msg":"trace[1046040845] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"263.814707ms","start":"2026-08-24T15:15:12.284072Z","end":"2026-08-24T15:15:12.547887Z","steps":["trace[1046040845] 'process raft request' (duration: 263.749296ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:12.547921Z","caller":"traceutil/trace.go:171","msg":"trace[1036425223] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"282.455664ms","start":"2026-08-24T15:15:12.26542Z","end":"2026-08-24T15:15:12.547876Z","steps":["trace[1036425223] 'process raft request' (duration: 169.605239ms)","trace[1036425223] 'compare' (duration: 112.313695ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:12.547947Z","caller":"traceutil/trace.go:171","msg":"trace[1480220121] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"281.673228ms","start":"2026-08-24T15:15:12.266238Z","end":"2026-08-24T15:15:12.547912Z","steps":["trace[1480220121] 'process raft request' (duration: 281.505865ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:12.548158Z","caller":"traceutil/trace.go:171","msg":"trace[1364482175] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"281.850392ms","start":"2026-08-24T15:15:12.266296Z","end":"2026-08-24T15:15:12.548147Z","steps":["trace[1364482175] 'process raft request' (duration: 281.495665ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:12.579938Z","caller":"traceutil/trace.go:171","msg":"trace[203372779] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"120.754201ms","start":"2026-08-24T15:15:12.459171Z","end":"2026-08-24T15:15:12.579925Z","steps":["trace[203372779] 'process raft request' (duration: 120.70245ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:12.722457Z","caller":"traceutil/trace.go:171","msg":"trace[1092400125] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"169.973296ms","start":"2026-08-24T15:15:12.55242Z","end":"2026-08-24T15:15:12.722394Z","steps":["trace[1092400125] 'process raft request' (duration: 169.423985ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:12.722495Z","caller":"traceutil/trace.go:171","msg":"trace[1554845594] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"169.695661ms","start":"2026-08-24T15:15:12.552741Z","end":"2026-08-24T15:15:12.722437Z","steps":["trace[1554845594] 'process raft request' (duration: 169.427666ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:12.722645Z","caller":"traceutil/trace.go:171","msg":"trace[1928835914] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"169.351074ms","start":"2026-08-24T15:15:12.553252Z","end":"2026-08-24T15:15:12.722603Z","steps":["trace[1928835914] 'process raft request' (duration: 168.994328ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:12.723933Z","caller":"traceutil/trace.go:171","msg":"trace[1550226501] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"145.929719ms","start":"2026-08-24T15:15:12.577972Z","end":"2026-08-24T15:15:12.723901Z","steps":["trace[1550226501] 'process raft request' (duration: 144.90387ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:13.205837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.059003ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:13.206131Z","caller":"traceutil/trace.go:171","msg":"trace[1427275721] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"621.397196ms","start":"2026-08-24T15:15:12.584662Z","end":"2026-08-24T15:15:13.206059Z","steps":["trace[1427275721] 'process raft request' (duration: 378.980076ms)","trace[1427275721] 'compare' (duration: 241.85337ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:13.206237Z","caller":"traceutil/trace.go:171","msg":"trace[1921430638] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"475.272993ms","start":"2026-08-24T15:15:12.730952Z","end":"2026-08-24T15:15:13.206225Z","steps":["trace[1921430638] 'process raft request' (duration: 475.156311ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:13.20622Z","caller":"traceutil/trace.go:171","msg":"trace[14643036] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"477.186539ms","start":"2026-08-24T15:15:12.728998Z","end":"2026-08-24T15:15:13.206185Z","steps":["trace[14643036] 'process raft request' (duration: 477.056037ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:13.206387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:12.730931Z","time spent":"475.343284ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4318,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:13.206542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:12.728966Z","time spent":"477.356492ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5562,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:13.206611Z","caller":"traceutil/trace.go:171","msg":"trace[1792062922] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"425.270144ms","start":"2026-08-24T15:15:12.781306Z","end":"2026-08-24T15:15:13.206577Z","steps":["trace[1792062922] 'process raft request' (duration: 424.853947ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:13.206617Z","caller":"traceutil/trace.go:171","msg":"trace[547599728] linearizableReadLoop","detail":"{readStateIndex:709; appliedIndex:704; }","duration":"416.38763ms","start":"2026-08-24T15:15:12.790216Z","end":"2026-08-24T15:15:13.206604Z","steps":["trace[547599728] 'read index received' (duration: 173.393509ms)","trace[547599728] 'applied index is now lower than readState.Index' (duration: 242.993291ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:13.206656Z","caller":"traceutil/trace.go:171","msg":"trace[1453342435] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"347.472131ms","start":"2026-08-24T15:15:12.859149Z","end":"2026-08-24T15:15:13.206621Z","steps":["trace[1453342435] 'process raft request' (duration: 347.296288ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:13.206733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:12.781267Z","time spent":"425.416857ms","remote":"127.0.0.1:33078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:15:13.206604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:12.584647Z","time spent":"621.843355ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:13.206816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:12.859113Z","time spent":"347.627433ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:15:13.206851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.628115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-8749s\" ","response":"range_response_count:1 size:4683"} {"level":"info","ts":"2026-08-24T15:15:13.206896Z","caller":"traceutil/trace.go:171","msg":"trace[1263598311] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-8749s; range_end:; response_count:1; response_revision:683; }","duration":"416.703956ms","start":"2026-08-24T15:15:12.79018Z","end":"2026-08-24T15:15:13.206884Z","steps":["trace[1263598311] 'agreement among raft nodes before linearized reading' (duration: 416.508341ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:13.206911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.375121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:15:13.20693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:12.790169Z","time spent":"416.753967ms","remote":"127.0.0.1:60998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4705,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-8749s\" "} {"level":"info","ts":"2026-08-24T15:15:13.206161Z","caller":"traceutil/trace.go:171","msg":"trace[2072199264] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"547.258579ms","start":"2026-08-24T15:15:12.658879Z","end":"2026-08-24T15:15:13.206138Z","steps":["trace[2072199264] 'process raft request' (duration: 547.097736ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:13.20696Z","caller":"traceutil/trace.go:171","msg":"trace[1036988584] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:683; }","duration":"149.477883ms","start":"2026-08-24T15:15:13.057467Z","end":"2026-08-24T15:15:13.206945Z","steps":["trace[1036988584] 'agreement among raft nodes before linearized reading' (duration: 149.395312ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:13.206984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:12.658861Z","time spent":"548.097946ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:15:13.72709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.60612ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:15:13.7274Z","caller":"traceutil/trace.go:171","msg":"trace[1417780268] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"512.117582ms","start":"2026-08-24T15:15:13.21526Z","end":"2026-08-24T15:15:13.727378Z","steps":["trace[1417780268] 'process raft request' (duration: 142.113225ms)","trace[1417780268] 'compare' (duration: 369.496787ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:13.727507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:13.215243Z","time spent":"512.209733ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5153,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:13.72763Z","caller":"traceutil/trace.go:171","msg":"trace[992002089] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"511.321157ms","start":"2026-08-24T15:15:13.216284Z","end":"2026-08-24T15:15:13.727605Z","steps":["trace[992002089] 'process raft request' (duration: 510.94057ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:13.727826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:13.21626Z","time spent":"511.44305ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5571,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:13.728053Z","caller":"traceutil/trace.go:171","msg":"trace[614023610] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"466.736649ms","start":"2026-08-24T15:15:13.261301Z","end":"2026-08-24T15:15:13.728038Z","steps":["trace[614023610] 'process raft request' (duration: 466.550885ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:13.728074Z","caller":"traceutil/trace.go:171","msg":"trace[1592165104] linearizableReadLoop","detail":"{readStateIndex:713; appliedIndex:710; }","duration":"509.751588ms","start":"2026-08-24T15:15:13.218302Z","end":"2026-08-24T15:15:13.728053Z","steps":["trace[1592165104] 'read index received' (duration: 139.19415ms)","trace[1592165104] 'applied index is now lower than readState.Index' (duration: 370.555568ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:13.72814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:13.261269Z","time spent":"466.83852ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:15:13.728395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.07093ms","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-08-24T15:15:13.728364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.014503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:15:13.728429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.508246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:15:13.728439Z","caller":"traceutil/trace.go:171","msg":"trace[1895630970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:688; }","duration":"347.147792ms","start":"2026-08-24T15:15:13.38128Z","end":"2026-08-24T15:15:13.728428Z","steps":["trace[1895630970] 'agreement among raft nodes before linearized reading' (duration: 346.918518ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:13.728474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:13.381264Z","time spent":"347.202703ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-24T15:15:13.728485Z","caller":"traceutil/trace.go:171","msg":"trace[311692971] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:688; }","duration":"270.569136ms","start":"2026-08-24T15:15:13.457879Z","end":"2026-08-24T15:15:13.728448Z","steps":["trace[311692971] 'agreement among raft nodes before linearized reading' (duration: 270.525415ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:13.728473Z","caller":"traceutil/trace.go:171","msg":"trace[940144559] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:688; }","duration":"510.155915ms","start":"2026-08-24T15:15:13.218291Z","end":"2026-08-24T15:15:13.728447Z","steps":["trace[940144559] 'agreement among raft nodes before linearized reading' (duration: 509.84952ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:13.728537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:13.218242Z","time spent":"510.284548ms","remote":"127.0.0.1:32816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-08-24T15:15:13.728065Z","caller":"traceutil/trace.go:171","msg":"trace[2037920124] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"273.026783ms","start":"2026-08-24T15:15:13.455022Z","end":"2026-08-24T15:15:13.728049Z","steps":["trace[2037920124] 'process raft request' (duration: 272.964252ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:13.729041Z","caller":"traceutil/trace.go:171","msg":"trace[1866099211] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"511.938759ms","start":"2026-08-24T15:15:13.217088Z","end":"2026-08-24T15:15:13.729027Z","steps":["trace[1866099211] 'process raft request' (duration: 510.627344ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:13.729191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:13.21708Z","time spent":"512.051012ms","remote":"127.0.0.1:60998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4873,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:13.729521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.822213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:15:13.729586Z","caller":"traceutil/trace.go:171","msg":"trace[1461067395] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:688; }","duration":"234.878492ms","start":"2026-08-24T15:15:13.494681Z","end":"2026-08-24T15:15:13.72956Z","steps":["trace[1461067395] 'agreement among raft nodes before linearized reading' (duration: 233.716661ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:14.013045Z","caller":"traceutil/trace.go:171","msg":"trace[1621206307] linearizableReadLoop","detail":"{readStateIndex:727; appliedIndex:725; }","duration":"156.034554ms","start":"2026-08-24T15:15:13.856988Z","end":"2026-08-24T15:15:14.013022Z","steps":["trace[1621206307] 'read index received' (duration: 49.211855ms)","trace[1621206307] 'applied index is now lower than readState.Index' (duration: 106.821649ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:14.01307Z","caller":"traceutil/trace.go:171","msg":"trace[844489519] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"156.171347ms","start":"2026-08-24T15:15:13.856873Z","end":"2026-08-24T15:15:14.013044Z","steps":["trace[844489519] 'process raft request' (duration: 155.532915ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:14.013466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.457002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:15:14.013522Z","caller":"traceutil/trace.go:171","msg":"trace[1664620920] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:700; }","duration":"156.544694ms","start":"2026-08-24T15:15:13.856962Z","end":"2026-08-24T15:15:14.013506Z","steps":["trace[1664620920] 'agreement among raft nodes before linearized reading' (duration: 156.455392ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:14.013625Z","caller":"traceutil/trace.go:171","msg":"trace[881748519] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"155.996565ms","start":"2026-08-24T15:15:13.857618Z","end":"2026-08-24T15:15:14.013615Z","steps":["trace[881748519] 'process raft request' (duration: 155.353362ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:14.013839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.648556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-08-24T15:15:14.013949Z","caller":"traceutil/trace.go:171","msg":"trace[120870474] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:700; }","duration":"156.799699ms","start":"2026-08-24T15:15:13.857134Z","end":"2026-08-24T15:15:14.013933Z","steps":["trace[120870474] 'agreement among raft nodes before linearized reading' (duration: 156.605495ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:14.173073Z","caller":"traceutil/trace.go:171","msg":"trace[1131157570] linearizableReadLoop","detail":"{readStateIndex:731; appliedIndex:728; }","duration":"115.776531ms","start":"2026-08-24T15:15:14.057273Z","end":"2026-08-24T15:15:14.17305Z","steps":["trace[1131157570] 'read index received' (duration: 43.675046ms)","trace[1131157570] 'applied index is now lower than readState.Index' (duration: 72.100465ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:14.173407Z","caller":"traceutil/trace.go:171","msg":"trace[1117788306] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"148.337288ms","start":"2026-08-24T15:15:14.025017Z","end":"2026-08-24T15:15:14.173355Z","steps":["trace[1117788306] 'process raft request' (duration: 147.834078ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:14.173517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.21676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-08-24T15:15:14.173619Z","caller":"traceutil/trace.go:171","msg":"trace[1265532675] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:703; }","duration":"116.333772ms","start":"2026-08-24T15:15:14.057266Z","end":"2026-08-24T15:15:14.1736Z","steps":["trace[1265532675] 'agreement among raft nodes before linearized reading' (duration: 115.942894ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:14.17363Z","caller":"traceutil/trace.go:171","msg":"trace[1600871936] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"148.544712ms","start":"2026-08-24T15:15:14.025064Z","end":"2026-08-24T15:15:14.173609Z","steps":["trace[1600871936] 'process raft request' (duration: 147.918859ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:14.23652Z","caller":"traceutil/trace.go:171","msg":"trace[331039800] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"118.785466ms","start":"2026-08-24T15:15:14.117709Z","end":"2026-08-24T15:15:14.236495Z","steps":["trace[331039800] 'process raft request' (duration: 118.183815ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:14.34054Z","caller":"traceutil/trace.go:171","msg":"trace[648386539] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"137.955654ms","start":"2026-08-24T15:15:14.202556Z","end":"2026-08-24T15:15:14.340512Z","steps":["trace[648386539] 'process raft request' (duration: 124.892071ms)","trace[648386539] 'compare' (duration: 12.865029ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:14.413376Z","caller":"traceutil/trace.go:171","msg":"trace[888164037] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"106.07222ms","start":"2026-08-24T15:15:14.307265Z","end":"2026-08-24T15:15:14.413337Z","steps":["trace[888164037] 'process raft request' (duration: 105.753135ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:14.635765Z","caller":"traceutil/trace.go:171","msg":"trace[956323988] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"121.353845ms","start":"2026-08-24T15:15:14.514388Z","end":"2026-08-24T15:15:14.635742Z","steps":["trace[956323988] 'process raft request' (duration: 121.308985ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:14.635866Z","caller":"traceutil/trace.go:171","msg":"trace[597424789] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"121.516138ms","start":"2026-08-24T15:15:14.514314Z","end":"2026-08-24T15:15:14.63583Z","steps":["trace[597424789] 'process raft request' (duration: 120.855075ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:14.970136Z","caller":"traceutil/trace.go:171","msg":"trace[86654825] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"110.125145ms","start":"2026-08-24T15:15:14.859979Z","end":"2026-08-24T15:15:14.970104Z","steps":["trace[86654825] 'process raft request' (duration: 109.992303ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:16.014236Z","caller":"traceutil/trace.go:171","msg":"trace[1242406567] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"435.814736ms","start":"2026-08-24T15:15:15.578398Z","end":"2026-08-24T15:15:16.014213Z","steps":["trace[1242406567] 'process raft request' (duration: 432.458162ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:16.01443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:15.578368Z","time spent":"435.939728ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:16.019919Z","caller":"traceutil/trace.go:171","msg":"trace[2048476290] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"335.159232ms","start":"2026-08-24T15:15:15.684744Z","end":"2026-08-24T15:15:16.019903Z","steps":["trace[2048476290] 'process raft request' (duration: 334.742035ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:16.019998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:15.684708Z","time spent":"335.249654ms","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:15:16.020333Z","caller":"traceutil/trace.go:171","msg":"trace[241870647] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:747; }","duration":"227.924166ms","start":"2026-08-24T15:15:15.792372Z","end":"2026-08-24T15:15:16.020296Z","steps":["trace[241870647] 'read index received' (duration: 218.57199ms)","trace[241870647] 'applied index is now lower than readState.Index' (duration: 9.350756ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:16.020408Z","caller":"traceutil/trace.go:171","msg":"trace[1637399929] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"134.959686ms","start":"2026-08-24T15:15:15.885411Z","end":"2026-08-24T15:15:16.02037Z","steps":["trace[1637399929] 'process raft request' (duration: 134.532478ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:16.020558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.175701ms","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-08-24T15:15:16.020605Z","caller":"traceutil/trace.go:171","msg":"trace[626638154] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:721; }","duration":"228.281053ms","start":"2026-08-24T15:15:15.792313Z","end":"2026-08-24T15:15:16.020594Z","steps":["trace[626638154] 'agreement among raft nodes before linearized reading' (duration: 228.162321ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:16.021028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.450344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-24T15:15:16.021058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.77292ms","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-08-24T15:15:16.021084Z","caller":"traceutil/trace.go:171","msg":"trace[717098023] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:721; }","duration":"205.812152ms","start":"2026-08-24T15:15:15.815265Z","end":"2026-08-24T15:15:16.021077Z","steps":["trace[717098023] 'agreement among raft nodes before linearized reading' (duration: 205.70931ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:16.021161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.945994ms","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-08-24T15:15:16.021171Z","caller":"traceutil/trace.go:171","msg":"trace[1920292471] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:721; }","duration":"206.602017ms","start":"2026-08-24T15:15:15.81447Z","end":"2026-08-24T15:15:16.021072Z","steps":["trace[1920292471] 'agreement among raft nodes before linearized reading' (duration: 206.100277ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:16.021205Z","caller":"traceutil/trace.go:171","msg":"trace[525415447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:721; }","duration":"206.028645ms","start":"2026-08-24T15:15:15.815164Z","end":"2026-08-24T15:15:16.021193Z","steps":["trace[525415447] 'agreement among raft nodes before linearized reading' (duration: 205.822641ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:22.013868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.840818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-82zdv\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-24T15:15:22.014016Z","caller":"traceutil/trace.go:171","msg":"trace[2070045533] range","detail":"{range_begin:/registry/pods/kube-system/cilium-82zdv; range_end:; response_count:1; response_revision:746; }","duration":"196.049572ms","start":"2026-08-24T15:15:21.817945Z","end":"2026-08-24T15:15:22.013995Z","steps":["trace[2070045533] 'range keys from in-memory index tree' (duration: 195.627324ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:22.146486Z","caller":"traceutil/trace.go:171","msg":"trace[138037376] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"117.442894ms","start":"2026-08-24T15:15:22.029004Z","end":"2026-08-24T15:15:22.146447Z","steps":["trace[138037376] 'process raft request' (duration: 116.613968ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:22.903266Z","caller":"traceutil/trace.go:171","msg":"trace[931222253] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"432.402747ms","start":"2026-08-24T15:15:22.470842Z","end":"2026-08-24T15:15:22.903245Z","steps":["trace[931222253] 'process raft request' (duration: 432.272925ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:22.90357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:22.470824Z","time spent":"432.510839ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:39.194288Z","caller":"traceutil/trace.go:171","msg":"trace[478639751] linearizableReadLoop","detail":"{readStateIndex:895; appliedIndex:894; }","duration":"204.01534ms","start":"2026-08-24T15:15:38.990251Z","end":"2026-08-24T15:15:39.194267Z","steps":["trace[478639751] 'read index received' (duration: 203.900908ms)","trace[478639751] 'applied index is now lower than readState.Index' (duration: 113.292µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:39.194373Z","caller":"traceutil/trace.go:171","msg":"trace[1753071904] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"265.089558ms","start":"2026-08-24T15:15:38.92924Z","end":"2026-08-24T15:15:39.194329Z","steps":["trace[1753071904] 'process raft request' (duration: 264.888085ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:39.194655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.275496ms","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-08-24T15:15:39.194716Z","caller":"traceutil/trace.go:171","msg":"trace[1213912766] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:860; }","duration":"204.498049ms","start":"2026-08-24T15:15:38.990194Z","end":"2026-08-24T15:15:39.194692Z","steps":["trace[1213912766] 'agreement among raft nodes before linearized reading' (duration: 204.195674ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:39.200813Z","caller":"traceutil/trace.go:171","msg":"trace[894442658] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"202.350829ms","start":"2026-08-24T15:15:38.99844Z","end":"2026-08-24T15:15:39.200791Z","steps":["trace[894442658] 'process raft request' (duration: 202.066963ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:17:02.348519Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2481378066346535413,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:17:02.84895Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2481378066346535413,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:17:03.349909Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2481378066346535413,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:17:03.85086Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2481378066346535413,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:17:04.085135Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.398664801s","expected-duration":"1s"} {"level":"info","ts":"2026-08-24T15:17:04.085495Z","caller":"traceutil/trace.go:171","msg":"trace[1863143828] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"2.399120801s","start":"2026-08-24T15:17:01.686347Z","end":"2026-08-24T15:17:04.085468Z","steps":["trace[1863143828] 'process raft request' (duration: 2.398985568s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:17:04.085658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:01.686326Z","time spent":"2.399233973s","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:17:04.104471Z","caller":"traceutil/trace.go:171","msg":"trace[555214622] linearizableReadLoop","detail":"{readStateIndex:1325; appliedIndex:1323; }","duration":"2.256765338s","start":"2026-08-24T15:17:01.847676Z","end":"2026-08-24T15:17:04.104442Z","steps":["trace[555214622] 'read index received' (duration: 2.237723626s)","trace[555214622] 'applied index is now lower than readState.Index' (duration: 19.040572ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:17:04.104546Z","caller":"traceutil/trace.go:171","msg":"trace[1818281359] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"1.693798974s","start":"2026-08-24T15:17:02.410713Z","end":"2026-08-24T15:17:04.104512Z","steps":["trace[1818281359] 'process raft request' (duration: 1.693578978s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:17:04.104841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:02.410681Z","time spent":"1.693994628s","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:17:04.135335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.067539679s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:17:04.135379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.447744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:17:04.135449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.204931763s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:17:04.135482Z","caller":"traceutil/trace.go:171","msg":"trace[729761955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1272; }","duration":"641.605977ms","start":"2026-08-24T15:17:03.493849Z","end":"2026-08-24T15:17:04.135455Z","steps":["trace[729761955] 'agreement among raft nodes before linearized reading' (duration: 610.792595ms)","trace[729761955] 'range keys from in-memory index tree' (duration: 30.68052ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:17:04.135503Z","caller":"traceutil/trace.go:171","msg":"trace[1523376185] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1272; }","duration":"2.205084877s","start":"2026-08-24T15:17:01.930401Z","end":"2026-08-24T15:17:04.135485Z","steps":["trace[1523376185] 'agreement among raft nodes before linearized reading' (duration: 2.174191943s)","trace[1523376185] 'count revisions from in-memory index tree' (duration: 30.811803ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:17:04.135527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:03.493833Z","time spent":"641.68618ms","remote":"127.0.0.1:60786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:17:04.135542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:01.930389Z","time spent":"2.205143588s","remote":"127.0.0.1:43876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:17:04.135553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.380332819s","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-08-24T15:17:04.135403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.943954699s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:17:04.136078Z","caller":"traceutil/trace.go:171","msg":"trace[1820510519] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1272; }","duration":"1.944663164s","start":"2026-08-24T15:17:02.1914Z","end":"2026-08-24T15:17:04.136063Z","steps":["trace[1820510519] 'agreement among raft nodes before linearized reading' (duration: 1.913266349s)","trace[1820510519] 'range keys from in-memory index tree' (duration: 30.704981ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:17:04.136077Z","caller":"traceutil/trace.go:171","msg":"trace[529317516] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1272; }","duration":"1.38084785s","start":"2026-08-24T15:17:02.755203Z","end":"2026-08-24T15:17:04.13605Z","steps":["trace[529317516] 'agreement among raft nodes before linearized reading' (duration: 1.349447255s)","trace[529317516] 'range keys from in-memory index tree' (duration: 30.775892ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:17:04.136114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:02.191379Z","time spent":"1.944723866s","remote":"127.0.0.1:60786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:17:04.135555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.380713868s","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-08-24T15:17:04.136237Z","caller":"traceutil/trace.go:171","msg":"trace[583845607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1272; }","duration":"1.381457713s","start":"2026-08-24T15:17:02.754767Z","end":"2026-08-24T15:17:04.136225Z","steps":["trace[583845607] 'agreement among raft nodes before linearized reading' (duration: 1.349883894s)","trace[583845607] 'range keys from in-memory index tree' (duration: 30.753212ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:17:04.136268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:02.754751Z","time spent":"1.381509044s","remote":"127.0.0.1:32840","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-08-24T15:17:04.136268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:02.755197Z","time spent":"1.380914651s","remote":"127.0.0.1:32840","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-08-24T15:17:04.135646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.246101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:17:04.135774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.515143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:17:04.13643Z","caller":"traceutil/trace.go:171","msg":"trace[1175355981] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1272; }","duration":"906.072878ms","start":"2026-08-24T15:17:03.230339Z","end":"2026-08-24T15:17:04.136411Z","steps":["trace[1175355981] 'agreement among raft nodes before linearized reading' (duration: 874.338446ms)","trace[1175355981] 'count revisions from in-memory index tree' (duration: 30.945386ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:17:04.136668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:03.230314Z","time spent":"906.335374ms","remote":"127.0.0.1:45306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-08-24T15:17:04.136576Z","caller":"traceutil/trace.go:171","msg":"trace[1396976990] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1272; }","duration":"112.311619ms","start":"2026-08-24T15:17:04.024212Z","end":"2026-08-24T15:17:04.136524Z","steps":["trace[1396976990] 'agreement among raft nodes before linearized reading' (duration: 80.405233ms)","trace[1396976990] 'count revisions from in-memory index tree' (duration: 31.12359ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:17:04.13589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.424856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.147\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-24T15:17:04.137075Z","caller":"traceutil/trace.go:171","msg":"trace[794987985] range","detail":"{range_begin:/registry/masterleases/199.19.213.147; range_end:; response_count:1; response_revision:1272; }","duration":"397.619442ms","start":"2026-08-24T15:17:03.739427Z","end":"2026-08-24T15:17:04.137046Z","steps":["trace[794987985] 'agreement among raft nodes before linearized reading' (duration: 365.206085ms)","trace[794987985] 'range keys from in-memory index tree' (duration: 31.16241ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:17:04.13712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:03.73941Z","time spent":"397.694643ms","remote":"127.0.0.1:60804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.147\" "} {"level":"warn","ts":"2026-08-24T15:17:04.135898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.409084178s","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-08-24T15:17:04.137259Z","caller":"traceutil/trace.go:171","msg":"trace[1896480551] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1272; }","duration":"1.410472217s","start":"2026-08-24T15:17:02.726773Z","end":"2026-08-24T15:17:04.137245Z","steps":["trace[1896480551] 'agreement among raft nodes before linearized reading' (duration: 1.377886787s)","trace[1896480551] 'range keys from in-memory index tree' (duration: 31.17304ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:17:04.137301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:02.726755Z","time spent":"1.410534298s","remote":"127.0.0.1:32840","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-08-24T15:17:04.135926Z","caller":"traceutil/trace.go:171","msg":"trace[1151620639] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1272; }","duration":"1.067657891s","start":"2026-08-24T15:17:03.067724Z","end":"2026-08-24T15:17:04.135382Z","steps":["trace[1151620639] 'agreement among raft nodes before linearized reading' (duration: 1.03695587s)","trace[1151620639] 'count revisions from in-memory index tree' (duration: 30.616728ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:17:04.137439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:03.0677Z","time spent":"1.069727674s","remote":"127.0.0.1:45162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:17:04.135828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.288127844s","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-08-24T15:17:04.137607Z","caller":"traceutil/trace.go:171","msg":"trace[1407722041] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1272; }","duration":"2.289950511s","start":"2026-08-24T15:17:01.847642Z","end":"2026-08-24T15:17:04.137593Z","steps":["trace[1407722041] 'agreement among raft nodes before linearized reading' (duration: 2.256907692s)","trace[1407722041] 'range keys from in-memory index tree' (duration: 31.105469ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:17:04.137667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:01.847625Z","time spent":"2.290032643s","remote":"127.0.0.1:32840","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-08-24T15:17:04.675361Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2481378066346535418,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-24T15:17:04.805949Z","caller":"traceutil/trace.go:171","msg":"trace[289691642] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"663.67706ms","start":"2026-08-24T15:17:04.142245Z","end":"2026-08-24T15:17:04.805922Z","steps":["trace[289691642] 'process raft request' (duration: 663.485126ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:17:04.80619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:04.14224Z","time spent":"663.828813ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:17:04.806195Z","caller":"traceutil/trace.go:171","msg":"trace[1355458562] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"663.726691ms","start":"2026-08-24T15:17:04.142437Z","end":"2026-08-24T15:17:04.806164Z","steps":["trace[1355458562] 'process raft request' (duration: 663.403364ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:17:04.806323Z","caller":"traceutil/trace.go:171","msg":"trace[1020055765] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"663.736391ms","start":"2026-08-24T15:17:04.142578Z","end":"2026-08-24T15:17:04.806314Z","steps":["trace[1020055765] 'process raft request' (duration: 663.505406ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:17:04.806433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:04.142388Z","time spent":"663.936045ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:17:04.806479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:04.142569Z","time spent":"663.799872ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:17:04.806608Z","caller":"traceutil/trace.go:171","msg":"trace[1567402874] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"664.561099ms","start":"2026-08-24T15:17:04.141973Z","end":"2026-08-24T15:17:04.806534Z","steps":["trace[1567402874] 'process raft request' (duration: 661.498254ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:17:04.806939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:04.141953Z","time spent":"664.831074ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:17:04.807279Z","caller":"traceutil/trace.go:171","msg":"trace[2069353825] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1326; }","duration":"632.465858ms","start":"2026-08-24T15:17:04.174795Z","end":"2026-08-24T15:17:04.807261Z","steps":["trace[2069353825] 'read index received' (duration: 628.662907ms)","trace[2069353825] 'applied index is now lower than readState.Index' (duration: 3.801651ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:17:04.807379Z","caller":"traceutil/trace.go:171","msg":"trace[269872935] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"655.619459ms","start":"2026-08-24T15:17:04.151749Z","end":"2026-08-24T15:17:04.807368Z","steps":["trace[269872935] 'process raft request' (duration: 655.403174ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:17:04.807518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:04.151724Z","time spent":"655.740642ms","remote":"127.0.0.1:60804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:17:04.807798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.333722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:17:04.807888Z","caller":"traceutil/trace.go:171","msg":"trace[1501779566] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1277; }","duration":"155.476755ms","start":"2026-08-24T15:17:04.652398Z","end":"2026-08-24T15:17:04.807875Z","steps":["trace[1501779566] 'agreement among raft nodes before linearized reading' (duration: 155.293751ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:17:04.807799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.002691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:17:04.808185Z","caller":"traceutil/trace.go:171","msg":"trace[987615959] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1277; }","duration":"633.427239ms","start":"2026-08-24T15:17:04.17474Z","end":"2026-08-24T15:17:04.808167Z","steps":["trace[987615959] 'agreement among raft nodes before linearized reading' (duration: 633.00618ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:17:04.808955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:04.174725Z","time spent":"634.204416ms","remote":"127.0.0.1:32930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "}