{"level":"warn","ts":"2026-07-29T00:49:09.041739Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-29T00:49:09.041833Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-07-29T00:49:09.041921Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-29T00:49:09.041951Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-07-29T00:49:09.041992Z","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-07-29T00:49:09.042619Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]} {"level":"info","ts":"2026-07-29T00:49:09.042715Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-07-29T00:49:09.047804Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.888038ms"} {"level":"info","ts":"2026-07-29T00:49:09.05367Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"} {"level":"info","ts":"2026-07-29T00:49:09.053854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"} {"level":"info","ts":"2026-07-29T00:49:09.053883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"} {"level":"info","ts":"2026-07-29T00:49:09.053956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-29T00:49:09.053986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"} {"level":"info","ts":"2026-07-29T00:49:09.054054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"warn","ts":"2026-07-29T00:49:09.061292Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-29T00:49:09.062556Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-29T00:49:09.065903Z","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-07-29T00:49:09.06891Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-29T00:49:09.072715Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-29T00:49:09.072842Z","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-07-29T00:49:09.072976Z","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-07-29T00:49:09.072991Z","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-07-29T00:49:09.073273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"info","ts":"2026-07-29T00:49:09.075242Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-07-29T00:49:09.076159Z","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-07-29T00:49:09.076372Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-29T00:49:09.076419Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-29T00:49:09.076537Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-07-29T00:49:09.076558Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-07-29T00:49:09.354947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"} {"level":"info","ts":"2026-07-29T00:49:09.355015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-29T00:49:09.355042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"} {"level":"info","ts":"2026-07-29T00:49:09.35506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"} {"level":"info","ts":"2026-07-29T00:49:09.355073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-07-29T00:49:09.355083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"} {"level":"info","ts":"2026-07-29T00:49:09.355095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-07-29T00:49:09.355794Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T00:49:09.356731Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-29T00:49:09.356754Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"} {"level":"info","ts":"2026-07-29T00:49:09.357123Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-29T00:49:09.3576Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-29T00:49:09.357633Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-29T00:49:09.35874Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-29T00:49:09.359211Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T00:49:09.359282Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T00:49:09.35931Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T00:49:09.359521Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"} {"level":"warn","ts":"2026-07-29T00:49:14.92823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.884074ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-29T00:49:14.928339Z","caller":"traceutil/trace.go:171","msg":"trace[1926698099] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"351.79511ms","start":"2026-07-29T00:49:14.576522Z","end":"2026-07-29T00:49:14.928317Z","steps":["trace[1926698099] 'process raft request' (duration: 224.471972ms)","trace[1926698099] 'compare' (duration: 126.785299ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:49:14.928453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:14.576503Z","time spent":"351.908576ms","remote":"127.0.0.1:39224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":373,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T00:49:14.928614Z","caller":"traceutil/trace.go:171","msg":"trace[207656196] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"152.798372ms","start":"2026-07-29T00:49:14.775805Z","end":"2026-07-29T00:49:14.928604Z","steps":["trace[207656196] 'process raft request' (duration: 152.76811ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:14.928805Z","caller":"traceutil/trace.go:171","msg":"trace[1265966336] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"153.941706ms","start":"2026-07-29T00:49:14.774848Z","end":"2026-07-29T00:49:14.92879Z","steps":["trace[1265966336] 'process raft request' (duration: 153.613168ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:14.928873Z","caller":"traceutil/trace.go:171","msg":"trace[61455899] transaction","detail":"{read_only:false; number_of_response:0; response_revision:223; }","duration":"167.859079ms","start":"2026-07-29T00:49:14.760994Z","end":"2026-07-29T00:49:14.928853Z","steps":["trace[61455899] 'process raft request' (duration: 167.415544ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:14.928932Z","caller":"traceutil/trace.go:171","msg":"trace[36385768] transaction","detail":"{read_only:false; number_of_response:0; response_revision:223; }","duration":"154.768362ms","start":"2026-07-29T00:49:14.774148Z","end":"2026-07-29T00:49:14.928916Z","steps":["trace[36385768] 'process raft request' (duration: 154.296826ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:14.929057Z","caller":"traceutil/trace.go:171","msg":"trace[273510498] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"153.66529ms","start":"2026-07-29T00:49:14.775319Z","end":"2026-07-29T00:49:14.928985Z","steps":["trace[273510498] 'process raft request' (duration: 153.222066ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:14.92907Z","caller":"traceutil/trace.go:171","msg":"trace[239760638] transaction","detail":"{read_only:false; number_of_response:0; response_revision:224; }","duration":"153.806878ms","start":"2026-07-29T00:49:14.775226Z","end":"2026-07-29T00:49:14.929032Z","steps":["trace[239760638] 'process raft request' (duration: 153.293779ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:14.929304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.826358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:49:14.929372Z","caller":"traceutil/trace.go:171","msg":"trace[320247492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:226; }","duration":"325.963637ms","start":"2026-07-29T00:49:14.603393Z","end":"2026-07-29T00:49:14.929357Z","steps":["trace[320247492] 'agreement among raft nodes before linearized reading' (duration: 325.791036ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:14.929411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:14.603383Z","time spent":"326.01971ms","remote":"127.0.0.1:39136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-29T00:49:14.92894Z","caller":"traceutil/trace.go:171","msg":"trace[1990457083] linearizableReadLoop","detail":"{readStateIndex:228; appliedIndex:227; }","duration":"325.468978ms","start":"2026-07-29T00:49:14.603426Z","end":"2026-07-29T00:49:14.928895Z","steps":["trace[1990457083] 'read index received' (duration: 197.583519ms)","trace[1990457083] 'applied index is now lower than readState.Index' (duration: 127.882219ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:49:14.930664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.543783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-07-29T00:49:14.930713Z","caller":"traceutil/trace.go:171","msg":"trace[1891234554] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:226; }","duration":"269.617308ms","start":"2026-07-29T00:49:14.661083Z","end":"2026-07-29T00:49:14.9307Z","steps":["trace[1891234554] 'agreement among raft nodes before linearized reading' (duration: 269.536803ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:14.930808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.749325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:49:14.93094Z","caller":"traceutil/trace.go:171","msg":"trace[6953516] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:226; }","duration":"269.898224ms","start":"2026-07-29T00:49:14.660996Z","end":"2026-07-29T00:49:14.930894Z","steps":["trace[6953516] 'agreement among raft nodes before linearized reading' (duration: 269.616278ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:20.409943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.285737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-07-29T00:49:20.409989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.497137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"warn","ts":"2026-07-29T00:49:20.409937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.743021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-07-29T00:49:20.410043Z","caller":"traceutil/trace.go:171","msg":"trace[819639996] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:302; }","duration":"240.90661ms","start":"2026-07-29T00:49:20.16913Z","end":"2026-07-29T00:49:20.410036Z","steps":["trace[819639996] 'range keys from in-memory index tree' (duration: 240.620246ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:20.410053Z","caller":"traceutil/trace.go:171","msg":"trace[1539825645] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:302; }","duration":"339.581091ms","start":"2026-07-29T00:49:20.070454Z","end":"2026-07-29T00:49:20.410035Z","steps":["trace[1539825645] 'range keys from in-memory index tree' (duration: 339.413942ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:20.410093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:20.07044Z","time spent":"339.644324ms","remote":"127.0.0.1:39068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":227,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-07-29T00:49:20.410153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.385474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-29T00:49:20.410171Z","caller":"traceutil/trace.go:171","msg":"trace[2082347716] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:302; }","duration":"190.444887ms","start":"2026-07-29T00:49:20.219721Z","end":"2026-07-29T00:49:20.410166Z","steps":["trace[2082347716] 'range keys from in-memory index tree' (duration: 190.304799ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:20.410229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.440552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-la23l1\" ","response":"range_response_count:1 size:540"} {"level":"info","ts":"2026-07-29T00:49:20.410243Z","caller":"traceutil/trace.go:171","msg":"trace[1671898926] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-la23l1; range_end:; response_count:1; response_revision:302; }","duration":"187.478083ms","start":"2026-07-29T00:49:20.222761Z","end":"2026-07-29T00:49:20.410239Z","steps":["trace[1671898926] 'range keys from in-memory index tree' (duration: 187.311995ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:20.410341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.782863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-07-29T00:49:20.410379Z","caller":"traceutil/trace.go:171","msg":"trace[1251401731] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:302; }","duration":"290.854057ms","start":"2026-07-29T00:49:20.11951Z","end":"2026-07-29T00:49:20.410364Z","steps":["trace[1251401731] 'range keys from in-memory index tree' (duration: 290.679828ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:20.410007Z","caller":"traceutil/trace.go:171","msg":"trace[1693768562] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:302; }","duration":"139.385032ms","start":"2026-07-29T00:49:20.270606Z","end":"2026-07-29T00:49:20.409992Z","steps":["trace[1693768562] 'range keys from in-memory index tree' (duration: 139.196322ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:20.788087Z","caller":"traceutil/trace.go:171","msg":"trace[1726146843] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"371.872698ms","start":"2026-07-29T00:49:20.416194Z","end":"2026-07-29T00:49:20.788067Z","steps":["trace[1726146843] 'process raft request' (duration: 371.778723ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:20.788332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:20.416174Z","time spent":"372.099509ms","remote":"127.0.0.1:39038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":596,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T00:49:21.266227Z","caller":"traceutil/trace.go:171","msg":"trace[1773955327] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:315; }","duration":"848.303489ms","start":"2026-07-29T00:49:20.417895Z","end":"2026-07-29T00:49:21.266198Z","steps":["trace[1773955327] 'read index received' (duration: 370.17166ms)","trace[1773955327] 'applied index is now lower than readState.Index' (duration: 478.130869ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T00:49:21.266267Z","caller":"traceutil/trace.go:171","msg":"trace[1328566657] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"849.119442ms","start":"2026-07-29T00:49:20.41712Z","end":"2026-07-29T00:49:21.26624Z","steps":["trace[1328566657] 'process raft request' (duration: 848.992794ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.266361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:20.417062Z","time spent":"849.255219ms","remote":"127.0.0.1:39150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T00:49:21.26636Z","caller":"traceutil/trace.go:171","msg":"trace[86921195] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"849.116721ms","start":"2026-07-29T00:49:20.417231Z","end":"2026-07-29T00:49:21.266347Z","steps":["trace[86921195] 'process raft request' (duration: 848.925641ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:21.266345Z","caller":"traceutil/trace.go:171","msg":"trace[503395523] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"849.317112ms","start":"2026-07-29T00:49:20.416986Z","end":"2026-07-29T00:49:21.266303Z","steps":["trace[503395523] 'process raft request' (duration: 848.999135ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.266443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:20.417221Z","time spent":"849.165384ms","remote":"127.0.0.1:39398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-29T00:49:21.266518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"847.894188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-07-29T00:49:21.266538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:20.416974Z","time spent":"849.468849ms","remote":"127.0.0.1:39068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T00:49:21.266594Z","caller":"traceutil/trace.go:171","msg":"trace[918810009] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:306; }","duration":"848.029815ms","start":"2026-07-29T00:49:20.418543Z","end":"2026-07-29T00:49:21.266573Z","steps":["trace[918810009] 'agreement among raft nodes before linearized reading' (duration: 847.872677ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.266637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:20.418526Z","time spent":"848.102028ms","remote":"127.0.0.1:39068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":258,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-07-29T00:49:21.266731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.445484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-29T00:49:21.266757Z","caller":"traceutil/trace.go:171","msg":"trace[1949831617] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:306; }","duration":"647.495817ms","start":"2026-07-29T00:49:20.619253Z","end":"2026-07-29T00:49:21.266749Z","steps":["trace[1949831617] 'agreement among raft nodes before linearized reading' (duration: 647.427053ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.266773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:20.619244Z","time spent":"647.525879ms","remote":"127.0.0.1:39068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-07-29T00:49:21.266775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.981421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-07-29T00:49:21.266803Z","caller":"traceutil/trace.go:171","msg":"trace[1139811509] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:306; }","duration":"697.031903ms","start":"2026-07-29T00:49:20.569762Z","end":"2026-07-29T00:49:21.266794Z","steps":["trace[1139811509] 'agreement among raft nodes before linearized reading' (duration: 696.97884ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.266833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.569482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-29T00:49:21.266832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:20.569749Z","time spent":"697.076275ms","remote":"127.0.0.1:39068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"info","ts":"2026-07-29T00:49:21.266846Z","caller":"traceutil/trace.go:171","msg":"trace[524518524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:306; }","duration":"297.613093ms","start":"2026-07-29T00:49:20.969229Z","end":"2026-07-29T00:49:21.266842Z","steps":["trace[524518524] 'agreement among raft nodes before linearized reading' (duration: 297.581712ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.266912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.639836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-07-29T00:49:21.266927Z","caller":"traceutil/trace.go:171","msg":"trace[955682121] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:306; }","duration":"748.676877ms","start":"2026-07-29T00:49:20.518245Z","end":"2026-07-29T00:49:21.266922Z","steps":["trace[955682121] 'agreement among raft nodes before linearized reading' (duration: 748.639185ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.266942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:20.518235Z","time spent":"748.703069ms","remote":"127.0.0.1:39068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":221,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-07-29T00:49:21.266987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.081178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-29T00:49:21.267027Z","caller":"traceutil/trace.go:171","msg":"trace[1016713502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:306; }","duration":"849.151432ms","start":"2026-07-29T00:49:20.417864Z","end":"2026-07-29T00:49:21.267015Z","steps":["trace[1016713502] 'agreement among raft nodes before linearized reading' (duration: 849.081338ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.267055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:20.417853Z","time spent":"849.195364ms","remote":"127.0.0.1:39136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-29T00:49:21.267312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.94363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-07-29T00:49:21.267373Z","caller":"traceutil/trace.go:171","msg":"trace[1104547930] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:306; }","duration":"798.126879ms","start":"2026-07-29T00:49:20.469215Z","end":"2026-07-29T00:49:21.267342Z","steps":["trace[1104547930] 'agreement among raft nodes before linearized reading' (duration: 797.93437ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.2674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:20.469203Z","time spent":"798.190232ms","remote":"127.0.0.1:39068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-07-29T00:49:21.930226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.033183ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-29T00:49:21.930364Z","caller":"traceutil/trace.go:171","msg":"trace[68593695] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"659.071049ms","start":"2026-07-29T00:49:21.271273Z","end":"2026-07-29T00:49:21.930344Z","steps":["trace[68593695] 'process raft request' (duration: 391.672217ms)","trace[68593695] 'compare' (duration: 266.871354ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:49:21.93043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.271258Z","time spent":"659.142703ms","remote":"127.0.0.1:39136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:49:21.933988Z","caller":"traceutil/trace.go:171","msg":"trace[432669470] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"661.408868ms","start":"2026-07-29T00:49:21.272552Z","end":"2026-07-29T00:49:21.933961Z","steps":["trace[432669470] 'process raft request' (duration: 661.177807ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.934273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.272528Z","time spent":"661.616349ms","remote":"127.0.0.1:39136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:49:21.934539Z","caller":"traceutil/trace.go:171","msg":"trace[2089848247] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"661.883172ms","start":"2026-07-29T00:49:21.272616Z","end":"2026-07-29T00:49:21.934499Z","steps":["trace[2089848247] 'process raft request' (duration: 661.234129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.934775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.272612Z","time spent":"662.0379ms","remote":"127.0.0.1:39136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:49:21.934845Z","caller":"traceutil/trace.go:171","msg":"trace[407946985] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"660.052058ms","start":"2026-07-29T00:49:21.274777Z","end":"2026-07-29T00:49:21.934829Z","steps":["trace[407946985] 'process raft request' (duration: 659.585565ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:21.934975Z","caller":"traceutil/trace.go:171","msg":"trace[700937690] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"655.710328ms","start":"2026-07-29T00:49:21.279247Z","end":"2026-07-29T00:49:21.934957Z","steps":["trace[700937690] 'process raft request' (duration: 655.464255ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:21.935037Z","caller":"traceutil/trace.go:171","msg":"trace[126956109] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"652.689064ms","start":"2026-07-29T00:49:21.282331Z","end":"2026-07-29T00:49:21.93502Z","steps":["trace[126956109] 'process raft request' (duration: 652.575988ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.935069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.27924Z","time spent":"655.783041ms","remote":"127.0.0.1:39136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:49:21.935107Z","caller":"traceutil/trace.go:171","msg":"trace[758739985] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"652.648042ms","start":"2026-07-29T00:49:21.282449Z","end":"2026-07-29T00:49:21.935097Z","steps":["trace[758739985] 'process raft request' (duration: 652.506655ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.935164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.282323Z","time spent":"652.778098ms","remote":"127.0.0.1:38940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-29T00:49:21.935203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.282444Z","time spent":"652.701194ms","remote":"127.0.0.1:39224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:49:21.935025Z","caller":"traceutil/trace.go:171","msg":"trace[111393919] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"652.959688ms","start":"2026-07-29T00:49:21.282034Z","end":"2026-07-29T00:49:21.934994Z","steps":["trace[111393919] 'process raft request' (duration: 652.825651ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.935293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.282014Z","time spent":"653.252392ms","remote":"127.0.0.1:39068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":172,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T00:49:21.935307Z","caller":"traceutil/trace.go:171","msg":"trace[1932438664] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"652.785089ms","start":"2026-07-29T00:49:21.282512Z","end":"2026-07-29T00:49:21.935297Z","steps":["trace[1932438664] 'process raft request' (duration: 652.491464ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.935354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.282503Z","time spent":"652.828251ms","remote":"127.0.0.1:39402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T00:49:21.935367Z","caller":"traceutil/trace.go:171","msg":"trace[2121611014] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"652.833511ms","start":"2026-07-29T00:49:21.28251Z","end":"2026-07-29T00:49:21.935344Z","steps":["trace[2121611014] 'process raft request' (duration: 652.686884ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:21.93546Z","caller":"traceutil/trace.go:171","msg":"trace[648686364] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"652.880113ms","start":"2026-07-29T00:49:21.282564Z","end":"2026-07-29T00:49:21.935444Z","steps":["trace[648686364] 'process raft request' (duration: 652.727366ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.935535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.282497Z","time spent":"652.943246ms","remote":"127.0.0.1:38978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2162,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T00:49:21.935599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.282251Z","time spent":"653.283384ms","remote":"127.0.0.1:38978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T00:49:21.935665Z","caller":"traceutil/trace.go:171","msg":"trace[1785888378] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"653.085954ms","start":"2026-07-29T00:49:21.282568Z","end":"2026-07-29T00:49:21.935654Z","steps":["trace[1785888378] 'process raft request' (duration: 652.772538ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.934969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.274771Z","time spent":"660.147144ms","remote":"127.0.0.1:39362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3691,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:49:21.93568Z","caller":"traceutil/trace.go:171","msg":"trace[2146366401] linearizableReadLoop","detail":"{readStateIndex:322; appliedIndex:318; }","duration":"660.178115ms","start":"2026-07-29T00:49:21.275489Z","end":"2026-07-29T00:49:21.935667Z","steps":["trace[2146366401] 'read index received' (duration: 387.516505ms)","trace[2146366401] 'applied index is now lower than readState.Index' (duration: 272.66071ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:49:21.935724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.282535Z","time spent":"653.160457ms","remote":"127.0.0.1:39054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4354,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:49:21.93575Z","caller":"traceutil/trace.go:171","msg":"trace[62454525] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"653.060003ms","start":"2026-07-29T00:49:21.28266Z","end":"2026-07-29T00:49:21.93572Z","steps":["trace[62454525] 'process raft request' (duration: 652.882083ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.935843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.346345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-29T00:49:21.935769Z","caller":"traceutil/trace.go:171","msg":"trace[2098697840] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"652.334215ms","start":"2026-07-29T00:49:21.283425Z","end":"2026-07-29T00:49:21.935759Z","steps":["trace[2098697840] 'process raft request' (duration: 652.192887ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:21.935889Z","caller":"traceutil/trace.go:171","msg":"trace[1050845336] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:320; }","duration":"660.416389ms","start":"2026-07-29T00:49:21.275464Z","end":"2026-07-29T00:49:21.93588Z","steps":["trace[1050845336] 'agreement among raft nodes before linearized reading' (duration: 660.324584ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.935897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.332833ms","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-07-29T00:49:21.935911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.283415Z","time spent":"652.471783ms","remote":"127.0.0.1:39224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T00:49:21.935928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.275457Z","time spent":"660.463921ms","remote":"127.0.0.1:39068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"info","ts":"2026-07-29T00:49:21.935938Z","caller":"traceutil/trace.go:171","msg":"trace[1274158175] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:320; }","duration":"537.402917ms","start":"2026-07-29T00:49:21.398524Z","end":"2026-07-29T00:49:21.935927Z","steps":["trace[1274158175] 'agreement among raft nodes before linearized reading' (duration: 537.330383ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:21.935849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.282653Z","time spent":"653.151058ms","remote":"127.0.0.1:39224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T00:49:21.935974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:21.398512Z","time spent":"537.455219ms","remote":"127.0.0.1:39136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-29T00:49:53.083901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:52.771393Z","time spent":"312.502613ms","remote":"127.0.0.1:38890","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-29T00:49:58.430259Z","caller":"traceutil/trace.go:171","msg":"trace[995946034] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"313.214113ms","start":"2026-07-29T00:49:58.116994Z","end":"2026-07-29T00:49:58.430208Z","steps":["trace[995946034] 'process raft request' (duration: 313.023827ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:58.43068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:58.116967Z","time spent":"313.434791ms","remote":"127.0.0.1:38904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T00:49:58.443963Z","caller":"traceutil/trace.go:171","msg":"trace[831953549] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"315.034644ms","start":"2026-07-29T00:49:58.128855Z","end":"2026-07-29T00:49:58.44389Z","steps":["trace[831953549] 'process raft request' (duration: 314.92349ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:58.444005Z","caller":"traceutil/trace.go:171","msg":"trace[1890704500] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"315.241791ms","start":"2026-07-29T00:49:58.128726Z","end":"2026-07-29T00:49:58.443968Z","steps":["trace[1890704500] 'process raft request' (duration: 313.826063ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:58.44411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:58.128824Z","time spent":"315.226971ms","remote":"127.0.0.1:38904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-29T00:49:58.444114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:58.12871Z","time spent":"315.340365ms","remote":"127.0.0.1:38904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T00:49:58.444033Z","caller":"traceutil/trace.go:171","msg":"trace[840316794] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"315.210681ms","start":"2026-07-29T00:49:58.128801Z","end":"2026-07-29T00:49:58.444011Z","steps":["trace[840316794] 'process raft request' (duration: 314.867718ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:58.444016Z","caller":"traceutil/trace.go:171","msg":"trace[106531220] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"315.21887ms","start":"2026-07-29T00:49:58.128752Z","end":"2026-07-29T00:49:58.443971Z","steps":["trace[106531220] 'process raft request' (duration: 313.938446ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:58.44451Z","caller":"traceutil/trace.go:171","msg":"trace[484586904] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"310.436939ms","start":"2026-07-29T00:49:58.134059Z","end":"2026-07-29T00:49:58.444496Z","steps":["trace[484586904] 'process raft request' (duration: 310.278714ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:58.444484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:58.128795Z","time spent":"315.536581ms","remote":"127.0.0.1:38904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T00:49:58.444591Z","caller":"traceutil/trace.go:171","msg":"trace[794842012] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"310.565534ms","start":"2026-07-29T00:49:58.134017Z","end":"2026-07-29T00:49:58.444583Z","steps":["trace[794842012] 'process raft request' (duration: 309.898311ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:58.444628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:58.134009Z","time spent":"310.601335ms","remote":"127.0.0.1:38904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-29T00:49:58.444561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:58.134056Z","time spent":"310.487221ms","remote":"127.0.0.1:38904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-29T00:49:58.444725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:58.128725Z","time spent":"315.967225ms","remote":"127.0.0.1:38904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T00:49:58.445131Z","caller":"traceutil/trace.go:171","msg":"trace[1550207108] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"310.521032ms","start":"2026-07-29T00:49:58.134215Z","end":"2026-07-29T00:49:58.444736Z","steps":["trace[1550207108] 'process raft request' (duration: 310.255033ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:58.445197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:58.134209Z","time spent":"310.952726ms","remote":"127.0.0.1:38904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T00:49:58.44559Z","caller":"traceutil/trace.go:171","msg":"trace[1264220150] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"296.725086ms","start":"2026-07-29T00:49:58.148822Z","end":"2026-07-29T00:49:58.445547Z","steps":["trace[1264220150] 'process raft request' (duration: 296.151107ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:58.445965Z","caller":"traceutil/trace.go:171","msg":"trace[1308301031] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"264.309121ms","start":"2026-07-29T00:49:58.181628Z","end":"2026-07-29T00:49:58.445937Z","steps":["trace[1308301031] 'process raft request' (duration: 264.157466ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:58.457267Z","caller":"traceutil/trace.go:171","msg":"trace[1620488311] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"287.269896ms","start":"2026-07-29T00:49:58.158659Z","end":"2026-07-29T00:49:58.445929Z","steps":["trace[1620488311] 'process raft request' (duration: 286.757619ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:58.457392Z","caller":"traceutil/trace.go:171","msg":"trace[214918393] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"143.879511ms","start":"2026-07-29T00:49:58.313502Z","end":"2026-07-29T00:49:58.457382Z","steps":["trace[214918393] 'process raft request' (duration: 143.301341ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:58.45748Z","caller":"traceutil/trace.go:171","msg":"trace[532375176] linearizableReadLoop","detail":"{readStateIndex:528; appliedIndex:526; }","duration":"339.013225ms","start":"2026-07-29T00:49:58.118434Z","end":"2026-07-29T00:49:58.457448Z","steps":["trace[532375176] 'read index received' (duration: 311.599369ms)","trace[532375176] 'applied index is now lower than readState.Index' (duration: 27.413136ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:49:58.458003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.540323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:49:58.45804Z","caller":"traceutil/trace.go:171","msg":"trace[633386564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"339.607795ms","start":"2026-07-29T00:49:58.118424Z","end":"2026-07-29T00:49:58.458032Z","steps":["trace[633386564] 'agreement among raft nodes before linearized reading' (duration: 339.512162ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:58.458063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:58.118417Z","time spent":"339.640337ms","remote":"127.0.0.1:38872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-29T00:49:58.464639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.974961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-29T00:49:58.464677Z","caller":"traceutil/trace.go:171","msg":"trace[817028177] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:519; }","duration":"275.045283ms","start":"2026-07-29T00:49:58.189623Z","end":"2026-07-29T00:49:58.464669Z","steps":["trace[817028177] 'agreement among raft nodes before linearized reading' (duration: 274.94938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:58.464747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.101946ms","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-07-29T00:49:58.464824Z","caller":"traceutil/trace.go:171","msg":"trace[1610691320] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:519; }","duration":"312.22738ms","start":"2026-07-29T00:49:58.152583Z","end":"2026-07-29T00:49:58.464811Z","steps":["trace[1610691320] 'agreement among raft nodes before linearized reading' (duration: 311.983512ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:58.464866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:58.152573Z","time spent":"312.285732ms","remote":"127.0.0.1:39136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-29T00:49:58.465009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.361881ms","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-07-29T00:49:58.465043Z","caller":"traceutil/trace.go:171","msg":"trace[1073596602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:519; }","duration":"306.416564ms","start":"2026-07-29T00:49:58.158619Z","end":"2026-07-29T00:49:58.465035Z","steps":["trace[1073596602] 'agreement among raft nodes before linearized reading' (duration: 306.357262ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:58.465065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:58.15861Z","time spent":"306.449934ms","remote":"127.0.0.1:39136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-29T00:49:58.465148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.613417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-29T00:49:58.46517Z","caller":"traceutil/trace.go:171","msg":"trace[2019964196] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:519; }","duration":"300.634918ms","start":"2026-07-29T00:49:58.164529Z","end":"2026-07-29T00:49:58.465164Z","steps":["trace[2019964196] 'agreement among raft nodes before linearized reading' (duration: 300.592636ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:58.465194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:58.16451Z","time spent":"300.67927ms","remote":"127.0.0.1:39136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-29T00:50:02.573212Z","caller":"traceutil/trace.go:171","msg":"trace[721369953] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"335.266674ms","start":"2026-07-29T00:50:02.237912Z","end":"2026-07-29T00:50:02.573179Z","steps":["trace[721369953] 'process raft request' (duration: 334.196598ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:50:02.573382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:50:02.237872Z","time spent":"335.423999ms","remote":"127.0.0.1:38972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036097,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:50:05.858314Z","caller":"traceutil/trace.go:171","msg":"trace[222910923] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"178.375462ms","start":"2026-07-29T00:50:05.679902Z","end":"2026-07-29T00:50:05.858277Z","steps":["trace[222910923] 'process raft request' (duration: 178.042232ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:50:06.100652Z","caller":"traceutil/trace.go:171","msg":"trace[1562130412] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"224.59707ms","start":"2026-07-29T00:50:05.876018Z","end":"2026-07-29T00:50:06.100615Z","steps":["trace[1562130412] 'read index received' (duration: 171.230804ms)","trace[1562130412] 'applied index is now lower than readState.Index' (duration: 53.364526ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:50:06.100807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.765536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:50:06.10076Z","caller":"traceutil/trace.go:171","msg":"trace[1994214028] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"229.237196ms","start":"2026-07-29T00:50:05.871482Z","end":"2026-07-29T00:50:06.100719Z","steps":["trace[1994214028] 'process raft request' (duration: 175.880281ms)","trace[1994214028] 'compare' (duration: 52.992684ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T00:50:06.100842Z","caller":"traceutil/trace.go:171","msg":"trace[719100668] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:619; }","duration":"224.867019ms","start":"2026-07-29T00:50:05.875964Z","end":"2026-07-29T00:50:06.100831Z","steps":["trace[719100668] 'agreement among raft nodes before linearized reading' (duration: 224.769306ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:50:06.692314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.986039ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-29T00:50:06.692569Z","caller":"traceutil/trace.go:171","msg":"trace[497106298] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"494.819146ms","start":"2026-07-29T00:50:06.197716Z","end":"2026-07-29T00:50:06.692535Z","steps":["trace[497106298] 'process raft request' (duration: 494.749364ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:50:06.692606Z","caller":"traceutil/trace.go:171","msg":"trace[2119486538] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"581.020337ms","start":"2026-07-29T00:50:06.111533Z","end":"2026-07-29T00:50:06.692553Z","steps":["trace[2119486538] 'process raft request' (duration: 351.717729ms)","trace[2119486538] 'compare' (duration: 228.804122ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:50:06.692697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:50:06.19769Z","time spent":"494.93663ms","remote":"127.0.0.1:39136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T00:50:06.692767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:50:06.111519Z","time spent":"581.176972ms","remote":"127.0.0.1:39058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T00:50:07.022479Z","caller":"traceutil/trace.go:171","msg":"trace[1217154953] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"266.091301ms","start":"2026-07-29T00:50:06.756348Z","end":"2026-07-29T00:50:07.022439Z","steps":["trace[1217154953] 'process raft request' (duration: 266.001568ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:50:07.022764Z","caller":"traceutil/trace.go:171","msg":"trace[1857163903] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"265.621246ms","start":"2026-07-29T00:50:06.757097Z","end":"2026-07-29T00:50:07.022718Z","steps":["trace[1857163903] 'process raft request' (duration: 265.299286ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:50:07.022934Z","caller":"traceutil/trace.go:171","msg":"trace[623323381] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"266.545345ms","start":"2026-07-29T00:50:06.756255Z","end":"2026-07-29T00:50:07.0228Z","steps":["trace[623323381] 'process raft request' (duration: 265.926136ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:50:07.66461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.903518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:50:07.664731Z","caller":"traceutil/trace.go:171","msg":"trace[521278416] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"557.088183ms","start":"2026-07-29T00:50:07.107618Z","end":"2026-07-29T00:50:07.664706Z","steps":["trace[521278416] 'range keys from in-memory index tree' (duration: 556.820885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:50:07.664791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:50:07.107595Z","time spent":"557.182537ms","remote":"127.0.0.1:38864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-29T00:50:08.795362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.237733ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-07-29T00:50:10.310072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.0729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:50:10.310188Z","caller":"traceutil/trace.go:171","msg":"trace[1134282746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"175.247095ms","start":"2026-07-29T00:50:10.134918Z","end":"2026-07-29T00:50:10.310165Z","steps":["trace[1134282746] 'range keys from in-memory index tree' (duration: 174.986817ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:50:24.150403Z","caller":"traceutil/trace.go:171","msg":"trace[1417609240] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"200.010879ms","start":"2026-07-29T00:50:23.95034Z","end":"2026-07-29T00:50:24.150351Z","steps":["trace[1417609240] 'process raft request' (duration: 199.742612ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:52:19.925933Z","caller":"traceutil/trace.go:171","msg":"trace[1228969209] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"121.100245ms","start":"2026-07-29T00:52:19.804801Z","end":"2026-07-29T00:52:19.925901Z","steps":["trace[1228969209] 'process raft request' (duration: 76.150098ms)","trace[1228969209] 'compare' (duration: 44.827326ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T00:52:19.937228Z","caller":"traceutil/trace.go:171","msg":"trace[1590342780] linearizableReadLoop","detail":"{readStateIndex:1399; appliedIndex:1397; }","duration":"124.684447ms","start":"2026-07-29T00:52:19.812529Z","end":"2026-07-29T00:52:19.937214Z","steps":["trace[1590342780] 'read index received' (duration: 68.473536ms)","trace[1590342780] 'applied index is now lower than readState.Index' (duration: 56.210021ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:52:19.93742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.874739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-29T00:52:19.937427Z","caller":"traceutil/trace.go:171","msg":"trace[1602569271] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"131.654118ms","start":"2026-07-29T00:52:19.805724Z","end":"2026-07-29T00:52:19.937378Z","steps":["trace[1602569271] 'process raft request' (duration: 131.393134ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:52:19.93746Z","caller":"traceutil/trace.go:171","msg":"trace[443797560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1338; }","duration":"124.96131ms","start":"2026-07-29T00:52:19.812489Z","end":"2026-07-29T00:52:19.93745Z","steps":["trace[443797560] 'agreement among raft nodes before linearized reading' (duration: 124.782997ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:52:22.024869Z","caller":"traceutil/trace.go:171","msg":"trace[1105813645] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"763.05437ms","start":"2026-07-29T00:52:21.261787Z","end":"2026-07-29T00:52:22.024841Z","steps":["trace[1105813645] 'process raft request' (duration: 762.869867ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:52:22.025025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:52:21.261764Z","time spent":"763.184851ms","remote":"127.0.0.1:39136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:52:22.033719Z","caller":"traceutil/trace.go:171","msg":"trace[58118456] linearizableReadLoop","detail":"{readStateIndex:1402; appliedIndex:1400; }","duration":"457.57812ms","start":"2026-07-29T00:52:21.576124Z","end":"2026-07-29T00:52:22.033702Z","steps":["trace[58118456] 'read index received' (duration: 448.568651ms)","trace[58118456] 'applied index is now lower than readState.Index' (duration: 9.008739ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T00:52:22.034071Z","caller":"traceutil/trace.go:171","msg":"trace[424178182] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"492.47049ms","start":"2026-07-29T00:52:21.54157Z","end":"2026-07-29T00:52:22.034041Z","steps":["trace[424178182] 'process raft request' (duration: 492.026784ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:52:22.034568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:52:21.541548Z","time spent":"492.973617ms","remote":"127.0.0.1:39136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T00:52:22.034755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.580439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-29T00:52:22.034785Z","caller":"traceutil/trace.go:171","msg":"trace[1842059561] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1341; }","duration":"367.632039ms","start":"2026-07-29T00:52:21.667143Z","end":"2026-07-29T00:52:22.034775Z","steps":["trace[1842059561] 'agreement among raft nodes before linearized reading' (duration: 367.577589ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:52:22.034814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:52:21.66713Z","time spent":"367.676841ms","remote":"127.0.0.1:39398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":5,"response size":31,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-07-29T00:52:22.034305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.161419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-29T00:52:22.035111Z","caller":"traceutil/trace.go:171","msg":"trace[1197065048] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1341; }","duration":"459.008631ms","start":"2026-07-29T00:52:21.576085Z","end":"2026-07-29T00:52:22.035094Z","steps":["trace[1197065048] 'agreement among raft nodes before linearized reading' (duration: 458.056018ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:52:22.035167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:52:21.576071Z","time spent":"459.075232ms","remote":"127.0.0.1:39136","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-07-29T00:52:22.035208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.541402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-29T00:52:22.035239Z","caller":"traceutil/trace.go:171","msg":"trace[957642209] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1341; }","duration":"105.613464ms","start":"2026-07-29T00:52:21.929617Z","end":"2026-07-29T00:52:22.03523Z","steps":["trace[957642209] 'agreement among raft nodes before linearized reading' (duration: 105.518452ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:52:22.035324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.774742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:52:22.035359Z","caller":"traceutil/trace.go:171","msg":"trace[1956848679] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1341; }","duration":"148.836132ms","start":"2026-07-29T00:52:21.886515Z","end":"2026-07-29T00:52:22.035351Z","steps":["trace[1956848679] 'agreement among raft nodes before linearized reading' (duration: 148.784282ms)"],"step_count":1}