{"level":"warn","ts":"2026-04-27T20:58:23.975589Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T20:58:23.975701Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-27T20:58:23.975788Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T20:58:23.975803Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-04-27T20:58:23.975822Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T20:58:23.976531Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-04-27T20:58:23.979966Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-27T20:58:23.987038Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.778286ms"} {"level":"info","ts":"2026-04-27T20:58:24.003665Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-04-27T20:58:24.003794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T20:58:24.003826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-04-27T20:58:24.003837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T20:58:24.003847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-04-27T20:58:24.003895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-04-27T20:58:24.017903Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T20:58:24.01927Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T20:58:24.020419Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-27T20:58:24.0225Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T20:58:24.022876Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T20:58:24.022986Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T20:58:24.022997Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T20:58:24.023356Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T20:58:24.024034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-04-27T20:58:24.024369Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-04-27T20:58:24.028644Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T20:58:24.028925Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-04-27T20:58:24.028952Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-04-27T20:58:24.029231Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T20:58:24.029266Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T20:58:24.204848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T20:58:24.204935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T20:58:24.205044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-04-27T20:58:24.205083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-04-27T20:58:24.205131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-04-27T20:58:24.205152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-04-27T20:58:24.205205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-04-27T20:58:24.206358Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T20:58:24.207037Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T20:58:24.207315Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T20:58:24.207366Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T20:58:24.207516Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T20:58:24.207782Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T20:58:24.207881Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T20:58:24.207356Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T20:58:24.207972Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T20:58:24.210804Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-04-27T20:58:24.21131Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T20:58:29.97502Z","caller":"traceutil/trace.go:171","msg":"trace[1902014451] linearizableReadLoop","detail":"{readStateIndex:292; appliedIndex:291; }","duration":"103.953455ms","start":"2026-04-27T20:58:29.871038Z","end":"2026-04-27T20:58:29.974991Z","steps":["trace[1902014451] 'read index received' (duration: 103.761641ms)","trace[1902014451] 'applied index is now lower than readState.Index' (duration: 190.204µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T20:58:29.975103Z","caller":"traceutil/trace.go:171","msg":"trace[174321426] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"106.410486ms","start":"2026-04-27T20:58:29.868649Z","end":"2026-04-27T20:58:29.97506Z","steps":["trace[174321426] 'process raft request' (duration: 106.16821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:29.975285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.174921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:58:29.975388Z","caller":"traceutil/trace.go:171","msg":"trace[378402930] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:282; }","duration":"104.364045ms","start":"2026-04-27T20:58:29.871002Z","end":"2026-04-27T20:58:29.975366Z","steps":["trace[378402930] 'agreement among raft nodes before linearized reading' (duration: 104.14198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:30.583427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.074183ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T20:58:30.58375Z","caller":"traceutil/trace.go:171","msg":"trace[1186047979] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"603.559942ms","start":"2026-04-27T20:58:29.98014Z","end":"2026-04-27T20:58:30.5837Z","steps":["trace[1186047979] 'process raft request' (duration: 603.384098ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:30.58394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.266162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:58:30.584001Z","caller":"traceutil/trace.go:171","msg":"trace[462693526] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:285; }","duration":"436.365184ms","start":"2026-04-27T20:58:30.147619Z","end":"2026-04-27T20:58:30.583984Z","steps":["trace[462693526] 'agreement among raft nodes before linearized reading' (duration: 436.2192ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:30.583989Z","caller":"traceutil/trace.go:171","msg":"trace[528798918] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"603.779059ms","start":"2026-04-27T20:58:29.980163Z","end":"2026-04-27T20:58:30.583942Z","steps":["trace[528798918] 'process raft request' (duration: 603.410929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:30.584069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:30.147595Z","time spent":"436.461416ms","remote":"127.0.0.1:54896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T20:58:30.58397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:29.98013Z","time spent":"603.755157ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T20:58:30.584151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:29.980153Z","time spent":"603.920462ms","remote":"127.0.0.1:55228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T20:58:30.583634Z","caller":"traceutil/trace.go:171","msg":"trace[1827302840] linearizableReadLoop","detail":"{readStateIndex:295; appliedIndex:292; }","duration":"435.962854ms","start":"2026-04-27T20:58:30.147652Z","end":"2026-04-27T20:58:30.583615Z","steps":["trace[1827302840] 'read index received' (duration: 59.365688ms)","trace[1827302840] 'applied index is now lower than readState.Index' (duration: 376.595806ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T20:58:30.584276Z","caller":"traceutil/trace.go:171","msg":"trace[312999159] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"604.334591ms","start":"2026-04-27T20:58:29.979839Z","end":"2026-04-27T20:58:30.584174Z","steps":["trace[312999159] 'process raft request' (duration: 227.061538ms)","trace[312999159] 'compare' (duration: 375.877449ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T20:58:30.584541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:29.979826Z","time spent":"604.601058ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T20:58:30.956665Z","caller":"traceutil/trace.go:171","msg":"trace[1867579671] transaction","detail":"{read_only:false; number_of_response:0; response_revision:285; }","duration":"406.611719ms","start":"2026-04-27T20:58:30.550025Z","end":"2026-04-27T20:58:30.956637Z","steps":["trace[1867579671] 'process raft request' (duration: 338.424975ms)","trace[1867579671] 'compare' (duration: 68.129053ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T20:58:30.956812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:30.55001Z","time spent":"406.742572ms","remote":"127.0.0.1:55060","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T20:58:31.43399Z","caller":"traceutil/trace.go:171","msg":"trace[62495123] transaction","detail":"{read_only:false; number_of_response:0; response_revision:285; }","duration":"883.262195ms","start":"2026-04-27T20:58:30.550691Z","end":"2026-04-27T20:58:31.433954Z","steps":["trace[62495123] 'process raft request' (duration: 882.935117ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:31.434027Z","caller":"traceutil/trace.go:171","msg":"trace[2036057954] linearizableReadLoop","detail":"{readStateIndex:297; appliedIndex:295; }","duration":"849.633334ms","start":"2026-04-27T20:58:30.584359Z","end":"2026-04-27T20:58:31.433992Z","steps":["trace[2036057954] 'read index received' (duration: 304.176228ms)","trace[2036057954] 'applied index is now lower than readState.Index' (duration: 545.456056ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T20:58:31.43408Z","caller":"traceutil/trace.go:171","msg":"trace[1056567550] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"844.374296ms","start":"2026-04-27T20:58:30.589643Z","end":"2026-04-27T20:58:31.434018Z","steps":["trace[1056567550] 'process raft request' (duration: 844.168891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:31.434145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:30.550663Z","time spent":"883.412568ms","remote":"127.0.0.1:55060","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T20:58:31.434235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.478369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T20:58:31.434244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:30.589622Z","time spent":"844.54663ms","remote":"127.0.0.1:55192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":302,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T20:58:31.434276Z","caller":"traceutil/trace.go:171","msg":"trace[117167514] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:287; }","duration":"958.586702ms","start":"2026-04-27T20:58:30.475677Z","end":"2026-04-27T20:58:31.434264Z","steps":["trace[117167514] 'agreement among raft nodes before linearized reading' (duration: 958.48584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:31.434274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.335859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"warn","ts":"2026-04-27T20:58:31.434322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:30.475658Z","time spent":"958.654993ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-27T20:58:31.43436Z","caller":"traceutil/trace.go:171","msg":"trace[1977627324] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:287; }","duration":"886.479703ms","start":"2026-04-27T20:58:30.547858Z","end":"2026-04-27T20:58:31.434338Z","steps":["trace[1977627324] 'agreement among raft nodes before linearized reading' (duration: 886.230707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:31.434414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:30.547836Z","time spent":"886.568675ms","remote":"127.0.0.1:55060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4003,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-04-27T20:58:31.434488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.822405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:58:31.43458Z","caller":"traceutil/trace.go:171","msg":"trace[2052870017] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:287; }","duration":"848.969728ms","start":"2026-04-27T20:58:30.585584Z","end":"2026-04-27T20:58:31.434554Z","steps":["trace[2052870017] 'agreement among raft nodes before linearized reading' (duration: 848.812874ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:31.434633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:30.585564Z","time spent":"849.05771ms","remote":"127.0.0.1:54908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T20:58:31.43463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.525983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:58:31.434691Z","caller":"traceutil/trace.go:171","msg":"trace[960677245] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pv-protection-controller; range_end:; response_count:0; response_revision:287; }","duration":"838.608405ms","start":"2026-04-27T20:58:30.596063Z","end":"2026-04-27T20:58:31.434671Z","steps":["trace[960677245] 'agreement among raft nodes before linearized reading' (duration: 838.503322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:31.434691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.259002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-27T20:58:31.434734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:30.596054Z","time spent":"838.668796ms","remote":"127.0.0.1:55088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" "} {"level":"info","ts":"2026-04-27T20:58:31.434737Z","caller":"traceutil/trace.go:171","msg":"trace[129362741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:287; }","duration":"846.323383ms","start":"2026-04-27T20:58:30.588399Z","end":"2026-04-27T20:58:31.434722Z","steps":["trace[129362741] 'agreement among raft nodes before linearized reading' (duration: 846.212341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:31.434732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.673612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-27T20:58:31.434774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:30.588393Z","time spent":"846.374465ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-27T20:58:31.43481Z","caller":"traceutil/trace.go:171","msg":"trace[374235493] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:287; }","duration":"846.776555ms","start":"2026-04-27T20:58:30.588008Z","end":"2026-04-27T20:58:31.434785Z","steps":["trace[374235493] 'agreement among raft nodes before linearized reading' (duration: 846.616111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:31.434831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.086525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-27T20:58:31.434855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:30.587993Z","time spent":"846.848956ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-27T20:58:31.434865Z","caller":"traceutil/trace.go:171","msg":"trace[418008645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:287; }","duration":"695.152256ms","start":"2026-04-27T20:58:30.739703Z","end":"2026-04-27T20:58:31.434855Z","steps":["trace[418008645] 'agreement among raft nodes before linearized reading' (duration: 695.083915ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:31.434895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:30.739681Z","time spent":"695.207897ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T20:58:31.434816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.043916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-04-27T20:58:31.434966Z","caller":"traceutil/trace.go:171","msg":"trace[716306604] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:287; }","duration":"477.19001ms","start":"2026-04-27T20:58:30.957763Z","end":"2026-04-27T20:58:31.434953Z","steps":["trace[716306604] 'agreement among raft nodes before linearized reading' (duration: 477.009155ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:31.435185Z","caller":"traceutil/trace.go:171","msg":"trace[2054733364] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"844.336335ms","start":"2026-04-27T20:58:30.589742Z","end":"2026-04-27T20:58:31.434078Z","steps":["trace[2054733364] 'process raft request' (duration: 844.16039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:31.435337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:30.589662Z","time spent":"845.590865ms","remote":"127.0.0.1:54964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":753,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T20:58:31.435006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:30.957727Z","time spent":"477.265751ms","remote":"127.0.0.1:55060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5920,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"info","ts":"2026-04-27T20:58:31.559104Z","caller":"traceutil/trace.go:171","msg":"trace[609192849] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"119.023624ms","start":"2026-04-27T20:58:31.440048Z","end":"2026-04-27T20:58:31.559072Z","steps":["trace[609192849] 'process raft request' (duration: 50.504982ms)","trace[609192849] 'compare' (duration: 68.349758ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T20:58:31.562228Z","caller":"traceutil/trace.go:171","msg":"trace[283415925] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"121.970176ms","start":"2026-04-27T20:58:31.44022Z","end":"2026-04-27T20:58:31.56219Z","steps":["trace[283415925] 'process raft request' (duration: 121.609937ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:31.562386Z","caller":"traceutil/trace.go:171","msg":"trace[2003480432] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"121.35694ms","start":"2026-04-27T20:58:31.441013Z","end":"2026-04-27T20:58:31.56237Z","steps":["trace[2003480432] 'process raft request' (duration: 121.063113ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:31.562564Z","caller":"traceutil/trace.go:171","msg":"trace[1204330167] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"119.785353ms","start":"2026-04-27T20:58:31.44277Z","end":"2026-04-27T20:58:31.562555Z","steps":["trace[1204330167] 'process raft request' (duration: 119.566777ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:31.562613Z","caller":"traceutil/trace.go:171","msg":"trace[1908566079] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"109.415869ms","start":"2026-04-27T20:58:31.453145Z","end":"2026-04-27T20:58:31.56256Z","steps":["trace[1908566079] 'process raft request' (duration: 109.379948ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:31.562649Z","caller":"traceutil/trace.go:171","msg":"trace[981099033] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"119.115996ms","start":"2026-04-27T20:58:31.443493Z","end":"2026-04-27T20:58:31.562609Z","steps":["trace[981099033] 'process raft request' (duration: 118.967742ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:31.56316Z","caller":"traceutil/trace.go:171","msg":"trace[1327227264] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"121.922894ms","start":"2026-04-27T20:58:31.441178Z","end":"2026-04-27T20:58:31.563101Z","steps":["trace[1327227264] 'process raft request' (duration: 120.94523ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:57.656378Z","caller":"traceutil/trace.go:171","msg":"trace[190682642] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"570.221879ms","start":"2026-04-27T20:58:57.08613Z","end":"2026-04-27T20:58:57.656351Z","steps":["trace[190682642] 'process raft request' (duration: 570.056004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:57.656502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:57.086104Z","time spent":"570.345123ms","remote":"127.0.0.1:54948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T20:58:57.66761Z","caller":"traceutil/trace.go:171","msg":"trace[1984699396] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"575.219721ms","start":"2026-04-27T20:58:57.09237Z","end":"2026-04-27T20:58:57.66759Z","steps":["trace[1984699396] 'process raft request' (duration: 574.189746ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:57.667725Z","caller":"traceutil/trace.go:171","msg":"trace[2117582237] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"555.412089ms","start":"2026-04-27T20:58:57.112271Z","end":"2026-04-27T20:58:57.667683Z","steps":["trace[2117582237] 'process raft request' (duration: 554.66674ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:57.667785Z","caller":"traceutil/trace.go:171","msg":"trace[1250099642] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"533.384341ms","start":"2026-04-27T20:58:57.13438Z","end":"2026-04-27T20:58:57.667764Z","steps":["trace[1250099642] 'process raft request' (duration: 532.720834ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:57.667841Z","caller":"traceutil/trace.go:171","msg":"trace[1091270509] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"575.404866ms","start":"2026-04-27T20:58:57.092427Z","end":"2026-04-27T20:58:57.667832Z","steps":["trace[1091270509] 'process raft request' (duration: 574.220677ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:57.667852Z","caller":"traceutil/trace.go:171","msg":"trace[1860768457] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"556.091414ms","start":"2026-04-27T20:58:57.111744Z","end":"2026-04-27T20:58:57.667835Z","steps":["trace[1860768457] 'process raft request' (duration: 555.079529ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:57.667861Z","caller":"traceutil/trace.go:171","msg":"trace[842173587] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"548.993141ms","start":"2026-04-27T20:58:57.118841Z","end":"2026-04-27T20:58:57.667834Z","steps":["trace[842173587] 'process raft request' (duration: 548.16599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:57.667894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:57.092422Z","time spent":"575.450627ms","remote":"127.0.0.1:54948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T20:58:57.667874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:57.134353Z","time spent":"533.483793ms","remote":"127.0.0.1:54948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T20:58:57.66795Z","caller":"traceutil/trace.go:171","msg":"trace[1761950934] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"567.934394ms","start":"2026-04-27T20:58:57.100007Z","end":"2026-04-27T20:58:57.667941Z","steps":["trace[1761950934] 'process raft request' (duration: 566.682413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:57.667982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:57.118832Z","time spent":"549.092503ms","remote":"127.0.0.1:54948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T20:58:57.667998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:57.09999Z","time spent":"567.989275ms","remote":"127.0.0.1:54948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T20:58:57.667802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:57.112263Z","time spent":"555.49744ms","remote":"127.0.0.1:54948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T20:58:57.668031Z","caller":"traceutil/trace.go:171","msg":"trace[1596559677] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"555.824999ms","start":"2026-04-27T20:58:57.112198Z","end":"2026-04-27T20:58:57.668023Z","steps":["trace[1596559677] 'process raft request' (duration: 554.704761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:57.667917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:57.111722Z","time spent":"556.163006ms","remote":"127.0.0.1:54948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T20:58:57.668079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:57.112182Z","time spent":"555.87448ms","remote":"127.0.0.1:54948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T20:58:57.667959Z","caller":"traceutil/trace.go:171","msg":"trace[237780521] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"413.21454ms","start":"2026-04-27T20:58:57.254636Z","end":"2026-04-27T20:58:57.667851Z","steps":["trace[237780521] 'process raft request' (duration: 412.556003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:57.668147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:57.254603Z","time spent":"413.524317ms","remote":"127.0.0.1:54948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T20:58:57.668002Z","caller":"traceutil/trace.go:171","msg":"trace[1548087598] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"558.408001ms","start":"2026-04-27T20:58:57.10958Z","end":"2026-04-27T20:58:57.667988Z","steps":["trace[1548087598] 'process raft request' (duration: 557.283843ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:57.66815Z","caller":"traceutil/trace.go:171","msg":"trace[1069060796] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"411.071157ms","start":"2026-04-27T20:58:57.25707Z","end":"2026-04-27T20:58:57.668141Z","steps":["trace[1069060796] 'process raft request' (duration: 410.196195ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:58:57.668191Z","caller":"traceutil/trace.go:171","msg":"trace[1708752963] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"559.833896ms","start":"2026-04-27T20:58:57.108348Z","end":"2026-04-27T20:58:57.668181Z","steps":["trace[1708752963] 'process raft request' (duration: 558.422371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:58:57.668341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:57.108333Z","time spent":"559.982899ms","remote":"127.0.0.1:54948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T20:58:57.668217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:57.109539Z","time spent":"558.651407ms","remote":"127.0.0.1:54948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T20:58:57.668363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:57.092351Z","time spent":"575.322974ms","remote":"127.0.0.1:54948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T20:58:57.668626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:58:57.257056Z","time spent":"411.20214ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T20:59:03.985109Z","caller":"traceutil/trace.go:171","msg":"trace[375820800] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"108.016005ms","start":"2026-04-27T20:59:03.877064Z","end":"2026-04-27T20:59:03.98508Z","steps":["trace[375820800] 'process raft request' (duration: 107.82501ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:59:04.297348Z","caller":"traceutil/trace.go:171","msg":"trace[1234805590] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"419.592575ms","start":"2026-04-27T20:59:03.877723Z","end":"2026-04-27T20:59:04.297316Z","steps":["trace[1234805590] 'process raft request' (duration: 419.313578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:59:04.297502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:59:03.877716Z","time spent":"419.707408ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T20:59:04.298211Z","caller":"traceutil/trace.go:171","msg":"trace[1269943946] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"349.3384ms","start":"2026-04-27T20:59:03.948837Z","end":"2026-04-27T20:59:04.298175Z","steps":["trace[1269943946] 'process raft request' (duration: 348.871489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:59:04.298608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:59:03.948795Z","time spent":"349.502244ms","remote":"127.0.0.1:54984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T20:59:05.208949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:59:04.40281Z","time spent":"806.132184ms","remote":"127.0.0.1:51592","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-27T20:59:05.209166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.633449ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T20:59:05.209344Z","caller":"traceutil/trace.go:171","msg":"trace[574786810] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"537.207114ms","start":"2026-04-27T20:59:04.672119Z","end":"2026-04-27T20:59:05.209326Z","steps":["trace[574786810] 'read index received' (duration: 253.126934ms)","trace[574786810] 'applied index is now lower than readState.Index' (duration: 284.0786ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T20:59:05.209363Z","caller":"traceutil/trace.go:171","msg":"trace[1645005010] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"851.5019ms","start":"2026-04-27T20:59:04.357834Z","end":"2026-04-27T20:59:05.209336Z","steps":["trace[1645005010] 'process raft request' (duration: 567.484432ms)","trace[1645005010] 'compare' (duration: 283.500976ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T20:59:05.210224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:59:04.357805Z","time spent":"852.388322ms","remote":"127.0.0.1:55114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T20:59:05.209639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.514651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-525lv\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-27T20:59:05.210769Z","caller":"traceutil/trace.go:171","msg":"trace[1342433602] range","detail":"{range_begin:/registry/pods/kube-system/cilium-525lv; range_end:; response_count:1; response_revision:629; }","duration":"538.550886ms","start":"2026-04-27T20:59:04.672076Z","end":"2026-04-27T20:59:05.210627Z","steps":["trace[1342433602] 'agreement among raft nodes before linearized reading' (duration: 537.339097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:59:05.21094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:59:04.67206Z","time spent":"538.863943ms","remote":"127.0.0.1:55060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-525lv\" "} {"level":"info","ts":"2026-04-27T20:59:17.029391Z","caller":"traceutil/trace.go:171","msg":"trace[823046901] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"107.195405ms","start":"2026-04-27T20:59:16.922163Z","end":"2026-04-27T20:59:17.029359Z","steps":["trace[823046901] 'process raft request' (duration: 74.132198ms)","trace[823046901] 'compare' (duration: 32.925584ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T20:59:18.325322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.281565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:59:18.325425Z","caller":"traceutil/trace.go:171","msg":"trace[133936776] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:776; }","duration":"175.399379ms","start":"2026-04-27T20:59:18.149998Z","end":"2026-04-27T20:59:18.325397Z","steps":["trace[133936776] 'range keys from in-memory index tree' (duration: 175.144423ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:59:21.161481Z","caller":"traceutil/trace.go:171","msg":"trace[697751904] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"394.622056ms","start":"2026-04-27T20:59:20.766835Z","end":"2026-04-27T20:59:21.161457Z","steps":["trace[697751904] 'read index received' (duration: 394.422581ms)","trace[697751904] 'applied index is now lower than readState.Index' (duration: 198.605µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T20:59:21.161562Z","caller":"traceutil/trace.go:171","msg":"trace[1788093569] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"479.24665ms","start":"2026-04-27T20:59:20.682289Z","end":"2026-04-27T20:59:21.161536Z","steps":["trace[1788093569] 'process raft request' (duration: 479.023804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:59:21.161711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:59:20.682264Z","time spent":"479.359073ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T20:59:21.162332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.440685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-tqc4h\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-27T20:59:21.162619Z","caller":"traceutil/trace.go:171","msg":"trace[544556012] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-tqc4h; range_end:; response_count:1; response_revision:792; }","duration":"395.787784ms","start":"2026-04-27T20:59:20.766786Z","end":"2026-04-27T20:59:21.162574Z","steps":["trace[544556012] 'agreement among raft nodes before linearized reading' (duration: 394.81326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:59:21.162712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:59:20.766767Z","time spent":"395.928298ms","remote":"127.0.0.1:55060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-tqc4h\" "} {"level":"info","ts":"2026-04-27T20:59:21.303685Z","caller":"traceutil/trace.go:171","msg":"trace[1890909905] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"134.819998ms","start":"2026-04-27T20:59:21.168822Z","end":"2026-04-27T20:59:21.303642Z","steps":["trace[1890909905] 'process raft request' (duration: 134.568552ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:59:44.740414Z","caller":"traceutil/trace.go:171","msg":"trace[1243825507] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"220.045285ms","start":"2026-04-27T20:59:44.520344Z","end":"2026-04-27T20:59:44.740389Z","steps":["trace[1243825507] 'process raft request' (duration: 219.885641ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:59:57.135471Z","caller":"traceutil/trace.go:171","msg":"trace[842871710] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"286.625454ms","start":"2026-04-27T20:59:56.848822Z","end":"2026-04-27T20:59:57.135447Z","steps":["trace[842871710] 'process raft request' (duration: 286.472841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:59:57.693214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.586221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T20:59:57.693294Z","caller":"traceutil/trace.go:171","msg":"trace[1830082130] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1007; }","duration":"364.747355ms","start":"2026-04-27T20:59:57.328529Z","end":"2026-04-27T20:59:57.693276Z","steps":["trace[1830082130] 'range keys from in-memory index tree' (duration: 364.395066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:59:57.693336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:59:57.32851Z","time spent":"364.816207ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-27T20:59:57.941194Z","caller":"traceutil/trace.go:171","msg":"trace[1772071712] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"243.109813ms","start":"2026-04-27T20:59:57.69806Z","end":"2026-04-27T20:59:57.94117Z","steps":["trace[1772071712] 'process raft request' (duration: 239.813202ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:59:57.941906Z","caller":"traceutil/trace.go:171","msg":"trace[1027769889] linearizableReadLoop","detail":"{readStateIndex:1047; appliedIndex:1045; }","duration":"146.427883ms","start":"2026-04-27T20:59:57.795454Z","end":"2026-04-27T20:59:57.941882Z","steps":["trace[1027769889] 'read index received' (duration: 142.456946ms)","trace[1027769889] 'applied index is now lower than readState.Index' (duration: 3.970107ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T20:59:57.942106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.632899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T20:59:57.942117Z","caller":"traceutil/trace.go:171","msg":"trace[1512954023] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"158.142212ms","start":"2026-04-27T20:59:57.783952Z","end":"2026-04-27T20:59:57.942094Z","steps":["trace[1512954023] 'process raft request' (duration: 157.812033ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:59:57.942153Z","caller":"traceutil/trace.go:171","msg":"trace[1926622417] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1009; }","duration":"146.712801ms","start":"2026-04-27T20:59:57.795425Z","end":"2026-04-27T20:59:57.942138Z","steps":["trace[1926622417] 'agreement among raft nodes before linearized reading' (duration: 146.554067ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:00:01.25681Z","caller":"traceutil/trace.go:171","msg":"trace[44613548] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"104.854391ms","start":"2026-04-27T21:00:01.151935Z","end":"2026-04-27T21:00:01.25679Z","steps":["trace[44613548] 'process raft request' (duration: 104.739358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:00:10.396497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.711909ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T21:00:10.396636Z","caller":"traceutil/trace.go:171","msg":"trace[1631775210] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"141.267456ms","start":"2026-04-27T21:00:10.255349Z","end":"2026-04-27T21:00:10.396617Z","steps":["trace[1631775210] 'process raft request' (duration: 31.348562ms)","trace[1631775210] 'compare' (duration: 109.574816ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T21:00:10.529208Z","caller":"traceutil/trace.go:171","msg":"trace[1371620043] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"114.518718ms","start":"2026-04-27T21:00:10.414667Z","end":"2026-04-27T21:00:10.529186Z","steps":["trace[1371620043] 'process raft request' (duration: 110.324314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:00:18.439079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.662221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T21:00:18.439142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.338903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-27T21:00:18.439201Z","caller":"traceutil/trace.go:171","msg":"trace[1089266082] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1076; }","duration":"164.425345ms","start":"2026-04-27T21:00:18.27476Z","end":"2026-04-27T21:00:18.439186Z","steps":["trace[1089266082] 'range keys from in-memory index tree' (duration: 164.258361ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:00:18.439201Z","caller":"traceutil/trace.go:171","msg":"trace[456127016] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1076; }","duration":"290.823345ms","start":"2026-04-27T21:00:18.148353Z","end":"2026-04-27T21:00:18.439177Z","steps":["trace[456127016] 'range keys from in-memory index tree' (duration: 290.57533ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:00:19.83848Z","caller":"traceutil/trace.go:171","msg":"trace[477004151] linearizableReadLoop","detail":"{readStateIndex:1123; appliedIndex:1122; }","duration":"435.012324ms","start":"2026-04-27T21:00:19.403439Z","end":"2026-04-27T21:00:19.838452Z","steps":["trace[477004151] 'read index received' (duration: 434.817939ms)","trace[477004151] 'applied index is now lower than readState.Index' (duration: 193.205µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T21:00:19.838596Z","caller":"traceutil/trace.go:171","msg":"trace[1890683790] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"466.975532ms","start":"2026-04-27T21:00:19.371579Z","end":"2026-04-27T21:00:19.838554Z","steps":["trace[1890683790] 'process raft request' (duration: 466.733756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:00:19.83877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.23895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T21:00:19.83864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.875807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T21:00:19.838802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T21:00:19.37156Z","time spent":"467.158987ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T21:00:19.838853Z","caller":"traceutil/trace.go:171","msg":"trace[1074331798] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1081; }","duration":"435.423144ms","start":"2026-04-27T21:00:19.403396Z","end":"2026-04-27T21:00:19.838819Z","steps":["trace[1074331798] 'agreement among raft nodes before linearized reading' (duration: 435.188548ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:00:19.838913Z","caller":"traceutil/trace.go:171","msg":"trace[1166038087] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1081; }","duration":"154.167484ms","start":"2026-04-27T21:00:19.684692Z","end":"2026-04-27T21:00:19.83886Z","steps":["trace[1166038087] 'agreement among raft nodes before linearized reading' (duration: 153.894307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:00:19.838939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T21:00:19.403381Z","time spent":"435.529257ms","remote":"127.0.0.1:56136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-27T21:00:21.639606Z","caller":"traceutil/trace.go:171","msg":"trace[1527554177] linearizableReadLoop","detail":"{readStateIndex:1129; appliedIndex:1128; }","duration":"489.24878ms","start":"2026-04-27T21:00:21.150327Z","end":"2026-04-27T21:00:21.639576Z","steps":["trace[1527554177] 'read index received' (duration: 488.991604ms)","trace[1527554177] 'applied index is now lower than readState.Index' (duration: 255.646µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T21:00:21.63968Z","caller":"traceutil/trace.go:171","msg":"trace[1890140590] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"489.955847ms","start":"2026-04-27T21:00:21.149691Z","end":"2026-04-27T21:00:21.639647Z","steps":["trace[1890140590] 'process raft request' (duration: 489.622539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:00:21.63976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.416704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T21:00:21.639825Z","caller":"traceutil/trace.go:171","msg":"trace[1008564135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1087; }","duration":"489.515547ms","start":"2026-04-27T21:00:21.150292Z","end":"2026-04-27T21:00:21.639807Z","steps":["trace[1008564135] 'agreement among raft nodes before linearized reading' (duration: 489.397124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:00:21.639867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T21:00:21.149672Z","time spent":"490.08921ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T21:00:21.63988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T21:00:21.150243Z","time spent":"489.626189ms","remote":"127.0.0.1:54908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T21:00:23.185276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.335807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T21:00:23.185349Z","caller":"traceutil/trace.go:171","msg":"trace[558120271] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1092; }","duration":"603.45444ms","start":"2026-04-27T21:00:22.581879Z","end":"2026-04-27T21:00:23.185333Z","steps":["trace[558120271] 'range keys from in-memory index tree' (duration: 603.142523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:00:23.185387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T21:00:22.581845Z","time spent":"603.533442ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-27T21:00:23.256911Z","caller":"traceutil/trace.go:171","msg":"trace[1156181058] linearizableReadLoop","detail":"{readStateIndex:1135; appliedIndex:1134; }","duration":"253.764854ms","start":"2026-04-27T21:00:23.003121Z","end":"2026-04-27T21:00:23.256886Z","steps":["trace[1156181058] 'read index received' (duration: 188.479808ms)","trace[1156181058] 'applied index is now lower than readState.Index' (duration: 65.283846ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T21:00:23.257057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.916687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T21:00:23.257151Z","caller":"traceutil/trace.go:171","msg":"trace[1536247217] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1092; }","duration":"254.055342ms","start":"2026-04-27T21:00:23.003074Z","end":"2026-04-27T21:00:23.25713Z","steps":["trace[1536247217] 'agreement among raft nodes before linearized reading' (duration: 253.923719ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:00:23.323503Z","caller":"traceutil/trace.go:171","msg":"trace[1461348886] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"134.50355ms","start":"2026-04-27T21:00:23.188972Z","end":"2026-04-27T21:00:23.323476Z","steps":["trace[1461348886] 'process raft request' (duration: 134.296915ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:00:23.323621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.223502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T21:00:23.323718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.173116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T21:00:23.323735Z","caller":"traceutil/trace.go:171","msg":"trace[1502579655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1093; }","duration":"175.393017ms","start":"2026-04-27T21:00:23.148318Z","end":"2026-04-27T21:00:23.323711Z","steps":["trace[1502579655] 'agreement among raft nodes before linearized reading' (duration: 175.209402ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:00:23.323764Z","caller":"traceutil/trace.go:171","msg":"trace[752138796] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1093; }","duration":"315.263849ms","start":"2026-04-27T21:00:23.008487Z","end":"2026-04-27T21:00:23.323751Z","steps":["trace[752138796] 'agreement among raft nodes before linearized reading' (duration: 314.949221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:00:23.323797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T21:00:23.008474Z","time spent":"315.31467ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-04-27T21:00:35.565858Z","caller":"traceutil/trace.go:171","msg":"trace[2066513223] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"150.711647ms","start":"2026-04-27T21:00:35.415121Z","end":"2026-04-27T21:00:35.565832Z","steps":["trace[2066513223] 'process raft request' (duration: 150.548163ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:00:51.849057Z","caller":"traceutil/trace.go:171","msg":"trace[1426038102] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"189.048174ms","start":"2026-04-27T21:00:51.65999Z","end":"2026-04-27T21:00:51.849038Z","steps":["trace[1426038102] 'process raft request' (duration: 188.931171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:00:52.183909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.473195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-27T21:00:52.18397Z","caller":"traceutil/trace.go:171","msg":"trace[489784116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1257; }","duration":"147.577258ms","start":"2026-04-27T21:00:52.036376Z","end":"2026-04-27T21:00:52.183953Z","steps":["trace[489784116] 'range keys from in-memory index tree' (duration: 147.330101ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:00:54.231261Z","caller":"traceutil/trace.go:171","msg":"trace[893466949] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"106.013408ms","start":"2026-04-27T21:00:54.125221Z","end":"2026-04-27T21:00:54.231234Z","steps":["trace[893466949] 'process raft request' (duration: 105.394623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:00:54.977164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.907397ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T21:00:54.977231Z","caller":"traceutil/trace.go:171","msg":"trace[1964916871] linearizableReadLoop","detail":"{readStateIndex:1325; appliedIndex:1324; }","duration":"173.349253ms","start":"2026-04-27T21:00:54.803871Z","end":"2026-04-27T21:00:54.97722Z","steps":["trace[1964916871] 'read index received' (duration: 75.722µs)","trace[1964916871] 'applied index is now lower than readState.Index' (duration: 173.272821ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T21:00:54.977314Z","caller":"traceutil/trace.go:171","msg":"trace[46896967] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"456.998544ms","start":"2026-04-27T21:00:54.520309Z","end":"2026-04-27T21:00:54.977307Z","steps":["trace[46896967] 'process raft request' (duration: 108.895362ms)","trace[46896967] 'compare' (duration: 347.827785ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T21:00:54.97735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T21:00:54.520294Z","time spent":"457.040606ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T21:00:54.97743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.575999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T21:00:54.977444Z","caller":"traceutil/trace.go:171","msg":"trace[697443055] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1274; }","duration":"173.59233ms","start":"2026-04-27T21:00:54.803846Z","end":"2026-04-27T21:00:54.977438Z","steps":["trace[697443055] 'agreement among raft nodes before linearized reading' (duration: 173.561799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:00:54.977573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.797669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-27T21:00:54.977681Z","caller":"traceutil/trace.go:171","msg":"trace[1793748629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1274; }","duration":"108.940233ms","start":"2026-04-27T21:00:54.868725Z","end":"2026-04-27T21:00:54.977665Z","steps":["trace[1793748629] 'agreement among raft nodes before linearized reading' (duration: 108.79254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:00:54.977703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.008928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T21:00:54.977791Z","caller":"traceutil/trace.go:171","msg":"trace[457270803] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1274; }","duration":"117.143272ms","start":"2026-04-27T21:00:54.860625Z","end":"2026-04-27T21:00:54.977768Z","steps":["trace[457270803] 'agreement among raft nodes before linearized reading' (duration: 116.897046ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:00:55.277056Z","caller":"traceutil/trace.go:171","msg":"trace[1682627469] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"296.799767ms","start":"2026-04-27T21:00:54.980217Z","end":"2026-04-27T21:00:55.277017Z","steps":["trace[1682627469] 'process raft request' (duration: 286.243458ms)","trace[1682627469] 'compare' (duration: 10.329213ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T21:00:55.281506Z","caller":"traceutil/trace.go:171","msg":"trace[55164838] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1325; }","duration":"134.919584ms","start":"2026-04-27T21:00:55.146558Z","end":"2026-04-27T21:00:55.281477Z","steps":["trace[55164838] 'read index received' (duration: 119.900121ms)","trace[55164838] 'applied index is now lower than readState.Index' (duration: 15.018063ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T21:00:55.281674Z","caller":"traceutil/trace.go:171","msg":"trace[740817357] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"299.855794ms","start":"2026-04-27T21:00:54.98178Z","end":"2026-04-27T21:00:55.281636Z","steps":["trace[740817357] 'process raft request' (duration: 299.548577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:00:55.281797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.158011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T21:00:55.281909Z","caller":"traceutil/trace.go:171","msg":"trace[917549436] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1276; }","duration":"135.366736ms","start":"2026-04-27T21:00:55.146524Z","end":"2026-04-27T21:00:55.28189Z","steps":["trace[917549436] 'agreement among raft nodes before linearized reading' (duration: 135.14943ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:01:05.647409Z","caller":"traceutil/trace.go:171","msg":"trace[100956357] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"326.833871ms","start":"2026-04-27T21:01:05.320546Z","end":"2026-04-27T21:01:05.64738Z","steps":["trace[100956357] 'process raft request' (duration: 326.665907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:01:05.647565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T21:01:05.320529Z","time spent":"326.953885ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T21:01:06.023288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.102093ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T21:01:06.023406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.263565ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T21:01:06.023421Z","caller":"traceutil/trace.go:171","msg":"trace[1576432725] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1349; }","duration":"198.250736ms","start":"2026-04-27T21:01:05.825153Z","end":"2026-04-27T21:01:06.023404Z","steps":["trace[1576432725] 'range keys from in-memory index tree' (duration: 198.086522ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:01:06.023478Z","caller":"traceutil/trace.go:171","msg":"trace[986311535] linearizableReadLoop","detail":"{readStateIndex:1403; appliedIndex:1401; }","duration":"559.35755ms","start":"2026-04-27T21:01:05.464108Z","end":"2026-04-27T21:01:06.023465Z","steps":["trace[986311535] 'read index received' (duration: 183.178963ms)","trace[986311535] 'applied index is now lower than readState.Index' (duration: 376.176767ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T21:01:06.023611Z","caller":"traceutil/trace.go:171","msg":"trace[389360248] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"700.252958ms","start":"2026-04-27T21:01:05.323346Z","end":"2026-04-27T21:01:06.023599Z","steps":["trace[389360248] 'process raft request' (duration: 377.732507ms)","trace[389360248] 'compare' (duration: 322.130981ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T21:01:06.02368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T21:01:05.323327Z","time spent":"700.312259ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T21:01:06.023786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.661048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T21:01:06.023912Z","caller":"traceutil/trace.go:171","msg":"trace[170639721] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1350; }","duration":"559.823253ms","start":"2026-04-27T21:01:05.464055Z","end":"2026-04-27T21:01:06.023878Z","steps":["trace[170639721] 'agreement among raft nodes before linearized reading' (duration: 559.661738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:01:06.023929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.882363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-27T21:01:06.023988Z","caller":"traceutil/trace.go:171","msg":"trace[475974541] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1350; }","duration":"196.982305ms","start":"2026-04-27T21:01:05.826989Z","end":"2026-04-27T21:01:06.023972Z","steps":["trace[475974541] 'agreement among raft nodes before linearized reading' (duration: 196.81994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:01:06.023984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T21:01:05.464036Z","time spent":"559.932005ms","remote":"127.0.0.1:56186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-04-27T21:01:06.25529Z","caller":"traceutil/trace.go:171","msg":"trace[584944593] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"227.090822ms","start":"2026-04-27T21:01:06.028174Z","end":"2026-04-27T21:01:06.255265Z","steps":["trace[584944593] 'process raft request' (duration: 221.897859ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:01:06.25573Z","caller":"traceutil/trace.go:171","msg":"trace[1805373589] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"225.695145ms","start":"2026-04-27T21:01:06.029681Z","end":"2026-04-27T21:01:06.255376Z","steps":["trace[1805373589] 'process raft request' (duration: 225.374987ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:01:30.897935Z","caller":"traceutil/trace.go:171","msg":"trace[460770656] transaction","detail":"{read_only:false; response_revision:1465; number_of_response:1; }","duration":"248.563218ms","start":"2026-04-27T21:01:30.649331Z","end":"2026-04-27T21:01:30.897894Z","steps":["trace[460770656] 'process raft request' (duration: 248.431495ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:02:05.218868Z","caller":"traceutil/trace.go:171","msg":"trace[1466224595] transaction","detail":"{read_only:false; response_revision:1624; number_of_response:1; }","duration":"159.200905ms","start":"2026-04-27T21:02:05.059644Z","end":"2026-04-27T21:02:05.218845Z","steps":["trace[1466224595] 'process raft request' (duration: 158.762455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:02:05.591819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.388023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T21:02:05.591884Z","caller":"traceutil/trace.go:171","msg":"trace[1501721526] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1624; }","duration":"247.502134ms","start":"2026-04-27T21:02:05.344368Z","end":"2026-04-27T21:02:05.59187Z","steps":["trace[1501721526] 'range keys from in-memory index tree' (duration: 247.191588ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:02:06.553612Z","caller":"traceutil/trace.go:171","msg":"trace[83821218] transaction","detail":"{read_only:false; response_revision:1627; number_of_response:1; }","duration":"163.841989ms","start":"2026-04-27T21:02:06.38975Z","end":"2026-04-27T21:02:06.553592Z","steps":["trace[83821218] 'process raft request' (duration: 163.620614ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:02:11.349081Z","caller":"traceutil/trace.go:171","msg":"trace[740257103] transaction","detail":"{read_only:false; response_revision:1650; number_of_response:1; }","duration":"111.61705ms","start":"2026-04-27T21:02:11.237439Z","end":"2026-04-27T21:02:11.349056Z","steps":["trace[740257103] 'process raft request' (duration: 111.444606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:02:12.104731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.952856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-27T21:02:12.105021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.053973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T21:02:12.105056Z","caller":"traceutil/trace.go:171","msg":"trace[2081136720] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1650; }","duration":"446.125425ms","start":"2026-04-27T21:02:11.658921Z","end":"2026-04-27T21:02:12.105047Z","steps":["trace[2081136720] 'count revisions from in-memory index tree' (duration: 445.973661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:02:12.105085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T21:02:11.658906Z","time spent":"446.172766ms","remote":"127.0.0.1:55060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":13,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-04-27T21:02:12.105303Z","caller":"traceutil/trace.go:171","msg":"trace[1997629634] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1650; }","duration":"407.068979ms","start":"2026-04-27T21:02:11.697728Z","end":"2026-04-27T21:02:12.104797Z","steps":["trace[1997629634] 'range keys from in-memory index tree' (duration: 406.822553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T21:02:12.105333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T21:02:11.697713Z","time spent":"407.612862ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-27T21:02:12.107875Z","caller":"traceutil/trace.go:171","msg":"trace[2084326209] transaction","detail":"{read_only:false; response_revision:1651; number_of_response:1; }","duration":"245.390103ms","start":"2026-04-27T21:02:11.862463Z","end":"2026-04-27T21:02:12.107853Z","steps":["trace[2084326209] 'process raft request' (duration: 245.225329ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:02:28.903313Z","caller":"traceutil/trace.go:171","msg":"trace[196552320] transaction","detail":"{read_only:false; response_revision:1732; number_of_response:1; }","duration":"100.55338ms","start":"2026-04-27T21:02:28.802735Z","end":"2026-04-27T21:02:28.903288Z","steps":["trace[196552320] 'process raft request' (duration: 100.421327ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:02:37.447929Z","caller":"traceutil/trace.go:171","msg":"trace[1959054379] transaction","detail":"{read_only:false; response_revision:1769; number_of_response:1; }","duration":"211.644239ms","start":"2026-04-27T21:02:37.236256Z","end":"2026-04-27T21:02:37.4479Z","steps":["trace[1959054379] 'process raft request' (duration: 211.484735ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:03:13.528534Z","caller":"traceutil/trace.go:171","msg":"trace[737407427] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"255.022948ms","start":"2026-04-27T21:03:13.273477Z","end":"2026-04-27T21:03:13.5285Z","steps":["trace[737407427] 'process raft request' (duration: 254.840404ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:03:13.535359Z","caller":"traceutil/trace.go:171","msg":"trace[550577260] transaction","detail":"{read_only:false; response_revision:1933; number_of_response:1; }","duration":"259.517118ms","start":"2026-04-27T21:03:13.275798Z","end":"2026-04-27T21:03:13.535316Z","steps":["trace[550577260] 'process raft request' (duration: 259.382415ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:03:13.535361Z","caller":"traceutil/trace.go:171","msg":"trace[703079227] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"259.917778ms","start":"2026-04-27T21:03:13.275393Z","end":"2026-04-27T21:03:13.535311Z","steps":["trace[703079227] 'process raft request' (duration: 259.752874ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:03:13.535446Z","caller":"traceutil/trace.go:171","msg":"trace[1690803343] linearizableReadLoop","detail":"{readStateIndex:2012; appliedIndex:2009; }","duration":"255.94567ms","start":"2026-04-27T21:03:13.279477Z","end":"2026-04-27T21:03:13.535423Z","steps":["trace[1690803343] 'read index received' (duration: 249.049541ms)","trace[1690803343] 'applied index is now lower than readState.Index' (duration: 6.894849ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T21:03:13.535574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.073124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T21:03:13.535614Z","caller":"traceutil/trace.go:171","msg":"trace[333627228] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1933; }","duration":"256.152985ms","start":"2026-04-27T21:03:13.27945Z","end":"2026-04-27T21:03:13.535603Z","steps":["trace[333627228] 'agreement among raft nodes before linearized reading' (duration: 256.057433ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:03:13.535735Z","caller":"traceutil/trace.go:171","msg":"trace[1597968824] transaction","detail":"{read_only:false; response_revision:1931; number_of_response:1; }","duration":"261.759892ms","start":"2026-04-27T21:03:13.273961Z","end":"2026-04-27T21:03:13.535721Z","steps":["trace[1597968824] 'process raft request' (duration: 261.033365ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T21:03:14.901409Z","caller":"traceutil/trace.go:171","msg":"trace[1040907243] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"238.810453ms","start":"2026-04-27T21:03:14.662563Z","end":"2026-04-27T21:03:14.901374Z","steps":["trace[1040907243] 'process raft request' (duration: 223.637512ms)","trace[1040907243] 'compare' (duration: 14.918164ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T21:03:14.902973Z","caller":"traceutil/trace.go:171","msg":"trace[163621766] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"192.796077ms","start":"2026-04-27T21:03:14.71015Z","end":"2026-04-27T21:03:14.902946Z","steps":["trace[163621766] 'process raft request' (duration: 192.671144ms)"],"step_count":1}