{"level":"warn","ts":"2026-08-20T20:26:42.963288Z","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-20T20:26:42.963544Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.108: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.108:2380","--initial-cluster=instance=https://199.19.213.108:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.108:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.108: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-20T20:26:42.963711Z","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-20T20:26:42.963739Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.108:2380"]} {"level":"info","ts":"2026-08-20T20:26:42.963789Z","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-20T20:26:42.964781Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.108:2379"]} {"level":"info","ts":"2026-08-20T20:26:42.964895Z","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.108:2380"],"listen-peer-urls":["https://199.19.213.108:2380"],"advertise-client-urls":["https://199.19.213.108:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.108:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.108: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-20T20:26:42.97358Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.304061ms"} {"level":"info","ts":"2026-08-20T20:26:42.985547Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e9047e95cdba2056","cluster-id":"51f5e218724a48a2"} {"level":"info","ts":"2026-08-20T20:26:42.985677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 switched to configuration voters=()"} {"level":"info","ts":"2026-08-20T20:26:42.985709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became follower at term 0"} {"level":"info","ts":"2026-08-20T20:26:42.985721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e9047e95cdba2056 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-20T20:26:42.985733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became follower at term 1"} {"level":"info","ts":"2026-08-20T20:26:42.985783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 switched to configuration voters=(16790684492610805846)"} {"level":"warn","ts":"2026-08-20T20:26:43.028178Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-20T20:26:43.034955Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-20T20:26:43.044111Z","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-20T20:26:43.05368Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e9047e95cdba2056","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-20T20:26:43.054137Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e9047e95cdba2056","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-20T20:26:43.054207Z","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-20T20:26:43.054247Z","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-20T20:26:43.054255Z","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-20T20:26:43.0598Z","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-20T20:26:43.059859Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.108:2380"} {"level":"info","ts":"2026-08-20T20:26:43.059961Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.108:2380"} {"level":"info","ts":"2026-08-20T20:26:43.060249Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e9047e95cdba2056","initial-advertise-peer-urls":["https://199.19.213.108:2380"],"listen-peer-urls":["https://199.19.213.108:2380"],"advertise-client-urls":["https://199.19.213.108:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.108:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-20T20:26:43.06035Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-20T20:26:43.067522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 switched to configuration voters=(16790684492610805846)"} {"level":"info","ts":"2026-08-20T20:26:43.067653Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"51f5e218724a48a2","local-member-id":"e9047e95cdba2056","added-peer-id":"e9047e95cdba2056","added-peer-peer-urls":["https://199.19.213.108:2380"]} {"level":"info","ts":"2026-08-20T20:26:43.085992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 is starting a new election at term 1"} {"level":"info","ts":"2026-08-20T20:26:43.086051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-20T20:26:43.086108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 received MsgPreVoteResp from e9047e95cdba2056 at term 1"} {"level":"info","ts":"2026-08-20T20:26:43.086132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became candidate at term 2"} {"level":"info","ts":"2026-08-20T20:26:43.086144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 received MsgVoteResp from e9047e95cdba2056 at term 2"} {"level":"info","ts":"2026-08-20T20:26:43.086158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became leader at term 2"} {"level":"info","ts":"2026-08-20T20:26:43.086189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e9047e95cdba2056 elected leader e9047e95cdba2056 at term 2"} {"level":"info","ts":"2026-08-20T20:26:43.090958Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e9047e95cdba2056","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.108:2379]}","request-path":"/0/members/e9047e95cdba2056/attributes","cluster-id":"51f5e218724a48a2","publish-timeout":"7s"} {"level":"info","ts":"2026-08-20T20:26:43.091171Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T20:26:43.091862Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T20:26:43.092008Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T20:26:43.092389Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-20T20:26:43.092426Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-20T20:26:43.095292Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.108:2379"} {"level":"info","ts":"2026-08-20T20:26:43.09787Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-20T20:26:43.09813Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"51f5e218724a48a2","local-member-id":"e9047e95cdba2056","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T20:26:43.098219Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T20:26:43.098257Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T20:26:46.579075Z","caller":"traceutil/trace.go:171","msg":"trace[1080313695] transaction","detail":"{read_only:false; response_revision:126; number_of_response:1; }","duration":"131.13445ms","start":"2026-08-20T20:26:46.447904Z","end":"2026-08-20T20:26:46.579039Z","steps":["trace[1080313695] 'process raft request' (duration: 69.378567ms)","trace[1080313695] 'compare' (duration: 61.581698ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:26:46.855098Z","caller":"traceutil/trace.go:171","msg":"trace[1679812423] transaction","detail":"{read_only:false; response_revision:139; number_of_response:1; }","duration":"110.935467ms","start":"2026-08-20T20:26:46.744124Z","end":"2026-08-20T20:26:46.855059Z","steps":["trace[1679812423] 'process raft request' (duration: 73.435429ms)","trace[1679812423] 'compare' (duration: 37.133996ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:26:50.246715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.034073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-08-20T20:26:50.246856Z","caller":"traceutil/trace.go:171","msg":"trace[299008204] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:315; }","duration":"180.234868ms","start":"2026-08-20T20:26:50.066599Z","end":"2026-08-20T20:26:50.246834Z","steps":["trace[299008204] 'range keys from in-memory index tree' (duration: 179.849928ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:26:50.373417Z","caller":"traceutil/trace.go:171","msg":"trace[582555298] transaction","detail":"{read_only:false; number_of_response:0; response_revision:315; }","duration":"162.395528ms","start":"2026-08-20T20:26:50.210999Z","end":"2026-08-20T20:26:50.373395Z","steps":["trace[582555298] 'process raft request' (duration: 162.321915ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:26:50.373759Z","caller":"traceutil/trace.go:171","msg":"trace[1096053651] linearizableReadLoop","detail":"{readStateIndex:329; appliedIndex:329; }","duration":"106.237065ms","start":"2026-08-20T20:26:50.267515Z","end":"2026-08-20T20:26:50.373752Z","steps":["trace[1096053651] 'read index received' (duration: 106.234165ms)","trace[1096053651] 'applied index is now lower than readState.Index' (duration: 2.4µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:26:50.373824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.290076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:26:50.373849Z","caller":"traceutil/trace.go:171","msg":"trace[1971058083] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:0; response_revision:315; }","duration":"106.332337ms","start":"2026-08-20T20:26:50.26751Z","end":"2026-08-20T20:26:50.373842Z","steps":["trace[1971058083] 'agreement among raft nodes before linearized reading' (duration: 106.274015ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:26:50.402159Z","caller":"traceutil/trace.go:171","msg":"trace[731582164] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"117.539039ms","start":"2026-08-20T20:26:50.284591Z","end":"2026-08-20T20:26:50.40213Z","steps":["trace[731582164] 'process raft request' (duration: 117.381574ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:01.528657Z","caller":"traceutil/trace.go:171","msg":"trace[866553875] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"338.729223ms","start":"2026-08-20T20:27:01.189894Z","end":"2026-08-20T20:27:01.528623Z","steps":["trace[866553875] 'process raft request' (duration: 338.514437ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:01.529527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:01.18987Z","time spent":"338.901127ms","remote":"127.0.0.1:40994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:27:02.667897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.140675ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-20T20:27:06.876754Z","caller":"traceutil/trace.go:171","msg":"trace[1307026569] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"173.686396ms","start":"2026-08-20T20:27:06.703038Z","end":"2026-08-20T20:27:06.876724Z","steps":["trace[1307026569] 'process raft request' (duration: 173.514942ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:17.38963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.089955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:27:17.389725Z","caller":"traceutil/trace.go:171","msg":"trace[2022621687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:459; }","duration":"103.235279ms","start":"2026-08-20T20:27:17.286469Z","end":"2026-08-20T20:27:17.389704Z","steps":["trace[2022621687] 'range keys from in-memory index tree' (duration: 103.011574ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:31.328249Z","caller":"traceutil/trace.go:171","msg":"trace[1549504350] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"312.745083ms","start":"2026-08-20T20:27:31.015477Z","end":"2026-08-20T20:27:31.328222Z","steps":["trace[1549504350] 'process raft request' (duration: 312.424186ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:31.328444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:31.015466Z","time spent":"312.861125ms","remote":"127.0.0.1:41078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:27:40.208126Z","caller":"traceutil/trace.go:171","msg":"trace[449017552] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"312.38621ms","start":"2026-08-20T20:27:39.895708Z","end":"2026-08-20T20:27:40.208095Z","steps":["trace[449017552] 'process raft request' (duration: 312.206717ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:40.208323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:39.89568Z","time spent":"312.544483ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:27:40.217662Z","caller":"traceutil/trace.go:171","msg":"trace[1658855906] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"319.142687ms","start":"2026-08-20T20:27:39.8985Z","end":"2026-08-20T20:27:40.217642Z","steps":["trace[1658855906] 'process raft request' (duration: 318.916583ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:40.217793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:39.898475Z","time spent":"319.248849ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:27:40.21795Z","caller":"traceutil/trace.go:171","msg":"trace[689278285] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"309.172806ms","start":"2026-08-20T20:27:39.908758Z","end":"2026-08-20T20:27:40.217931Z","steps":["trace[689278285] 'process raft request' (duration: 308.980413ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:40.217894Z","caller":"traceutil/trace.go:171","msg":"trace[920960892] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"309.144386ms","start":"2026-08-20T20:27:39.9087Z","end":"2026-08-20T20:27:40.217845Z","steps":["trace[920960892] 'process raft request' (duration: 308.942362ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:40.218046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:39.908754Z","time spent":"309.246547ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:27:40.218112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:39.908682Z","time spent":"309.3393ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:27:40.218088Z","caller":"traceutil/trace.go:171","msg":"trace[1577621899] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"317.706629ms","start":"2026-08-20T20:27:39.900285Z","end":"2026-08-20T20:27:40.217992Z","steps":["trace[1577621899] 'process raft request' (duration: 317.267741ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:40.218609Z","caller":"traceutil/trace.go:171","msg":"trace[857769876] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"309.765198ms","start":"2026-08-20T20:27:39.90883Z","end":"2026-08-20T20:27:40.218595Z","steps":["trace[857769876] 'process raft request' (duration: 309.560585ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:40.218675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:39.908826Z","time spent":"309.817319ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:27:40.218726Z","caller":"traceutil/trace.go:171","msg":"trace[2090384140] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"308.776709ms","start":"2026-08-20T20:27:39.909925Z","end":"2026-08-20T20:27:40.218702Z","steps":["trace[2090384140] 'process raft request' (duration: 308.554845ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:40.218801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:39.909916Z","time spent":"308.846222ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:27:40.218841Z","caller":"traceutil/trace.go:171","msg":"trace[1390773748] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"308.683337ms","start":"2026-08-20T20:27:39.910137Z","end":"2026-08-20T20:27:40.218821Z","steps":["trace[1390773748] 'process raft request' (duration: 308.482363ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:40.218934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:39.910129Z","time spent":"308.767319ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:27:40.219306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:39.900277Z","time spent":"318.589307ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:27:40.227645Z","caller":"traceutil/trace.go:171","msg":"trace[1592393445] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"307.758959ms","start":"2026-08-20T20:27:39.919866Z","end":"2026-08-20T20:27:40.227625Z","steps":["trace[1592393445] 'process raft request' (duration: 299.543223ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:40.227756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:39.919843Z","time spent":"307.864151ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:27:40.228304Z","caller":"traceutil/trace.go:171","msg":"trace[785630486] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"304.546168ms","start":"2026-08-20T20:27:39.923728Z","end":"2026-08-20T20:27:40.228274Z","steps":["trace[785630486] 'process raft request' (duration: 303.829585ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:40.233059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:39.923713Z","time spent":"309.265287ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:27:40.233453Z","caller":"traceutil/trace.go:171","msg":"trace[423065701] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"283.729559ms","start":"2026-08-20T20:27:39.949705Z","end":"2026-08-20T20:27:40.233435Z","steps":["trace[423065701] 'process raft request' (duration: 278.583851ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:40.233686Z","caller":"traceutil/trace.go:171","msg":"trace[663758695] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"147.216234ms","start":"2026-08-20T20:27:40.086461Z","end":"2026-08-20T20:27:40.233677Z","steps":["trace[663758695] 'process raft request' (duration: 146.386959ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:46.883251Z","caller":"traceutil/trace.go:171","msg":"trace[500324042] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"179.872426ms","start":"2026-08-20T20:27:46.703292Z","end":"2026-08-20T20:27:46.883165Z","steps":["trace[500324042] 'process raft request' (duration: 178.806496ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:48.209289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.052808518s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:27:48.209391Z","caller":"traceutil/trace.go:171","msg":"trace[236359465] linearizableReadLoop","detail":"{readStateIndex:720; appliedIndex:719; }","duration":"921.336244ms","start":"2026-08-20T20:27:47.288036Z","end":"2026-08-20T20:27:48.209372Z","steps":["trace[236359465] 'read index received' (duration: 72.002µs)","trace[236359465] 'applied index is now lower than readState.Index' (duration: 921.262792ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:27:48.209528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.492526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:27:48.20957Z","caller":"traceutil/trace.go:171","msg":"trace[1878742006] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:687; }","duration":"921.574608ms","start":"2026-08-20T20:27:47.287987Z","end":"2026-08-20T20:27:48.209562Z","steps":["trace[1878742006] 'agreement among raft nodes before linearized reading' (duration: 921.484577ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:48.2096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:47.287965Z","time spent":"921.627579ms","remote":"127.0.0.1:40842","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-20T20:27:48.209631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.408345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.108\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-20T20:27:48.209707Z","caller":"traceutil/trace.go:171","msg":"trace[1519054125] range","detail":"{range_begin:/registry/masterleases/199.19.213.108; range_end:; response_count:1; response_revision:687; }","duration":"769.519947ms","start":"2026-08-20T20:27:47.440165Z","end":"2026-08-20T20:27:48.209685Z","steps":["trace[1519054125] 'agreement among raft nodes before linearized reading' (duration: 769.371095ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:48.209757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:47.44014Z","time spent":"769.604399ms","remote":"127.0.0.1:40862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.108\" "} {"level":"warn","ts":"2026-08-20T20:27:48.209802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.660422ms","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-20T20:27:48.209866Z","caller":"traceutil/trace.go:171","msg":"trace[1810992952] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:687; }","duration":"698.767254ms","start":"2026-08-20T20:27:47.511079Z","end":"2026-08-20T20:27:48.209846Z","steps":["trace[1810992952] 'agreement among raft nodes before linearized reading' (duration: 698.583021ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:48.20991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:47.511053Z","time spent":"698.844455ms","remote":"127.0.0.1:41078","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-20T20:27:48.209915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.491891ms","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-20T20:27:48.210044Z","caller":"traceutil/trace.go:171","msg":"trace[805750859] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:687; }","duration":"750.668243ms","start":"2026-08-20T20:27:47.459342Z","end":"2026-08-20T20:27:48.210011Z","steps":["trace[805750859] 'agreement among raft nodes before linearized reading' (duration: 750.331357ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:48.21011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:47.459311Z","time spent":"750.784786ms","remote":"127.0.0.1:41078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-20T20:27:48.210265Z","caller":"traceutil/trace.go:171","msg":"trace[705819840] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"1.262097938s","start":"2026-08-20T20:27:46.947286Z","end":"2026-08-20T20:27:48.209384Z","steps":["trace[705819840] 'process raft request' (duration: 208.930485ms)","trace[705819840] 'compare' (duration: 1.052658134s)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:27:48.210227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.250627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-20T20:27:48.210389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:46.947257Z","time spent":"1.263086195s","remote":"127.0.0.1:41046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:27:48.211088Z","caller":"traceutil/trace.go:171","msg":"trace[543188537] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:687; }","duration":"727.247595ms","start":"2026-08-20T20:27:47.483816Z","end":"2026-08-20T20:27:48.211064Z","steps":["trace[543188537] 'agreement among raft nodes before linearized reading' (duration: 725.90054ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:48.210467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.722646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-20T20:27:48.211694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:47.483795Z","time spent":"727.870927ms","remote":"127.0.0.1:41078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-20T20:27:48.211756Z","caller":"traceutil/trace.go:171","msg":"trace[1096618349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:687; }","duration":"705.041479ms","start":"2026-08-20T20:27:47.506686Z","end":"2026-08-20T20:27:48.211728Z","steps":["trace[1096618349] 'agreement among raft nodes before linearized reading' (duration: 703.605072ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:48.211927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:47.506656Z","time spent":"705.195592ms","remote":"127.0.0.1:41078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-20T20:27:49.448282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.135106394s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:27:49.448672Z","caller":"traceutil/trace.go:171","msg":"trace[1685588924] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"1.160096568s","start":"2026-08-20T20:27:48.28855Z","end":"2026-08-20T20:27:49.448646Z","steps":["trace[1685588924] 'process raft request' (duration: 1.160029447s)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:49.448673Z","caller":"traceutil/trace.go:171","msg":"trace[436602761] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"1.232522725s","start":"2026-08-20T20:27:48.216112Z","end":"2026-08-20T20:27:49.448635Z","steps":["trace[436602761] 'process raft request' (duration: 1.232369312s)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:49.448709Z","caller":"traceutil/trace.go:171","msg":"trace[454398148] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"1.230995699s","start":"2026-08-20T20:27:48.217691Z","end":"2026-08-20T20:27:49.448686Z","steps":["trace[454398148] 'process raft request' (duration: 1.230831015s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:49.448772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:48.288521Z","time spent":"1.160201872s","remote":"127.0.0.1:40862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:27:49.448767Z","caller":"traceutil/trace.go:171","msg":"trace[62398760] linearizableReadLoop","detail":"{readStateIndex:725; appliedIndex:721; }","duration":"1.161649908s","start":"2026-08-20T20:27:48.287079Z","end":"2026-08-20T20:27:49.448729Z","steps":["trace[62398760] 'read index received' (duration: 25.960212ms)","trace[62398760] 'applied index is now lower than readState.Index' (duration: 1.135685716s)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:27:49.448852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:48.217673Z","time spent":"1.231128071s","remote":"127.0.0.1:41078","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-20T20:27:49.448869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:48.215561Z","time spent":"1.233201059s","remote":"127.0.0.1:41078","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-20T20:27:49.448667Z","caller":"traceutil/trace.go:171","msg":"trace[227524764] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"1.233809699s","start":"2026-08-20T20:27:48.214818Z","end":"2026-08-20T20:27:49.448628Z","steps":["trace[227524764] 'process raft request' (duration: 1.233594285s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:49.449001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.153927056s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T20:27:49.449039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.23378392s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-08-20T20:27:49.449053Z","caller":"traceutil/trace.go:171","msg":"trace[307927987] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:692; }","duration":"1.154031328s","start":"2026-08-20T20:27:48.295006Z","end":"2026-08-20T20:27:49.449038Z","steps":["trace[307927987] 'agreement among raft nodes before linearized reading' (duration: 1.153911716s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:49.449058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:48.214804Z","time spent":"1.234223617s","remote":"127.0.0.1:41078","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-20T20:27:49.449109Z","caller":"traceutil/trace.go:171","msg":"trace[932827635] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:692; }","duration":"1.233917062s","start":"2026-08-20T20:27:48.215172Z","end":"2026-08-20T20:27:49.449089Z","steps":["trace[932827635] 'agreement among raft nodes before linearized reading' (duration: 1.233736079s)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:49.449022Z","caller":"traceutil/trace.go:171","msg":"trace[775972792] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"1.234336879s","start":"2026-08-20T20:27:48.214653Z","end":"2026-08-20T20:27:49.44899Z","steps":["trace[775972792] 'process raft request' (duration: 98.388819ms)","trace[775972792] 'compare' (duration: 1.134915211s)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:27:49.449122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.967161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T20:27:49.449117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:48.294996Z","time spent":"1.154107089s","remote":"127.0.0.1:40842","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-20T20:27:49.449162Z","caller":"traceutil/trace.go:171","msg":"trace[1665288837] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:692; }","duration":"705.053693ms","start":"2026-08-20T20:27:48.744098Z","end":"2026-08-20T20:27:49.449151Z","steps":["trace[1665288837] 'agreement among raft nodes before linearized reading' (duration: 704.980332ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:49.449156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:48.21512Z","time spent":"1.234025844s","remote":"127.0.0.1:41008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-08-20T20:27:49.449191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:48.744071Z","time spent":"705.113274ms","remote":"127.0.0.1:41212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-20T20:27:49.449211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:48.214622Z","time spent":"1.234530352s","remote":"127.0.0.1:41078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:27:49.745162Z","caller":"traceutil/trace.go:171","msg":"trace[126368322] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"261.261958ms","start":"2026-08-20T20:27:49.483873Z","end":"2026-08-20T20:27:49.745135Z","steps":["trace[126368322] 'process raft request' (duration: 261.194257ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:49.745244Z","caller":"traceutil/trace.go:171","msg":"trace[106305172] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"262.157603ms","start":"2026-08-20T20:27:49.483045Z","end":"2026-08-20T20:27:49.745203Z","steps":["trace[106305172] 'process raft request' (duration: 261.837937ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:49.871306Z","caller":"traceutil/trace.go:171","msg":"trace[1203089140] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"199.621182ms","start":"2026-08-20T20:27:49.671659Z","end":"2026-08-20T20:27:49.87128Z","steps":["trace[1203089140] 'process raft request' (duration: 199.583612ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:49.871379Z","caller":"traceutil/trace.go:171","msg":"trace[1865399518] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"199.734694ms","start":"2026-08-20T20:27:49.671604Z","end":"2026-08-20T20:27:49.871339Z","steps":["trace[1865399518] 'process raft request' (duration: 199.444499ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:52.886382Z","caller":"traceutil/trace.go:171","msg":"trace[1542018434] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"286.399547ms","start":"2026-08-20T20:27:52.599944Z","end":"2026-08-20T20:27:52.886343Z","steps":["trace[1542018434] 'process raft request' (duration: 235.528519ms)","trace[1542018434] 'compare' (duration: 50.524152ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:27:52.889621Z","caller":"traceutil/trace.go:171","msg":"trace[479232641] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:766; }","duration":"169.702116ms","start":"2026-08-20T20:27:52.719886Z","end":"2026-08-20T20:27:52.889588Z","steps":["trace[479232641] 'read index received' (duration: 115.636393ms)","trace[479232641] 'applied index is now lower than readState.Index' (duration: 54.063553ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:27:52.889796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.883269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:27:52.88985Z","caller":"traceutil/trace.go:171","msg":"trace[2040636749] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:732; }","duration":"170.020012ms","start":"2026-08-20T20:27:52.719811Z","end":"2026-08-20T20:27:52.889831Z","steps":["trace[2040636749] 'agreement among raft nodes before linearized reading' (duration: 169.89941ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:54.713501Z","caller":"traceutil/trace.go:171","msg":"trace[1268155680] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"123.964609ms","start":"2026-08-20T20:27:54.589479Z","end":"2026-08-20T20:27:54.713444Z","steps":["trace[1268155680] 'process raft request' (duration: 123.703824ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:05.115897Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2330225920180465735,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:05.616185Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2330225920180465735,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:05.665666Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.195892888s","expected-duration":"1s"} {"level":"info","ts":"2026-08-20T20:28:05.6662Z","caller":"traceutil/trace.go:171","msg":"trace[314382226] linearizableReadLoop","detail":"{readStateIndex:890; appliedIndex:889; }","duration":"1.050636667s","start":"2026-08-20T20:28:04.615543Z","end":"2026-08-20T20:28:05.666179Z","steps":["trace[314382226] 'read index received' (duration: 1.050477495s)","trace[314382226] 'applied index is now lower than readState.Index' (duration: 158.372µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:05.666236Z","caller":"traceutil/trace.go:171","msg":"trace[124014604] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"1.19655923s","start":"2026-08-20T20:28:04.469657Z","end":"2026-08-20T20:28:05.666216Z","steps":["trace[124014604] 'process raft request' (duration: 1.196385757s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:05.666364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.05081486s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-20T20:28:05.666405Z","caller":"traceutil/trace.go:171","msg":"trace[365947470] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:851; }","duration":"1.050905812s","start":"2026-08-20T20:28:04.615489Z","end":"2026-08-20T20:28:05.666395Z","steps":["trace[365947470] 'agreement among raft nodes before linearized reading' (duration: 1.0507884s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:05.666444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.355612ms","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-20T20:28:05.666438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"951.995782ms","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-20T20:28:05.666482Z","caller":"traceutil/trace.go:171","msg":"trace[1986867774] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:851; }","duration":"114.431324ms","start":"2026-08-20T20:28:05.55204Z","end":"2026-08-20T20:28:05.666471Z","steps":["trace[1986867774] 'agreement among raft nodes before linearized reading' (duration: 114.292482ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:05.66652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.627962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:05.666564Z","caller":"traceutil/trace.go:171","msg":"trace[835362160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:851; }","duration":"379.690922ms","start":"2026-08-20T20:28:05.286852Z","end":"2026-08-20T20:28:05.666543Z","steps":["trace[835362160] 'agreement among raft nodes before linearized reading' (duration: 379.648751ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:05.666601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:05.286832Z","time spent":"379.757454ms","remote":"127.0.0.1:40856","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-20T20:28:05.666619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.647203ms","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-20T20:28:05.66647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:04.615469Z","time spent":"1.050991183s","remote":"127.0.0.1:41078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":7,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-08-20T20:28:05.666516Z","caller":"traceutil/trace.go:171","msg":"trace[260572753] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:851; }","duration":"952.154494ms","start":"2026-08-20T20:28:04.714343Z","end":"2026-08-20T20:28:05.666498Z","steps":["trace[260572753] 'agreement among raft nodes before linearized reading' (duration: 951.980862ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:05.666725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:04.714325Z","time spent":"952.390039ms","remote":"127.0.0.1:41308","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-20T20:28:05.666782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.970201ms","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-20T20:28:05.666832Z","caller":"traceutil/trace.go:171","msg":"trace[640564196] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:851; }","duration":"122.054482ms","start":"2026-08-20T20:28:05.544765Z","end":"2026-08-20T20:28:05.666819Z","steps":["trace[640564196] 'agreement among raft nodes before linearized reading' (duration: 121.9617ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:05.666655Z","caller":"traceutil/trace.go:171","msg":"trace[282129704] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:851; }","duration":"907.723055ms","start":"2026-08-20T20:28:04.758924Z","end":"2026-08-20T20:28:05.666647Z","steps":["trace[282129704] 'agreement among raft nodes before linearized reading' (duration: 907.617473ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:05.666462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.218189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-20T20:28:05.666899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:04.758904Z","time spent":"907.983199ms","remote":"127.0.0.1:41078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-20T20:28:05.666915Z","caller":"traceutil/trace.go:171","msg":"trace[1782989168] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:851; }","duration":"102.733317ms","start":"2026-08-20T20:28:05.564171Z","end":"2026-08-20T20:28:05.666904Z","steps":["trace[1782989168] 'agreement among raft nodes before linearized reading' (duration: 102.192588ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:05.667084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.63134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-20T20:28:05.667122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:04.469631Z","time spent":"1.196650942s","remote":"127.0.0.1:40994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:28:05.667319Z","caller":"traceutil/trace.go:171","msg":"trace[459528879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:851; }","duration":"113.776392ms","start":"2026-08-20T20:28:05.553395Z","end":"2026-08-20T20:28:05.667171Z","steps":["trace[459528879] 'agreement among raft nodes before linearized reading' (duration: 113.294145ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:08.61708Z","caller":"traceutil/trace.go:171","msg":"trace[517901507] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"128.32963ms","start":"2026-08-20T20:28:08.488733Z","end":"2026-08-20T20:28:08.617063Z","steps":["trace[517901507] 'process raft request' (duration: 128.212228ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:10.656897Z","caller":"traceutil/trace.go:171","msg":"trace[963488340] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"133.959386ms","start":"2026-08-20T20:28:10.522915Z","end":"2026-08-20T20:28:10.656875Z","steps":["trace[963488340] 'process raft request' (duration: 123.85432ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:11.54694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.750283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-20T20:28:11.54702Z","caller":"traceutil/trace.go:171","msg":"trace[535418003] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:904; }","duration":"161.890536ms","start":"2026-08-20T20:28:11.385111Z","end":"2026-08-20T20:28:11.547001Z","steps":["trace[535418003] 'count revisions from in-memory index tree' (duration: 161.668252ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:11.919865Z","caller":"traceutil/trace.go:171","msg":"trace[956307528] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"112.090169ms","start":"2026-08-20T20:28:11.80775Z","end":"2026-08-20T20:28:11.91984Z","steps":["trace[956307528] 'process raft request' (duration: 111.810145ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:12.285067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.385113ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:28:12.285171Z","caller":"traceutil/trace.go:171","msg":"trace[520489142] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"360.541355ms","start":"2026-08-20T20:28:11.924611Z","end":"2026-08-20T20:28:12.285152Z","steps":["trace[520489142] 'process raft request' (duration: 24.98591ms)","trace[520489142] 'compare' (duration: 335.285191ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:12.285491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.924589Z","time spent":"360.792321ms","remote":"127.0.0.1:41078","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-20T20:28:12.298082Z","caller":"traceutil/trace.go:171","msg":"trace[909453340] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"373.123191ms","start":"2026-08-20T20:28:11.924926Z","end":"2026-08-20T20:28:12.298049Z","steps":["trace[909453340] 'process raft request' (duration: 372.908028ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:12.29816Z","caller":"traceutil/trace.go:171","msg":"trace[789520489] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"373.04363ms","start":"2026-08-20T20:28:11.925086Z","end":"2026-08-20T20:28:12.29813Z","steps":["trace[789520489] 'process raft request' (duration: 372.892188ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:12.298286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.92491Z","time spent":"373.263283ms","remote":"127.0.0.1:41078","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-20T20:28:12.298313Z","caller":"traceutil/trace.go:171","msg":"trace[1472587451] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"373.267164ms","start":"2026-08-20T20:28:11.925007Z","end":"2026-08-20T20:28:12.298274Z","steps":["trace[1472587451] 'process raft request' (duration: 372.928968ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:12.298299Z","caller":"traceutil/trace.go:171","msg":"trace[477972632] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"371.594187ms","start":"2026-08-20T20:28:11.926686Z","end":"2026-08-20T20:28:12.29828Z","steps":["trace[477972632] 'process raft request' (duration: 371.325962ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:12.298487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.924975Z","time spent":"373.422866ms","remote":"127.0.0.1:41078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:28:12.298503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.926674Z","time spent":"371.78034ms","remote":"127.0.0.1:32928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":553,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:28:12.298549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.898866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-20T20:28:12.298653Z","caller":"traceutil/trace.go:171","msg":"trace[1912162361] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:911; }","duration":"252.025807ms","start":"2026-08-20T20:28:12.046607Z","end":"2026-08-20T20:28:12.298632Z","steps":["trace[1912162361] 'agreement among raft nodes before linearized reading' (duration: 251.883655ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:12.29852Z","caller":"traceutil/trace.go:171","msg":"trace[1168355863] linearizableReadLoop","detail":"{readStateIndex:951; appliedIndex:947; }","duration":"251.577321ms","start":"2026-08-20T20:28:12.04664Z","end":"2026-08-20T20:28:12.298217Z","steps":["trace[1168355863] 'read index received' (duration: 251.121943ms)","trace[1168355863] 'applied index is now lower than readState.Index' (duration: 454.118µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:12.299112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.706565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:12.299203Z","caller":"traceutil/trace.go:171","msg":"trace[1456410084] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:911; }","duration":"160.776036ms","start":"2026-08-20T20:28:12.13838Z","end":"2026-08-20T20:28:12.299156Z","steps":["trace[1456410084] 'agreement among raft nodes before linearized reading' (duration: 160.672844ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:12.299625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.925066Z","time spent":"373.974105ms","remote":"127.0.0.1:41078","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-20T20:28:13.114929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.293973ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-20T20:28:13.115237Z","caller":"traceutil/trace.go:171","msg":"trace[896732411] linearizableReadLoop","detail":"{readStateIndex:953; appliedIndex:952; }","duration":"311.897039ms","start":"2026-08-20T20:28:12.803316Z","end":"2026-08-20T20:28:13.115213Z","steps":["trace[896732411] 'read index received' (duration: 34.288601ms)","trace[896732411] 'applied index is now lower than readState.Index' (duration: 277.605578ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:13.115493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.645834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:13.115585Z","caller":"traceutil/trace.go:171","msg":"trace[227630505] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:0; response_revision:913; }","duration":"210.798867ms","start":"2026-08-20T20:28:12.90477Z","end":"2026-08-20T20:28:13.115569Z","steps":["trace[227630505] 'agreement among raft nodes before linearized reading' (duration: 210.629854ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:13.115507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.173954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-oidc-hmac\" ","response":"range_response_count:1 size:452"} {"level":"info","ts":"2026-08-20T20:28:13.115693Z","caller":"traceutil/trace.go:171","msg":"trace[679235680] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-oidc-hmac; range_end:; response_count:1; response_revision:913; }","duration":"312.396248ms","start":"2026-08-20T20:28:12.803271Z","end":"2026-08-20T20:28:13.115667Z","steps":["trace[679235680] 'agreement among raft nodes before linearized reading' (duration: 312.046872ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:13.115765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:12.803246Z","time spent":"312.500889ms","remote":"127.0.0.1:40920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":475,"request content":"key:\"/registry/secrets/envoy-gateway-system/envoy-oidc-hmac\" "} {"level":"warn","ts":"2026-08-20T20:28:13.665406Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2330225920180465851,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:13.722628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.225479ms","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-20T20:28:13.722793Z","caller":"traceutil/trace.go:171","msg":"trace[493553051] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:914; }","duration":"407.410662ms","start":"2026-08-20T20:28:13.31536Z","end":"2026-08-20T20:28:13.722771Z","steps":["trace[493553051] 'range keys from in-memory index tree' (duration: 407.203638ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:13.722776Z","caller":"traceutil/trace.go:171","msg":"trace[479191953] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"564.798043ms","start":"2026-08-20T20:28:13.157945Z","end":"2026-08-20T20:28:13.722743Z","steps":["trace[479191953] 'process raft request' (duration: 556.518018ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:13.722946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:13.157921Z","time spent":"564.931915ms","remote":"127.0.0.1:41078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:28:13.723215Z","caller":"traceutil/trace.go:171","msg":"trace[104859486] linearizableReadLoop","detail":"{readStateIndex:958; appliedIndex:955; }","duration":"558.188604ms","start":"2026-08-20T20:28:13.164972Z","end":"2026-08-20T20:28:13.723161Z","steps":["trace[104859486] 'read index received' (duration: 549.498053ms)","trace[104859486] 'applied index is now lower than readState.Index' (duration: 8.689301ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:13.723257Z","caller":"traceutil/trace.go:171","msg":"trace[1162059152] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"565.219599ms","start":"2026-08-20T20:28:13.158016Z","end":"2026-08-20T20:28:13.723236Z","steps":["trace[1162059152] 'process raft request' (duration: 564.897234ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:13.723275Z","caller":"traceutil/trace.go:171","msg":"trace[80305962] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"564.481178ms","start":"2026-08-20T20:28:13.158773Z","end":"2026-08-20T20:28:13.723255Z","steps":["trace[80305962] 'process raft request' (duration: 564.283835ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:13.723385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:13.157993Z","time spent":"565.319492ms","remote":"127.0.0.1:40900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":902,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:28:13.723401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:13.158747Z","time spent":"564.57592ms","remote":"127.0.0.1:32928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1071,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:28:13.723417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.55416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:13.723469Z","caller":"traceutil/trace.go:171","msg":"trace[1614875419] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:917; }","duration":"134.646252ms","start":"2026-08-20T20:28:13.588808Z","end":"2026-08-20T20:28:13.723455Z","steps":["trace[1614875419] 'agreement among raft nodes before linearized reading' (duration: 134.562021ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:13.723486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.020589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-gz268\" ","response":"range_response_count:1 size:5393"} {"level":"warn","ts":"2026-08-20T20:28:13.723489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.50785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/\" range_end:\"/registry/serviceaccounts/envoy-gateway-system0\" limit:10000 ","response":"range_response_count:3 size:1862"} {"level":"info","ts":"2026-08-20T20:28:13.723532Z","caller":"traceutil/trace.go:171","msg":"trace[1406404619] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-gz268; range_end:; response_count:1; response_revision:917; }","duration":"226.09025ms","start":"2026-08-20T20:28:13.497426Z","end":"2026-08-20T20:28:13.723516Z","steps":["trace[1406404619] 'agreement among raft nodes before linearized reading' (duration: 225.938597ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:13.723547Z","caller":"traceutil/trace.go:171","msg":"trace[1950296306] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/; range_end:/registry/serviceaccounts/envoy-gateway-system0; response_count:3; response_revision:917; }","duration":"558.594892ms","start":"2026-08-20T20:28:13.164933Z","end":"2026-08-20T20:28:13.723528Z","steps":["trace[1950296306] 'agreement among raft nodes before linearized reading' (duration: 558.401119ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:13.723594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:13.164923Z","time spent":"558.655563ms","remote":"127.0.0.1:41008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":3,"response size":1885,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/\" range_end:\"/registry/serviceaccounts/envoy-gateway-system0\" limit:10000 "} {"level":"info","ts":"2026-08-20T20:28:14.030336Z","caller":"traceutil/trace.go:171","msg":"trace[630961826] linearizableReadLoop","detail":"{readStateIndex:959; appliedIndex:958; }","duration":"295.223943ms","start":"2026-08-20T20:28:13.735097Z","end":"2026-08-20T20:28:14.03032Z","steps":["trace[630961826] 'read index received' (duration: 294.479481ms)","trace[630961826] 'applied index is now lower than readState.Index' (duration: 743.832µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:14.030412Z","caller":"traceutil/trace.go:171","msg":"trace[1189303933] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"296.8556ms","start":"2026-08-20T20:28:13.733552Z","end":"2026-08-20T20:28:14.030408Z","steps":["trace[1189303933] 'process raft request' (duration: 296.031176ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:14.030535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.351142ms","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-20T20:28:14.03059Z","caller":"traceutil/trace.go:171","msg":"trace[617622312] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:918; }","duration":"105.447715ms","start":"2026-08-20T20:28:13.925129Z","end":"2026-08-20T20:28:14.030577Z","steps":["trace[617622312] 'agreement among raft nodes before linearized reading' (duration: 105.287062ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:14.030556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.450687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/envoy-gateway-system/\" range_end:\"/registry/deployments/envoy-gateway-system0\" limit:10000 ","response":"range_response_count:1 size:5616"} {"level":"info","ts":"2026-08-20T20:28:14.030758Z","caller":"traceutil/trace.go:171","msg":"trace[796637217] range","detail":"{range_begin:/registry/deployments/envoy-gateway-system/; range_end:/registry/deployments/envoy-gateway-system0; response_count:1; response_revision:918; }","duration":"295.673891ms","start":"2026-08-20T20:28:13.735073Z","end":"2026-08-20T20:28:14.030747Z","steps":["trace[796637217] 'agreement among raft nodes before linearized reading' (duration: 295.428356ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:14.38078Z","caller":"traceutil/trace.go:171","msg":"trace[1904614037] linearizableReadLoop","detail":"{readStateIndex:963; appliedIndex:962; }","duration":"161.328566ms","start":"2026-08-20T20:28:14.21943Z","end":"2026-08-20T20:28:14.380759Z","steps":["trace[1904614037] 'read index received' (duration: 161.168213ms)","trace[1904614037] 'applied index is now lower than readState.Index' (duration: 159.683µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:14.38092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.478228ms","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-20T20:28:14.380949Z","caller":"traceutil/trace.go:171","msg":"trace[823150756] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:922; }","duration":"161.55731ms","start":"2026-08-20T20:28:14.219385Z","end":"2026-08-20T20:28:14.380942Z","steps":["trace[823150756] 'agreement among raft nodes before linearized reading' (duration: 161.484119ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:14.381039Z","caller":"traceutil/trace.go:171","msg":"trace[40079487] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"225.522347ms","start":"2026-08-20T20:28:14.155492Z","end":"2026-08-20T20:28:14.381014Z","steps":["trace[40079487] 'process raft request' (duration: 225.15259ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:17.627975Z","caller":"traceutil/trace.go:171","msg":"trace[1837616899] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"144.68043ms","start":"2026-08-20T20:28:17.48326Z","end":"2026-08-20T20:28:17.62794Z","steps":["trace[1837616899] 'process raft request' (duration: 79.930132ms)","trace[1837616899] 'compare' (duration: 64.592766ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:18.816791Z","caller":"traceutil/trace.go:171","msg":"trace[808818602] linearizableReadLoop","detail":"{readStateIndex:1020; appliedIndex:1019; }","duration":"277.378131ms","start":"2026-08-20T20:28:18.539394Z","end":"2026-08-20T20:28:18.816772Z","steps":["trace[808818602] 'read index received' (duration: 277.203118ms)","trace[808818602] 'applied index is now lower than readState.Index' (duration: 174.063µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:18.816903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.499913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:18.816908Z","caller":"traceutil/trace.go:171","msg":"trace[1281018316] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"278.275505ms","start":"2026-08-20T20:28:18.53861Z","end":"2026-08-20T20:28:18.816886Z","steps":["trace[1281018316] 'process raft request' (duration: 278.041501ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:18.816933Z","caller":"traceutil/trace.go:171","msg":"trace[817237661] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:0; response_revision:978; }","duration":"277.578284ms","start":"2026-08-20T20:28:18.539345Z","end":"2026-08-20T20:28:18.816923Z","steps":["trace[817237661] 'agreement among raft nodes before linearized reading' (duration: 277.513833ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:18.979706Z","caller":"traceutil/trace.go:171","msg":"trace[671973672] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"125.338792ms","start":"2026-08-20T20:28:18.854337Z","end":"2026-08-20T20:28:18.979676Z","steps":["trace[671973672] 'process raft request' (duration: 125.232971ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:18.979725Z","caller":"traceutil/trace.go:171","msg":"trace[1549135122] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"127.865462ms","start":"2026-08-20T20:28:18.851837Z","end":"2026-08-20T20:28:18.979702Z","steps":["trace[1549135122] 'process raft request' (duration: 120.80485ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:19.274562Z","caller":"traceutil/trace.go:171","msg":"trace[923609526] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"196.00715ms","start":"2026-08-20T20:28:19.078505Z","end":"2026-08-20T20:28:19.274513Z","steps":["trace[923609526] 'process raft request' (duration: 179.842323ms)","trace[923609526] 'compare' (duration: 15.679359ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:19.484442Z","caller":"traceutil/trace.go:171","msg":"trace[1868284176] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"115.987926ms","start":"2026-08-20T20:28:19.368427Z","end":"2026-08-20T20:28:19.484415Z","steps":["trace[1868284176] 'process raft request' (duration: 115.834364ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:19.723487Z","caller":"traceutil/trace.go:171","msg":"trace[1767859906] linearizableReadLoop","detail":"{readStateIndex:1033; appliedIndex:1032; }","duration":"282.098511ms","start":"2026-08-20T20:28:19.441365Z","end":"2026-08-20T20:28:19.723463Z","steps":["trace[1767859906] 'read index received' (duration: 43.049985ms)","trace[1767859906] 'applied index is now lower than readState.Index' (duration: 239.047466ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:19.723554Z","caller":"traceutil/trace.go:171","msg":"trace[1296964528] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"281.877678ms","start":"2026-08-20T20:28:19.441644Z","end":"2026-08-20T20:28:19.723522Z","steps":["trace[1296964528] 'process raft request' (duration: 281.749296ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:19.723558Z","caller":"traceutil/trace.go:171","msg":"trace[1105849083] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"283.247979ms","start":"2026-08-20T20:28:19.440279Z","end":"2026-08-20T20:28:19.723527Z","steps":["trace[1105849083] 'process raft request' (duration: 276.313188ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:19.723709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.304534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T20:28:19.723774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.08918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12755"} {"level":"info","ts":"2026-08-20T20:28:19.723816Z","caller":"traceutil/trace.go:171","msg":"trace[1693592351] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:992; }","duration":"172.210702ms","start":"2026-08-20T20:28:19.551592Z","end":"2026-08-20T20:28:19.723803Z","steps":["trace[1693592351] 'agreement among raft nodes before linearized reading' (duration: 172.020809ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:19.723819Z","caller":"traceutil/trace.go:171","msg":"trace[665041245] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:992; }","duration":"282.503717ms","start":"2026-08-20T20:28:19.44129Z","end":"2026-08-20T20:28:19.723793Z","steps":["trace[665041245] 'agreement among raft nodes before linearized reading' (duration: 282.259863ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:19.909197Z","caller":"traceutil/trace.go:171","msg":"trace[2005722849] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"111.765529ms","start":"2026-08-20T20:28:19.797388Z","end":"2026-08-20T20:28:19.909154Z","steps":["trace[2005722849] 'process raft request' (duration: 31.077655ms)","trace[2005722849] 'compare' (duration: 79.977973ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:19.909361Z","caller":"traceutil/trace.go:171","msg":"trace[1377460102] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"111.903431ms","start":"2026-08-20T20:28:19.797423Z","end":"2026-08-20T20:28:19.909326Z","steps":["trace[1377460102] 'process raft request' (duration: 111.542126ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:19.909579Z","caller":"traceutil/trace.go:171","msg":"trace[1625853296] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"110.59053ms","start":"2026-08-20T20:28:19.798968Z","end":"2026-08-20T20:28:19.909558Z","steps":["trace[1625853296] 'process raft request' (duration: 110.278575ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:19.912201Z","caller":"traceutil/trace.go:171","msg":"trace[1955940554] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"112.888816ms","start":"2026-08-20T20:28:19.79928Z","end":"2026-08-20T20:28:19.912169Z","steps":["trace[1955940554] 'process raft request' (duration: 110.190303ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:19.98795Z","caller":"traceutil/trace.go:171","msg":"trace[1049596269] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"147.361066ms","start":"2026-08-20T20:28:19.840563Z","end":"2026-08-20T20:28:19.987924Z","steps":["trace[1049596269] 'process raft request' (duration: 147.117973ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:20.030453Z","caller":"traceutil/trace.go:171","msg":"trace[644797930] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"110.374646ms","start":"2026-08-20T20:28:19.920057Z","end":"2026-08-20T20:28:20.030432Z","steps":["trace[644797930] 'process raft request' (duration: 110.256464ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:20.030526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.067287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3696"} {"level":"info","ts":"2026-08-20T20:28:20.030529Z","caller":"traceutil/trace.go:171","msg":"trace[1336606599] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"113.719559ms","start":"2026-08-20T20:28:19.916773Z","end":"2026-08-20T20:28:20.030493Z","steps":["trace[1336606599] 'process raft request' (duration: 107.774574ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:20.030576Z","caller":"traceutil/trace.go:171","msg":"trace[1260708950] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:1000; }","duration":"111.169908ms","start":"2026-08-20T20:28:19.919391Z","end":"2026-08-20T20:28:20.030561Z","steps":["trace[1260708950] 'agreement among raft nodes before linearized reading' (duration: 110.988635ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:34.931771Z","caller":"traceutil/trace.go:171","msg":"trace[1952656430] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"121.720236ms","start":"2026-08-20T20:28:34.810022Z","end":"2026-08-20T20:28:34.931743Z","steps":["trace[1952656430] 'process raft request' (duration: 120.407336ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:34.931983Z","caller":"traceutil/trace.go:171","msg":"trace[255233924] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"121.652784ms","start":"2026-08-20T20:28:34.810319Z","end":"2026-08-20T20:28:34.931972Z","steps":["trace[255233924] 'process raft request' (duration: 121.37555ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:36.788409Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2330225920180466168,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-20T20:28:36.859617Z","caller":"traceutil/trace.go:171","msg":"trace[1326485595] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"571.911418ms","start":"2026-08-20T20:28:36.28769Z","end":"2026-08-20T20:28:36.859602Z","steps":["trace[1326485595] 'read index received' (duration: 571.758046ms)","trace[1326485595] 'applied index is now lower than readState.Index' (duration: 152.672µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:36.859889Z","caller":"traceutil/trace.go:171","msg":"trace[502596678] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"717.29ms","start":"2026-08-20T20:28:36.142579Z","end":"2026-08-20T20:28:36.859869Z","steps":["trace[502596678] 'process raft request' (duration: 716.920665ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:36.860032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:36.142552Z","time spent":"717.369071ms","remote":"127.0.0.1:41078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:28:36.86022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.543698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:36.860243Z","caller":"traceutil/trace.go:171","msg":"trace[2004796701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1074; }","duration":"572.605049ms","start":"2026-08-20T20:28:36.287632Z","end":"2026-08-20T20:28:36.860237Z","steps":["trace[2004796701] 'agreement among raft nodes before linearized reading' (duration: 572.568018ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:36.860262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:36.287605Z","time spent":"572.652229ms","remote":"127.0.0.1:40842","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-20T20:28:36.860513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.10803ms","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-20T20:28:36.860596Z","caller":"traceutil/trace.go:171","msg":"trace[1394623068] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1074; }","duration":"404.244212ms","start":"2026-08-20T20:28:36.456332Z","end":"2026-08-20T20:28:36.860576Z","steps":["trace[1394623068] 'agreement among raft nodes before linearized reading' (duration: 404.040599ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:36.860642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:36.45631Z","time spent":"404.323914ms","remote":"127.0.0.1:41078","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-20T20:28:37.462086Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2330225920180466176,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:37.963023Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2330225920180466176,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:38.463667Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2330225920180466176,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:38.964044Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2330225920180466176,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:39.192911Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.254051399s","expected-duration":"1s"} {"level":"info","ts":"2026-08-20T20:28:39.19348Z","caller":"traceutil/trace.go:171","msg":"trace[1260803383] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"2.254711739s","start":"2026-08-20T20:28:36.93874Z","end":"2026-08-20T20:28:39.193452Z","steps":["trace[1260803383] 'process raft request' (duration: 2.254550447s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:39.193755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:36.938724Z","time spent":"2.254856871s","remote":"127.0.0.1:41078","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-20T20:28:39.195733Z","caller":"traceutil/trace.go:171","msg":"trace[1319756038] linearizableReadLoop","detail":"{readStateIndex:1125; appliedIndex:1121; }","duration":"2.234427363s","start":"2026-08-20T20:28:36.961286Z","end":"2026-08-20T20:28:39.195713Z","steps":["trace[1319756038] 'read index received' (duration: 2.232010617s)","trace[1319756038] 'applied index is now lower than readState.Index' (duration: 2.415736ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:39.195987Z","caller":"traceutil/trace.go:171","msg":"trace[833962096] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"331.874517ms","start":"2026-08-20T20:28:38.864089Z","end":"2026-08-20T20:28:39.195963Z","steps":["trace[833962096] 'process raft request' (duration: 331.583823ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:39.196049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.75394548s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.108\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-20T20:28:39.196074Z","caller":"traceutil/trace.go:171","msg":"trace[404476882] range","detail":"{range_begin:/registry/masterleases/199.19.213.108; range_end:; response_count:1; response_revision:1080; }","duration":"1.753997491s","start":"2026-08-20T20:28:37.442069Z","end":"2026-08-20T20:28:39.196066Z","steps":["trace[404476882] 'agreement among raft nodes before linearized reading' (duration: 1.75390334s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:39.19609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:37.442053Z","time spent":"1.754033252s","remote":"127.0.0.1:40862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.108\" "} {"level":"warn","ts":"2026-08-20T20:28:39.196092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:38.864067Z","time spent":"331.968298ms","remote":"127.0.0.1:41078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:28:39.196099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.12656ms","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-20T20:28:39.196146Z","caller":"traceutil/trace.go:171","msg":"trace[1631424284] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1080; }","duration":"328.20351ms","start":"2026-08-20T20:28:38.867927Z","end":"2026-08-20T20:28:39.19613Z","steps":["trace[1631424284] 'agreement among raft nodes before linearized reading' (duration: 328.070498ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:39.196178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:38.867906Z","time spent":"328.265192ms","remote":"127.0.0.1:41078","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-20T20:28:39.196194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.399195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:39.196208Z","caller":"traceutil/trace.go:171","msg":"trace[1104144421] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1080; }","duration":"908.414475ms","start":"2026-08-20T20:28:38.287789Z","end":"2026-08-20T20:28:39.196204Z","steps":["trace[1104144421] 'agreement among raft nodes before linearized reading' (duration: 908.391485ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:39.196222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:38.287733Z","time spent":"908.486467ms","remote":"127.0.0.1:40842","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-20T20:28:39.196303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.28943322s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T20:28:39.196299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.235013042s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-20T20:28:39.196317Z","caller":"traceutil/trace.go:171","msg":"trace[268036613] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1080; }","duration":"1.28947797s","start":"2026-08-20T20:28:37.906834Z","end":"2026-08-20T20:28:39.196312Z","steps":["trace[268036613] 'agreement among raft nodes before linearized reading' (duration: 1.28945298s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:39.196329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:37.906811Z","time spent":"1.289514481s","remote":"127.0.0.1:41020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"info","ts":"2026-08-20T20:28:39.196317Z","caller":"traceutil/trace.go:171","msg":"trace[425905912] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"2.256342094s","start":"2026-08-20T20:28:36.939959Z","end":"2026-08-20T20:28:39.196301Z","steps":["trace[425905912] 'process raft request' (duration: 2.255580813s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:39.19637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.130132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:1 size:224"} {"level":"warn","ts":"2026-08-20T20:28:39.1964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.576787498s","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-20T20:28:39.196326Z","caller":"traceutil/trace.go:171","msg":"trace[954533534] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1080; }","duration":"2.235071603s","start":"2026-08-20T20:28:36.961246Z","end":"2026-08-20T20:28:39.196318Z","steps":["trace[954533534] 'agreement among raft nodes before linearized reading' (duration: 2.234999172s)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:39.196463Z","caller":"traceutil/trace.go:171","msg":"trace[912995329] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1080; }","duration":"1.576892809s","start":"2026-08-20T20:28:37.619565Z","end":"2026-08-20T20:28:39.196458Z","steps":["trace[912995329] 'agreement among raft nodes before linearized reading' (duration: 1.576823188s)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:39.196396Z","caller":"traceutil/trace.go:171","msg":"trace[1565101729] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:1080; }","duration":"194.171612ms","start":"2026-08-20T20:28:39.002215Z","end":"2026-08-20T20:28:39.196387Z","steps":["trace[1565101729] 'agreement among raft nodes before linearized reading' (duration: 194.127441ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:39.196389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:36.93993Z","time spent":"2.256420275s","remote":"127.0.0.1:41078","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-20T20:28:39.196475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:36.961229Z","time spent":"2.235237125s","remote":"127.0.0.1:41078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-20T20:28:39.196478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:37.619504Z","time spent":"1.57696976s","remote":"127.0.0.1:41246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-08-20T20:28:39.19668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.934706ms","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-20T20:28:39.196677Z","caller":"traceutil/trace.go:171","msg":"trace[1450246366] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"1.614821989s","start":"2026-08-20T20:28:37.581841Z","end":"2026-08-20T20:28:39.196663Z","steps":["trace[1450246366] 'process raft request' (duration: 1.613789184s)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:39.196711Z","caller":"traceutil/trace.go:171","msg":"trace[196878865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1080; }","duration":"327.985618ms","start":"2026-08-20T20:28:38.868714Z","end":"2026-08-20T20:28:39.1967Z","steps":["trace[196878865] 'agreement among raft nodes before linearized reading' (duration: 327.903146ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:39.196736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:38.868706Z","time spent":"328.024698ms","remote":"127.0.0.1:41078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-20T20:28:39.196763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:37.581822Z","time spent":"1.61488465s","remote":"127.0.0.1:41078","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-20T20:28:39.446437Z","caller":"traceutil/trace.go:171","msg":"trace[542680948] linearizableReadLoop","detail":"{readStateIndex:1129; appliedIndex:1125; }","duration":"241.432437ms","start":"2026-08-20T20:28:39.204983Z","end":"2026-08-20T20:28:39.446416Z","steps":["trace[542680948] 'read index received' (duration: 10.218883ms)","trace[542680948] 'applied index is now lower than readState.Index' (duration: 231.212514ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:39.446471Z","caller":"traceutil/trace.go:171","msg":"trace[1086723208] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"244.90912ms","start":"2026-08-20T20:28:39.201543Z","end":"2026-08-20T20:28:39.446452Z","steps":["trace[1086723208] 'process raft request' (duration: 242.798448ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:39.44665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.699242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:39.44668Z","caller":"traceutil/trace.go:171","msg":"trace[1464399991] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1083; }","duration":"158.760492ms","start":"2026-08-20T20:28:39.287911Z","end":"2026-08-20T20:28:39.446671Z","steps":["trace[1464399991] 'agreement among raft nodes before linearized reading' (duration: 158.704171ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:39.446649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.64185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:2897"} {"level":"info","ts":"2026-08-20T20:28:39.446756Z","caller":"traceutil/trace.go:171","msg":"trace[362937104] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1083; }","duration":"241.760593ms","start":"2026-08-20T20:28:39.204966Z","end":"2026-08-20T20:28:39.446727Z","steps":["trace[362937104] 'agreement among raft nodes before linearized reading' (duration: 241.56253ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:43.431778Z","caller":"traceutil/trace.go:171","msg":"trace[2050393636] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"119.316564ms","start":"2026-08-20T20:28:43.312433Z","end":"2026-08-20T20:28:43.43175Z","steps":["trace[2050393636] 'process raft request' (duration: 119.269073ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:43.431881Z","caller":"traceutil/trace.go:171","msg":"trace[20511073] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"119.494116ms","start":"2026-08-20T20:28:43.31235Z","end":"2026-08-20T20:28:43.431845Z","steps":["trace[20511073] 'process raft request' (duration: 119.255963ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:43.565162Z","caller":"traceutil/trace.go:171","msg":"trace[600455640] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"100.20596ms","start":"2026-08-20T20:28:43.464929Z","end":"2026-08-20T20:28:43.565135Z","steps":["trace[600455640] 'process raft request' (duration: 91.97475ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:53.480503Z","caller":"traceutil/trace.go:171","msg":"trace[1022999454] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"144.271591ms","start":"2026-08-20T20:28:53.33621Z","end":"2026-08-20T20:28:53.480481Z","steps":["trace[1022999454] 'process raft request' (duration: 144.065658ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:53.571035Z","caller":"traceutil/trace.go:171","msg":"trace[1076115868] linearizableReadLoop","detail":"{readStateIndex:1180; appliedIndex:1178; }","duration":"124.256532ms","start":"2026-08-20T20:28:53.446753Z","end":"2026-08-20T20:28:53.571009Z","steps":["trace[1076115868] 'read index received' (duration: 33.519763ms)","trace[1076115868] 'applied index is now lower than readState.Index' (duration: 90.735439ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:53.571638Z","caller":"traceutil/trace.go:171","msg":"trace[1640674211] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"234.513882ms","start":"2026-08-20T20:28:53.337059Z","end":"2026-08-20T20:28:53.571573Z","steps":["trace[1640674211] 'process raft request' (duration: 224.414267ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:53.572095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.326948ms","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-20T20:28:53.572156Z","caller":"traceutil/trace.go:171","msg":"trace[2053954756] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1131; }","duration":"125.44326ms","start":"2026-08-20T20:28:53.446697Z","end":"2026-08-20T20:28:53.57214Z","steps":["trace[2053954756] 'agreement among raft nodes before linearized reading' (duration: 124.551626ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:53.57216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.099099ms","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-20T20:28:53.572273Z","caller":"traceutil/trace.go:171","msg":"trace[1867621096] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1131; }","duration":"101.26048ms","start":"2026-08-20T20:28:53.470994Z","end":"2026-08-20T20:28:53.572255Z","steps":["trace[1867621096] 'agreement among raft nodes before linearized reading' (duration: 100.404007ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:29:30.000271Z","caller":"traceutil/trace.go:171","msg":"trace[679681436] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1304; }","duration":"188.331954ms","start":"2026-08-20T20:29:29.811915Z","end":"2026-08-20T20:29:30.000247Z","steps":["trace[679681436] 'read index received' (duration: 188.157872ms)","trace[679681436] 'applied index is now lower than readState.Index' (duration: 173.202µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:29:30.000433Z","caller":"traceutil/trace.go:171","msg":"trace[1515617178] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"193.757878ms","start":"2026-08-20T20:29:29.806635Z","end":"2026-08-20T20:29:30.000393Z","steps":["trace[1515617178] 'process raft request' (duration: 193.487393ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:30.000575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.458617ms","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-20T20:29:30.000663Z","caller":"traceutil/trace.go:171","msg":"trace[1068233858] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1248; }","duration":"188.539538ms","start":"2026-08-20T20:29:29.812078Z","end":"2026-08-20T20:29:30.000617Z","steps":["trace[1068233858] 'agreement among raft nodes before linearized reading' (duration: 188.385776ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:30.000799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.881802ms","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-20T20:29:30.000832Z","caller":"traceutil/trace.go:171","msg":"trace[1074038507] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1248; }","duration":"188.964914ms","start":"2026-08-20T20:29:29.811859Z","end":"2026-08-20T20:29:30.000824Z","steps":["trace[1074038507] 'agreement among raft nodes before linearized reading' (duration: 188.883613ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:30.001028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.804961ms","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-20T20:29:30.001089Z","caller":"traceutil/trace.go:171","msg":"trace[1909571791] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1248; }","duration":"188.877162ms","start":"2026-08-20T20:29:29.812197Z","end":"2026-08-20T20:29:30.001074Z","steps":["trace[1909571791] 'agreement among raft nodes before linearized reading' (duration: 188.73417ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:30.001139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.324184ms","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-20T20:29:30.001187Z","caller":"traceutil/trace.go:171","msg":"trace[1636887617] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1248; }","duration":"188.389195ms","start":"2026-08-20T20:29:29.812786Z","end":"2026-08-20T20:29:30.001175Z","steps":["trace[1636887617] 'agreement among raft nodes before linearized reading' (duration: 188.245573ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:36.745875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.932643ms","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-20T20:29:36.745956Z","caller":"traceutil/trace.go:171","msg":"trace[1575766816] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1273; }","duration":"196.062104ms","start":"2026-08-20T20:29:36.549869Z","end":"2026-08-20T20:29:36.745932Z","steps":["trace[1575766816] 'count revisions from in-memory index tree' (duration: 195.84488ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:36.746006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.259915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-08-20T20:29:36.746079Z","caller":"traceutil/trace.go:171","msg":"trace[260727066] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1273; }","duration":"509.378048ms","start":"2026-08-20T20:29:36.236684Z","end":"2026-08-20T20:29:36.746062Z","steps":["trace[260727066] 'range keys from in-memory index tree' (duration: 508.982222ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:36.746119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:29:36.236661Z","time spent":"509.449069ms","remote":"127.0.0.1:40920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":329975,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"info","ts":"2026-08-20T20:29:47.556449Z","caller":"traceutil/trace.go:171","msg":"trace[74782009] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"104.622234ms","start":"2026-08-20T20:29:47.451791Z","end":"2026-08-20T20:29:47.556413Z","steps":["trace[74782009] 'process raft request' (duration: 55.947099ms)","trace[74782009] 'compare' (duration: 48.498951ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:29:48.340333Z","caller":"traceutil/trace.go:171","msg":"trace[952914528] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"103.11649ms","start":"2026-08-20T20:29:48.237189Z","end":"2026-08-20T20:29:48.340306Z","steps":["trace[952914528] 'process raft request' (duration: 103.024569ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:29:48.34032Z","caller":"traceutil/trace.go:171","msg":"trace[954072058] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"103.342034ms","start":"2026-08-20T20:29:48.236941Z","end":"2026-08-20T20:29:48.340283Z","steps":["trace[954072058] 'process raft request' (duration: 103.117601ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:03.207323Z","caller":"traceutil/trace.go:171","msg":"trace[1019493923] transaction","detail":"{read_only:false; response_revision:1398; number_of_response:1; }","duration":"104.677202ms","start":"2026-08-20T20:30:03.10262Z","end":"2026-08-20T20:30:03.207297Z","steps":["trace[1019493923] 'process raft request' (duration: 104.48952ms)"],"step_count":1}