{"level":"warn","ts":"2026-08-24T15:18:13.158806Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-24T15:18:13.158928Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.219:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.219:2380","--initial-cluster=instance=https://199.19.213.219:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.219:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.219:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-24T15:18:13.159021Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-24T15:18:13.159039Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.219:2380"]} {"level":"info","ts":"2026-08-24T15:18:13.15907Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-24T15:18:13.15992Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.219:2379"]} {"level":"info","ts":"2026-08-24T15:18:13.160011Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.219:2380"],"listen-peer-urls":["https://199.19.213.219:2380"],"advertise-client-urls":["https://199.19.213.219:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.219:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.219:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-24T15:18:13.16509Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.779432ms"} {"level":"info","ts":"2026-08-24T15:18:13.175425Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7e142186203fa167","cluster-id":"e7586aea7e662ee6"} {"level":"info","ts":"2026-08-24T15:18:13.175524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 switched to configuration voters=()"} {"level":"info","ts":"2026-08-24T15:18:13.175551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became follower at term 0"} {"level":"info","ts":"2026-08-24T15:18:13.175696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7e142186203fa167 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-24T15:18:13.17571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became follower at term 1"} {"level":"info","ts":"2026-08-24T15:18:13.175761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 switched to configuration voters=(9084923208263508327)"} {"level":"warn","ts":"2026-08-24T15:18:13.181966Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-24T15:18:13.187327Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-24T15:18:13.188404Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-24T15:18:13.19084Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7e142186203fa167","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-24T15:18:13.19118Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7e142186203fa167","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-24T15:18:13.191494Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-24T15:18:13.191636Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-24T15:18:13.191652Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-24T15:18:13.193773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 switched to configuration voters=(9084923208263508327)"} {"level":"info","ts":"2026-08-24T15:18:13.194075Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e7586aea7e662ee6","local-member-id":"7e142186203fa167","added-peer-id":"7e142186203fa167","added-peer-peer-urls":["https://199.19.213.219:2380"]} {"level":"info","ts":"2026-08-24T15:18:13.195726Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-24T15:18:13.195867Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.219:2380"} {"level":"info","ts":"2026-08-24T15:18:13.195925Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.219:2380"} {"level":"info","ts":"2026-08-24T15:18:13.196Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7e142186203fa167","initial-advertise-peer-urls":["https://199.19.213.219:2380"],"listen-peer-urls":["https://199.19.213.219:2380"],"advertise-client-urls":["https://199.19.213.219:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.219:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-24T15:18:13.196033Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-24T15:18:13.276578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 is starting a new election at term 1"} {"level":"info","ts":"2026-08-24T15:18:13.276643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-24T15:18:13.276662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 received MsgPreVoteResp from 7e142186203fa167 at term 1"} {"level":"info","ts":"2026-08-24T15:18:13.276681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became candidate at term 2"} {"level":"info","ts":"2026-08-24T15:18:13.276693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 received MsgVoteResp from 7e142186203fa167 at term 2"} {"level":"info","ts":"2026-08-24T15:18:13.27673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became leader at term 2"} {"level":"info","ts":"2026-08-24T15:18:13.276745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7e142186203fa167 elected leader 7e142186203fa167 at term 2"} {"level":"info","ts":"2026-08-24T15:18:13.27769Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:18:13.278601Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7e142186203fa167","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.219:2379]}","request-path":"/0/members/7e142186203fa167/attributes","cluster-id":"e7586aea7e662ee6","publish-timeout":"7s"} {"level":"info","ts":"2026-08-24T15:18:13.278887Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T15:18:13.279082Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-24T15:18:13.27929Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e7586aea7e662ee6","local-member-id":"7e142186203fa167","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:18:13.279219Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-24T15:18:13.279413Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:18:13.279462Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:18:13.279389Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T15:18:13.281839Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.219:2379"} {"level":"info","ts":"2026-08-24T15:18:13.283627Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-08-24T15:18:39.733723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.029428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-24T15:18:39.733833Z","caller":"traceutil/trace.go:171","msg":"trace[1516395545] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:393; }","duration":"324.222591ms","start":"2026-08-24T15:18:39.409591Z","end":"2026-08-24T15:18:39.733814Z","steps":["trace[1516395545] 'range keys from in-memory index tree' (duration: 323.907247ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:39.733878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:39.40956Z","time spent":"324.309942ms","remote":"127.0.0.1:52444","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-08-24T15:18:45.0007Z","caller":"traceutil/trace.go:171","msg":"trace[910149647] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"146.925428ms","start":"2026-08-24T15:18:44.853752Z","end":"2026-08-24T15:18:45.000678Z","steps":["trace[910149647] 'process raft request' (duration: 146.796916ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:18:45.090693Z","caller":"traceutil/trace.go:171","msg":"trace[304829483] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:419; }","duration":"131.540717ms","start":"2026-08-24T15:18:44.959129Z","end":"2026-08-24T15:18:45.09067Z","steps":["trace[304829483] 'read index received' (duration: 41.449522ms)","trace[304829483] 'applied index is now lower than readState.Index' (duration: 90.090025ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:18:45.090876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.73158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:18:45.090918Z","caller":"traceutil/trace.go:171","msg":"trace[1244314948] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:404; }","duration":"131.831001ms","start":"2026-08-24T15:18:44.959075Z","end":"2026-08-24T15:18:45.090906Z","steps":["trace[1244314948] 'agreement among raft nodes before linearized reading' (duration: 131.750829ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:18:45.090889Z","caller":"traceutil/trace.go:171","msg":"trace[310279954] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"191.204894ms","start":"2026-08-24T15:18:44.899561Z","end":"2026-08-24T15:18:45.090765Z","steps":["trace[310279954] 'process raft request' (duration: 190.994001ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:21.48625Z","caller":"traceutil/trace.go:171","msg":"trace[759416461] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"254.787659ms","start":"2026-08-24T15:19:21.231446Z","end":"2026-08-24T15:19:21.486234Z","steps":["trace[759416461] 'process raft request' (duration: 254.694217ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:21.499371Z","caller":"traceutil/trace.go:171","msg":"trace[1019267476] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"251.997384ms","start":"2026-08-24T15:19:21.247344Z","end":"2026-08-24T15:19:21.499342Z","steps":["trace[1019267476] 'process raft request' (duration: 251.502008ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:21.499672Z","caller":"traceutil/trace.go:171","msg":"trace[513628049] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"236.348258ms","start":"2026-08-24T15:19:21.263107Z","end":"2026-08-24T15:19:21.499455Z","steps":["trace[513628049] 'process raft request' (duration: 235.884093ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:21.499747Z","caller":"traceutil/trace.go:171","msg":"trace[1802637659] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"266.07401ms","start":"2026-08-24T15:19:21.23365Z","end":"2026-08-24T15:19:21.499724Z","steps":["trace[1802637659] 'process raft request' (duration: 264.913785ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:21.499663Z","caller":"traceutil/trace.go:171","msg":"trace[1595353224] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"242.553355ms","start":"2026-08-24T15:19:21.257063Z","end":"2026-08-24T15:19:21.499617Z","steps":["trace[1595353224] 'process raft request' (duration: 241.874477ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:21.499964Z","caller":"traceutil/trace.go:171","msg":"trace[150459351] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"266.16412ms","start":"2026-08-24T15:19:21.233786Z","end":"2026-08-24T15:19:21.49995Z","steps":["trace[150459351] 'process raft request' (duration: 264.906485ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:21.500117Z","caller":"traceutil/trace.go:171","msg":"trace[1854426003] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"254.228301ms","start":"2026-08-24T15:19:21.245876Z","end":"2026-08-24T15:19:21.500104Z","steps":["trace[1854426003] 'process raft request' (duration: 252.908735ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:21.500116Z","caller":"traceutil/trace.go:171","msg":"trace[1167555465] linearizableReadLoop","detail":"{readStateIndex:582; appliedIndex:576; }","duration":"232.970196ms","start":"2026-08-24T15:19:21.26712Z","end":"2026-08-24T15:19:21.500091Z","steps":["trace[1167555465] 'read index received' (duration: 219.173395ms)","trace[1167555465] 'applied index is now lower than readState.Index' (duration: 13.795361ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:21.500223Z","caller":"traceutil/trace.go:171","msg":"trace[666196244] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"233.117479ms","start":"2026-08-24T15:19:21.267092Z","end":"2026-08-24T15:19:21.500209Z","steps":["trace[666196244] 'process raft request' (duration: 231.949044ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:21.500369Z","caller":"traceutil/trace.go:171","msg":"trace[1884921448] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"225.128549ms","start":"2026-08-24T15:19:21.275226Z","end":"2026-08-24T15:19:21.500354Z","steps":["trace[1884921448] 'process raft request' (duration: 223.876573ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:21.500438Z","caller":"traceutil/trace.go:171","msg":"trace[1248116106] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"217.851398ms","start":"2026-08-24T15:19:21.282574Z","end":"2026-08-24T15:19:21.500426Z","steps":["trace[1248116106] 'process raft request' (duration: 216.770554ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:21.500499Z","caller":"traceutil/trace.go:171","msg":"trace[384416055] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"192.920658ms","start":"2026-08-24T15:19:21.307538Z","end":"2026-08-24T15:19:21.500459Z","steps":["trace[384416055] 'process raft request' (duration: 191.969695ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:21.500627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.480883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-24T15:19:21.50069Z","caller":"traceutil/trace.go:171","msg":"trace[826690266] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:561; }","duration":"233.592705ms","start":"2026-08-24T15:19:21.267082Z","end":"2026-08-24T15:19:21.500675Z","steps":["trace[826690266] 'agreement among raft nodes before linearized reading' (duration: 233.441413ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:22.568977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.88168ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-24T15:19:22.569461Z","caller":"traceutil/trace.go:171","msg":"trace[635573353] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"788.669587ms","start":"2026-08-24T15:19:21.780765Z","end":"2026-08-24T15:19:22.569434Z","steps":["trace[635573353] 'process raft request' (duration: 788.380103ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:22.569755Z","caller":"traceutil/trace.go:171","msg":"trace[1036798290] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:623; }","duration":"611.066682ms","start":"2026-08-24T15:19:21.958665Z","end":"2026-08-24T15:19:22.569732Z","steps":["trace[1036798290] 'read index received' (duration: 92.359802ms)","trace[1036798290] 'applied index is now lower than readState.Index' (duration: 518.70627ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:22.569886Z","caller":"traceutil/trace.go:171","msg":"trace[2032385490] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"786.622081ms","start":"2026-08-24T15:19:21.783256Z","end":"2026-08-24T15:19:22.569878Z","steps":["trace[2032385490] 'process raft request' (duration: 786.122895ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:22.569963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:21.783238Z","time spent":"786.670832ms","remote":"127.0.0.1:52226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:19:22.570063Z","caller":"traceutil/trace.go:171","msg":"trace[392149300] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"778.425239ms","start":"2026-08-24T15:19:21.791631Z","end":"2026-08-24T15:19:22.570056Z","steps":["trace[392149300] 'process raft request' (duration: 777.960014ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:22.570046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:21.78074Z","time spent":"788.769309ms","remote":"127.0.0.1:52226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65190,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:19:22.570184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:21.791595Z","time spent":"778.48701ms","remote":"127.0.0.1:52226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:19:22.570286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.619409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:19:22.570298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.030839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-24T15:19:22.570311Z","caller":"traceutil/trace.go:171","msg":"trace[903068161] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"611.685729ms","start":"2026-08-24T15:19:21.958619Z","end":"2026-08-24T15:19:22.570304Z","steps":["trace[903068161] 'agreement among raft nodes before linearized reading' (duration: 611.640719ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:22.57033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:21.958595Z","time spent":"611.731ms","remote":"127.0.0.1:52202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-24T15:19:22.570334Z","caller":"traceutil/trace.go:171","msg":"trace[1797645385] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:597; }","duration":"521.107651ms","start":"2026-08-24T15:19:22.049214Z","end":"2026-08-24T15:19:22.570322Z","steps":["trace[1797645385] 'agreement among raft nodes before linearized reading' (duration: 520.989989ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:22.570368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:22.04919Z","time spent":"521.170902ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-24T15:19:28.917074Z","caller":"traceutil/trace.go:171","msg":"trace[1869986445] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"261.8307ms","start":"2026-08-24T15:19:28.655202Z","end":"2026-08-24T15:19:28.917033Z","steps":["trace[1869986445] 'process raft request' (duration: 244.86953ms)","trace[1869986445] 'compare' (duration: 16.605785ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:29.264596Z","caller":"traceutil/trace.go:171","msg":"trace[1296110890] linearizableReadLoop","detail":"{readStateIndex:684; appliedIndex:683; }","duration":"304.717404ms","start":"2026-08-24T15:19:28.959852Z","end":"2026-08-24T15:19:29.264569Z","steps":["trace[1296110890] 'read index received' (duration: 284.719928ms)","trace[1296110890] 'applied index is now lower than readState.Index' (duration: 19.996486ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:29.264614Z","caller":"traceutil/trace.go:171","msg":"trace[920231510] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"528.443784ms","start":"2026-08-24T15:19:28.736149Z","end":"2026-08-24T15:19:29.264593Z","steps":["trace[920231510] 'process raft request' (duration: 508.68038ms)","trace[920231510] 'compare' (duration: 19.288588ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:19:29.264782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.898997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:19:29.264786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:28.736126Z","time spent":"528.557386ms","remote":"127.0.0.1:52272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:19:29.26487Z","caller":"traceutil/trace.go:171","msg":"trace[52457383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"305.034808ms","start":"2026-08-24T15:19:28.959785Z","end":"2026-08-24T15:19:29.26482Z","steps":["trace[52457383] 'agreement among raft nodes before linearized reading' (duration: 304.873756ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:29.264913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:28.959767Z","time spent":"305.136319ms","remote":"127.0.0.1:52198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-24T15:19:29.588911Z","caller":"traceutil/trace.go:171","msg":"trace[1891794159] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"265.136776ms","start":"2026-08-24T15:19:29.323745Z","end":"2026-08-24T15:19:29.588881Z","steps":["trace[1891794159] 'process raft request' (duration: 264.918324ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:30.943483Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440709412338975,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:19:31.443889Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440709412338975,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:19:31.944851Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440709412338975,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:19:32.445416Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440709412338975,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:19:32.945562Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440709412338975,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:19:33.446462Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440709412338975,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:19:33.869555Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.830707655s","expected-duration":"1s"} {"level":"info","ts":"2026-08-24T15:19:33.870693Z","caller":"traceutil/trace.go:171","msg":"trace[518301586] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"3.83355601s","start":"2026-08-24T15:19:30.037113Z","end":"2026-08-24T15:19:33.870669Z","steps":["trace[518301586] 'process raft request' (duration: 3.832925483s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:33.870878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:30.036736Z","time spent":"3.834054427s","remote":"127.0.0.1:52272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036201,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:19:33.958809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000471207s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-24T15:19:33.958897Z","caller":"traceutil/trace.go:171","msg":"trace[1316268179] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000597418s","start":"2026-08-24T15:19:31.958277Z","end":"2026-08-24T15:19:33.958874Z","steps":["trace[1316268179] 'agreement among raft nodes before linearized reading' (duration: 2.000498057s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:33.958944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:31.958256Z","time spent":"2.000678389s","remote":"127.0.0.1:52202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:19:34.353676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.06087ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-24T15:19:34.353869Z","caller":"traceutil/trace.go:171","msg":"trace[166026291] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"412.825319ms","start":"2026-08-24T15:19:33.94103Z","end":"2026-08-24T15:19:34.353855Z","steps":["trace[166026291] 'process raft request' (duration: 412.743898ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:34.353969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:33.941015Z","time spent":"412.87994ms","remote":"127.0.0.1:52520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:19:34.354064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.911506027s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:19:34.354092Z","caller":"traceutil/trace.go:171","msg":"trace[999437933] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:660; }","duration":"3.911564238s","start":"2026-08-24T15:19:30.442517Z","end":"2026-08-24T15:19:34.354081Z","steps":["trace[999437933] 'agreement among raft nodes before linearized reading' (duration: 3.911501517s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:34.354109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:30.442499Z","time spent":"3.911605249s","remote":"127.0.0.1:52438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-08-24T15:19:34.354211Z","caller":"traceutil/trace.go:171","msg":"trace[1156820604] linearizableReadLoop","detail":"{readStateIndex:691; appliedIndex:689; }","duration":"3.911297845s","start":"2026-08-24T15:19:30.442569Z","end":"2026-08-24T15:19:34.353867Z","steps":["trace[1156820604] 'read index received' (duration: 3.427204733s)","trace[1156820604] 'applied index is now lower than readState.Index' (duration: 484.090382ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:19:34.354423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.863313806s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-24T15:19:34.354459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.71568475s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-24T15:19:34.354488Z","caller":"traceutil/trace.go:171","msg":"trace[989373523] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:660; }","duration":"2.715765502s","start":"2026-08-24T15:19:31.638715Z","end":"2026-08-24T15:19:34.35448Z","steps":["trace[989373523] 'agreement among raft nodes before linearized reading' (duration: 2.7156737s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:34.354504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:31.638704Z","time spent":"2.715796302s","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-24T15:19:34.354506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"880.246153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:19:34.354563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.71074792s","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-08-24T15:19:34.35461Z","caller":"traceutil/trace.go:171","msg":"trace[2134748148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:660; }","duration":"2.710815642s","start":"2026-08-24T15:19:31.643779Z","end":"2026-08-24T15:19:34.354594Z","steps":["trace[2134748148] 'agreement among raft nodes before linearized reading' (duration: 2.71065139s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:34.354547Z","caller":"traceutil/trace.go:171","msg":"trace[1112197434] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:660; }","duration":"3.863431977s","start":"2026-08-24T15:19:30.491044Z","end":"2026-08-24T15:19:34.354476Z","steps":["trace[1112197434] 'agreement among raft nodes before linearized reading' (duration: 3.863308425s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:34.354662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:31.643767Z","time spent":"2.710886143s","remote":"127.0.0.1:52444","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-08-24T15:19:34.354674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.720282126s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-24T15:19:34.3547Z","caller":"traceutil/trace.go:171","msg":"trace[803261080] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:660; }","duration":"3.720353966s","start":"2026-08-24T15:19:30.63434Z","end":"2026-08-24T15:19:34.354694Z","steps":["trace[803261080] 'agreement among raft nodes before linearized reading' (duration: 3.720297675s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:34.354722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:30.63432Z","time spent":"3.720398577s","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-24T15:19:34.354685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:30.491023Z","time spent":"3.863642009s","remote":"127.0.0.1:52596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:19:34.354791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.869497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:19:34.354836Z","caller":"traceutil/trace.go:171","msg":"trace[1970159481] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:660; }","duration":"424.942678ms","start":"2026-08-24T15:19:33.929878Z","end":"2026-08-24T15:19:34.354821Z","steps":["trace[1970159481] 'agreement among raft nodes before linearized reading' (duration: 424.839306ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:34.354614Z","caller":"traceutil/trace.go:171","msg":"trace[557006146] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:660; }","duration":"880.404685ms","start":"2026-08-24T15:19:33.474182Z","end":"2026-08-24T15:19:34.354586Z","steps":["trace[557006146] 'agreement among raft nodes before linearized reading' (duration: 880.189992ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:34.354882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:33.929851Z","time spent":"425.019768ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:19:34.354914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:33.474162Z","time spent":"880.74155ms","remote":"127.0.0.1:52202","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-08-24T15:19:34.354943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.244008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:34.355019Z","caller":"traceutil/trace.go:171","msg":"trace[1537373407] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:660; }","duration":"316.378539ms","start":"2026-08-24T15:19:34.038623Z","end":"2026-08-24T15:19:34.355002Z","steps":["trace[1537373407] 'agreement among raft nodes before linearized reading' (duration: 316.242767ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:34.355055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.07562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:19:34.355076Z","caller":"traceutil/trace.go:171","msg":"trace[336734886] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:660; }","duration":"786.135141ms","start":"2026-08-24T15:19:33.568935Z","end":"2026-08-24T15:19:34.35507Z","steps":["trace[336734886] 'agreement among raft nodes before linearized reading' (duration: 786.041509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:34.355066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:34.038604Z","time spent":"316.45284ms","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:19:34.355092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:33.568914Z","time spent":"786.173651ms","remote":"127.0.0.1:52528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":66,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:19:34.355339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.030064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:34.355363Z","caller":"traceutil/trace.go:171","msg":"trace[792237890] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:660; }","duration":"396.082494ms","start":"2026-08-24T15:19:33.959274Z","end":"2026-08-24T15:19:34.355356Z","steps":["trace[792237890] 'agreement among raft nodes before linearized reading' (duration: 395.098192ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:34.355824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.722056219s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-24T15:19:34.355897Z","caller":"traceutil/trace.go:171","msg":"trace[1512125878] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:660; }","duration":"2.72216112s","start":"2026-08-24T15:19:31.633724Z","end":"2026-08-24T15:19:34.355885Z","steps":["trace[1512125878] 'agreement among raft nodes before linearized reading' (duration: 2.720848194s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:34.356133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:31.633702Z","time spent":"2.722415654s","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-24T15:19:34.357071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:33.959257Z","time spent":"397.732414ms","remote":"127.0.0.1:52198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-24T15:19:35.160967Z","caller":"traceutil/trace.go:171","msg":"trace[260927937] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"107.615524ms","start":"2026-08-24T15:19:35.053327Z","end":"2026-08-24T15:19:35.160942Z","steps":["trace[260927937] 'process raft request' (duration: 107.373211ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:36.181644Z","caller":"traceutil/trace.go:171","msg":"trace[997314800] linearizableReadLoop","detail":"{readStateIndex:710; appliedIndex:709; }","duration":"221.113267ms","start":"2026-08-24T15:19:35.960509Z","end":"2026-08-24T15:19:36.181622Z","steps":["trace[997314800] 'read index received' (duration: 220.128336ms)","trace[997314800] 'applied index is now lower than readState.Index' (duration: 984.121µs)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:19:36.181777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.249479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:36.181796Z","caller":"traceutil/trace.go:171","msg":"trace[736727264] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:678; }","duration":"221.316539ms","start":"2026-08-24T15:19:35.960473Z","end":"2026-08-24T15:19:36.181789Z","steps":["trace[736727264] 'agreement among raft nodes before linearized reading' (duration: 221.260169ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:36.181773Z","caller":"traceutil/trace.go:171","msg":"trace[2039928244] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"311.652852ms","start":"2026-08-24T15:19:35.870056Z","end":"2026-08-24T15:19:36.181708Z","steps":["trace[2039928244] 'process raft request' (duration: 310.720451ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:36.18199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.428396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-24T15:19:36.181971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:35.87002Z","time spent":"311.858635ms","remote":"127.0.0.1:52272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:19:36.182011Z","caller":"traceutil/trace.go:171","msg":"trace[414902220] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:678; }","duration":"205.475676ms","start":"2026-08-24T15:19:35.976531Z","end":"2026-08-24T15:19:36.182006Z","steps":["trace[414902220] 'agreement among raft nodes before linearized reading' (duration: 205.420915ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:37.248781Z","caller":"traceutil/trace.go:171","msg":"trace[530575581] linearizableReadLoop","detail":"{readStateIndex:746; appliedIndex:745; }","duration":"281.367607ms","start":"2026-08-24T15:19:36.967389Z","end":"2026-08-24T15:19:37.248757Z","steps":["trace[530575581] 'read index received' (duration: 278.733635ms)","trace[530575581] 'applied index is now lower than readState.Index' (duration: 2.633082ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:37.24891Z","caller":"traceutil/trace.go:171","msg":"trace[218670984] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"316.438505ms","start":"2026-08-24T15:19:36.932449Z","end":"2026-08-24T15:19:37.248888Z","steps":["trace[218670984] 'process raft request' (duration: 313.794273ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:37.248959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.557689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:37.248997Z","caller":"traceutil/trace.go:171","msg":"trace[1964448082] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:712; }","duration":"281.64506ms","start":"2026-08-24T15:19:36.967339Z","end":"2026-08-24T15:19:37.248984Z","steps":["trace[1964448082] 'agreement among raft nodes before linearized reading' (duration: 281.548449ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:37.249012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:36.932418Z","time spent":"316.538997ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:19:42.888873Z","caller":"traceutil/trace.go:171","msg":"trace[1398295767] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"156.582905ms","start":"2026-08-24T15:19:42.732264Z","end":"2026-08-24T15:19:42.888847Z","steps":["trace[1398295767] 'process raft request' (duration: 156.413043ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:42.995766Z","caller":"traceutil/trace.go:171","msg":"trace[86784050] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"103.31186ms","start":"2026-08-24T15:19:42.892429Z","end":"2026-08-24T15:19:42.995741Z","steps":["trace[86784050] 'process raft request' (duration: 24.985122ms)","trace[86784050] 'compare' (duration: 78.122266ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:44.622305Z","caller":"traceutil/trace.go:171","msg":"trace[924454227] linearizableReadLoop","detail":"{readStateIndex:823; appliedIndex:821; }","duration":"108.012354ms","start":"2026-08-24T15:19:44.514266Z","end":"2026-08-24T15:19:44.622278Z","steps":["trace[924454227] 'read index received' (duration: 44.761341ms)","trace[924454227] 'applied index is now lower than readState.Index' (duration: 63.250063ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:44.62246Z","caller":"traceutil/trace.go:171","msg":"trace[1278122995] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"120.724897ms","start":"2026-08-24T15:19:44.501698Z","end":"2026-08-24T15:19:44.622423Z","steps":["trace[1278122995] 'process raft request' (duration: 89.815194ms)","trace[1278122995] 'compare' (duration: 30.64738ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:19:44.622577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.290678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-24T15:19:44.622627Z","caller":"traceutil/trace.go:171","msg":"trace[422651085] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:787; }","duration":"108.392569ms","start":"2026-08-24T15:19:44.51422Z","end":"2026-08-24T15:19:44.622613Z","steps":["trace[422651085] 'agreement among raft nodes before linearized reading' (duration: 108.230156ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:46.56253Z","caller":"traceutil/trace.go:171","msg":"trace[220803689] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"499.234482ms","start":"2026-08-24T15:19:46.06327Z","end":"2026-08-24T15:19:46.562504Z","steps":["trace[220803689] 'process raft request' (duration: 499.081ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:46.562678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.385842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-24T15:19:46.562716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:46.063248Z","time spent":"499.377033ms","remote":"127.0.0.1:52360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18698,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:19:46.562782Z","caller":"traceutil/trace.go:171","msg":"trace[1042849765] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:795; }","duration":"107.540325ms","start":"2026-08-24T15:19:46.455225Z","end":"2026-08-24T15:19:46.562765Z","steps":["trace[1042849765] 'agreement among raft nodes before linearized reading' (duration: 107.371123ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:46.562553Z","caller":"traceutil/trace.go:171","msg":"trace[1517018601] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:831; }","duration":"107.244991ms","start":"2026-08-24T15:19:46.455275Z","end":"2026-08-24T15:19:46.56252Z","steps":["trace[1517018601] 'read index received' (duration: 107.235941ms)","trace[1517018601] 'applied index is now lower than readState.Index' (duration: 7.56µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:46.617971Z","caller":"traceutil/trace.go:171","msg":"trace[1377687328] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"136.99161ms","start":"2026-08-24T15:19:46.480924Z","end":"2026-08-24T15:19:46.617916Z","steps":["trace[1377687328] 'process raft request' (duration: 136.858798ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:46.894291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.973395ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:19:46.894472Z","caller":"traceutil/trace.go:171","msg":"trace[817441370] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"264.524956ms","start":"2026-08-24T15:19:46.629926Z","end":"2026-08-24T15:19:46.894451Z","steps":["trace[817441370] 'process raft request' (duration: 134.312737ms)","trace[817441370] 'compare' (duration: 129.790873ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:46.951514Z","caller":"traceutil/trace.go:171","msg":"trace[2012819954] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:832; }","duration":"306.738394ms","start":"2026-08-24T15:19:46.64475Z","end":"2026-08-24T15:19:46.951489Z","steps":["trace[2012819954] 'read index received' (duration: 119.498989ms)","trace[2012819954] 'applied index is now lower than readState.Index' (duration: 187.238455ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:46.951635Z","caller":"traceutil/trace.go:171","msg":"trace[1255911021] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"318.0253ms","start":"2026-08-24T15:19:46.633566Z","end":"2026-08-24T15:19:46.951591Z","steps":["trace[1255911021] 'process raft request' (duration: 317.789567ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:46.951735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.964026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-24T15:19:46.951809Z","caller":"traceutil/trace.go:171","msg":"trace[2061862843] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:798; }","duration":"307.077338ms","start":"2026-08-24T15:19:46.644719Z","end":"2026-08-24T15:19:46.951797Z","steps":["trace[2061862843] 'agreement among raft nodes before linearized reading' (duration: 306.874175ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:46.951796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:46.633549Z","time spent":"318.170832ms","remote":"127.0.0.1:52360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:19:46.951855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:46.644708Z","time spent":"307.139918ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-24T15:19:46.952053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.179302ms","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-08-24T15:19:46.952142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.273451ms","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-08-24T15:19:46.952181Z","caller":"traceutil/trace.go:171","msg":"trace[1055528269] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"298.345162ms","start":"2026-08-24T15:19:46.65383Z","end":"2026-08-24T15:19:46.952175Z","steps":["trace[1055528269] 'agreement among raft nodes before linearized reading' (duration: 298.270221ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:46.952204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.007808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.219\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-24T15:19:46.952142Z","caller":"traceutil/trace.go:171","msg":"trace[1032705046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:798; }","duration":"299.296544ms","start":"2026-08-24T15:19:46.652831Z","end":"2026-08-24T15:19:46.952127Z","steps":["trace[1032705046] 'agreement among raft nodes before linearized reading' (duration: 299.101172ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:46.952254Z","caller":"traceutil/trace.go:171","msg":"trace[1235706876] range","detail":"{range_begin:/registry/masterleases/199.19.213.219; range_end:; response_count:1; response_revision:798; }","duration":"288.074419ms","start":"2026-08-24T15:19:46.664167Z","end":"2026-08-24T15:19:46.952241Z","steps":["trace[1235706876] 'agreement among raft nodes before linearized reading' (duration: 287.921247ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:47.29808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.457302ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-08-24T15:19:47.298183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:46.958976Z","time spent":"339.203811ms","remote":"127.0.0.1:52212","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-24T15:19:47.343572Z","caller":"traceutil/trace.go:171","msg":"trace[1588512419] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"382.630563ms","start":"2026-08-24T15:19:46.960916Z","end":"2026-08-24T15:19:47.343546Z","steps":["trace[1588512419] 'process raft request' (duration: 382.4336ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:47.343752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:46.960896Z","time spent":"382.755584ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:19:47.344133Z","caller":"traceutil/trace.go:171","msg":"trace[1712386554] linearizableReadLoop","detail":"{readStateIndex:839; appliedIndex:834; }","duration":"380.978022ms","start":"2026-08-24T15:19:46.963136Z","end":"2026-08-24T15:19:47.344114Z","steps":["trace[1712386554] 'read index received' (duration: 45.464337ms)","trace[1712386554] 'applied index is now lower than readState.Index' (duration: 335.512815ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:47.344182Z","caller":"traceutil/trace.go:171","msg":"trace[1945934015] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"383.168719ms","start":"2026-08-24T15:19:46.960984Z","end":"2026-08-24T15:19:47.344153Z","steps":["trace[1945934015] 'process raft request' (duration: 382.514371ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:47.344223Z","caller":"traceutil/trace.go:171","msg":"trace[1233656089] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"381.206156ms","start":"2026-08-24T15:19:46.963004Z","end":"2026-08-24T15:19:47.34421Z","steps":["trace[1233656089] 'process raft request' (duration: 380.825061ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:47.344292Z","caller":"traceutil/trace.go:171","msg":"trace[979350645] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"381.274196ms","start":"2026-08-24T15:19:46.963005Z","end":"2026-08-24T15:19:47.344279Z","steps":["trace[979350645] 'process raft request' (duration: 380.71705ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:47.344305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:46.96098Z","time spent":"383.25584ms","remote":"127.0.0.1:52444","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-08-24T15:19:47.344321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.162744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:19:47.34436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:46.96299Z","time spent":"381.336957ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:19:47.344397Z","caller":"traceutil/trace.go:171","msg":"trace[959893627] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"381.251245ms","start":"2026-08-24T15:19:46.96311Z","end":"2026-08-24T15:19:47.344361Z","steps":["trace[959893627] 'agreement among raft nodes before linearized reading' (duration: 381.127924ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:47.344313Z","caller":"traceutil/trace.go:171","msg":"trace[936937597] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"375.311754ms","start":"2026-08-24T15:19:46.968924Z","end":"2026-08-24T15:19:47.344236Z","steps":["trace[936937597] 'process raft request' (duration: 374.9932ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:47.344387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:46.962987Z","time spent":"381.305176ms","remote":"127.0.0.1:52350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4177,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:19:47.344449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:46.963105Z","time spent":"381.337156ms","remote":"127.0.0.1:52202","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-08-24T15:19:47.344542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:46.968905Z","time spent":"375.555967ms","remote":"127.0.0.1:52650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:19:47.352147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.879215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:19:47.352202Z","caller":"traceutil/trace.go:171","msg":"trace[27874684] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:804; }","duration":"229.942886ms","start":"2026-08-24T15:19:47.122246Z","end":"2026-08-24T15:19:47.352189Z","steps":["trace[27874684] 'agreement among raft nodes before linearized reading' (duration: 229.813934ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:47.352243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.004657ms","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-08-24T15:19:47.352382Z","caller":"traceutil/trace.go:171","msg":"trace[369177962] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:804; }","duration":"334.136859ms","start":"2026-08-24T15:19:47.018172Z","end":"2026-08-24T15:19:47.352309Z","steps":["trace[369177962] 'agreement among raft nodes before linearized reading' (duration: 333.911526ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:47.352432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:47.018153Z","time spent":"334.26914ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-24T15:19:47.649503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.034575ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:19:47.649686Z","caller":"traceutil/trace.go:171","msg":"trace[1838427063] linearizableReadLoop","detail":"{readStateIndex:843; appliedIndex:841; }","duration":"297.62886ms","start":"2026-08-24T15:19:47.352037Z","end":"2026-08-24T15:19:47.649666Z","steps":["trace[1838427063] 'read index received' (duration: 112.334201ms)","trace[1838427063] 'applied index is now lower than readState.Index' (duration: 185.293659ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:47.649792Z","caller":"traceutil/trace.go:171","msg":"trace[1355514407] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"302.251076ms","start":"2026-08-24T15:19:47.347446Z","end":"2026-08-24T15:19:47.649697Z","steps":["trace[1355514407] 'process raft request' (duration: 116.912997ms)","trace[1355514407] 'compare' (duration: 184.837153ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:47.64997Z","caller":"traceutil/trace.go:171","msg":"trace[165551834] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"298.273537ms","start":"2026-08-24T15:19:47.351679Z","end":"2026-08-24T15:19:47.649952Z","steps":["trace[165551834] 'process raft request' (duration: 297.920733ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:47.650004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.638241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:47.650052Z","caller":"traceutil/trace.go:171","msg":"trace[1280986025] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:806; }","duration":"303.711813ms","start":"2026-08-24T15:19:47.346325Z","end":"2026-08-24T15:19:47.650037Z","steps":["trace[1280986025] 'agreement among raft nodes before linearized reading' (duration: 303.636212ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:47.650103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:47.346313Z","time spent":"303.778904ms","remote":"127.0.0.1:52198","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-08-24T15:19:47.650395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:47.347434Z","time spent":"302.466788ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:19:47.74549Z","caller":"traceutil/trace.go:171","msg":"trace[1505339362] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"388.596134ms","start":"2026-08-24T15:19:47.356867Z","end":"2026-08-24T15:19:47.745463Z","steps":["trace[1505339362] 'process raft request' (duration: 388.23001ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:47.745626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:47.356857Z","time spent":"388.691825ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:19:47.745572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.058486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-08-24T15:19:47.74577Z","caller":"traceutil/trace.go:171","msg":"trace[119126794] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:807; }","duration":"392.271019ms","start":"2026-08-24T15:19:47.353432Z","end":"2026-08-24T15:19:47.745703Z","steps":["trace[119126794] 'agreement among raft nodes before linearized reading' (duration: 391.963375ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:47.745872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:47.353413Z","time spent":"392.44143ms","remote":"127.0.0.1:52344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-08-24T15:19:48.914024Z","caller":"traceutil/trace.go:171","msg":"trace[2061944929] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"123.512694ms","start":"2026-08-24T15:19:48.790479Z","end":"2026-08-24T15:19:48.913992Z","steps":["trace[2061944929] 'process raft request' (duration: 123.258241ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:50.311147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.920572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:50.311226Z","caller":"traceutil/trace.go:171","msg":"trace[1143349546] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:823; }","duration":"324.046024ms","start":"2026-08-24T15:19:49.987163Z","end":"2026-08-24T15:19:50.311209Z","steps":["trace[1143349546] 'range keys from in-memory index tree' (duration: 323.805371ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:50.311501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:49.987095Z","time spent":"324.389468ms","remote":"127.0.0.1:52202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-24T15:19:53.028122Z","caller":"traceutil/trace.go:171","msg":"trace[1024354707] transaction","detail":"{read_only:false; response_revision:835; number_of_response:1; }","duration":"142.010319ms","start":"2026-08-24T15:19:52.886085Z","end":"2026-08-24T15:19:53.028095Z","steps":["trace[1024354707] 'process raft request' (duration: 136.110769ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:54.617057Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440709412339341,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:19:55.128316Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440709412339341,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:19:55.629255Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440709412339341,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:19:56.116465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00031403s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-24T15:19:56.11654Z","caller":"traceutil/trace.go:171","msg":"trace[1788516091] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000429401s","start":"2026-08-24T15:19:54.116095Z","end":"2026-08-24T15:19:56.116524Z","steps":["trace[1788516091] 'agreement among raft nodes before linearized reading' (duration: 2.00033234s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.116579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.116081Z","time spent":"2.000490452s","remote":"127.0.0.1:52198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:19:56.129988Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440709412339341,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:19:56.500668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.128550724s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-24T15:19:56.500753Z","caller":"traceutil/trace.go:171","msg":"trace[1100024967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:840; }","duration":"3.128663105s","start":"2026-08-24T15:19:53.372065Z","end":"2026-08-24T15:19:56.500728Z","steps":["trace[1100024967] 'range keys from in-memory index tree' (duration: 3.128393552s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.500823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:53.372051Z","time spent":"3.128753696s","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-24T15:19:56.500809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.140163678s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.500891Z","caller":"traceutil/trace.go:171","msg":"trace[772306470] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:840; }","duration":"1.140250649s","start":"2026-08-24T15:19:55.360628Z","end":"2026-08-24T15:19:56.500878Z","steps":["trace[772306470] 'range keys from in-memory index tree' (duration: 1.140149928s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.501255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.121031334s","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-08-24T15:19:56.501307Z","caller":"traceutil/trace.go:171","msg":"trace[926398302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:840; }","duration":"3.121082714s","start":"2026-08-24T15:19:53.380208Z","end":"2026-08-24T15:19:56.50129Z","steps":["trace[926398302] 'range keys from in-memory index tree' (duration: 3.120911532s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.501339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:53.38016Z","time spent":"3.121170525s","remote":"127.0.0.1:52444","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-08-24T15:19:56.501359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.387184996s","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-08-24T15:19:56.501394Z","caller":"traceutil/trace.go:171","msg":"trace[1569082445] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:840; }","duration":"2.387246998s","start":"2026-08-24T15:19:54.114136Z","end":"2026-08-24T15:19:56.501383Z","steps":["trace[1569082445] 'range keys from in-memory index tree' (duration: 2.387094156s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.501421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.114122Z","time spent":"2.387293058s","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-24T15:19:56.501499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.949666147s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:19:56.501549Z","caller":"traceutil/trace.go:171","msg":"trace[799186249] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:840; }","duration":"2.949740807s","start":"2026-08-24T15:19:53.551799Z","end":"2026-08-24T15:19:56.501539Z","steps":["trace[799186249] 'count revisions from in-memory index tree' (duration: 2.949613956s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.501549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.121087304s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-24T15:19:56.501626Z","caller":"traceutil/trace.go:171","msg":"trace[545632880] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:840; }","duration":"3.121193595s","start":"2026-08-24T15:19:53.38041Z","end":"2026-08-24T15:19:56.501604Z","steps":["trace[545632880] 'range keys from in-memory index tree' (duration: 3.120916343s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.501638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.027981422s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.501672Z","caller":"traceutil/trace.go:171","msg":"trace[1810362070] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:840; }","duration":"3.028053683s","start":"2026-08-24T15:19:53.473609Z","end":"2026-08-24T15:19:56.501663Z","steps":["trace[1810362070] 'range keys from in-memory index tree' (duration: 3.027893581s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.501672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:53.380404Z","time spent":"3.121257007s","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-24T15:19:56.501697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:53.473585Z","time spent":"3.028106393s","remote":"127.0.0.1:52202","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-08-24T15:19:56.501578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:53.551786Z","time spent":"2.949783278s","remote":"127.0.0.1:52280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":13,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:19:56.630441Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440709412339341,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:19:56.869504Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.754039045s","expected-duration":"1s"} {"level":"info","ts":"2026-08-24T15:19:56.86993Z","caller":"traceutil/trace.go:171","msg":"trace[721672816] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"2.754528601s","start":"2026-08-24T15:19:54.115378Z","end":"2026-08-24T15:19:56.869906Z","steps":["trace[721672816] 'process raft request' (duration: 2.754355209s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.870269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.115361Z","time spent":"2.754631494s","remote":"127.0.0.1:52424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:19:56.885991Z","caller":"traceutil/trace.go:171","msg":"trace[892612732] linearizableReadLoop","detail":"{readStateIndex:884; appliedIndex:878; }","duration":"2.769845225s","start":"2026-08-24T15:19:54.116129Z","end":"2026-08-24T15:19:56.885974Z","steps":["trace[892612732] 'read index received' (duration: 2.753693402s)","trace[892612732] 'applied index is now lower than readState.Index' (duration: 16.151123ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:56.8861Z","caller":"traceutil/trace.go:171","msg":"trace[661467227] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"380.440171ms","start":"2026-08-24T15:19:56.505654Z","end":"2026-08-24T15:19:56.886094Z","steps":["trace[661467227] 'process raft request' (duration: 380.223429ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.886179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:56.505629Z","time spent":"380.488152ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:19:56.886253Z","caller":"traceutil/trace.go:171","msg":"trace[1247268261] transaction","detail":"{read_only:false; response_revision:842; number_of_response:1; }","duration":"1.342453465s","start":"2026-08-24T15:19:55.543774Z","end":"2026-08-24T15:19:56.886228Z","steps":["trace[1247268261] 'process raft request' (duration: 1.34200662s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.886367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:55.543755Z","time spent":"1.342557566s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:19:56.886362Z","caller":"traceutil/trace.go:171","msg":"trace[995707591] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"378.211465ms","start":"2026-08-24T15:19:56.508115Z","end":"2026-08-24T15:19:56.886327Z","steps":["trace[995707591] 'process raft request' (duration: 377.838531ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.886413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.611331712s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.886439Z","caller":"traceutil/trace.go:171","msg":"trace[1191454023] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:846; }","duration":"2.611359202s","start":"2026-08-24T15:19:54.275074Z","end":"2026-08-24T15:19:56.886433Z","steps":["trace[1191454023] 'agreement among raft nodes before linearized reading' (duration: 2.611318022s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.886457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.275035Z","time spent":"2.611417403s","remote":"127.0.0.1:41944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-08-24T15:19:56.886552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:56.508106Z","time spent":"378.310456ms","remote":"127.0.0.1:52444","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-08-24T15:19:56.886658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.138536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.219\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-24T15:19:56.886691Z","caller":"traceutil/trace.go:171","msg":"trace[1972713402] range","detail":"{range_begin:/registry/masterleases/199.19.213.219; range_end:; response_count:1; response_revision:846; }","duration":"222.169716ms","start":"2026-08-24T15:19:56.664512Z","end":"2026-08-24T15:19:56.886682Z","steps":["trace[1972713402] 'agreement among raft nodes before linearized reading' (duration: 222.075225ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:56.886657Z","caller":"traceutil/trace.go:171","msg":"trace[1845600395] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"379.52968ms","start":"2026-08-24T15:19:56.507115Z","end":"2026-08-24T15:19:56.886644Z","steps":["trace[1845600395] 'process raft request' (duration: 378.795841ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.886804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.36898606s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:19:56.886825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:56.507096Z","time spent":"379.62185ms","remote":"127.0.0.1:52444","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-08-24T15:19:56.886853Z","caller":"traceutil/trace.go:171","msg":"trace[275979397] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:846; }","duration":"2.369043631s","start":"2026-08-24T15:19:54.517798Z","end":"2026-08-24T15:19:56.886842Z","steps":["trace[275979397] 'agreement among raft nodes before linearized reading' (duration: 2.368961949s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.886887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.517762Z","time spent":"2.369116601s","remote":"127.0.0.1:41976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:19:56.887049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.369349684s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:19:56.886961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.324130615s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:19:56.887077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.337749837s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:19:56.887098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.36981691s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.887085Z","caller":"traceutil/trace.go:171","msg":"trace[452750823] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"379.506601ms","start":"2026-08-24T15:19:56.507563Z","end":"2026-08-24T15:19:56.88707Z","steps":["trace[452750823] 'process raft request' (duration: 378.369026ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:56.887113Z","caller":"traceutil/trace.go:171","msg":"trace[34977790] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:846; }","duration":"2.3698457s","start":"2026-08-24T15:19:54.517264Z","end":"2026-08-24T15:19:56.887109Z","steps":["trace[34977790] 'agreement among raft nodes before linearized reading' (duration: 2.36982234s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:56.887106Z","caller":"traceutil/trace.go:171","msg":"trace[1228799128] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:846; }","duration":"2.337828179s","start":"2026-08-24T15:19:54.54927Z","end":"2026-08-24T15:19:56.887098Z","steps":["trace[1228799128] 'agreement among raft nodes before linearized reading' (duration: 2.337777948s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.88713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.517256Z","time spent":"2.36987041s","remote":"127.0.0.1:41976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 "} {"level":"warn","ts":"2026-08-24T15:19:56.887138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.549258Z","time spent":"2.337871769s","remote":"127.0.0.1:41986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "} {"level":"warn","ts":"2026-08-24T15:19:56.887159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:56.507556Z","time spent":"379.566051ms","remote":"127.0.0.1:52444","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-08-24T15:19:56.887242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.385007801s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.887109Z","caller":"traceutil/trace.go:171","msg":"trace[130938803] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:846; }","duration":"2.324307147s","start":"2026-08-24T15:19:54.562785Z","end":"2026-08-24T15:19:56.887092Z","steps":["trace[130938803] 'agreement among raft nodes before linearized reading' (duration: 2.324134835s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.887273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.338941821s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:19:56.8873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.385659799s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.887313Z","caller":"traceutil/trace.go:171","msg":"trace[1360381457] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:846; }","duration":"2.385688219s","start":"2026-08-24T15:19:54.501621Z","end":"2026-08-24T15:19:56.88731Z","steps":["trace[1360381457] 'agreement among raft nodes before linearized reading' (duration: 2.385670369s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:56.88731Z","caller":"traceutil/trace.go:171","msg":"trace[379069489] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:846; }","duration":"2.338991292s","start":"2026-08-24T15:19:54.54831Z","end":"2026-08-24T15:19:56.887302Z","steps":["trace[379069489] 'agreement among raft nodes before linearized reading' (duration: 2.338941992s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.887327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.501609Z","time spent":"2.38571497s","remote":"127.0.0.1:41960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-08-24T15:19:56.88734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.548303Z","time spent":"2.339029753s","remote":"127.0.0.1:41986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "} {"level":"warn","ts":"2026-08-24T15:19:56.88737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.848086284s","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-08-24T15:19:56.887409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.511875835s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:19:56.887341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.56277Z","time spent":"2.324507079s","remote":"127.0.0.1:42002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"info","ts":"2026-08-24T15:19:56.887427Z","caller":"traceutil/trace.go:171","msg":"trace[324788395] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:846; }","duration":"2.511924407s","start":"2026-08-24T15:19:54.375496Z","end":"2026-08-24T15:19:56.88742Z","steps":["trace[324788395] 'agreement among raft nodes before linearized reading' (duration: 2.511901516s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:56.887427Z","caller":"traceutil/trace.go:171","msg":"trace[1162615376] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:846; }","duration":"1.848163384s","start":"2026-08-24T15:19:55.039248Z","end":"2026-08-24T15:19:56.887412Z","steps":["trace[1162615376] 'agreement among raft nodes before linearized reading' (duration: 1.847991422s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.887454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.375482Z","time spent":"2.511962507s","remote":"127.0.0.1:41958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-08-24T15:19:56.887441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.324275397s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:19:56.887474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:55.039226Z","time spent":"1.848236685s","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-24T15:19:56.88749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.339168114s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.887519Z","caller":"traceutil/trace.go:171","msg":"trace[1888618041] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:846; }","duration":"2.324348977s","start":"2026-08-24T15:19:54.563134Z","end":"2026-08-24T15:19:56.887483Z","steps":["trace[1888618041] 'agreement among raft nodes before linearized reading' (duration: 2.324247756s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.887551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.512031718s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.887569Z","caller":"traceutil/trace.go:171","msg":"trace[1214211624] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:846; }","duration":"2.512073438s","start":"2026-08-24T15:19:54.37549Z","end":"2026-08-24T15:19:56.887564Z","steps":["trace[1214211624] 'agreement among raft nodes before linearized reading' (duration: 2.512042938s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.887583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.375472Z","time spent":"2.512106998s","remote":"127.0.0.1:41958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-08-24T15:19:56.88758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.355167875s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:19:56.887586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.563128Z","time spent":"2.324440458s","remote":"127.0.0.1:42002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "} {"level":"info","ts":"2026-08-24T15:19:56.887618Z","caller":"traceutil/trace.go:171","msg":"trace[1997643666] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:846; }","duration":"2.355215596s","start":"2026-08-24T15:19:54.532391Z","end":"2026-08-24T15:19:56.887607Z","steps":["trace[1997643666] 'agreement among raft nodes before linearized reading' (duration: 2.355161585s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.887651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.532385Z","time spent":"2.355257236s","remote":"127.0.0.1:41980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "} {"level":"warn","ts":"2026-08-24T15:19:56.887669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.512383841s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.887696Z","caller":"traceutil/trace.go:171","msg":"trace[646247546] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:846; }","duration":"2.512434013s","start":"2026-08-24T15:19:54.375256Z","end":"2026-08-24T15:19:56.88769Z","steps":["trace[646247546] 'agreement among raft nodes before linearized reading' (duration: 2.512395952s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.887713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.37524Z","time spent":"2.512467333s","remote":"127.0.0.1:41958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:19:56.887704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.958527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-24T15:19:56.887718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.192641886s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.887754Z","caller":"traceutil/trace.go:171","msg":"trace[1331654711] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:846; }","duration":"297.049358ms","start":"2026-08-24T15:19:56.59069Z","end":"2026-08-24T15:19:56.88774Z","steps":["trace[1331654711] 'agreement among raft nodes before linearized reading' (duration: 296.959927ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.887787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.612264964s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.887803Z","caller":"traceutil/trace.go:171","msg":"trace[1021841007] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:846; }","duration":"2.612308565s","start":"2026-08-24T15:19:54.27549Z","end":"2026-08-24T15:19:56.887798Z","steps":["trace[1021841007] 'agreement among raft nodes before linearized reading' (duration: 2.612283555s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.887817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.275475Z","time spent":"2.612339195s","remote":"127.0.0.1:41944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-08-24T15:19:56.887872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.324962485s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:19:56.887914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.61281944s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.887951Z","caller":"traceutil/trace.go:171","msg":"trace[1676911526] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:846; }","duration":"2.325057486s","start":"2026-08-24T15:19:54.562881Z","end":"2026-08-24T15:19:56.887938Z","steps":["trace[1676911526] 'agreement among raft nodes before linearized reading' (duration: 2.324951724s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:56.887961Z","caller":"traceutil/trace.go:171","msg":"trace[1594097811] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:846; }","duration":"2.612889822s","start":"2026-08-24T15:19:54.275059Z","end":"2026-08-24T15:19:56.887949Z","steps":["trace[1594097811] 'agreement among raft nodes before linearized reading' (duration: 2.612816561s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.888013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.275048Z","time spent":"2.612942462s","remote":"127.0.0.1:41944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:19:56.888024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.562871Z","time spent":"2.325111506s","remote":"127.0.0.1:42002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "} {"level":"info","ts":"2026-08-24T15:19:56.887077Z","caller":"traceutil/trace.go:171","msg":"trace[884536647] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:846; }","duration":"2.369398005s","start":"2026-08-24T15:19:54.517672Z","end":"2026-08-24T15:19:56.88707Z","steps":["trace[884536647] 'agreement among raft nodes before linearized reading' (duration: 2.369355254s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.888246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.517658Z","time spent":"2.370573609s","remote":"127.0.0.1:41976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 "} {"level":"info","ts":"2026-08-24T15:19:56.887756Z","caller":"traceutil/trace.go:171","msg":"trace[1381567934] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:846; }","duration":"2.192711056s","start":"2026-08-24T15:19:54.695034Z","end":"2026-08-24T15:19:56.887745Z","steps":["trace[1381567934] 'agreement among raft nodes before linearized reading' (duration: 2.192653816s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:19:56.887259Z","caller":"traceutil/trace.go:171","msg":"trace[917761099] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:846; }","duration":"2.385041323s","start":"2026-08-24T15:19:54.502213Z","end":"2026-08-24T15:19:56.887255Z","steps":["trace[917761099] 'agreement among raft nodes before linearized reading' (duration: 2.385012012s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.888466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.695017Z","time spent":"2.193436365s","remote":"127.0.0.1:52638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:19:56.888521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.502207Z","time spent":"2.386288407s","remote":"127.0.0.1:41960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"info","ts":"2026-08-24T15:19:56.88753Z","caller":"traceutil/trace.go:171","msg":"trace[1335488379] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:846; }","duration":"2.339235325s","start":"2026-08-24T15:19:54.548282Z","end":"2026-08-24T15:19:56.887517Z","steps":["trace[1335488379] 'agreement among raft nodes before linearized reading' (duration: 2.339177104s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.889269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.548265Z","time spent":"2.340986605s","remote":"127.0.0.1:41986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:19:56.889847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.358235991s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.889918Z","caller":"traceutil/trace.go:171","msg":"trace[1595672737] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:846; }","duration":"2.358329303s","start":"2026-08-24T15:19:54.531572Z","end":"2026-08-24T15:19:56.889901Z","steps":["trace[1595672737] 'agreement among raft nodes before linearized reading' (duration: 2.358219442s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.890205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.531563Z","time spent":"2.358618497s","remote":"127.0.0.1:41980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-08-24T15:19:56.888302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.356657463s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.890713Z","caller":"traceutil/trace.go:171","msg":"trace[365980333] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:846; }","duration":"2.359078241s","start":"2026-08-24T15:19:54.53162Z","end":"2026-08-24T15:19:56.890698Z","steps":["trace[365980333] 'agreement among raft nodes before linearized reading' (duration: 2.356645052s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.890793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.531616Z","time spent":"2.359160152s","remote":"127.0.0.1:41980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:19:56.887281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.385196914s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.890837Z","caller":"traceutil/trace.go:171","msg":"trace[1904117852] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:846; }","duration":"2.388762696s","start":"2026-08-24T15:19:54.502062Z","end":"2026-08-24T15:19:56.890825Z","steps":["trace[1904117852] 'agreement among raft nodes before linearized reading' (duration: 2.385205114s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.890865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:54.502053Z","time spent":"2.388803406s","remote":"127.0.0.1:41960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:19:56.888133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.097427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:56.891291Z","caller":"traceutil/trace.go:171","msg":"trace[907569416] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:846; }","duration":"765.279195ms","start":"2026-08-24T15:19:56.125993Z","end":"2026-08-24T15:19:56.891273Z","steps":["trace[907569416] 'agreement among raft nodes before linearized reading' (duration: 762.057187ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:56.891438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:19:56.125979Z","time spent":"765.402896ms","remote":"127.0.0.1:52202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-24T15:19:57.003402Z","caller":"traceutil/trace.go:171","msg":"trace[1266549821] linearizableReadLoop","detail":"{readStateIndex:885; appliedIndex:884; }","duration":"112.689842ms","start":"2026-08-24T15:19:56.890681Z","end":"2026-08-24T15:19:57.00337Z","steps":["trace[1266549821] 'read index received' (duration: 463.636µs)","trace[1266549821] 'applied index is now lower than readState.Index' (duration: 112.223416ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:19:57.00356Z","caller":"traceutil/trace.go:171","msg":"trace[2042211728] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"108.214788ms","start":"2026-08-24T15:19:56.895329Z","end":"2026-08-24T15:19:57.003544Z","steps":["trace[2042211728] 'process raft request' (duration: 107.889605ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:57.003622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.629644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:19:57.003684Z","caller":"traceutil/trace.go:171","msg":"trace[905003476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:847; }","duration":"108.725475ms","start":"2026-08-24T15:19:56.894943Z","end":"2026-08-24T15:19:57.003669Z","steps":["trace[905003476] 'agreement among raft nodes before linearized reading' (duration: 108.592043ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:19:57.003723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.034316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18cec6e199a32b11\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-08-24T15:19:57.003794Z","caller":"traceutil/trace.go:171","msg":"trace[2116275373] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18cec6e199a32b11; range_end:; response_count:1; response_revision:847; }","duration":"113.143978ms","start":"2026-08-24T15:19:56.890611Z","end":"2026-08-24T15:19:57.003755Z","steps":["trace[2116275373] 'agreement among raft nodes before linearized reading' (duration: 112.901515ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:20:04.383521Z","caller":"traceutil/trace.go:171","msg":"trace[1850443276] linearizableReadLoop","detail":"{readStateIndex:965; appliedIndex:964; }","duration":"126.382334ms","start":"2026-08-24T15:20:04.257117Z","end":"2026-08-24T15:20:04.3835Z","steps":["trace[1850443276] 'read index received' (duration: 126.200372ms)","trace[1850443276] 'applied index is now lower than readState.Index' (duration: 181.052µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:20:04.383586Z","caller":"traceutil/trace.go:171","msg":"trace[992813942] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"150.049354ms","start":"2026-08-24T15:20:04.233507Z","end":"2026-08-24T15:20:04.383556Z","steps":["trace[992813942] 'process raft request' (duration: 149.859652ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:20:04.383805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.518335ms","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-08-24T15:20:04.383855Z","caller":"traceutil/trace.go:171","msg":"trace[364694829] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:925; }","duration":"126.760239ms","start":"2026-08-24T15:20:04.257083Z","end":"2026-08-24T15:20:04.383843Z","steps":["trace[364694829] 'agreement among raft nodes before linearized reading' (duration: 126.524816ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:20:25.279745Z","caller":"traceutil/trace.go:171","msg":"trace[513813299] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"123.03728ms","start":"2026-08-24T15:20:25.156672Z","end":"2026-08-24T15:20:25.279709Z","steps":["trace[513813299] 'process raft request' (duration: 75.291884ms)","trace[513813299] 'compare' (duration: 47.37439ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:20:25.513413Z","caller":"traceutil/trace.go:171","msg":"trace[1432747718] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"229.445628ms","start":"2026-08-24T15:20:25.283933Z","end":"2026-08-24T15:20:25.513378Z","steps":["trace[1432747718] 'process raft request' (duration: 180.814974ms)","trace[1432747718] 'compare' (duration: 48.491438ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:20:27.34894Z","caller":"traceutil/trace.go:171","msg":"trace[2002109937] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"129.645891ms","start":"2026-08-24T15:20:27.219268Z","end":"2026-08-24T15:20:27.348914Z","steps":["trace[2002109937] 'read index received' (duration: 74.649544ms)","trace[2002109937] 'applied index is now lower than readState.Index' (duration: 54.990406ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:20:27.349027Z","caller":"traceutil/trace.go:171","msg":"trace[265451583] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"156.821051ms","start":"2026-08-24T15:20:27.192172Z","end":"2026-08-24T15:20:27.348993Z","steps":["trace[265451583] 'process raft request' (duration: 101.74561ms)","trace[265451583] 'compare' (duration: 54.882952ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:20:27.349203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.918663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-24T15:20:27.349245Z","caller":"traceutil/trace.go:171","msg":"trace[1048378480] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1073; }","duration":"130.007687ms","start":"2026-08-24T15:20:27.219226Z","end":"2026-08-24T15:20:27.349233Z","steps":["trace[1048378480] 'agreement among raft nodes before linearized reading' (duration: 129.817899ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:20:27.530354Z","caller":"traceutil/trace.go:171","msg":"trace[2085015242] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"175.689612ms","start":"2026-08-24T15:20:27.354622Z","end":"2026-08-24T15:20:27.530312Z","steps":["trace[2085015242] 'process raft request' (duration: 131.844176ms)","trace[2085015242] 'compare' (duration: 43.634727ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:20:27.558043Z","caller":"traceutil/trace.go:171","msg":"trace[2137369425] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"203.117603ms","start":"2026-08-24T15:20:27.354905Z","end":"2026-08-24T15:20:27.558022Z","steps":["trace[2137369425] 'process raft request' (duration: 202.678285ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:20:43.776745Z","caller":"traceutil/trace.go:171","msg":"trace[1951786716] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"137.908562ms","start":"2026-08-24T15:20:43.638823Z","end":"2026-08-24T15:20:43.776731Z","steps":["trace[1951786716] 'process raft request' (duration: 136.375151ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:21:15.558907Z","caller":"traceutil/trace.go:171","msg":"trace[1260154734] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"136.174314ms","start":"2026-08-24T15:21:15.422702Z","end":"2026-08-24T15:21:15.558876Z","steps":["trace[1260154734] 'process raft request' (duration: 135.990378ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:21:21.686509Z","caller":"traceutil/trace.go:171","msg":"trace[47666754] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"103.595055ms","start":"2026-08-24T15:21:21.582885Z","end":"2026-08-24T15:21:21.68648Z","steps":["trace[47666754] 'process raft request' (duration: 103.41504ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:21:21.823696Z","caller":"traceutil/trace.go:171","msg":"trace[570755064] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"132.367925ms","start":"2026-08-24T15:21:21.691298Z","end":"2026-08-24T15:21:21.823666Z","steps":["trace[570755064] 'process raft request' (duration: 37.880143ms)","trace[570755064] 'compare' (duration: 94.281666ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:21:22.265318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.723169ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-24T15:21:22.265421Z","caller":"traceutil/trace.go:171","msg":"trace[2102846668] linearizableReadLoop","detail":"{readStateIndex:1313; appliedIndex:1312; }","duration":"333.153847ms","start":"2026-08-24T15:21:21.932251Z","end":"2026-08-24T15:21:22.265404Z","steps":["trace[2102846668] 'read index received' (duration: 39.542µs)","trace[2102846668] 'applied index is now lower than readState.Index' (duration: 333.113005ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:21:22.265556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.987595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:21:22.265593Z","caller":"traceutil/trace.go:171","msg":"trace[1065154431] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1255; }","duration":"307.055266ms","start":"2026-08-24T15:21:21.958527Z","end":"2026-08-24T15:21:22.265582Z","steps":["trace[1065154431] 'agreement among raft nodes before linearized reading' (duration: 306.986274ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:22.26563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:21.958512Z","time spent":"307.106578ms","remote":"127.0.0.1:52202","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-08-24T15:21:22.265669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.406415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-24T15:21:22.265711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.197764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:21:22.265751Z","caller":"traceutil/trace.go:171","msg":"trace[1158049767] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1255; }","duration":"333.53907ms","start":"2026-08-24T15:21:21.932194Z","end":"2026-08-24T15:21:22.265733Z","steps":["trace[1158049767] 'agreement among raft nodes before linearized reading' (duration: 333.310952ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:22.2658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:21.932175Z","time spent":"333.616462ms","remote":"127.0.0.1:52444","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-08-24T15:21:22.265804Z","caller":"traceutil/trace.go:171","msg":"trace[575771395] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1255; }","duration":"287.339359ms","start":"2026-08-24T15:21:21.978446Z","end":"2026-08-24T15:21:22.265785Z","steps":["trace[575771395] 'agreement among raft nodes before linearized reading' (duration: 287.120241ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:22.265823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.219205ms","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-08-24T15:21:22.26589Z","caller":"traceutil/trace.go:171","msg":"trace[1294053656] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1255; }","duration":"302.311058ms","start":"2026-08-24T15:21:21.96356Z","end":"2026-08-24T15:21:22.265871Z","steps":["trace[1294053656] 'agreement among raft nodes before linearized reading' (duration: 302.115422ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:22.265938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:21.963553Z","time spent":"302.37646ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-24T15:21:22.266894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.772469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-24T15:21:22.266942Z","caller":"traceutil/trace.go:171","msg":"trace[1432805200] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1255; }","duration":"175.848911ms","start":"2026-08-24T15:21:22.091082Z","end":"2026-08-24T15:21:22.26693Z","steps":["trace[1432805200] 'agreement among raft nodes before linearized reading' (duration: 175.129288ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:21:22.529258Z","caller":"traceutil/trace.go:171","msg":"trace[2072976018] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"259.286314ms","start":"2026-08-24T15:21:22.26994Z","end":"2026-08-24T15:21:22.529227Z","steps":["trace[2072976018] 'process raft request' (duration: 259.133519ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:21:22.607153Z","caller":"traceutil/trace.go:171","msg":"trace[94932110] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"336.930213ms","start":"2026-08-24T15:21:22.27021Z","end":"2026-08-24T15:21:22.60714Z","steps":["trace[94932110] 'process raft request' (duration: 336.212298ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:22.607283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.085348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:21:22.607326Z","caller":"traceutil/trace.go:171","msg":"trace[1955916994] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1258; }","duration":"309.161341ms","start":"2026-08-24T15:21:22.298152Z","end":"2026-08-24T15:21:22.607313Z","steps":["trace[1955916994] 'agreement among raft nodes before linearized reading' (duration: 309.058187ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:22.607331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:22.270189Z","time spent":"337.091189ms","remote":"127.0.0.1:52444","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-08-24T15:21:22.607366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:22.298142Z","time spent":"309.207772ms","remote":"127.0.0.1:37356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-08-24T15:21:22.607139Z","caller":"traceutil/trace.go:171","msg":"trace[250933248] linearizableReadLoop","detail":"{readStateIndex:1316; appliedIndex:1313; }","duration":"308.934353ms","start":"2026-08-24T15:21:22.298172Z","end":"2026-08-24T15:21:22.607107Z","steps":["trace[250933248] 'read index received' (duration: 230.827008ms)","trace[250933248] 'applied index is now lower than readState.Index' (duration: 78.106285ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:21:22.607397Z","caller":"traceutil/trace.go:171","msg":"trace[36782339] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"337.000775ms","start":"2026-08-24T15:21:22.270366Z","end":"2026-08-24T15:21:22.607367Z","steps":["trace[36782339] 'process raft request' (duration: 336.700085ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:22.60753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:22.270361Z","time spent":"337.096788ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:21:42.956089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.041608ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:21:42.956316Z","caller":"traceutil/trace.go:171","msg":"trace[1033612797] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"179.56098ms","start":"2026-08-24T15:21:42.776732Z","end":"2026-08-24T15:21:42.956293Z","steps":["trace[1033612797] 'process raft request' (duration: 179.485567ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:21:42.956407Z","caller":"traceutil/trace.go:171","msg":"trace[105969013] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"181.467798ms","start":"2026-08-24T15:21:42.774859Z","end":"2026-08-24T15:21:42.956326Z","steps":["trace[105969013] 'process raft request' (duration: 46.087589ms)","trace[105969013] 'compare' (duration: 134.856612ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:21:44.078036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.628785ms","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-08-24T15:21:44.078199Z","caller":"traceutil/trace.go:171","msg":"trace[197940124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1359; }","duration":"122.897653ms","start":"2026-08-24T15:21:43.955274Z","end":"2026-08-24T15:21:44.078172Z","steps":["trace[197940124] 'range keys from in-memory index tree' (duration: 122.346306ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:53.706931Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440709412340659,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-24T15:21:53.869368Z","caller":"traceutil/trace.go:171","msg":"trace[1001180535] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"763.013775ms","start":"2026-08-24T15:21:53.106331Z","end":"2026-08-24T15:21:53.869344Z","steps":["trace[1001180535] 'process raft request' (duration: 762.872041ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:53.869549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:53.106312Z","time spent":"763.149728ms","remote":"127.0.0.1:52350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5719,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:21:53.879802Z","caller":"traceutil/trace.go:171","msg":"trace[1764797627] linearizableReadLoop","detail":"{readStateIndex:1461; appliedIndex:1459; }","duration":"673.123962ms","start":"2026-08-24T15:21:53.206659Z","end":"2026-08-24T15:21:53.879783Z","steps":["trace[1764797627] 'read index received' (duration: 663.623773ms)","trace[1764797627] 'applied index is now lower than readState.Index' (duration: 9.499289ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:21:53.879845Z","caller":"traceutil/trace.go:171","msg":"trace[1092285858] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"766.23255ms","start":"2026-08-24T15:21:53.113585Z","end":"2026-08-24T15:21:53.879817Z","steps":["trace[1092285858] 'process raft request' (duration: 766.050305ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:53.880032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:53.113562Z","time spent":"766.373913ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:21:53.87985Z","caller":"traceutil/trace.go:171","msg":"trace[1883180532] transaction","detail":"{read_only:false; response_revision:1396; number_of_response:1; }","duration":"355.609474ms","start":"2026-08-24T15:21:53.524225Z","end":"2026-08-24T15:21:53.879834Z","steps":["trace[1883180532] 'process raft request' (duration: 355.515922ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:53.880151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:53.524212Z","time spent":"355.897882ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:21:53.880253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.876476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:21:53.88028Z","caller":"traceutil/trace.go:171","msg":"trace[1402702406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1396; }","duration":"405.927718ms","start":"2026-08-24T15:21:53.474343Z","end":"2026-08-24T15:21:53.880271Z","steps":["trace[1402702406] 'agreement among raft nodes before linearized reading' (duration: 405.889747ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:53.880304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:53.47433Z","time spent":"405.970879ms","remote":"127.0.0.1:52202","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-08-24T15:21:53.880446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.840466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-24T15:21:53.880482Z","caller":"traceutil/trace.go:171","msg":"trace[1918894653] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1396; }","duration":"669.913808ms","start":"2026-08-24T15:21:53.21056Z","end":"2026-08-24T15:21:53.880474Z","steps":["trace[1918894653] 'agreement among raft nodes before linearized reading' (duration: 669.477865ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:53.880606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:53.21054Z","time spent":"670.058672ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-24T15:21:53.881648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.372599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-24T15:21:53.881745Z","caller":"traceutil/trace.go:171","msg":"trace[2029141712] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1396; }","duration":"675.10036ms","start":"2026-08-24T15:21:53.206618Z","end":"2026-08-24T15:21:53.881718Z","steps":["trace[2029141712] 'agreement among raft nodes before linearized reading' (duration: 673.334388ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:53.881822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:53.206597Z","time spent":"675.213843ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-24T15:21:56.093003Z","caller":"traceutil/trace.go:171","msg":"trace[382725287] linearizableReadLoop","detail":"{readStateIndex:1473; appliedIndex:1472; }","duration":"135.016124ms","start":"2026-08-24T15:21:55.957814Z","end":"2026-08-24T15:21:56.09283Z","steps":["trace[382725287] 'read index received' (duration: 116.099676ms)","trace[382725287] 'applied index is now lower than readState.Index' (duration: 18.915168ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:21:56.093305Z","caller":"traceutil/trace.go:171","msg":"trace[1773676939] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"195.504722ms","start":"2026-08-24T15:21:55.897598Z","end":"2026-08-24T15:21:56.093103Z","steps":["trace[1773676939] 'process raft request' (duration: 176.292556ms)","trace[1773676939] 'compare' (duration: 18.807884ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:21:56.093499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.659572ms","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-08-24T15:21:56.093533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.21201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:21:56.093561Z","caller":"traceutil/trace.go:171","msg":"trace[1163214956] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1408; }","duration":"135.272471ms","start":"2026-08-24T15:21:55.958281Z","end":"2026-08-24T15:21:56.093553Z","steps":["trace[1163214956] 'agreement among raft nodes before linearized reading' (duration: 135.198389ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:21:56.093564Z","caller":"traceutil/trace.go:171","msg":"trace[1767261432] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1408; }","duration":"135.766656ms","start":"2026-08-24T15:21:55.95778Z","end":"2026-08-24T15:21:56.093546Z","steps":["trace[1767261432] 'agreement among raft nodes before linearized reading' (duration: 135.355004ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:04.289002Z","caller":"traceutil/trace.go:171","msg":"trace[816057446] linearizableReadLoop","detail":"{readStateIndex:1501; appliedIndex:1500; }","duration":"158.923056ms","start":"2026-08-24T15:22:04.13005Z","end":"2026-08-24T15:22:04.288973Z","steps":["trace[816057446] 'read index received' (duration: 158.783412ms)","trace[816057446] 'applied index is now lower than readState.Index' (duration: 137.974µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:22:04.289108Z","caller":"traceutil/trace.go:171","msg":"trace[1066219721] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"160.09432ms","start":"2026-08-24T15:22:04.128937Z","end":"2026-08-24T15:22:04.289031Z","steps":["trace[1066219721] 'process raft request' (duration: 159.877293ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:04.289194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.119532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cluster-admin\" ","response":"range_response_count:1 size:679"} {"level":"info","ts":"2026-08-24T15:22:04.289258Z","caller":"traceutil/trace.go:171","msg":"trace[1957946939] range","detail":"{range_begin:/registry/clusterrolebindings/cluster-admin; range_end:; response_count:1; response_revision:1434; }","duration":"159.216644ms","start":"2026-08-24T15:22:04.130025Z","end":"2026-08-24T15:22:04.289241Z","steps":["trace[1957946939] 'agreement among raft nodes before linearized reading' (duration: 159.094891ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:04.355611Z","caller":"traceutil/trace.go:171","msg":"trace[670655338] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"178.587768ms","start":"2026-08-24T15:22:04.176997Z","end":"2026-08-24T15:22:04.355585Z","steps":["trace[670655338] 'process raft request' (duration: 164.334388ms)","trace[670655338] 'compare' (duration: 14.113386ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:22:04.355745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.570789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-24T15:22:04.355808Z","caller":"traceutil/trace.go:171","msg":"trace[1715868473] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1435; }","duration":"225.709942ms","start":"2026-08-24T15:22:04.130087Z","end":"2026-08-24T15:22:04.355796Z","steps":["trace[1715868473] 'agreement among raft nodes before linearized reading' (duration: 225.492876ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:04.355931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.512162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:expand-controller\" ","response":"range_response_count:1 size:880"} {"level":"info","ts":"2026-08-24T15:22:04.355968Z","caller":"traceutil/trace.go:171","msg":"trace[1695268254] range","detail":"{range_begin:/registry/clusterroles/system:controller:expand-controller; range_end:; response_count:1; response_revision:1435; }","duration":"180.551773ms","start":"2026-08-24T15:22:04.175409Z","end":"2026-08-24T15:22:04.355961Z","steps":["trace[1695268254] 'agreement among raft nodes before linearized reading' (duration: 180.482212ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:14.108554Z","caller":"traceutil/trace.go:171","msg":"trace[1515011486] transaction","detail":"{read_only:false; response_revision:1465; number_of_response:1; }","duration":"110.684082ms","start":"2026-08-24T15:22:13.997839Z","end":"2026-08-24T15:22:14.108523Z","steps":["trace[1515011486] 'process raft request' (duration: 110.369523ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:14.403237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.856764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/default/\" range_end:\"/registry/deployments/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:22:14.403296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.433589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/default/kube-root-ca.crt\" ","response":"range_response_count:1 size:1738"} {"level":"info","ts":"2026-08-24T15:22:14.403314Z","caller":"traceutil/trace.go:171","msg":"trace[197524035] range","detail":"{range_begin:/registry/deployments/default/; range_end:/registry/deployments/default0; response_count:0; response_revision:1466; }","duration":"208.979066ms","start":"2026-08-24T15:22:14.194318Z","end":"2026-08-24T15:22:14.403297Z","steps":["trace[197524035] 'range keys from in-memory index tree' (duration: 208.780041ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:14.403349Z","caller":"traceutil/trace.go:171","msg":"trace[15108570] range","detail":"{range_begin:/registry/configmaps/default/kube-root-ca.crt; range_end:; response_count:1; response_revision:1466; }","duration":"209.522731ms","start":"2026-08-24T15:22:14.193812Z","end":"2026-08-24T15:22:14.403335Z","steps":["trace[15108570] 'range keys from in-memory index tree' (duration: 209.333126ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:14.403388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.228894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/envoy-gateway-system/kube-root-ca.crt\" ","response":"range_response_count:1 size:1764"} {"level":"info","ts":"2026-08-24T15:22:14.403466Z","caller":"traceutil/trace.go:171","msg":"trace[1676523843] range","detail":"{range_begin:/registry/configmaps/envoy-gateway-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:1466; }","duration":"160.358727ms","start":"2026-08-24T15:22:14.24309Z","end":"2026-08-24T15:22:14.403449Z","steps":["trace[1676523843] 'range keys from in-memory index tree' (duration: 160.125412ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:14.403647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.644458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/envoy-gateway-system/\" range_end:\"/registry/deployments/envoy-gateway-system0\" limit:500 ","response":"range_response_count:1 size:5641"} {"level":"info","ts":"2026-08-24T15:22:14.403726Z","caller":"traceutil/trace.go:171","msg":"trace[1569809539] range","detail":"{range_begin:/registry/deployments/envoy-gateway-system/; range_end:/registry/deployments/envoy-gateway-system0; response_count:1; response_revision:1466; }","duration":"142.75665ms","start":"2026-08-24T15:22:14.260952Z","end":"2026-08-24T15:22:14.403708Z","steps":["trace[1569809539] 'range keys from in-memory index tree' (duration: 142.515474ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:15.466541Z","caller":"traceutil/trace.go:171","msg":"trace[186935506] linearizableReadLoop","detail":"{readStateIndex:1540; appliedIndex:1539; }","duration":"215.330289ms","start":"2026-08-24T15:22:15.251184Z","end":"2026-08-24T15:22:15.466515Z","steps":["trace[186935506] 'read index received' (duration: 215.118302ms)","trace[186935506] 'applied index is now lower than readState.Index' (duration: 210.876µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:22:15.466655Z","caller":"traceutil/trace.go:171","msg":"trace[741291503] transaction","detail":"{read_only:false; response_revision:1471; number_of_response:1; }","duration":"239.408069ms","start":"2026-08-24T15:22:15.227216Z","end":"2026-08-24T15:22:15.466624Z","steps":["trace[741291503] 'process raft request' (duration: 239.145971ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:15.466769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.632688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/default/\" range_end:\"/registry/secrets/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:22:15.466811Z","caller":"traceutil/trace.go:171","msg":"trace[1190201693] range","detail":"{range_begin:/registry/secrets/default/; range_end:/registry/secrets/default0; response_count:0; response_revision:1471; }","duration":"168.692589ms","start":"2026-08-24T15:22:15.29811Z","end":"2026-08-24T15:22:15.466802Z","steps":["trace[1190201693] 'agreement among raft nodes before linearized reading' (duration: 168.582636ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:15.466866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.681081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-plnsr\" ","response":"range_response_count:1 size:5484"} {"level":"warn","ts":"2026-08-24T15:22:15.466871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.665047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-08-24T15:22:15.466923Z","caller":"traceutil/trace.go:171","msg":"trace[891292769] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-plnsr; range_end:; response_count:1; response_revision:1471; }","duration":"197.763824ms","start":"2026-08-24T15:22:15.269143Z","end":"2026-08-24T15:22:15.466907Z","steps":["trace[891292769] 'agreement among raft nodes before linearized reading' (duration: 197.547908ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:15.466946Z","caller":"traceutil/trace.go:171","msg":"trace[1089084388] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1471; }","duration":"215.786981ms","start":"2026-08-24T15:22:15.251139Z","end":"2026-08-24T15:22:15.466926Z","steps":["trace[1089084388] 'agreement among raft nodes before linearized reading' (duration: 215.527954ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:18.347561Z","caller":"traceutil/trace.go:171","msg":"trace[841205733] linearizableReadLoop","detail":"{readStateIndex:1549; appliedIndex:1548; }","duration":"174.159786ms","start":"2026-08-24T15:22:18.173382Z","end":"2026-08-24T15:22:18.347541Z","steps":["trace[841205733] 'read index received' (duration: 173.91721ms)","trace[841205733] 'applied index is now lower than readState.Index' (duration: 238.536µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:22:18.347673Z","caller":"traceutil/trace.go:171","msg":"trace[916452918] transaction","detail":"{read_only:false; response_revision:1479; number_of_response:1; }","duration":"200.485922ms","start":"2026-08-24T15:22:18.147136Z","end":"2026-08-24T15:22:18.347621Z","steps":["trace[916452918] 'process raft request' (duration: 200.265076ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:18.347767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.357412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/kubeadm:bootstrap-signer-clusterinfo\" ","response":"range_response_count:1 size:371"} {"level":"info","ts":"2026-08-24T15:22:18.347835Z","caller":"traceutil/trace.go:171","msg":"trace[1552749419] range","detail":"{range_begin:/registry/roles/kube-public/kubeadm:bootstrap-signer-clusterinfo; range_end:; response_count:1; response_revision:1479; }","duration":"174.470255ms","start":"2026-08-24T15:22:18.17335Z","end":"2026-08-24T15:22:18.34782Z","steps":["trace[1552749419] 'agreement among raft nodes before linearized reading' (duration: 174.319151ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:18.347936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.287753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-public/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:741"} {"level":"warn","ts":"2026-08-24T15:22:18.347985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.854723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-24T15:22:18.348047Z","caller":"traceutil/trace.go:171","msg":"trace[2036545604] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1479; }","duration":"172.941755ms","start":"2026-08-24T15:22:18.175092Z","end":"2026-08-24T15:22:18.348033Z","steps":["trace[2036545604] 'agreement among raft nodes before linearized reading' (duration: 172.751779ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:18.348098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.64943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/local-path-storage/\" range_end:\"/registry/cronjobs/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:22:18.348149Z","caller":"traceutil/trace.go:171","msg":"trace[1800797965] range","detail":"{range_begin:/registry/cronjobs/local-path-storage/; range_end:/registry/cronjobs/local-path-storage0; response_count:0; response_revision:1479; }","duration":"119.716231ms","start":"2026-08-24T15:22:18.228423Z","end":"2026-08-24T15:22:18.34814Z","steps":["trace[1800797965] 'agreement among raft nodes before linearized reading' (duration: 119.597808ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:18.34811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.455432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/kube-system/\" range_end:\"/registry/networkpolicies/kube-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:22:18.348284Z","caller":"traceutil/trace.go:171","msg":"trace[770619786] range","detail":"{range_begin:/registry/networkpolicies/kube-system/; range_end:/registry/networkpolicies/kube-system0; response_count:0; response_revision:1479; }","duration":"147.629327ms","start":"2026-08-24T15:22:18.200631Z","end":"2026-08-24T15:22:18.34826Z","steps":["trace[770619786] 'agreement among raft nodes before linearized reading' (duration: 147.457142ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:18.347999Z","caller":"traceutil/trace.go:171","msg":"trace[1834766902] range","detail":"{range_begin:/registry/rolebindings/kube-public/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:1479; }","duration":"130.380836ms","start":"2026-08-24T15:22:18.217603Z","end":"2026-08-24T15:22:18.347984Z","steps":["trace[1834766902] 'agreement among raft nodes before linearized reading' (duration: 130.268683ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:18.631504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.480697ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:22:18.631593Z","caller":"traceutil/trace.go:171","msg":"trace[509888258] transaction","detail":"{read_only:false; response_revision:1480; number_of_response:1; }","duration":"280.545062ms","start":"2026-08-24T15:22:18.351035Z","end":"2026-08-24T15:22:18.631581Z","steps":["trace[509888258] 'process raft request' (duration: 176.921781ms)","trace[509888258] 'compare' (duration: 103.411155ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:22:18.631593Z","caller":"traceutil/trace.go:171","msg":"trace[628508773] linearizableReadLoop","detail":"{readStateIndex:1550; appliedIndex:1549; }","duration":"279.637277ms","start":"2026-08-24T15:22:18.351943Z","end":"2026-08-24T15:22:18.63158Z","steps":["trace[628508773] 'read index received' (duration: 176.009336ms)","trace[628508773] 'applied index is now lower than readState.Index' (duration: 103.626821ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:22:18.631655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.705109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-public/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:741"} {"level":"info","ts":"2026-08-24T15:22:18.631713Z","caller":"traceutil/trace.go:171","msg":"trace[531400142] range","detail":"{range_begin:/registry/rolebindings/kube-public/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:1480; }","duration":"279.777051ms","start":"2026-08-24T15:22:18.351914Z","end":"2026-08-24T15:22:18.631691Z","steps":["trace[531400142] 'agreement among raft nodes before linearized reading' (duration: 279.698659ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:18.631761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.874281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/kubeadm:bootstrap-signer-clusterinfo\" ","response":"range_response_count:1 size:371"} {"level":"info","ts":"2026-08-24T15:22:18.631828Z","caller":"traceutil/trace.go:171","msg":"trace[1961400500] range","detail":"{range_begin:/registry/roles/kube-public/kubeadm:bootstrap-signer-clusterinfo; range_end:; response_count:1; response_revision:1480; }","duration":"206.952563ms","start":"2026-08-24T15:22:18.424859Z","end":"2026-08-24T15:22:18.631812Z","steps":["trace[1961400500] 'agreement among raft nodes before linearized reading' (duration: 206.82994ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:18.63179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.412883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/local-path-storage/\" range_end:\"/registry/daemonsets/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:22:18.631979Z","caller":"traceutil/trace.go:171","msg":"trace[973438715] range","detail":"{range_begin:/registry/daemonsets/local-path-storage/; range_end:/registry/daemonsets/local-path-storage0; response_count:0; response_revision:1480; }","duration":"165.62218ms","start":"2026-08-24T15:22:18.466346Z","end":"2026-08-24T15:22:18.631968Z","steps":["trace[973438715] 'agreement among raft nodes before linearized reading' (duration: 165.423124ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:18.632007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.181955ms","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-08-24T15:22:18.632038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.216075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/\" range_end:\"/registry/pods/kube-system0\" limit:500 ","response":"range_response_count:10 size:65282"} {"level":"info","ts":"2026-08-24T15:22:18.632068Z","caller":"traceutil/trace.go:171","msg":"trace[1847436217] range","detail":"{range_begin:/registry/pods/kube-system/; range_end:/registry/pods/kube-system0; response_count:10; response_revision:1480; }","duration":"206.279247ms","start":"2026-08-24T15:22:18.425783Z","end":"2026-08-24T15:22:18.632062Z","steps":["trace[1847436217] 'agreement among raft nodes before linearized reading' (duration: 206.177164ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:18.632068Z","caller":"traceutil/trace.go:171","msg":"trace[1654563573] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1480; }","duration":"175.275067ms","start":"2026-08-24T15:22:18.456772Z","end":"2026-08-24T15:22:18.632047Z","steps":["trace[1654563573] 'agreement among raft nodes before linearized reading' (duration: 175.102412ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:19.11767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.968323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/local-path-storage/\" range_end:\"/registry/services/endpoints/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:22:19.11793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.873388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:22:19.11792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.72186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/local-path-storage/\" range_end:\"/registry/ingress/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:22:19.117953Z","caller":"traceutil/trace.go:171","msg":"trace[1050079273] range","detail":"{range_begin:/registry/services/endpoints/local-path-storage/; range_end:/registry/services/endpoints/local-path-storage0; response_count:0; response_revision:1483; }","duration":"241.318283ms","start":"2026-08-24T15:22:18.87661Z","end":"2026-08-24T15:22:19.117928Z","steps":["trace[1050079273] 'range keys from in-memory index tree' (duration: 240.895271ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:19.117972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.765011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:1 size:612"} {"level":"info","ts":"2026-08-24T15:22:19.117993Z","caller":"traceutil/trace.go:171","msg":"trace[126553498] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1483; }","duration":"158.9281ms","start":"2026-08-24T15:22:18.959045Z","end":"2026-08-24T15:22:19.117973Z","steps":["trace[126553498] 'range keys from in-memory index tree' (duration: 158.822637ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:19.118006Z","caller":"traceutil/trace.go:171","msg":"trace[243822440] range","detail":"{range_begin:/registry/ingress/local-path-storage/; range_end:/registry/ingress/local-path-storage0; response_count:0; response_revision:1483; }","duration":"194.039288ms","start":"2026-08-24T15:22:18.923946Z","end":"2026-08-24T15:22:19.117985Z","steps":["trace[243822440] 'range keys from in-memory index tree' (duration: 193.655638ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:19.118035Z","caller":"traceutil/trace.go:171","msg":"trace[1407512857] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:1; response_revision:1483; }","duration":"202.864554ms","start":"2026-08-24T15:22:18.915155Z","end":"2026-08-24T15:22:19.11802Z","steps":["trace[1407512857] 'range keys from in-memory index tree' (duration: 202.677148ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:19.118374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.080352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/cilium-config\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-08-24T15:22:19.118459Z","caller":"traceutil/trace.go:171","msg":"trace[1191533309] range","detail":"{range_begin:/registry/configmaps/kube-system/cilium-config; range_end:; response_count:1; response_revision:1483; }","duration":"239.871783ms","start":"2026-08-24T15:22:18.878574Z","end":"2026-08-24T15:22:19.118446Z","steps":["trace[1191533309] 'range keys from in-memory index tree' (duration: 238.945228ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:19.68667Z","caller":"traceutil/trace.go:171","msg":"trace[330401753] transaction","detail":"{read_only:false; response_revision:1484; number_of_response:1; }","duration":"162.220453ms","start":"2026-08-24T15:22:19.524425Z","end":"2026-08-24T15:22:19.686645Z","steps":["trace[330401753] 'process raft request' (duration: 162.055149ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:19.686627Z","caller":"traceutil/trace.go:171","msg":"trace[548890566] linearizableReadLoop","detail":"{readStateIndex:1554; appliedIndex:1553; }","duration":"135.414788ms","start":"2026-08-24T15:22:19.55119Z","end":"2026-08-24T15:22:19.686605Z","steps":["trace[548890566] 'read index received' (duration: 135.243334ms)","trace[548890566] 'applied index is now lower than readState.Index' (duration: 170.284µs)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:22:19.687095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.677525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-proxy\" ","response":"range_response_count:1 size:1949"} {"level":"warn","ts":"2026-08-24T15:22:19.687102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.075307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-root-ca.crt\" ","response":"range_response_count:1 size:1746"} {"level":"info","ts":"2026-08-24T15:22:19.687158Z","caller":"traceutil/trace.go:171","msg":"trace[1002838422] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:1484; }","duration":"130.177728ms","start":"2026-08-24T15:22:19.55697Z","end":"2026-08-24T15:22:19.687148Z","steps":["trace[1002838422] 'agreement among raft nodes before linearized reading' (duration: 130.079276ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:19.687116Z","caller":"traceutil/trace.go:171","msg":"trace[1684869592] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1484; }","duration":"132.729697ms","start":"2026-08-24T15:22:19.55438Z","end":"2026-08-24T15:22:19.68711Z","steps":["trace[1684869592] 'agreement among raft nodes before linearized reading' (duration: 132.655185ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:19.687104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.896191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:4 size:329960"} {"level":"info","ts":"2026-08-24T15:22:19.687295Z","caller":"traceutil/trace.go:171","msg":"trace[939259518] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1484; }","duration":"136.147388ms","start":"2026-08-24T15:22:19.55114Z","end":"2026-08-24T15:22:19.687287Z","steps":["trace[939259518] 'agreement among raft nodes before linearized reading' (duration: 135.738287ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:19.93805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.872774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubelet-config\" ","response":"range_response_count:1 size:1357"} {"level":"info","ts":"2026-08-24T15:22:19.938144Z","caller":"traceutil/trace.go:171","msg":"trace[2114648557] range","detail":"{range_begin:/registry/configmaps/kube-system/kubelet-config; range_end:; response_count:1; response_revision:1484; }","duration":"165.001667ms","start":"2026-08-24T15:22:19.773124Z","end":"2026-08-24T15:22:19.938125Z","steps":["trace[2114648557] 'range keys from in-memory index tree' (duration: 164.747551ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:19.93814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.118757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/local-path-storage/\" range_end:\"/registry/persistentvolumeclaims/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:22:19.938205Z","caller":"traceutil/trace.go:171","msg":"trace[1884813925] range","detail":"{range_begin:/registry/persistentvolumeclaims/local-path-storage/; range_end:/registry/persistentvolumeclaims/local-path-storage0; response_count:0; response_revision:1484; }","duration":"151.22781ms","start":"2026-08-24T15:22:19.786961Z","end":"2026-08-24T15:22:19.938189Z","steps":["trace[1884813925] 'range keys from in-memory index tree' (duration: 151.051285ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:19.938314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.19189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubeadm-config\" ","response":"range_response_count:1 size:1084"} {"level":"info","ts":"2026-08-24T15:22:19.938347Z","caller":"traceutil/trace.go:171","msg":"trace[1193013740] range","detail":"{range_begin:/registry/configmaps/kube-system/kubeadm-config; range_end:; response_count:1; response_revision:1484; }","duration":"166.286043ms","start":"2026-08-24T15:22:19.772052Z","end":"2026-08-24T15:22:19.938338Z","steps":["trace[1193013740] 'range keys from in-memory index tree' (duration: 166.100626ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:19.938532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.176717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/\" range_end:\"/registry/serviceaccounts/kube-system0\" limit:500 ","response":"range_response_count:37 size:8042"} {"level":"info","ts":"2026-08-24T15:22:19.93861Z","caller":"traceutil/trace.go:171","msg":"trace[1350864756] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/; range_end:/registry/serviceaccounts/kube-system0; response_count:37; response_revision:1484; }","duration":"116.291009ms","start":"2026-08-24T15:22:19.822299Z","end":"2026-08-24T15:22:19.93859Z","steps":["trace[1350864756] 'range keys from in-memory index tree' (duration: 115.983721ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:20.484873Z","caller":"traceutil/trace.go:171","msg":"trace[1462383974] transaction","detail":"{read_only:false; response_revision:1485; number_of_response:1; }","duration":"133.467405ms","start":"2026-08-24T15:22:20.351386Z","end":"2026-08-24T15:22:20.484853Z","steps":["trace[1462383974] 'process raft request' (duration: 133.331771ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:20.836636Z","caller":"traceutil/trace.go:171","msg":"trace[373008364] linearizableReadLoop","detail":"{readStateIndex:1558; appliedIndex:1556; }","duration":"106.732276ms","start":"2026-08-24T15:22:20.729887Z","end":"2026-08-24T15:22:20.836619Z","steps":["trace[373008364] 'read index received' (duration: 64.241206ms)","trace[373008364] 'applied index is now lower than readState.Index' (duration: 42.490039ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:22:20.83667Z","caller":"traceutil/trace.go:171","msg":"trace[686599018] transaction","detail":"{read_only:false; response_revision:1487; number_of_response:1; }","duration":"108.539193ms","start":"2026-08-24T15:22:20.728096Z","end":"2026-08-24T15:22:20.836635Z","steps":["trace[686599018] 'process raft request' (duration: 66.028623ms)","trace[686599018] 'compare' (duration: 42.371575ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:22:20.836749Z","caller":"traceutil/trace.go:171","msg":"trace[1280819627] transaction","detail":"{read_only:false; response_revision:1488; number_of_response:1; }","duration":"108.153883ms","start":"2026-08-24T15:22:20.728559Z","end":"2026-08-24T15:22:20.836713Z","steps":["trace[1280819627] 'process raft request' (duration: 108.032289ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:20.836824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.92036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4219"} {"level":"info","ts":"2026-08-24T15:22:20.836856Z","caller":"traceutil/trace.go:171","msg":"trace[1733527964] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:1488; }","duration":"106.996302ms","start":"2026-08-24T15:22:20.72985Z","end":"2026-08-24T15:22:20.836846Z","steps":["trace[1733527964] 'agreement among raft nodes before linearized reading' (duration: 106.859239ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:23.18785Z","caller":"traceutil/trace.go:171","msg":"trace[1586193043] linearizableReadLoop","detail":"{readStateIndex:1566; appliedIndex:1564; }","duration":"309.833697ms","start":"2026-08-24T15:22:22.877992Z","end":"2026-08-24T15:22:23.187825Z","steps":["trace[1586193043] 'read index received' (duration: 260.614282ms)","trace[1586193043] 'applied index is now lower than readState.Index' (duration: 49.218205ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:22:23.188041Z","caller":"traceutil/trace.go:171","msg":"trace[1929240946] transaction","detail":"{read_only:false; response_revision:1495; number_of_response:1; }","duration":"343.072063ms","start":"2026-08-24T15:22:22.844894Z","end":"2026-08-24T15:22:23.187966Z","steps":["trace[1929240946] 'process raft request' (duration: 342.886819ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:23.188224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.81899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system:controller:cloud-provider\" ","response":"range_response_count:1 size:733"} {"level":"warn","ts":"2026-08-24T15:22:23.188292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.291959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:741"} {"level":"warn","ts":"2026-08-24T15:22:23.188296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:22:22.844879Z","time spent":"343.250899ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:22:23.188355Z","caller":"traceutil/trace.go:171","msg":"trace[339824837] range","detail":"{range_begin:/registry/rolebindings/kube-system/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:1495; }","duration":"310.394131ms","start":"2026-08-24T15:22:22.877944Z","end":"2026-08-24T15:22:23.188339Z","steps":["trace[339824837] 'agreement among raft nodes before linearized reading' (duration: 310.286488ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:23.188383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:22:22.877927Z","time spent":"310.450803ms","remote":"127.0.0.1:52520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":764,"request content":"key:\"/registry/rolebindings/kube-system/system:controller:bootstrap-signer\" "} {"level":"info","ts":"2026-08-24T15:22:23.187982Z","caller":"traceutil/trace.go:171","msg":"trace[192282678] transaction","detail":"{read_only:false; response_revision:1494; number_of_response:1; }","duration":"344.45053ms","start":"2026-08-24T15:22:22.843485Z","end":"2026-08-24T15:22:23.187936Z","steps":["trace[192282678] 'process raft request' (duration: 295.106312ms)","trace[192282678] 'compare' (duration: 49.05028ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:22:23.18831Z","caller":"traceutil/trace.go:171","msg":"trace[375244363] range","detail":"{range_begin:/registry/rolebindings/kube-system/system:controller:cloud-provider; range_end:; response_count:1; response_revision:1495; }","duration":"305.937454ms","start":"2026-08-24T15:22:22.882353Z","end":"2026-08-24T15:22:23.18829Z","steps":["trace[375244363] 'agreement among raft nodes before linearized reading' (duration: 305.7735ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:23.18848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.901371ms","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-08-24T15:22:23.188498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:22:22.84347Z","time spent":"344.948072ms","remote":"127.0.0.1:52444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:22:23.188518Z","caller":"traceutil/trace.go:171","msg":"trace[740702202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1495; }","duration":"297.968523ms","start":"2026-08-24T15:22:22.890539Z","end":"2026-08-24T15:22:23.188507Z","steps":["trace[740702202] 'agreement among raft nodes before linearized reading' (duration: 297.805349ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:23.188492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:22:22.882344Z","time spent":"306.109758ms","remote":"127.0.0.1:52520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":756,"request content":"key:\"/registry/rolebindings/kube-system/system:controller:cloud-provider\" "} {"level":"info","ts":"2026-08-24T15:22:24.746689Z","caller":"traceutil/trace.go:171","msg":"trace[699713223] transaction","detail":"{read_only:false; response_revision:1499; number_of_response:1; }","duration":"133.571859ms","start":"2026-08-24T15:22:24.613095Z","end":"2026-08-24T15:22:24.746667Z","steps":["trace[699713223] 'process raft request' (duration: 133.325183ms)"],"step_count":1}