{"level":"warn","ts":"2026-06-04T06:30:45.485552Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-04T06:30:45.485643Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109: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.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-06-04T06:30:45.485723Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-04T06:30:45.485764Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-06-04T06:30:45.485797Z","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-06-04T06:30:45.486529Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-06-04T06:30:45.48663Z","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.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-06-04T06:30:45.491186Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.311153ms"} {"level":"info","ts":"2026-06-04T06:30:45.500392Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-06-04T06:30:45.500459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-06-04T06:30:45.50048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-06-04T06:30:45.500488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-04T06:30:45.500499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-06-04T06:30:45.500534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-06-04T06:30:45.511656Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-04T06:30:45.513585Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-04T06:30:45.517845Z","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-06-04T06:30:45.522057Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-04T06:30:45.525187Z","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-06-04T06:30:45.525323Z","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-06-04T06:30:45.525406Z","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-06-04T06:30:45.525229Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-04T06:30:45.528113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-06-04T06:30:45.528341Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-06-04T06:30:45.530426Z","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-06-04T06:30:45.530839Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-06-04T06:30:45.53089Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-06-04T06:30:45.53104Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-04T06:30:45.53111Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-04T06:30:45.901663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-06-04T06:30:45.901721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-06-04T06:30:45.901764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-06-04T06:30:45.901783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-06-04T06:30:45.901799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-06-04T06:30:45.901814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-06-04T06:30:45.901831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-06-04T06:30:45.904488Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-06-04T06:30:45.904718Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-04T06:30:45.904741Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-04T06:30:45.905119Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T06:30:45.90644Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-04T06:30:45.906521Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-04T06:30:45.907931Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T06:30:45.908149Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T06:30:45.908214Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T06:30:45.910283Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-04T06:30:45.915313Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"info","ts":"2026-06-04T06:31:14.01133Z","caller":"traceutil/trace.go:171","msg":"trace[1460847267] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"219.952674ms","start":"2026-06-04T06:31:13.791351Z","end":"2026-06-04T06:31:14.011304Z","steps":["trace[1460847267] 'process raft request' (duration: 219.8002ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:31:21.541512Z","caller":"traceutil/trace.go:171","msg":"trace[2026802991] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:501; }","duration":"126.034096ms","start":"2026-06-04T06:31:21.41544Z","end":"2026-06-04T06:31:21.541474Z","steps":["trace[2026802991] 'read index received' (duration: 125.729669ms)","trace[2026802991] 'applied index is now lower than readState.Index' (duration: 302.947µs)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:31:21.541685Z","caller":"traceutil/trace.go:171","msg":"trace[215992150] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"136.063464ms","start":"2026-06-04T06:31:21.405606Z","end":"2026-06-04T06:31:21.541669Z","steps":["trace[215992150] 'process raft request' (duration: 135.686885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:31:21.541941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.469466ms","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-06-04T06:31:21.542133Z","caller":"traceutil/trace.go:171","msg":"trace[1492141090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:484; }","duration":"126.755203ms","start":"2026-06-04T06:31:21.415353Z","end":"2026-06-04T06:31:21.542108Z","steps":["trace[1492141090] 'agreement among raft nodes before linearized reading' (duration: 126.451756ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:31:22.084917Z","caller":"traceutil/trace.go:171","msg":"trace[270264097] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"214.026977ms","start":"2026-06-04T06:31:21.870856Z","end":"2026-06-04T06:31:22.084883Z","steps":["trace[270264097] 'process raft request' (duration: 213.669019ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:31:22.085339Z","caller":"traceutil/trace.go:171","msg":"trace[1117103934] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"177.650083ms","start":"2026-06-04T06:31:21.907667Z","end":"2026-06-04T06:31:22.085317Z","steps":["trace[1117103934] 'process raft request' (duration: 177.588371ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:31:22.085488Z","caller":"traceutil/trace.go:171","msg":"trace[1028841951] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"211.159289ms","start":"2026-06-04T06:31:21.874321Z","end":"2026-06-04T06:31:22.085481Z","steps":["trace[1028841951] 'process raft request' (duration: 210.344849ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:31:22.085544Z","caller":"traceutil/trace.go:171","msg":"trace[829431571] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"211.148069ms","start":"2026-06-04T06:31:21.874391Z","end":"2026-06-04T06:31:22.085539Z","steps":["trace[829431571] 'process raft request' (duration: 210.318449ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:31:22.085714Z","caller":"traceutil/trace.go:171","msg":"trace[1736175656] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"202.449472ms","start":"2026-06-04T06:31:21.883258Z","end":"2026-06-04T06:31:22.085708Z","steps":["trace[1736175656] 'process raft request' (duration: 201.609092ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:31:22.085738Z","caller":"traceutil/trace.go:171","msg":"trace[843873929] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"202.651497ms","start":"2026-06-04T06:31:21.883072Z","end":"2026-06-04T06:31:22.085723Z","steps":["trace[843873929] 'process raft request' (duration: 201.704135ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:31:22.085783Z","caller":"traceutil/trace.go:171","msg":"trace[511612731] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"198.437957ms","start":"2026-06-04T06:31:21.887339Z","end":"2026-06-04T06:31:22.085777Z","steps":["trace[511612731] 'process raft request' (duration: 197.569916ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:31:22.085847Z","caller":"traceutil/trace.go:171","msg":"trace[1810723342] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"178.314358ms","start":"2026-06-04T06:31:21.907528Z","end":"2026-06-04T06:31:22.085842Z","steps":["trace[1810723342] 'process raft request' (duration: 177.609551ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:31:22.085896Z","caller":"traceutil/trace.go:171","msg":"trace[2017106018] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"210.689278ms","start":"2026-06-04T06:31:21.875196Z","end":"2026-06-04T06:31:22.085886Z","steps":["trace[2017106018] 'process raft request' (duration: 209.552271ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:31:22.085923Z","caller":"traceutil/trace.go:171","msg":"trace[524319494] transaction","detail":"{read_only:false; number_of_response:1; response_revision:500; }","duration":"202.707818ms","start":"2026-06-04T06:31:21.883177Z","end":"2026-06-04T06:31:22.085885Z","steps":["trace[524319494] 'process raft request' (duration: 201.640753ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:31:22.094993Z","caller":"traceutil/trace.go:171","msg":"trace[1174848758] transaction","detail":"{read_only:false; number_of_response:1; response_revision:504; }","duration":"168.28494ms","start":"2026-06-04T06:31:21.926697Z","end":"2026-06-04T06:31:22.094982Z","steps":["trace[1174848758] 'process raft request' (duration: 167.629925ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:31:27.760154Z","caller":"traceutil/trace.go:171","msg":"trace[1310797216] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"182.703493ms","start":"2026-06-04T06:31:27.577415Z","end":"2026-06-04T06:31:27.760118Z","steps":["trace[1310797216] 'read index received' (duration: 181.73876ms)","trace[1310797216] 'applied index is now lower than readState.Index' (duration: 963.833µs)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:31:27.760237Z","caller":"traceutil/trace.go:171","msg":"trace[1713996010] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"209.703744ms","start":"2026-06-04T06:31:27.550478Z","end":"2026-06-04T06:31:27.760182Z","steps":["trace[1713996010] 'process raft request' (duration: 208.969137ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:31:27.760417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.398504ms","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-06-04T06:31:27.760461Z","caller":"traceutil/trace.go:171","msg":"trace[1531606118] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:586; }","duration":"118.487566ms","start":"2026-06-04T06:31:27.641961Z","end":"2026-06-04T06:31:27.760449Z","steps":["trace[1531606118] 'agreement among raft nodes before linearized reading' (duration: 118.320112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:31:27.76043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.00654ms","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-06-04T06:31:27.760514Z","caller":"traceutil/trace.go:171","msg":"trace[258703231] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:586; }","duration":"183.117853ms","start":"2026-06-04T06:31:27.577378Z","end":"2026-06-04T06:31:27.760496Z","steps":["trace[258703231] 'agreement among raft nodes before linearized reading' (duration: 182.874717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:31:28.143932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.572337ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T06:31:28.144115Z","caller":"traceutil/trace.go:171","msg":"trace[394158815] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"377.970494ms","start":"2026-06-04T06:31:27.766104Z","end":"2026-06-04T06:31:28.144075Z","steps":["trace[394158815] 'process raft request' (duration: 224.599078ms)","trace[394158815] 'compare' (duration: 152.410163ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:31:28.144185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:31:27.766089Z","time spent":"378.066296ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:31:28.160524Z","caller":"traceutil/trace.go:171","msg":"trace[1676320471] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"340.474353ms","start":"2026-06-04T06:31:27.820017Z","end":"2026-06-04T06:31:28.160492Z","steps":["trace[1676320471] 'process raft request' (duration: 340.253898ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:31:28.16065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:31:27.819985Z","time spent":"340.610187ms","remote":"127.0.0.1:37338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T06:31:29.343753Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.055310752s","expected-duration":"1s"} {"level":"info","ts":"2026-06-04T06:31:29.413371Z","caller":"traceutil/trace.go:171","msg":"trace[1901999173] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"1.140145969s","start":"2026-06-04T06:31:28.273194Z","end":"2026-06-04T06:31:29.41334Z","steps":["trace[1901999173] 'process raft request' (duration: 1.070839901s)","trace[1901999173] 'compare' (duration: 68.933009ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:31:29.413523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:31:28.273167Z","time spent":"1.140283212s","remote":"127.0.0.1:37228","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-06-04T06:31:29.416206Z","caller":"traceutil/trace.go:171","msg":"trace[2035657109] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"822.687433ms","start":"2026-06-04T06:31:28.593463Z","end":"2026-06-04T06:31:29.41615Z","steps":["trace[2035657109] 'process raft request' (duration: 820.760668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:31:29.416558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:31:28.593429Z","time spent":"822.925759ms","remote":"127.0.0.1:37020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:31:29.417012Z","caller":"traceutil/trace.go:171","msg":"trace[1029327463] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:616; }","duration":"381.61944ms","start":"2026-06-04T06:31:29.035321Z","end":"2026-06-04T06:31:29.416941Z","steps":["trace[1029327463] 'read index received' (duration: 308.766129ms)","trace[1029327463] 'applied index is now lower than readState.Index' (duration: 72.730408ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:31:29.417235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.893047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-04T06:31:29.417354Z","caller":"traceutil/trace.go:171","msg":"trace[703770350] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:594; }","duration":"382.053231ms","start":"2026-06-04T06:31:29.035258Z","end":"2026-06-04T06:31:29.417312Z","steps":["trace[703770350] 'agreement among raft nodes before linearized reading' (duration: 381.653491ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:31:29.417401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:31:29.035233Z","time spent":"382.160283ms","remote":"127.0.0.1:36972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.109\" "} {"level":"info","ts":"2026-06-04T06:31:30.38487Z","caller":"traceutil/trace.go:171","msg":"trace[1274969074] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:633; }","duration":"151.864049ms","start":"2026-06-04T06:31:30.232979Z","end":"2026-06-04T06:31:30.384843Z","steps":["trace[1274969074] 'read index received' (duration: 26.632973ms)","trace[1274969074] 'applied index is now lower than readState.Index' (duration: 125.229706ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:31:30.38495Z","caller":"traceutil/trace.go:171","msg":"trace[1142579634] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"185.871858ms","start":"2026-06-04T06:31:30.199038Z","end":"2026-06-04T06:31:30.38491Z","steps":["trace[1142579634] 'process raft request' (duration: 184.843043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:31:30.385115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.110346ms","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-06-04T06:31:30.385165Z","caller":"traceutil/trace.go:171","msg":"trace[166555509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:610; }","duration":"152.203298ms","start":"2026-06-04T06:31:30.232949Z","end":"2026-06-04T06:31:30.385153Z","steps":["trace[166555509] 'agreement among raft nodes before linearized reading' (duration: 152.018273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:31:44.958076Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334368128255656569,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-04T06:31:45.02503Z","caller":"traceutil/trace.go:171","msg":"trace[638927848] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"587.867053ms","start":"2026-06-04T06:31:44.43713Z","end":"2026-06-04T06:31:45.024997Z","steps":["trace[638927848] 'process raft request' (duration: 587.674119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:31:45.025219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:31:44.437113Z","time spent":"588.000726ms","remote":"127.0.0.1:37228","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-06-04T06:31:45.157637Z","caller":"traceutil/trace.go:171","msg":"trace[1717431078] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:785; }","duration":"700.046779ms","start":"2026-06-04T06:31:44.457559Z","end":"2026-06-04T06:31:45.157606Z","steps":["trace[1717431078] 'read index received' (duration: 567.256623ms)","trace[1717431078] 'applied index is now lower than readState.Index' (duration: 132.788716ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:31:45.157961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.366414ms","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-06-04T06:31:45.158003Z","caller":"traceutil/trace.go:171","msg":"trace[1745468607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:758; }","duration":"699.456455ms","start":"2026-06-04T06:31:44.458533Z","end":"2026-06-04T06:31:45.157989Z","steps":["trace[1745468607] 'agreement among raft nodes before linearized reading' (duration: 699.24558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:31:45.15804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:31:44.45852Z","time spent":"699.512176ms","remote":"127.0.0.1:37228","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-06-04T06:31:45.158044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.429978ms","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-06-04T06:31:45.158235Z","caller":"traceutil/trace.go:171","msg":"trace[879778862] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:758; }","duration":"469.642123ms","start":"2026-06-04T06:31:44.68854Z","end":"2026-06-04T06:31:45.158182Z","steps":["trace[879778862] 'agreement among raft nodes before linearized reading' (duration: 469.388007ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:31:45.158043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.402798ms","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-06-04T06:31:45.158329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:31:44.688513Z","time spent":"469.773706ms","remote":"127.0.0.1:37228","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-06-04T06:31:45.158346Z","caller":"traceutil/trace.go:171","msg":"trace[1615950676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:758; }","duration":"700.847679ms","start":"2026-06-04T06:31:44.45746Z","end":"2026-06-04T06:31:45.158307Z","steps":["trace[1615950676] 'agreement among raft nodes before linearized reading' (duration: 700.298176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:31:45.158483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:31:44.457448Z","time spent":"700.989272ms","remote":"127.0.0.1:37228","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-06-04T06:32:13.175123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.174564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:32:13.175209Z","caller":"traceutil/trace.go:171","msg":"trace[1202616298] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:946; }","duration":"101.298368ms","start":"2026-06-04T06:32:13.073891Z","end":"2026-06-04T06:32:13.175189Z","steps":["trace[1202616298] 'range keys from in-memory index tree' (duration: 101.087253ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:13.285721Z","caller":"traceutil/trace.go:171","msg":"trace[2125471556] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"107.063545ms","start":"2026-06-04T06:32:13.17863Z","end":"2026-06-04T06:32:13.285693Z","steps":["trace[2125471556] 'process raft request' (duration: 106.8857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:19.537921Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334368128255657023,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-04T06:32:20.038367Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334368128255657023,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-04T06:32:20.199455Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.74097733s","expected-duration":"1s"} {"level":"info","ts":"2026-06-04T06:32:20.19982Z","caller":"traceutil/trace.go:171","msg":"trace[1939940564] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"1.741424391s","start":"2026-06-04T06:32:18.458378Z","end":"2026-06-04T06:32:20.199802Z","steps":["trace[1939940564] 'process raft request' (duration: 1.741251367s)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:20.199873Z","caller":"traceutil/trace.go:171","msg":"trace[159257762] linearizableReadLoop","detail":"{readStateIndex:1006; appliedIndex:1006; }","duration":"1.162805899s","start":"2026-06-04T06:32:19.037038Z","end":"2026-06-04T06:32:20.199844Z","steps":["trace[159257762] 'read index received' (duration: 1.162792729s)","trace[159257762] 'applied index is now lower than readState.Index' (duration: 10.43µs)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:32:20.199978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:18.458357Z","time spent":"1.741534413s","remote":"127.0.0.1:37228","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-06-04T06:32:20.200128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.163068455s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-04T06:32:20.200167Z","caller":"traceutil/trace.go:171","msg":"trace[889651886] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:968; }","duration":"1.163159667s","start":"2026-06-04T06:32:19.036996Z","end":"2026-06-04T06:32:20.200156Z","steps":["trace[889651886] 'agreement among raft nodes before linearized reading' (duration: 1.162957692s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:20.200203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:19.036982Z","time spent":"1.163215218s","remote":"127.0.0.1:36972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.109\" "} {"level":"warn","ts":"2026-06-04T06:32:21.170672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.650259ms","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-06-04T06:32:21.170789Z","caller":"traceutil/trace.go:171","msg":"trace[1309377339] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:968; }","duration":"529.778542ms","start":"2026-06-04T06:32:20.640995Z","end":"2026-06-04T06:32:21.170773Z","steps":["trace[1309377339] 'range keys from in-memory index tree' (duration: 529.636099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:21.171229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.424014ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-06-04T06:32:21.171591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:20.201136Z","time spent":"970.449516ms","remote":"127.0.0.1:36972","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-04T06:32:21.171625Z","caller":"traceutil/trace.go:171","msg":"trace[197344371] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"1.024481121s","start":"2026-06-04T06:32:20.147109Z","end":"2026-06-04T06:32:21.17159Z","steps":["trace[197344371] 'process raft request' (duration: 202.546434ms)","trace[197344371] 'compare' (duration: 820.953713ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:32:21.171711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.793015538s","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-06-04T06:32:21.171741Z","caller":"traceutil/trace.go:171","msg":"trace[1589753036] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:969; }","duration":"1.79309771s","start":"2026-06-04T06:32:19.378636Z","end":"2026-06-04T06:32:21.171734Z","steps":["trace[1589753036] 'agreement among raft nodes before linearized reading' (duration: 1.792988937s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:21.171767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:19.378608Z","time spent":"1.793152902s","remote":"127.0.0.1:37228","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-06-04T06:32:21.171801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:20.147094Z","time spent":"1.024603544s","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:32:21.171598Z","caller":"traceutil/trace.go:171","msg":"trace[151535082] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:1006; }","duration":"971.653115ms","start":"2026-06-04T06:32:20.199929Z","end":"2026-06-04T06:32:21.171582Z","steps":["trace[151535082] 'read index received' (duration: 149.600356ms)","trace[151535082] 'applied index is now lower than readState.Index' (duration: 822.051019ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:32:21.171846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.694078937s","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-06-04T06:32:21.171935Z","caller":"traceutil/trace.go:171","msg":"trace[629740466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:969; }","duration":"1.6942272s","start":"2026-06-04T06:32:19.477688Z","end":"2026-06-04T06:32:21.171915Z","steps":["trace[629740466] 'agreement among raft nodes before linearized reading' (duration: 1.693965944s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:21.171947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.716670684s","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-06-04T06:32:21.171974Z","caller":"traceutil/trace.go:171","msg":"trace[768897389] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:969; }","duration":"1.716757836s","start":"2026-06-04T06:32:19.455209Z","end":"2026-06-04T06:32:21.171967Z","steps":["trace[768897389] 'agreement among raft nodes before linearized reading' (duration: 1.716692884s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:21.171979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:19.477663Z","time spent":"1.694308883s","remote":"127.0.0.1:37228","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-06-04T06:32:21.171998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:19.455168Z","time spent":"1.716826097s","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-04T06:32:21.172102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.098254315s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-04T06:32:21.172097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.768549776s","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-06-04T06:32:21.172127Z","caller":"traceutil/trace.go:171","msg":"trace[2126936771] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:969; }","duration":"1.098322796s","start":"2026-06-04T06:32:20.073797Z","end":"2026-06-04T06:32:21.17212Z","steps":["trace[2126936771] 'agreement among raft nodes before linearized reading' (duration: 1.098282475s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:21.172099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.867885ms","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":"warn","ts":"2026-06-04T06:32:21.172151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:20.073775Z","time spent":"1.098372217s","remote":"127.0.0.1:36930","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-06-04T06:32:21.172151Z","caller":"traceutil/trace.go:171","msg":"trace[1333451798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:969; }","duration":"1.768642419s","start":"2026-06-04T06:32:19.403486Z","end":"2026-06-04T06:32:21.172129Z","steps":["trace[1333451798] 'agreement among raft nodes before linearized reading' (duration: 1.768458825s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:21.172207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:19.403461Z","time spent":"1.768738181s","remote":"127.0.0.1:37228","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-06-04T06:32:21.172187Z","caller":"traceutil/trace.go:171","msg":"trace[1103540506] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:969; }","duration":"148.032959ms","start":"2026-06-04T06:32:21.024132Z","end":"2026-06-04T06:32:21.172165Z","steps":["trace[1103540506] 'agreement among raft nodes before linearized reading' (duration: 147.876246ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:21.172265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.054023703s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-04T06:32:21.172366Z","caller":"traceutil/trace.go:171","msg":"trace[418187452] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:969; }","duration":"1.054170176s","start":"2026-06-04T06:32:20.11817Z","end":"2026-06-04T06:32:21.172341Z","steps":["trace[418187452] 'agreement among raft nodes before linearized reading' (duration: 1.053852139s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:21.172421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:20.118159Z","time spent":"1.054253009s","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-04T06:32:21.68149Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334368128255657032,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-04T06:32:22.182608Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334368128255657032,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-04T06:32:22.532352Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.358614153s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-04T06:32:22.668804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.045473ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T06:32:22.66897Z","caller":"traceutil/trace.go:171","msg":"trace[1182610185] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"1.49525163s","start":"2026-06-04T06:32:21.173678Z","end":"2026-06-04T06:32:22.66893Z","steps":["trace[1182610185] 'process raft request' (duration: 1.358968221s)","trace[1182610185] 'compare' (duration: 135.718865ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:32:22.669046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:21.173666Z","time spent":"1.495349802s","remote":"127.0.0.1:36972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:32:23.181684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000835136s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-04T06:32:23.181773Z","caller":"traceutil/trace.go:171","msg":"trace[144345053] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00097217s","start":"2026-06-04T06:32:21.180782Z","end":"2026-06-04T06:32:23.181754Z","steps":["trace[144345053] 'agreement among raft nodes before linearized reading' (duration: 2.000866397s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:23.181824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:21.180763Z","time spent":"2.001051952s","remote":"127.0.0.1:36930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/04 06:32:23 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-04T06:32:24.457833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"991.793114ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T06:32:24.458053Z","caller":"traceutil/trace.go:171","msg":"trace[1148835803] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"3.28119467s","start":"2026-06-04T06:32:21.176834Z","end":"2026-06-04T06:32:24.458029Z","steps":["trace[1148835803] 'process raft request' (duration: 2.289088348s)","trace[1148835803] 'compare' (duration: 991.659701ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:32:24.458117Z","caller":"traceutil/trace.go:171","msg":"trace[1064670719] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"3.280898813s","start":"2026-06-04T06:32:21.177167Z","end":"2026-06-04T06:32:24.458066Z","steps":["trace[1064670719] 'process raft request' (duration: 3.28078671s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:24.458181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:21.176807Z","time spent":"3.281299053s","remote":"127.0.0.1:37228","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-06-04T06:32:24.458196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:21.17716Z","time spent":"3.280999435s","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:32:24.458448Z","caller":"traceutil/trace.go:171","msg":"trace[1961039293] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"3.281003525s","start":"2026-06-04T06:32:21.177421Z","end":"2026-06-04T06:32:24.458425Z","steps":["trace[1961039293] 'process raft request' (duration: 3.280876232s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:24.458588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:21.177392Z","time spent":"3.281122609s","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:32:24.458642Z","caller":"traceutil/trace.go:171","msg":"trace[1364438507] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"2.253482802s","start":"2026-06-04T06:32:22.205151Z","end":"2026-06-04T06:32:24.458633Z","steps":["trace[1364438507] 'process raft request' (duration: 2.253305068s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:24.458694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:22.205117Z","time spent":"2.253545124s","remote":"127.0.0.1:37228","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-06-04T06:32:24.45878Z","caller":"traceutil/trace.go:171","msg":"trace[568823618] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"3.281319323s","start":"2026-06-04T06:32:21.177454Z","end":"2026-06-04T06:32:24.458773Z","steps":["trace[568823618] 'process raft request' (duration: 3.280936694s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:24.458823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:21.177446Z","time spent":"3.281356543s","remote":"127.0.0.1:37228","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-06-04T06:32:24.458484Z","caller":"traceutil/trace.go:171","msg":"trace[1684430588] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"3.281258112s","start":"2026-06-04T06:32:21.177217Z","end":"2026-06-04T06:32:24.458475Z","steps":["trace[1684430588] 'process raft request' (duration: 3.280804771s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:24.458896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:21.177213Z","time spent":"3.281642921s","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:32:24.45897Z","caller":"traceutil/trace.go:171","msg":"trace[1006522542] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"2.194628193s","start":"2026-06-04T06:32:22.264335Z","end":"2026-06-04T06:32:24.458964Z","steps":["trace[1006522542] 'process raft request' (duration: 2.194167582s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:24.459013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:22.264309Z","time spent":"2.194677735s","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:32:24.459384Z","caller":"traceutil/trace.go:171","msg":"trace[2099980388] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1008; }","duration":"3.278512216s","start":"2026-06-04T06:32:21.18084Z","end":"2026-06-04T06:32:24.459352Z","steps":["trace[2099980388] 'read index received' (duration: 1.35175969s)","trace[2099980388] 'applied index is now lower than readState.Index' (duration: 1.926748486s)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:32:24.537098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.354931896s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-04T06:32:24.537119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.158622348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:32:24.537165Z","caller":"traceutil/trace.go:171","msg":"trace[2057265494] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:977; }","duration":"1.355042629s","start":"2026-06-04T06:32:23.182106Z","end":"2026-06-04T06:32:24.537149Z","steps":["trace[2057265494] 'agreement among raft nodes before linearized reading' (duration: 1.354922606s)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:24.537261Z","caller":"traceutil/trace.go:171","msg":"trace[853579803] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:977; }","duration":"2.158798122s","start":"2026-06-04T06:32:22.378396Z","end":"2026-06-04T06:32:24.537194Z","steps":["trace[853579803] 'agreement among raft nodes before linearized reading' (duration: 2.158625948s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:24.537304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:23.182084Z","time spent":"1.355210822s","remote":"127.0.0.1:36946","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-06-04T06:32:24.537312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:22.378367Z","time spent":"2.158932765s","remote":"127.0.0.1:37156","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":"warn","ts":"2026-06-04T06:32:24.537367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.865978043s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"warn","ts":"2026-06-04T06:32:24.537371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.303176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:32:24.537473Z","caller":"traceutil/trace.go:171","msg":"trace[502224095] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:977; }","duration":"1.866183628s","start":"2026-06-04T06:32:22.671266Z","end":"2026-06-04T06:32:24.53745Z","steps":["trace[502224095] 'agreement among raft nodes before linearized reading' (duration: 1.865808249s)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:24.537498Z","caller":"traceutil/trace.go:171","msg":"trace[1007793644] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:977; }","duration":"963.494661ms","start":"2026-06-04T06:32:23.57398Z","end":"2026-06-04T06:32:24.537474Z","steps":["trace[1007793644] 'agreement among raft nodes before linearized reading' (duration: 963.209045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:24.537521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:22.671245Z","time spent":"1.866265679s","remote":"127.0.0.1:37108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-06-04T06:32:24.537556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:23.573965Z","time spent":"963.582153ms","remote":"127.0.0.1:36930","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-06-04T06:32:26.610521Z","caller":"traceutil/trace.go:171","msg":"trace[1573927907] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"141.1282ms","start":"2026-06-04T06:32:26.469373Z","end":"2026-06-04T06:32:26.610501Z","steps":["trace[1573927907] 'process raft request' (duration: 141.066338ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:26.610598Z","caller":"traceutil/trace.go:171","msg":"trace[347821176] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"141.539979ms","start":"2026-06-04T06:32:26.469024Z","end":"2026-06-04T06:32:26.610564Z","steps":["trace[347821176] 'process raft request' (duration: 141.370695ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:26.610907Z","caller":"traceutil/trace.go:171","msg":"trace[1063502949] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"140.909954ms","start":"2026-06-04T06:32:26.469979Z","end":"2026-06-04T06:32:26.610889Z","steps":["trace[1063502949] 'process raft request' (duration: 140.74251ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:26.611024Z","caller":"traceutil/trace.go:171","msg":"trace[353151810] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"141.228422ms","start":"2026-06-04T06:32:26.46974Z","end":"2026-06-04T06:32:26.610969Z","steps":["trace[353151810] 'process raft request' (duration: 140.72831ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:26.611156Z","caller":"traceutil/trace.go:171","msg":"trace[523176250] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"142.040371ms","start":"2026-06-04T06:32:26.468495Z","end":"2026-06-04T06:32:26.610536Z","steps":["trace[523176250] 'process raft request' (duration: 127.204988ms)","trace[523176250] 'compare' (duration: 14.567017ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:32:28.684308Z","caller":"traceutil/trace.go:171","msg":"trace[1989679187] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"162.517288ms","start":"2026-06-04T06:32:28.521754Z","end":"2026-06-04T06:32:28.684271Z","steps":["trace[1989679187] 'process raft request' (duration: 161.485184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:30.903208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.824337ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T06:32:30.90342Z","caller":"traceutil/trace.go:171","msg":"trace[2055441692] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"109.337653ms","start":"2026-06-04T06:32:30.794059Z","end":"2026-06-04T06:32:30.903397Z","steps":["trace[2055441692] 'compare' (duration: 107.705394ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:30.903634Z","caller":"traceutil/trace.go:171","msg":"trace[482801866] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"108.469812ms","start":"2026-06-04T06:32:30.795145Z","end":"2026-06-04T06:32:30.903615Z","steps":["trace[482801866] 'process raft request' (duration: 108.3843ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:30.903662Z","caller":"traceutil/trace.go:171","msg":"trace[1308737524] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"108.587385ms","start":"2026-06-04T06:32:30.795053Z","end":"2026-06-04T06:32:30.903641Z","steps":["trace[1308737524] 'process raft request' (duration: 108.285258ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:30.951565Z","caller":"traceutil/trace.go:171","msg":"trace[853649494] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"156.27957ms","start":"2026-06-04T06:32:30.795264Z","end":"2026-06-04T06:32:30.951543Z","steps":["trace[853649494] 'process raft request' (duration: 156.135597ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:32.872448Z","caller":"traceutil/trace.go:171","msg":"trace[41168116] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"105.371428ms","start":"2026-06-04T06:32:32.767059Z","end":"2026-06-04T06:32:32.87243Z","steps":["trace[41168116] 'process raft request' (duration: 105.087261ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:35.153014Z","caller":"traceutil/trace.go:171","msg":"trace[1099868799] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"105.642384ms","start":"2026-06-04T06:32:35.047334Z","end":"2026-06-04T06:32:35.152977Z","steps":["trace[1099868799] 'process raft request' (duration: 105.420349ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:35.181395Z","caller":"traceutil/trace.go:171","msg":"trace[1056565956] linearizableReadLoop","detail":"{readStateIndex:1052; appliedIndex:1049; }","duration":"107.505729ms","start":"2026-06-04T06:32:35.073868Z","end":"2026-06-04T06:32:35.181373Z","steps":["trace[1056565956] 'read index received' (duration: 78.857377ms)","trace[1056565956] 'applied index is now lower than readState.Index' (duration: 28.647442ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:32:35.181475Z","caller":"traceutil/trace.go:171","msg":"trace[920534470] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"134.153773ms","start":"2026-06-04T06:32:35.047281Z","end":"2026-06-04T06:32:35.181435Z","steps":["trace[920534470] 'process raft request' (duration: 133.891997ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:35.181567Z","caller":"traceutil/trace.go:171","msg":"trace[2079355322] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"134.154804ms","start":"2026-06-04T06:32:35.047396Z","end":"2026-06-04T06:32:35.181551Z","steps":["trace[2079355322] 'process raft request' (duration: 133.919438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:35.181518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.634702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:32:35.181726Z","caller":"traceutil/trace.go:171","msg":"trace[506188858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1011; }","duration":"107.874298ms","start":"2026-06-04T06:32:35.073822Z","end":"2026-06-04T06:32:35.181696Z","steps":["trace[506188858] 'agreement among raft nodes before linearized reading' (duration: 107.641283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:44.685202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.820133ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-04T06:32:44.685318Z","caller":"traceutil/trace.go:171","msg":"trace[146101953] linearizableReadLoop","detail":"{readStateIndex:1081; appliedIndex:1080; }","duration":"416.806192ms","start":"2026-06-04T06:32:44.268493Z","end":"2026-06-04T06:32:44.685299Z","steps":["trace[146101953] 'read index received' (duration: 280.808174ms)","trace[146101953] 'applied index is now lower than readState.Index' (duration: 135.996228ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:32:44.685532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.020807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-04T06:32:44.685604Z","caller":"traceutil/trace.go:171","msg":"trace[734209155] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1037; }","duration":"417.14601ms","start":"2026-06-04T06:32:44.268448Z","end":"2026-06-04T06:32:44.685594Z","steps":["trace[734209155] 'agreement among raft nodes before linearized reading' (duration: 416.900904ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:44.685677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:44.26843Z","time spent":"417.231121ms","remote":"127.0.0.1:37514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":93,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-06-04T06:32:45.331208Z","caller":"traceutil/trace.go:171","msg":"trace[1100152348] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"104.554349ms","start":"2026-06-04T06:32:45.226627Z","end":"2026-06-04T06:32:45.331181Z","steps":["trace[1100152348] 'process raft request' (duration: 104.389625ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:47.532353Z","caller":"traceutil/trace.go:171","msg":"trace[467701768] linearizableReadLoop","detail":"{readStateIndex:1090; appliedIndex:1089; }","duration":"365.533611ms","start":"2026-06-04T06:32:47.166793Z","end":"2026-06-04T06:32:47.532327Z","steps":["trace[467701768] 'read index received' (duration: 289.923411ms)","trace[467701768] 'applied index is now lower than readState.Index' (duration: 75.6088ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:32:47.532494Z","caller":"traceutil/trace.go:171","msg":"trace[361906630] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"402.033071ms","start":"2026-06-04T06:32:47.130336Z","end":"2026-06-04T06:32:47.532369Z","steps":["trace[361906630] 'process raft request' (duration: 326.38673ms)","trace[361906630] 'compare' (duration: 75.429706ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:32:47.532651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:47.130315Z","time spent":"402.249745ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:32:47.53283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.397092ms","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-06-04T06:32:47.532872Z","caller":"traceutil/trace.go:171","msg":"trace[852994993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1046; }","duration":"324.483044ms","start":"2026-06-04T06:32:47.208378Z","end":"2026-06-04T06:32:47.532861Z","steps":["trace[852994993] 'agreement among raft nodes before linearized reading' (duration: 324.28496ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:47.53291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:47.208348Z","time spent":"324.553875ms","remote":"127.0.0.1:37228","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-06-04T06:32:47.533169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.375555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-04T06:32:47.53322Z","caller":"traceutil/trace.go:171","msg":"trace[2144261406] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1046; }","duration":"196.473287ms","start":"2026-06-04T06:32:47.336733Z","end":"2026-06-04T06:32:47.533207Z","steps":["trace[2144261406] 'agreement among raft nodes before linearized reading' (duration: 196.339393ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:47.533279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.343389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-04T06:32:47.533352Z","caller":"traceutil/trace.go:171","msg":"trace[772753463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1046; }","duration":"234.449111ms","start":"2026-06-04T06:32:47.298884Z","end":"2026-06-04T06:32:47.533333Z","steps":["trace[772753463] 'agreement among raft nodes before linearized reading' (duration: 234.231455ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:47.533531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.74746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-04T06:32:47.533636Z","caller":"traceutil/trace.go:171","msg":"trace[1731952309] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1046; }","duration":"366.853632ms","start":"2026-06-04T06:32:47.166719Z","end":"2026-06-04T06:32:47.533573Z","steps":["trace[1731952309] 'agreement among raft nodes before linearized reading' (duration: 365.853259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:47.533757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:47.166698Z","time spent":"367.048338ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-04T06:32:48.19528Z","caller":"traceutil/trace.go:171","msg":"trace[620138899] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"658.096905ms","start":"2026-06-04T06:32:47.537153Z","end":"2026-06-04T06:32:48.19525Z","steps":["trace[620138899] 'process raft request' (duration: 593.764033ms)","trace[620138899] 'compare' (duration: 63.909512ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:32:48.195511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:47.537131Z","time spent":"658.299949ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:32:48.30611Z","caller":"traceutil/trace.go:171","msg":"trace[260981444] linearizableReadLoop","detail":"{readStateIndex:1094; appliedIndex:1090; }","duration":"232.625148ms","start":"2026-06-04T06:32:48.073412Z","end":"2026-06-04T06:32:48.306037Z","steps":["trace[260981444] 'read index received' (duration: 57.512179ms)","trace[260981444] 'applied index is now lower than readState.Index' (duration: 175.111989ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:32:48.306247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.816142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:32:48.306287Z","caller":"traceutil/trace.go:171","msg":"trace[383175705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1050; }","duration":"232.906114ms","start":"2026-06-04T06:32:48.073371Z","end":"2026-06-04T06:32:48.306278Z","steps":["trace[383175705] 'agreement among raft nodes before linearized reading' (duration: 232.813232ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:48.306337Z","caller":"traceutil/trace.go:171","msg":"trace[2004882659] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"768.84419ms","start":"2026-06-04T06:32:47.537472Z","end":"2026-06-04T06:32:48.306316Z","steps":["trace[2004882659] 'process raft request' (duration: 763.291438ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:48.30636Z","caller":"traceutil/trace.go:171","msg":"trace[94173849] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"768.210475ms","start":"2026-06-04T06:32:47.538087Z","end":"2026-06-04T06:32:48.306298Z","steps":["trace[94173849] 'process raft request' (duration: 767.857907ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:48.306445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:47.537463Z","time spent":"768.916142ms","remote":"127.0.0.1:37228","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-06-04T06:32:48.306415Z","caller":"traceutil/trace.go:171","msg":"trace[1805113208] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"768.312208ms","start":"2026-06-04T06:32:47.538072Z","end":"2026-06-04T06:32:48.306385Z","steps":["trace[1805113208] 'process raft request' (duration: 767.924689ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:48.3067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:47.538046Z","time spent":"768.529163ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:32:48.306572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:47.538075Z","time spent":"768.41363ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:33:06.898673Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334368128255657488,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-04T06:33:06.933666Z","caller":"traceutil/trace.go:171","msg":"trace[1525454616] linearizableReadLoop","detail":"{readStateIndex:1209; appliedIndex:1208; }","duration":"535.672851ms","start":"2026-06-04T06:33:06.397969Z","end":"2026-06-04T06:33:06.933642Z","steps":["trace[1525454616] 'read index received' (duration: 535.489737ms)","trace[1525454616] 'applied index is now lower than readState.Index' (duration: 182.204µs)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:33:06.933783Z","caller":"traceutil/trace.go:171","msg":"trace[730695703] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"624.103666ms","start":"2026-06-04T06:33:06.309617Z","end":"2026-06-04T06:33:06.93372Z","steps":["trace[730695703] 'process raft request' (duration: 623.893761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:06.933909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.142326ms","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-06-04T06:33:06.933951Z","caller":"traceutil/trace.go:171","msg":"trace[1403877557] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1159; }","duration":"508.249418ms","start":"2026-06-04T06:33:06.425687Z","end":"2026-06-04T06:33:06.933936Z","steps":["trace[1403877557] 'agreement among raft nodes before linearized reading' (duration: 508.084295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:06.933934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.933028ms","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-06-04T06:33:06.933992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:06.425666Z","time spent":"508.31856ms","remote":"127.0.0.1:37228","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-06-04T06:33:06.934017Z","caller":"traceutil/trace.go:171","msg":"trace[1812918733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1159; }","duration":"536.073001ms","start":"2026-06-04T06:33:06.397924Z","end":"2026-06-04T06:33:06.933997Z","steps":["trace[1812918733] 'agreement among raft nodes before linearized reading' (duration: 535.812585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:06.93404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:06.309601Z","time spent":"624.29204ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:33:06.934063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:06.397903Z","time spent":"536.151852ms","remote":"127.0.0.1:37228","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-06-04T06:33:06.934085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.559082ms","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-06-04T06:33:06.934162Z","caller":"traceutil/trace.go:171","msg":"trace[1339945251] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1159; }","duration":"507.689525ms","start":"2026-06-04T06:33:06.426452Z","end":"2026-06-04T06:33:06.934141Z","steps":["trace[1339945251] 'agreement among raft nodes before linearized reading' (duration: 507.47149ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:06.934202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:06.426438Z","time spent":"507.754617ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-04T06:33:07.298328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.338953ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T06:33:07.298434Z","caller":"traceutil/trace.go:171","msg":"trace[547839221] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"360.539912ms","start":"2026-06-04T06:33:06.937874Z","end":"2026-06-04T06:33:07.298414Z","steps":["trace[547839221] 'process raft request' (duration: 256.001044ms)","trace[547839221] 'compare' (duration: 104.238531ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:33:07.298528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:06.937851Z","time spent":"360.616204ms","remote":"127.0.0.1:37228","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-06-04T06:33:07.326381Z","caller":"traceutil/trace.go:171","msg":"trace[1844049735] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"387.72653ms","start":"2026-06-04T06:33:06.938633Z","end":"2026-06-04T06:33:07.326359Z","steps":["trace[1844049735] 'process raft request' (duration: 387.563976ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:07.326694Z","caller":"traceutil/trace.go:171","msg":"trace[951233166] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"387.523274ms","start":"2026-06-04T06:33:06.939151Z","end":"2026-06-04T06:33:07.326674Z","steps":["trace[951233166] 'process raft request' (duration: 387.169136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:07.3267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:06.938604Z","time spent":"387.926134ms","remote":"127.0.0.1:37228","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-06-04T06:33:07.326855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:06.939139Z","time spent":"387.660118ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:33:07.327497Z","caller":"traceutil/trace.go:171","msg":"trace[1915226201] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"151.205139ms","start":"2026-06-04T06:33:07.176274Z","end":"2026-06-04T06:33:07.327479Z","steps":["trace[1915226201] 'process raft request' (duration: 150.323028ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:19.177123Z","caller":"traceutil/trace.go:171","msg":"trace[492268506] linearizableReadLoop","detail":"{readStateIndex:1250; appliedIndex:1249; }","duration":"137.189255ms","start":"2026-06-04T06:33:19.039915Z","end":"2026-06-04T06:33:19.177104Z","steps":["trace[492268506] 'read index received' (duration: 137.014731ms)","trace[492268506] 'applied index is now lower than readState.Index' (duration: 173.974µs)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:33:19.177544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.625316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-04T06:33:19.177647Z","caller":"traceutil/trace.go:171","msg":"trace[646510500] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:1198; }","duration":"137.77052ms","start":"2026-06-04T06:33:19.039858Z","end":"2026-06-04T06:33:19.177629Z","steps":["trace[646510500] 'agreement among raft nodes before linearized reading' (duration: 137.554974ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:19.178012Z","caller":"traceutil/trace.go:171","msg":"trace[928255036] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"171.929702ms","start":"2026-06-04T06:33:19.005486Z","end":"2026-06-04T06:33:19.177415Z","steps":["trace[928255036] 'process raft request' (duration: 171.491562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:19.179421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.336486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:19.179494Z","caller":"traceutil/trace.go:171","msg":"trace[1600578241] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1198; }","duration":"104.479767ms","start":"2026-06-04T06:33:19.074985Z","end":"2026-06-04T06:33:19.179465Z","steps":["trace[1600578241] 'agreement among raft nodes before linearized reading' (duration: 102.337536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:19.478035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.224144ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-06-04T06:33:19.478333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.114362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:19.478308Z","caller":"traceutil/trace.go:171","msg":"trace[1044163813] linearizableReadLoop","detail":"{readStateIndex:1251; appliedIndex:1250; }","duration":"297.054171ms","start":"2026-06-04T06:33:19.181201Z","end":"2026-06-04T06:33:19.478255Z","steps":["trace[1044163813] 'read index received' (duration: 94.5402ms)","trace[1044163813] 'applied index is now lower than readState.Index' (duration: 202.447019ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:33:19.478416Z","caller":"traceutil/trace.go:171","msg":"trace[371396613] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1198; }","duration":"297.199775ms","start":"2026-06-04T06:33:19.181174Z","end":"2026-06-04T06:33:19.478374Z","steps":["trace[371396613] 'agreement among raft nodes before linearized reading' (duration: 297.103982ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:19.47862Z","caller":"traceutil/trace.go:171","msg":"trace[113967488] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"106.725501ms","start":"2026-06-04T06:33:19.371874Z","end":"2026-06-04T06:33:19.4786Z","steps":["trace[113967488] 'process raft request' (duration: 106.391283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:19.480021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.646105ms","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-06-04T06:33:19.480066Z","caller":"traceutil/trace.go:171","msg":"trace[1375472359] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1199; }","duration":"126.736217ms","start":"2026-06-04T06:33:19.353324Z","end":"2026-06-04T06:33:19.480061Z","steps":["trace[1375472359] 'agreement among raft nodes before linearized reading' (duration: 125.19914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:20.140761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.240284ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T06:33:20.140884Z","caller":"traceutil/trace.go:171","msg":"trace[1735166188] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"660.918802ms","start":"2026-06-04T06:33:19.479946Z","end":"2026-06-04T06:33:20.140865Z","steps":["trace[1735166188] 'process raft request' (duration: 279.469773ms)","trace[1735166188] 'compare' (duration: 381.09224ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:33:20.140957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:19.479929Z","time spent":"660.999793ms","remote":"127.0.0.1:36972","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-06-04T06:33:20.174296Z","caller":"traceutil/trace.go:171","msg":"trace[1638771308] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"689.928992ms","start":"2026-06-04T06:33:19.48434Z","end":"2026-06-04T06:33:20.174269Z","steps":["trace[1638771308] 'process raft request' (duration: 689.84974ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:20.174315Z","caller":"traceutil/trace.go:171","msg":"trace[847136659] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"689.996913ms","start":"2026-06-04T06:33:19.484301Z","end":"2026-06-04T06:33:20.174298Z","steps":["trace[847136659] 'process raft request' (duration: 689.765268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:20.174451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:19.484316Z","time spent":"690.055155ms","remote":"127.0.0.1:37228","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-06-04T06:33:20.175024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:19.484278Z","time spent":"690.27704ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:33:20.175344Z","caller":"traceutil/trace.go:171","msg":"trace[1602144154] linearizableReadLoop","detail":"{readStateIndex:1256; appliedIndex:1253; }","duration":"401.457806ms","start":"2026-06-04T06:33:19.773871Z","end":"2026-06-04T06:33:20.175329Z","steps":["trace[1602144154] 'read index received' (duration: 400.104674ms)","trace[1602144154] 'applied index is now lower than readState.Index' (duration: 1.351882ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:33:20.175436Z","caller":"traceutil/trace.go:171","msg":"trace[1367466651] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"689.086482ms","start":"2026-06-04T06:33:19.486334Z","end":"2026-06-04T06:33:20.17542Z","steps":["trace[1367466651] 'process raft request' (duration: 687.898934ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:20.175475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.953219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-04T06:33:20.175506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.65039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-04T06:33:20.175514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:19.486316Z","time spent":"689.155073ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:33:20.175528Z","caller":"traceutil/trace.go:171","msg":"trace[134340721] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1203; }","duration":"134.047011ms","start":"2026-06-04T06:33:20.041466Z","end":"2026-06-04T06:33:20.175513Z","steps":["trace[134340721] 'agreement among raft nodes before linearized reading' (duration: 133.967529ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:20.175539Z","caller":"traceutil/trace.go:171","msg":"trace[448791545] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1203; }","duration":"401.741603ms","start":"2026-06-04T06:33:19.773786Z","end":"2026-06-04T06:33:20.175528Z","steps":["trace[448791545] 'agreement among raft nodes before linearized reading' (duration: 401.62602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:20.175568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:19.773751Z","time spent":"401.810233ms","remote":"127.0.0.1:37228","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-06-04T06:33:20.175705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.104817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:20.17573Z","caller":"traceutil/trace.go:171","msg":"trace[429218082] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1203; }","duration":"101.127747ms","start":"2026-06-04T06:33:20.074594Z","end":"2026-06-04T06:33:20.175722Z","steps":["trace[429218082] 'agreement among raft nodes before linearized reading' (duration: 101.089536ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:20.714077Z","caller":"traceutil/trace.go:171","msg":"trace[2069665775] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"532.872405ms","start":"2026-06-04T06:33:20.181182Z","end":"2026-06-04T06:33:20.714055Z","steps":["trace[2069665775] 'process raft request' (duration: 532.743152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:20.714214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:20.181161Z","time spent":"532.981037ms","remote":"127.0.0.1:37228","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-06-04T06:33:21.699956Z","caller":"traceutil/trace.go:171","msg":"trace[1170242435] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"207.856957ms","start":"2026-06-04T06:33:21.49207Z","end":"2026-06-04T06:33:21.699927Z","steps":["trace[1170242435] 'process raft request' (duration: 206.127066ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:22.49038Z","caller":"traceutil/trace.go:171","msg":"trace[1430783769] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"216.37853ms","start":"2026-06-04T06:33:22.273976Z","end":"2026-06-04T06:33:22.490354Z","steps":["trace[1430783769] 'process raft request' (duration: 216.198166ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:23.194214Z","caller":"traceutil/trace.go:171","msg":"trace[106847513] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"914.081428ms","start":"2026-06-04T06:33:22.280107Z","end":"2026-06-04T06:33:23.194188Z","steps":["trace[106847513] 'process raft request' (duration: 913.985056ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:23.194303Z","caller":"traceutil/trace.go:171","msg":"trace[1922610985] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"918.583626ms","start":"2026-06-04T06:33:22.275691Z","end":"2026-06-04T06:33:23.194274Z","steps":["trace[1922610985] 'process raft request' (duration: 865.513613ms)","trace[1922610985] 'compare' (duration: 52.681494ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:33:23.194356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:22.280084Z","time spent":"914.197671ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:33:23.194432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:22.27567Z","time spent":"918.692528ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:33:23.229583Z","caller":"traceutil/trace.go:171","msg":"trace[2116594645] linearizableReadLoop","detail":"{readStateIndex:1263; appliedIndex:1260; }","duration":"511.776362ms","start":"2026-06-04T06:33:22.717781Z","end":"2026-06-04T06:33:23.229557Z","steps":["trace[2116594645] 'read index received' (duration: 423.355077ms)","trace[2116594645] 'applied index is now lower than readState.Index' (duration: 88.420105ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:33:23.229706Z","caller":"traceutil/trace.go:171","msg":"trace[1691616361] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"654.726194ms","start":"2026-06-04T06:33:22.574969Z","end":"2026-06-04T06:33:23.229695Z","steps":["trace[1691616361] 'process raft request' (duration: 654.449418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:23.229828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:22.57494Z","time spent":"654.800887ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:33:23.229945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.799113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:23.230023Z","caller":"traceutil/trace.go:171","msg":"trace[561944549] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1210; }","duration":"156.918196ms","start":"2026-06-04T06:33:23.073085Z","end":"2026-06-04T06:33:23.230003Z","steps":["trace[561944549] 'agreement among raft nodes before linearized reading' (duration: 156.806453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:23.230471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.663363ms","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-06-04T06:33:23.230573Z","caller":"traceutil/trace.go:171","msg":"trace[169080020] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1210; }","duration":"512.797427ms","start":"2026-06-04T06:33:22.71775Z","end":"2026-06-04T06:33:23.230547Z","steps":["trace[169080020] 'agreement among raft nodes before linearized reading' (duration: 512.4997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:23.230637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:22.717733Z","time spent":"512.890658ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-04T06:33:23.355795Z","caller":"traceutil/trace.go:171","msg":"trace[800605242] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"120.54167ms","start":"2026-06-04T06:33:23.235228Z","end":"2026-06-04T06:33:23.355769Z","steps":["trace[800605242] 'process raft request' (duration: 60.316546ms)","trace[800605242] 'compare' (duration: 59.989158ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:33:24.211335Z","caller":"traceutil/trace.go:171","msg":"trace[170922000] linearizableReadLoop","detail":"{readStateIndex:1266; appliedIndex:1265; }","duration":"269.505365ms","start":"2026-06-04T06:33:23.941812Z","end":"2026-06-04T06:33:24.211317Z","steps":["trace[170922000] 'read index received' (duration: 269.32647ms)","trace[170922000] 'applied index is now lower than readState.Index' (duration: 178.295µs)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:33:24.211425Z","caller":"traceutil/trace.go:171","msg":"trace[295691442] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"504.265353ms","start":"2026-06-04T06:33:23.707152Z","end":"2026-06-04T06:33:24.211418Z","steps":["trace[295691442] 'process raft request' (duration: 504.052468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:24.211548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.055046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:24.211604Z","caller":"traceutil/trace.go:171","msg":"trace[686003600] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1213; }","duration":"138.150658ms","start":"2026-06-04T06:33:24.073442Z","end":"2026-06-04T06:33:24.211593Z","steps":["trace[686003600] 'agreement among raft nodes before linearized reading' (duration: 138.066276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:24.211504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:23.707127Z","time spent":"504.318375ms","remote":"127.0.0.1:37228","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-06-04T06:33:24.21173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.819853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:24.211843Z","caller":"traceutil/trace.go:171","msg":"trace[1904113213] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1213; }","duration":"270.037028ms","start":"2026-06-04T06:33:23.941796Z","end":"2026-06-04T06:33:24.211833Z","steps":["trace[1904113213] 'agreement among raft nodes before linearized reading' (duration: 269.798512ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:25.567883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.422076ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-04T06:33:25.567983Z","caller":"traceutil/trace.go:171","msg":"trace[1969829326] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1266; }","duration":"1.072893409s","start":"2026-06-04T06:33:24.49507Z","end":"2026-06-04T06:33:25.567963Z","steps":["trace[1969829326] 'read index received' (duration: 211.378182ms)","trace[1969829326] 'applied index is now lower than readState.Index' (duration: 861.513757ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:33:25.568171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.073095344s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-04T06:33:25.568199Z","caller":"traceutil/trace.go:171","msg":"trace[1274511965] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1213; }","duration":"1.073166686s","start":"2026-06-04T06:33:24.495023Z","end":"2026-06-04T06:33:25.568189Z","steps":["trace[1274511965] 'agreement among raft nodes before linearized reading' (duration: 1.073017052s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:25.568231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:24.495003Z","time spent":"1.073219997s","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-04T06:33:25.607386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.946946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:25.607462Z","caller":"traceutil/trace.go:171","msg":"trace[869394886] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1214; }","duration":"533.083529ms","start":"2026-06-04T06:33:25.074362Z","end":"2026-06-04T06:33:25.607446Z","steps":["trace[869394886] 'agreement among raft nodes before linearized reading' (duration: 532.953436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:25.607499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:25.074341Z","time spent":"533.150531ms","remote":"127.0.0.1:36930","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-06-04T06:33:25.607663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.216316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-04T06:33:25.607718Z","caller":"traceutil/trace.go:171","msg":"trace[269687226] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1214; }","duration":"329.276148ms","start":"2026-06-04T06:33:25.278424Z","end":"2026-06-04T06:33:25.6077Z","steps":["trace[269687226] 'agreement among raft nodes before linearized reading' (duration: 329.134605ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:25.607742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.602836ms","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-06-04T06:33:25.607763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:25.278418Z","time spent":"329.334519ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-04T06:33:25.607776Z","caller":"traceutil/trace.go:171","msg":"trace[1820164003] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1214; }","duration":"408.645438ms","start":"2026-06-04T06:33:25.199119Z","end":"2026-06-04T06:33:25.607765Z","steps":["trace[1820164003] 'agreement among raft nodes before linearized reading' (duration: 408.549836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:25.607803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:25.199114Z","time spent":"408.683479ms","remote":"127.0.0.1:37228","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-06-04T06:33:25.607958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.093188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-04T06:33:25.608048Z","caller":"traceutil/trace.go:171","msg":"trace[1837814068] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1214; }","duration":"409.226661ms","start":"2026-06-04T06:33:25.198799Z","end":"2026-06-04T06:33:25.608026Z","steps":["trace[1837814068] 'agreement among raft nodes before linearized reading' (duration: 408.944574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:25.608116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:25.198782Z","time spent":"409.323474ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-04T06:33:25.60799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.400839ms","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-06-04T06:33:25.608202Z","caller":"traceutil/trace.go:171","msg":"trace[880576576] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1214; }","duration":"247.627635ms","start":"2026-06-04T06:33:25.360561Z","end":"2026-06-04T06:33:25.608189Z","steps":["trace[880576576] 'agreement among raft nodes before linearized reading' (duration: 247.366039ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:26.062136Z","caller":"traceutil/trace.go:171","msg":"trace[1142292128] linearizableReadLoop","detail":"{readStateIndex:1269; appliedIndex:1268; }","duration":"453.401843ms","start":"2026-06-04T06:33:25.608707Z","end":"2026-06-04T06:33:26.062108Z","steps":["trace[1142292128] 'read index received' (duration: 428.184383ms)","trace[1142292128] 'applied index is now lower than readState.Index' (duration: 25.21621ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:33:26.062255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.528856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:26.062285Z","caller":"traceutil/trace.go:171","msg":"trace[278869752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1215; }","duration":"453.593487ms","start":"2026-06-04T06:33:25.608682Z","end":"2026-06-04T06:33:26.062275Z","steps":["trace[278869752] 'agreement among raft nodes before linearized reading' (duration: 453.522745ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:26.062295Z","caller":"traceutil/trace.go:171","msg":"trace[175920336] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"490.689341ms","start":"2026-06-04T06:33:25.571572Z","end":"2026-06-04T06:33:26.062261Z","steps":["trace[175920336] 'process raft request' (duration: 465.330107ms)","trace[175920336] 'compare' (duration: 24.815681ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:33:26.06232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:25.60867Z","time spent":"453.638689ms","remote":"127.0.0.1:36946","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-06-04T06:33:26.06241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:25.57155Z","time spent":"490.790982ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:33:26.129049Z","caller":"traceutil/trace.go:171","msg":"trace[1113885529] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"516.858784ms","start":"2026-06-04T06:33:25.612162Z","end":"2026-06-04T06:33:26.129021Z","steps":["trace[1113885529] 'process raft request' (duration: 516.786662ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:26.129061Z","caller":"traceutil/trace.go:171","msg":"trace[835908429] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"517.251333ms","start":"2026-06-04T06:33:25.611781Z","end":"2026-06-04T06:33:26.129032Z","steps":["trace[835908429] 'process raft request' (duration: 517.005467ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:26.129085Z","caller":"traceutil/trace.go:171","msg":"trace[24134105] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"517.254363ms","start":"2026-06-04T06:33:25.611807Z","end":"2026-06-04T06:33:26.129062Z","steps":["trace[24134105] 'process raft request' (duration: 517.108189ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:26.129198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:25.611793Z","time spent":"517.345996ms","remote":"127.0.0.1:37228","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-06-04T06:33:26.129198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:25.612144Z","time spent":"516.976776ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:33:26.129213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:25.611766Z","time spent":"517.368395ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:33:26.129402Z","caller":"traceutil/trace.go:171","msg":"trace[1023672190] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"105.610174ms","start":"2026-06-04T06:33:26.023762Z","end":"2026-06-04T06:33:26.129372Z","steps":["trace[1023672190] 'process raft request' (duration: 105.457621ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:26.129468Z","caller":"traceutil/trace.go:171","msg":"trace[390151714] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"516.467184ms","start":"2026-06-04T06:33:25.612874Z","end":"2026-06-04T06:33:26.129341Z","steps":["trace[390151714] 'process raft request' (duration: 516.114666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:26.129689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:25.612852Z","time spent":"516.750031ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:33:27.263537Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.047068613s","expected-duration":"1s"} {"level":"info","ts":"2026-06-04T06:33:27.263897Z","caller":"traceutil/trace.go:171","msg":"trace[1432907286] linearizableReadLoop","detail":"{readStateIndex:1275; appliedIndex:1274; }","duration":"190.678219ms","start":"2026-06-04T06:33:27.073198Z","end":"2026-06-04T06:33:27.263876Z","steps":["trace[1432907286] 'read index received' (duration: 190.474414ms)","trace[1432907286] 'applied index is now lower than readState.Index' (duration: 203.015µs)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:33:27.263966Z","caller":"traceutil/trace.go:171","msg":"trace[1726020626] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"1.047555215s","start":"2026-06-04T06:33:26.216376Z","end":"2026-06-04T06:33:27.263932Z","steps":["trace[1726020626] 'process raft request' (duration: 1.04735201s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:27.26403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.817532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:27.264085Z","caller":"traceutil/trace.go:171","msg":"trace[1732802664] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1221; }","duration":"190.926924ms","start":"2026-06-04T06:33:27.073146Z","end":"2026-06-04T06:33:27.264072Z","steps":["trace[1732802664] 'agreement among raft nodes before linearized reading' (duration: 190.796831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:27.264117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:26.216358Z","time spent":"1.047676347s","remote":"127.0.0.1:37228","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-06-04T06:33:29.466899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.07463515s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-04T06:33:29.466957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.393727675s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-04T06:33:29.467022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"990.953889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:29.46703Z","caller":"traceutil/trace.go:171","msg":"trace[1733302660] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1221; }","duration":"1.393835858s","start":"2026-06-04T06:33:28.073175Z","end":"2026-06-04T06:33:29.467011Z","steps":["trace[1733302660] 'range keys from in-memory index tree' (duration: 1.393656914s)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:29.467054Z","caller":"traceutil/trace.go:171","msg":"trace[744537748] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1221; }","duration":"991.018249ms","start":"2026-06-04T06:33:28.476027Z","end":"2026-06-04T06:33:29.467045Z","steps":["trace[744537748] 'count revisions from in-memory index tree' (duration: 990.856915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:29.467073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:28.07316Z","time spent":"1.3939044s","remote":"127.0.0.1:36930","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-06-04T06:33:29.467065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.715197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-04T06:33:29.4671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:28.476008Z","time spent":"991.072041ms","remote":"127.0.0.1:35952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-04T06:33:29.467095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.573447434s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:29.467125Z","caller":"traceutil/trace.go:171","msg":"trace[1270939996] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:1221; }","duration":"426.80975ms","start":"2026-06-04T06:33:29.040297Z","end":"2026-06-04T06:33:29.467106Z","steps":["trace[1270939996] 'range keys from in-memory index tree' (duration: 426.547643ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:29.467154Z","caller":"traceutil/trace.go:171","msg":"trace[1697218275] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1221; }","duration":"1.573558997s","start":"2026-06-04T06:33:27.893581Z","end":"2026-06-04T06:33:29.46714Z","steps":["trace[1697218275] 'count revisions from in-memory index tree' (duration: 1.573347202s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:29.467165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.400327973s","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-06-04T06:33:29.467168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:29.040278Z","time spent":"426.882221ms","remote":"127.0.0.1:36972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.109\" "} {"level":"warn","ts":"2026-06-04T06:33:29.467189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:27.893562Z","time spent":"1.573618338s","remote":"127.0.0.1:36082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-04T06:33:29.467204Z","caller":"traceutil/trace.go:171","msg":"trace[1478111629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1221; }","duration":"1.400360974s","start":"2026-06-04T06:33:28.06683Z","end":"2026-06-04T06:33:29.467191Z","steps":["trace[1478111629] 'range keys from in-memory index tree' (duration: 1.40018059s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:29.467235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:28.066734Z","time spent":"1.400493407s","remote":"127.0.0.1:37228","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-06-04T06:33:29.467156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.730961373s","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-06-04T06:33:29.467384Z","caller":"traceutil/trace.go:171","msg":"trace[290974531] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1221; }","duration":"1.731232319s","start":"2026-06-04T06:33:27.736142Z","end":"2026-06-04T06:33:29.467374Z","steps":["trace[290974531] 'count revisions from in-memory index tree' (duration: 1.730890661s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:29.467053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.512902613s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-04T06:33:29.467417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.333537703s","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-06-04T06:33:29.46743Z","caller":"traceutil/trace.go:171","msg":"trace[1002935102] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1221; }","duration":"1.513333863s","start":"2026-06-04T06:33:27.954084Z","end":"2026-06-04T06:33:29.467418Z","steps":["trace[1002935102] 'count revisions from in-memory index tree' (duration: 1.51281957s)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:29.467452Z","caller":"traceutil/trace.go:171","msg":"trace[1248306678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1221; }","duration":"1.333613135s","start":"2026-06-04T06:33:28.133828Z","end":"2026-06-04T06:33:29.467441Z","steps":["trace[1248306678] 'range keys from in-memory index tree' (duration: 1.333298248s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:29.46746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:27.954062Z","time spent":"1.513387144s","remote":"127.0.0.1:47970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-06-04T06:33:29.46748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:28.133804Z","time spent":"1.333669496s","remote":"127.0.0.1:37228","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":"info","ts":"2026-06-04T06:33:29.466979Z","caller":"traceutil/trace.go:171","msg":"trace[1957463536] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1221; }","duration":"1.074724732s","start":"2026-06-04T06:33:28.392231Z","end":"2026-06-04T06:33:29.466956Z","steps":["trace[1957463536] 'count revisions from in-memory index tree' (duration: 1.074499237s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:29.467687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:28.392176Z","time spent":"1.075496611s","remote":"127.0.0.1:37338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":55,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-06-04T06:33:29.46774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.332646713s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-04T06:33:29.467757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.332672213s","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-06-04T06:33:29.467782Z","caller":"traceutil/trace.go:171","msg":"trace[1093498997] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1221; }","duration":"1.332721724s","start":"2026-06-04T06:33:28.135054Z","end":"2026-06-04T06:33:29.467776Z","steps":["trace[1093498997] 'range keys from in-memory index tree' (duration: 1.332538579s)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:29.467782Z","caller":"traceutil/trace.go:171","msg":"trace[1455444496] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1221; }","duration":"1.332705154s","start":"2026-06-04T06:33:28.135063Z","end":"2026-06-04T06:33:29.467769Z","steps":["trace[1455444496] 'range keys from in-memory index tree' (duration: 1.332424786s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:29.4678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:28.135043Z","time spent":"1.332752964s","remote":"127.0.0.1:37228","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-06-04T06:33:29.46782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:28.135053Z","time spent":"1.332759345s","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-04T06:33:29.467421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:27.736123Z","time spent":"1.731287721s","remote":"127.0.0.1:37376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"info","ts":"2026-06-04T06:33:29.467852Z","caller":"traceutil/trace.go:171","msg":"trace[1307676010] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"198.27664ms","start":"2026-06-04T06:33:29.269559Z","end":"2026-06-04T06:33:29.467836Z","steps":["trace[1307676010] 'process raft request' (duration: 108.230367ms)","trace[1307676010] 'compare' (duration: 88.908096ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:33:29.467863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.332288674s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-04T06:33:29.467903Z","caller":"traceutil/trace.go:171","msg":"trace[1215639423] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1221; }","duration":"1.332365135s","start":"2026-06-04T06:33:28.135524Z","end":"2026-06-04T06:33:29.46789Z","steps":["trace[1215639423] 'range keys from in-memory index tree' (duration: 1.33214408s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:29.467935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:28.135504Z","time spent":"1.332422236s","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-04T06:33:30.008189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.676204ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-06-04T06:33:30.008263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:29.469519Z","time spent":"538.740715ms","remote":"127.0.0.1:36972","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-04T06:33:30.077274Z","caller":"traceutil/trace.go:171","msg":"trace[384939773] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"604.714875ms","start":"2026-06-04T06:33:29.472536Z","end":"2026-06-04T06:33:30.077251Z","steps":["trace[384939773] 'process raft request' (duration: 604.645333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:30.077469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:29.472528Z","time spent":"604.867258ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:33:30.077521Z","caller":"traceutil/trace.go:171","msg":"trace[377309861] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"604.658834ms","start":"2026-06-04T06:33:29.472837Z","end":"2026-06-04T06:33:30.077496Z","steps":["trace[377309861] 'process raft request' (duration: 604.380457ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:30.077607Z","caller":"traceutil/trace.go:171","msg":"trace[1294869417] linearizableReadLoop","detail":"{readStateIndex:1282; appliedIndex:1276; }","duration":"601.492758ms","start":"2026-06-04T06:33:29.476101Z","end":"2026-06-04T06:33:30.077594Z","steps":["trace[1294869417] 'read index received' (duration: 400.416862ms)","trace[1294869417] 'applied index is now lower than readState.Index' (duration: 201.074936ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:33:30.077666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:29.47283Z","time spent":"604.760076ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:33:30.077677Z","caller":"traceutil/trace.go:171","msg":"trace[1860262066] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"604.559381ms","start":"2026-06-04T06:33:29.473085Z","end":"2026-06-04T06:33:30.077644Z","steps":["trace[1860262066] 'process raft request' (duration: 604.332506ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:30.077309Z","caller":"traceutil/trace.go:171","msg":"trace[160414150] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"605.096313ms","start":"2026-06-04T06:33:29.47218Z","end":"2026-06-04T06:33:30.077277Z","steps":["trace[160414150] 'process raft request' (duration: 604.810046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:30.077729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.620751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:30.077763Z","caller":"traceutil/trace.go:171","msg":"trace[1203186488] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1227; }","duration":"601.670862ms","start":"2026-06-04T06:33:29.476081Z","end":"2026-06-04T06:33:30.077752Z","steps":["trace[1203186488] 'agreement among raft nodes before linearized reading' (duration: 601.59171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:30.077798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:29.476074Z","time spent":"601.717593ms","remote":"127.0.0.1:36930","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-06-04T06:33:30.07782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:29.473076Z","time spent":"604.665733ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:33:30.07782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:29.472163Z","time spent":"605.587316ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:33:30.077328Z","caller":"traceutil/trace.go:171","msg":"trace[459600696] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"605.006561ms","start":"2026-06-04T06:33:29.472299Z","end":"2026-06-04T06:33:30.077305Z","steps":["trace[459600696] 'process raft request' (duration: 604.841097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:30.07811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:29.472276Z","time spent":"605.79955ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:33:30.094404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.5124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-04T06:33:30.094452Z","caller":"traceutil/trace.go:171","msg":"trace[1141329020] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1228; }","duration":"591.576482ms","start":"2026-06-04T06:33:29.502862Z","end":"2026-06-04T06:33:30.094439Z","steps":["trace[1141329020] 'agreement among raft nodes before linearized reading' (duration: 591.436059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:30.09448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:29.502854Z","time spent":"591.618933ms","remote":"127.0.0.1:37440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-06-04T06:33:30.094391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.776679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:30.094539Z","caller":"traceutil/trace.go:171","msg":"trace[511341641] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1228; }","duration":"200.975604ms","start":"2026-06-04T06:33:29.893551Z","end":"2026-06-04T06:33:30.094527Z","steps":["trace[511341641] 'agreement among raft nodes before linearized reading' (duration: 200.762679ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:31.663403Z","caller":"traceutil/trace.go:171","msg":"trace[321857110] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"188.825329ms","start":"2026-06-04T06:33:31.474553Z","end":"2026-06-04T06:33:31.663378Z","steps":["trace[321857110] 'process raft request' (duration: 188.704296ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:32.327718Z","caller":"traceutil/trace.go:171","msg":"trace[889761004] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"242.248829ms","start":"2026-06-04T06:33:32.085447Z","end":"2026-06-04T06:33:32.327695Z","steps":["trace[889761004] 'process raft request' (duration: 242.089265ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:32.356211Z","caller":"traceutil/trace.go:171","msg":"trace[1122242416] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"270.320713ms","start":"2026-06-04T06:33:32.085869Z","end":"2026-06-04T06:33:32.35619Z","steps":["trace[1122242416] 'process raft request' (duration: 270.165849ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:32.35639Z","caller":"traceutil/trace.go:171","msg":"trace[1232073513] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"269.870031ms","start":"2026-06-04T06:33:32.086502Z","end":"2026-06-04T06:33:32.356373Z","steps":["trace[1232073513] 'process raft request' (duration: 269.654126ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:32.356799Z","caller":"traceutil/trace.go:171","msg":"trace[857326619] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"173.154526ms","start":"2026-06-04T06:33:32.183622Z","end":"2026-06-04T06:33:32.356777Z","steps":["trace[857326619] 'process raft request' (duration: 173.101125ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:32.357047Z","caller":"traceutil/trace.go:171","msg":"trace[1467012845] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"269.376629ms","start":"2026-06-04T06:33:32.087659Z","end":"2026-06-04T06:33:32.357036Z","steps":["trace[1467012845] 'process raft request' (duration: 268.98162ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:32.35712Z","caller":"traceutil/trace.go:171","msg":"trace[2066955183] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"269.887602ms","start":"2026-06-04T06:33:32.08722Z","end":"2026-06-04T06:33:32.357108Z","steps":["trace[2066955183] 'process raft request' (duration: 269.130714ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:33.784771Z","caller":"traceutil/trace.go:171","msg":"trace[412006478] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"261.126799ms","start":"2026-06-04T06:33:33.523621Z","end":"2026-06-04T06:33:33.784748Z","steps":["trace[412006478] 'process raft request' (duration: 260.985905ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:33.787831Z","caller":"traceutil/trace.go:171","msg":"trace[6067831] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"118.862764ms","start":"2026-06-04T06:33:33.668935Z","end":"2026-06-04T06:33:33.787797Z","steps":["trace[6067831] 'process raft request' (duration: 118.715351ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:35.6811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.48498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:35.681293Z","caller":"traceutil/trace.go:171","msg":"trace[371016918] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:1262; }","duration":"441.704996ms","start":"2026-06-04T06:33:35.239567Z","end":"2026-06-04T06:33:35.681272Z","steps":["trace[371016918] 'range keys from in-memory index tree' (duration: 441.44237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:35.681434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:35.23956Z","time spent":"441.85896ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-06-04T06:33:35.966392Z","caller":"traceutil/trace.go:171","msg":"trace[1341961720] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"366.408543ms","start":"2026-06-04T06:33:35.599959Z","end":"2026-06-04T06:33:35.966367Z","steps":["trace[1341961720] 'process raft request' (duration: 366.28017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:35.966542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:35.599933Z","time spent":"366.525435ms","remote":"127.0.0.1:37006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T06:33:36.341977Z","caller":"traceutil/trace.go:171","msg":"trace[1478775276] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"549.46936ms","start":"2026-06-04T06:33:35.792483Z","end":"2026-06-04T06:33:36.341953Z","steps":["trace[1478775276] 'process raft request' (duration: 549.410268ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:36.342023Z","caller":"traceutil/trace.go:171","msg":"trace[261254774] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"658.626218ms","start":"2026-06-04T06:33:35.683376Z","end":"2026-06-04T06:33:36.342002Z","steps":["trace[261254774] 'process raft request' (duration: 658.191837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:36.342358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:35.683347Z","time spent":"658.947616ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T06:33:36.342512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:35.792462Z","time spent":"549.754897ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:33:36.349006Z","caller":"traceutil/trace.go:171","msg":"trace[323758752] linearizableReadLoop","detail":"{readStateIndex:1322; appliedIndex:1319; }","duration":"275.872078ms","start":"2026-06-04T06:33:36.073121Z","end":"2026-06-04T06:33:36.348993Z","steps":["trace[323758752] 'read index received' (duration: 268.508569ms)","trace[323758752] 'applied index is now lower than readState.Index' (duration: 7.362709ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:33:36.349072Z","caller":"traceutil/trace.go:171","msg":"trace[2004091902] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"378.955548ms","start":"2026-06-04T06:33:35.970092Z","end":"2026-06-04T06:33:36.349047Z","steps":["trace[2004091902] 'process raft request' (duration: 378.759944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:36.349107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.98172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:36.349146Z","caller":"traceutil/trace.go:171","msg":"trace[33455987] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1267; }","duration":"276.060512ms","start":"2026-06-04T06:33:36.073073Z","end":"2026-06-04T06:33:36.349134Z","steps":["trace[33455987] 'agreement among raft nodes before linearized reading' (duration: 275.994271ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:36.349264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:35.970054Z","time spent":"379.115102ms","remote":"127.0.0.1:37006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T06:33:40.830317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.237508ms","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-06-04T06:33:40.830509Z","caller":"traceutil/trace.go:171","msg":"trace[612106112] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1299; }","duration":"189.462134ms","start":"2026-06-04T06:33:40.641016Z","end":"2026-06-04T06:33:40.830478Z","steps":["trace[612106112] 'range keys from in-memory index tree' (duration: 189.199997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:40.830833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.232473ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-04T06:33:40.831082Z","caller":"traceutil/trace.go:171","msg":"trace[1366565803] linearizableReadLoop","detail":"{readStateIndex:1358; appliedIndex:1356; }","duration":"395.881581ms","start":"2026-06-04T06:33:40.435174Z","end":"2026-06-04T06:33:40.831056Z","steps":["trace[1366565803] 'read index received' (duration: 106.140885ms)","trace[1366565803] 'applied index is now lower than readState.Index' (duration: 289.739376ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:33:40.831175Z","caller":"traceutil/trace.go:171","msg":"trace[1528013020] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"400.079913ms","start":"2026-06-04T06:33:40.431055Z","end":"2026-06-04T06:33:40.831135Z","steps":["trace[1528013020] 'process raft request' (duration: 399.904759ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:40.831295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.43102Z","time spent":"400.199696ms","remote":"127.0.0.1:37228","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-06-04T06:33:40.831422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.471631ms","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-06-04T06:33:40.831185Z","caller":"traceutil/trace.go:171","msg":"trace[232581640] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"455.38939ms","start":"2026-06-04T06:33:40.375778Z","end":"2026-06-04T06:33:40.831167Z","steps":["trace[232581640] 'process raft request' (duration: 165.49133ms)","trace[232581640] 'compare' (duration: 288.891955ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:33:40.831482Z","caller":"traceutil/trace.go:171","msg":"trace[2126263270] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1301; }","duration":"393.561844ms","start":"2026-06-04T06:33:40.437906Z","end":"2026-06-04T06:33:40.831468Z","steps":["trace[2126263270] 'agreement among raft nodes before linearized reading' (duration: 393.40208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:40.831529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.437899Z","time spent":"393.620165ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-04T06:33:40.831845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.900482ms","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-06-04T06:33:40.831553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.375747Z","time spent":"455.762679ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T06:33:40.831886Z","caller":"traceutil/trace.go:171","msg":"trace[795947163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1301; }","duration":"393.957853ms","start":"2026-06-04T06:33:40.437918Z","end":"2026-06-04T06:33:40.831875Z","steps":["trace[795947163] 'agreement among raft nodes before linearized reading' (duration: 393.808779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:40.831951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.012375ms","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-06-04T06:33:40.832034Z","caller":"traceutil/trace.go:171","msg":"trace[534563769] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1301; }","duration":"394.140328ms","start":"2026-06-04T06:33:40.437874Z","end":"2026-06-04T06:33:40.832015Z","steps":["trace[534563769] 'agreement among raft nodes before linearized reading' (duration: 393.866362ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:40.831996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.828983ms","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-06-04T06:33:40.832083Z","caller":"traceutil/trace.go:171","msg":"trace[767916111] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1301; }","duration":"396.954227ms","start":"2026-06-04T06:33:40.435114Z","end":"2026-06-04T06:33:40.832068Z","steps":["trace[767916111] 'agreement among raft nodes before linearized reading' (duration: 396.051315ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:40.832141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.435095Z","time spent":"397.031738ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-04T06:33:40.832036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.43768Z","time spent":"394.333712ms","remote":"127.0.0.1:37228","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-06-04T06:33:40.832091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.437867Z","time spent":"394.20723ms","remote":"127.0.0.1:37228","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-06-04T06:33:40.832417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.520977ms","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-06-04T06:33:40.832463Z","caller":"traceutil/trace.go:171","msg":"trace[1664775196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1301; }","duration":"394.612389ms","start":"2026-06-04T06:33:40.43784Z","end":"2026-06-04T06:33:40.832452Z","steps":["trace[1664775196] 'agreement among raft nodes before linearized reading' (duration: 393.447371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:40.832501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.43782Z","time spent":"394.671851ms","remote":"127.0.0.1:37228","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-06-04T06:33:41.250116Z","caller":"traceutil/trace.go:171","msg":"trace[1930524919] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"411.139122ms","start":"2026-06-04T06:33:40.83895Z","end":"2026-06-04T06:33:41.25009Z","steps":["trace[1930524919] 'process raft request' (duration: 411.087831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:41.250316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.83893Z","time spent":"411.282336ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:33:41.250266Z","caller":"traceutil/trace.go:171","msg":"trace[694539874] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"411.233674ms","start":"2026-06-04T06:33:40.83895Z","end":"2026-06-04T06:33:41.250184Z","steps":["trace[694539874] 'process raft request' (duration: 410.927877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:41.250829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.83893Z","time spent":"411.732097ms","remote":"127.0.0.1:37228","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-06-04T06:33:41.251369Z","caller":"traceutil/trace.go:171","msg":"trace[1978263636] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"412.366542ms","start":"2026-06-04T06:33:40.838989Z","end":"2026-06-04T06:33:41.251356Z","steps":["trace[1978263636] 'process raft request' (duration: 412.192998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:41.251461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.838962Z","time spent":"412.446204ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:33:41.251345Z","caller":"traceutil/trace.go:171","msg":"trace[706056329] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1360; }","duration":"409.853561ms","start":"2026-06-04T06:33:40.841468Z","end":"2026-06-04T06:33:41.251322Z","steps":["trace[706056329] 'read index received' (duration: 408.59974ms)","trace[706056329] 'applied index is now lower than readState.Index' (duration: 1.252451ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:33:41.251811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.319742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-04T06:33:41.251865Z","caller":"traceutil/trace.go:171","msg":"trace[1311805944] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1307; }","duration":"410.412124ms","start":"2026-06-04T06:33:40.841436Z","end":"2026-06-04T06:33:41.251848Z","steps":["trace[1311805944] 'agreement among raft nodes before linearized reading' (duration: 409.965093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:41.252544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.841427Z","time spent":"411.099821ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-04T06:33:41.251956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.482934ms","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-06-04T06:33:41.25263Z","caller":"traceutil/trace.go:171","msg":"trace[1146562958] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1307; }","duration":"353.204241ms","start":"2026-06-04T06:33:40.899406Z","end":"2026-06-04T06:33:41.25261Z","steps":["trace[1146562958] 'agreement among raft nodes before linearized reading' (duration: 352.446313ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:41.252694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.899389Z","time spent":"353.284523ms","remote":"127.0.0.1:37148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":45,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-06-04T06:33:41.252016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.697463ms","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-06-04T06:33:41.252788Z","caller":"traceutil/trace.go:171","msg":"trace[1467779449] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1307; }","duration":"138.500592ms","start":"2026-06-04T06:33:41.114274Z","end":"2026-06-04T06:33:41.252775Z","steps":["trace[1467779449] 'agreement among raft nodes before linearized reading' (duration: 137.720973ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:41.251996Z","caller":"traceutil/trace.go:171","msg":"trace[649737768] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"412.884044ms","start":"2026-06-04T06:33:40.839076Z","end":"2026-06-04T06:33:41.25196Z","steps":["trace[649737768] 'process raft request' (duration: 412.142446ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:41.25296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.839066Z","time spent":"413.808847ms","remote":"127.0.0.1:37228","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-06-04T06:33:41.252058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.085483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:33:41.253057Z","caller":"traceutil/trace.go:171","msg":"trace[286705321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1307; }","duration":"178.130108ms","start":"2026-06-04T06:33:41.074911Z","end":"2026-06-04T06:33:41.253041Z","steps":["trace[286705321] 'agreement among raft nodes before linearized reading' (duration: 177.123093ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:41.252076Z","caller":"traceutil/trace.go:171","msg":"trace[2017415233] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"409.799009ms","start":"2026-06-04T06:33:40.842267Z","end":"2026-06-04T06:33:41.252066Z","steps":["trace[2017415233] 'process raft request' (duration: 408.993539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:41.253208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.842236Z","time spent":"410.942527ms","remote":"127.0.0.1:37006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":911,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T06:33:41.251799Z","caller":"traceutil/trace.go:171","msg":"trace[152429969] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"412.800803ms","start":"2026-06-04T06:33:40.838969Z","end":"2026-06-04T06:33:41.251769Z","steps":["trace[152429969] 'process raft request' (duration: 412.114116ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:33:41.25337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:33:40.838942Z","time spent":"414.36409ms","remote":"127.0.0.1:37228","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-06-04T06:33:51.491341Z","caller":"traceutil/trace.go:171","msg":"trace[1421963949] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"162.946118ms","start":"2026-06-04T06:33:51.328368Z","end":"2026-06-04T06:33:51.491314Z","steps":["trace[1421963949] 'process raft request' (duration: 162.724042ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:51.491383Z","caller":"traceutil/trace.go:171","msg":"trace[2081375228] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"162.881457ms","start":"2026-06-04T06:33:51.328486Z","end":"2026-06-04T06:33:51.491367Z","steps":["trace[2081375228] 'process raft request' (duration: 162.643501ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:51.491391Z","caller":"traceutil/trace.go:171","msg":"trace[1182402769] transaction","detail":"{read_only:false; response_revision:1365; number_of_response:1; }","duration":"162.050376ms","start":"2026-06-04T06:33:51.329296Z","end":"2026-06-04T06:33:51.491346Z","steps":["trace[1182402769] 'process raft request' (duration: 161.953704ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:33:51.491502Z","caller":"traceutil/trace.go:171","msg":"trace[697052663] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"163.354838ms","start":"2026-06-04T06:33:51.328135Z","end":"2026-06-04T06:33:51.49149Z","steps":["trace[697052663] 'process raft request' (duration: 138.947253ms)","trace[697052663] 'compare' (duration: 23.885832ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:34:01.085366Z","caller":"traceutil/trace.go:171","msg":"trace[492945013] transaction","detail":"{read_only:false; response_revision:1406; number_of_response:1; }","duration":"182.104615ms","start":"2026-06-04T06:34:00.903222Z","end":"2026-06-04T06:34:01.085327Z","steps":["trace[492945013] 'process raft request' (duration: 181.744896ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:34:09.930687Z","caller":"traceutil/trace.go:171","msg":"trace[64400302] linearizableReadLoop","detail":"{readStateIndex:1510; appliedIndex:1509; }","duration":"326.585243ms","start":"2026-06-04T06:34:09.604077Z","end":"2026-06-04T06:34:09.930663Z","steps":["trace[64400302] 'read index received' (duration: 326.389248ms)","trace[64400302] 'applied index is now lower than readState.Index' (duration: 194.915µs)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:34:09.930737Z","caller":"traceutil/trace.go:171","msg":"trace[146523510] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"331.8297ms","start":"2026-06-04T06:34:09.598877Z","end":"2026-06-04T06:34:09.930707Z","steps":["trace[146523510] 'process raft request' (duration: 331.605775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:34:09.930955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:34:09.598857Z","time spent":"331.985704ms","remote":"127.0.0.1:37228","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-06-04T06:34:09.930984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.616234ms","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-06-04T06:34:09.931002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.520536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-04T06:34:09.931035Z","caller":"traceutil/trace.go:171","msg":"trace[1733311035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1447; }","duration":"319.684765ms","start":"2026-06-04T06:34:09.611337Z","end":"2026-06-04T06:34:09.931022Z","steps":["trace[1733311035] 'agreement among raft nodes before linearized reading' (duration: 319.530601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:34:09.931071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:34:09.611329Z","time spent":"319.734396ms","remote":"127.0.0.1:37228","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":"info","ts":"2026-06-04T06:34:09.93107Z","caller":"traceutil/trace.go:171","msg":"trace[1412553595] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1447; }","duration":"320.640798ms","start":"2026-06-04T06:34:09.61041Z","end":"2026-06-04T06:34:09.931051Z","steps":["trace[1412553595] 'agreement among raft nodes before linearized reading' (duration: 320.447364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:34:09.931024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.941502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-04T06:34:09.931128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:34:09.61039Z","time spent":"320.72492ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-06-04T06:34:09.931139Z","caller":"traceutil/trace.go:171","msg":"trace[1539984244] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1447; }","duration":"327.070125ms","start":"2026-06-04T06:34:09.604051Z","end":"2026-06-04T06:34:09.931121Z","steps":["trace[1539984244] 'agreement among raft nodes before linearized reading' (duration: 326.796879ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:34:09.931184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.121606ms","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-06-04T06:34:09.931302Z","caller":"traceutil/trace.go:171","msg":"trace[184250186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1447; }","duration":"320.278019ms","start":"2026-06-04T06:34:09.610999Z","end":"2026-06-04T06:34:09.931277Z","steps":["trace[184250186] 'agreement among raft nodes before linearized reading' (duration: 319.9275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:34:09.931308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:34:09.604042Z","time spent":"327.183488ms","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-04T06:34:09.931363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:34:09.610993Z","time spent":"320.358901ms","remote":"127.0.0.1:37228","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-06-04T06:34:10.119867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.995801ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T06:34:10.120212Z","caller":"traceutil/trace.go:171","msg":"trace[650044700] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"183.459336ms","start":"2026-06-04T06:34:09.936733Z","end":"2026-06-04T06:34:10.120192Z","steps":["trace[650044700] 'process raft request' (duration: 183.253891ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:34:10.120404Z","caller":"traceutil/trace.go:171","msg":"trace[1089830501] transaction","detail":"{read_only:false; response_revision:1450; number_of_response:1; }","duration":"183.502708ms","start":"2026-06-04T06:34:09.936877Z","end":"2026-06-04T06:34:10.12038Z","steps":["trace[1089830501] 'process raft request' (duration: 183.16469ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:34:10.120491Z","caller":"traceutil/trace.go:171","msg":"trace[2057364620] transaction","detail":"{read_only:false; response_revision:1451; number_of_response:1; }","duration":"181.374816ms","start":"2026-06-04T06:34:09.9391Z","end":"2026-06-04T06:34:10.120475Z","steps":["trace[2057364620] 'process raft request' (duration: 181.0989ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:34:10.120306Z","caller":"traceutil/trace.go:171","msg":"trace[696198629] transaction","detail":"{read_only:false; response_revision:1448; number_of_response:1; }","duration":"184.395509ms","start":"2026-06-04T06:34:09.93588Z","end":"2026-06-04T06:34:10.120275Z","steps":["trace[696198629] 'process raft request' (duration: 38.906916ms)","trace[696198629] 'compare' (duration: 144.890859ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:34:26.413009Z","caller":"traceutil/trace.go:171","msg":"trace[478636655] transaction","detail":"{read_only:false; response_revision:1520; number_of_response:1; }","duration":"124.177243ms","start":"2026-06-04T06:34:26.288812Z","end":"2026-06-04T06:34:26.412989Z","steps":["trace[478636655] 'process raft request' (duration: 124.05065ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:34:26.414645Z","caller":"traceutil/trace.go:171","msg":"trace[1643048580] transaction","detail":"{read_only:false; response_revision:1521; number_of_response:1; }","duration":"124.654856ms","start":"2026-06-04T06:34:26.289954Z","end":"2026-06-04T06:34:26.414609Z","steps":["trace[1643048580] 'process raft request' (duration: 124.358638ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:34:26.414795Z","caller":"traceutil/trace.go:171","msg":"trace[2032772759] transaction","detail":"{read_only:false; response_revision:1522; number_of_response:1; }","duration":"124.631445ms","start":"2026-06-04T06:34:26.290059Z","end":"2026-06-04T06:34:26.414691Z","steps":["trace[2032772759] 'process raft request' (duration: 124.390319ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:34:26.416163Z","caller":"traceutil/trace.go:171","msg":"trace[1253880248] transaction","detail":"{read_only:false; response_revision:1523; number_of_response:1; }","duration":"124.739587ms","start":"2026-06-04T06:34:26.290106Z","end":"2026-06-04T06:34:26.414845Z","steps":["trace[1253880248] 'process raft request' (duration: 124.382309ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:37:11.053696Z","caller":"traceutil/trace.go:171","msg":"trace[742728090] linearizableReadLoop","detail":"{readStateIndex:2397; appliedIndex:2396; }","duration":"148.272834ms","start":"2026-06-04T06:37:10.905401Z","end":"2026-06-04T06:37:11.053673Z","steps":["trace[742728090] 'read index received' (duration: 147.941486ms)","trace[742728090] 'applied index is now lower than readState.Index' (duration: 330.308µs)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:37:11.053933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.515569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2476"} {"level":"info","ts":"2026-06-04T06:37:11.053973Z","caller":"traceutil/trace.go:171","msg":"trace[1915102138] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:2297; }","duration":"148.610122ms","start":"2026-06-04T06:37:10.905352Z","end":"2026-06-04T06:37:11.053962Z","steps":["trace[1915102138] 'agreement among raft nodes before linearized reading' (duration: 148.417437ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:37:11.05408Z","caller":"traceutil/trace.go:171","msg":"trace[1346625079] transaction","detail":"{read_only:false; response_revision:2297; number_of_response:1; }","duration":"181.824155ms","start":"2026-06-04T06:37:10.872001Z","end":"2026-06-04T06:37:11.053825Z","steps":["trace[1346625079] 'process raft request' (duration: 181.461047ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:37:17.441587Z","caller":"traceutil/trace.go:171","msg":"trace[1169338944] linearizableReadLoop","detail":"{readStateIndex:2434; appliedIndex:2433; }","duration":"133.088151ms","start":"2026-06-04T06:37:17.308472Z","end":"2026-06-04T06:37:17.44156Z","steps":["trace[1169338944] 'read index received' (duration: 69.702767ms)","trace[1169338944] 'applied index is now lower than readState.Index' (duration: 63.384314ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:37:17.441805Z","caller":"traceutil/trace.go:171","msg":"trace[1519270287] transaction","detail":"{read_only:false; response_revision:2333; number_of_response:1; }","duration":"134.002863ms","start":"2026-06-04T06:37:17.30773Z","end":"2026-06-04T06:37:17.441733Z","steps":["trace[1519270287] 'process raft request' (duration: 90.562974ms)","trace[1519270287] 'compare' (duration: 43.146542ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:37:17.441865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.365918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-04T06:37:17.442063Z","caller":"traceutil/trace.go:171","msg":"trace[76762884] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2333; }","duration":"133.577423ms","start":"2026-06-04T06:37:17.308457Z","end":"2026-06-04T06:37:17.442035Z","steps":["trace[76762884] 'agreement among raft nodes before linearized reading' (duration: 133.276026ms)"],"step_count":1}