{"level":"warn","ts":"2026-06-27T08:48:18.615327Z","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-27T08:48:18.615426Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138: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-27T08:48:18.615654Z","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-27T08:48:18.615677Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-06-27T08:48:18.615699Z","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-27T08:48:18.617334Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-06-27T08:48:18.617429Z","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.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138: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-27T08:48:18.621433Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.820468ms"} {"level":"info","ts":"2026-06-27T08:48:18.62827Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-06-27T08:48:18.628471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-06-27T08:48:18.628522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-06-27T08:48:18.628545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-27T08:48:18.62857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-06-27T08:48:18.628638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-06-27T08:48:18.636809Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-27T08:48:18.638269Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-27T08:48:18.639815Z","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-27T08:48:18.645236Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-27T08:48:18.646696Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-27T08:48:18.646874Z","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-27T08:48:18.646935Z","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-27T08:48:18.64695Z","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-27T08:48:18.647498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-06-27T08:48:18.647629Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-06-27T08:48:18.653733Z","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-27T08:48:18.653859Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-06-27T08:48:18.65395Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-06-27T08:48:18.65408Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-27T08:48:18.654135Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-27T08:48:19.135291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-06-27T08:48:19.135464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-27T08:48:19.135494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-06-27T08:48:19.13552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-06-27T08:48:19.135536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-06-27T08:48:19.135557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-06-27T08:48:19.135574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-06-27T08:48:19.137997Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-06-27T08:48:19.142673Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-27T08:48:19.14351Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-27T08:48:19.14851Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-27T08:48:19.148716Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-06-27T08:48:19.148836Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-27T08:48:19.14887Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-27T08:48:19.152388Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-27T08:48:19.154423Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-06-27T08:48:19.154807Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-27T08:48:19.154901Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-06-27T08:48:42.749855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.559413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-27T08:48:42.749965Z","caller":"traceutil/trace.go:171","msg":"trace[571862944] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"371.358892ms","start":"2026-06-27T08:48:42.378595Z","end":"2026-06-27T08:48:42.749953Z","steps":["trace[571862944] 'process raft request' (duration: 222.309035ms)","trace[571862944] 'compare' (duration: 148.444043ms)"],"step_count":2} {"level":"warn","ts":"2026-06-27T08:48:42.7501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T08:48:42.378579Z","time spent":"371.418003ms","remote":"127.0.0.1:56778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3840,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-27T08:48:42.753889Z","caller":"traceutil/trace.go:171","msg":"trace[1069617888] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"352.766606ms","start":"2026-06-27T08:48:42.401099Z","end":"2026-06-27T08:48:42.753866Z","steps":["trace[1069617888] 'process raft request' (duration: 352.652085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:48:42.754032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T08:48:42.401089Z","time spent":"352.854347ms","remote":"127.0.0.1:56754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-27T08:48:55.188875Z","caller":"traceutil/trace.go:171","msg":"trace[1018207024] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"132.065392ms","start":"2026-06-27T08:48:55.056777Z","end":"2026-06-27T08:48:55.188842Z","steps":["trace[1018207024] 'process raft request' (duration: 131.942471ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:48:55.194846Z","caller":"traceutil/trace.go:171","msg":"trace[912039436] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:542; }","duration":"102.282935ms","start":"2026-06-27T08:48:55.092548Z","end":"2026-06-27T08:48:55.194831Z","steps":["trace[912039436] 'read index received' (duration: 96.257576ms)","trace[912039436] 'applied index is now lower than readState.Index' (duration: 6.024729ms)"],"step_count":2} {"level":"info","ts":"2026-06-27T08:48:55.195041Z","caller":"traceutil/trace.go:171","msg":"trace[1450019013] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"137.093395ms","start":"2026-06-27T08:48:55.057939Z","end":"2026-06-27T08:48:55.195032Z","steps":["trace[1450019013] 'process raft request' (duration: 136.493541ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:48:55.195256Z","caller":"traceutil/trace.go:171","msg":"trace[2024574890] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"135.889727ms","start":"2026-06-27T08:48:55.059359Z","end":"2026-06-27T08:48:55.195248Z","steps":["trace[2024574890] 'process raft request' (duration: 135.148442ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:48:55.195397Z","caller":"traceutil/trace.go:171","msg":"trace[901560874] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"124.648523ms","start":"2026-06-27T08:48:55.070725Z","end":"2026-06-27T08:48:55.195374Z","steps":["trace[901560874] 'process raft request' (duration: 123.806418ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:48:55.195512Z","caller":"traceutil/trace.go:171","msg":"trace[421112016] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"124.718524ms","start":"2026-06-27T08:48:55.070786Z","end":"2026-06-27T08:48:55.195505Z","steps":["trace[421112016] 'process raft request' (duration: 123.777828ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:48:55.195536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.95872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-27T08:48:55.195584Z","caller":"traceutil/trace.go:171","msg":"trace[1045081344] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:536; }","duration":"103.0624ms","start":"2026-06-27T08:48:55.092514Z","end":"2026-06-27T08:48:55.195577Z","steps":["trace[1045081344] 'agreement among raft nodes before linearized reading' (duration: 102.916909ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:48:55.1956Z","caller":"traceutil/trace.go:171","msg":"trace[213417152] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"122.216396ms","start":"2026-06-27T08:48:55.073375Z","end":"2026-06-27T08:48:55.195591Z","steps":["trace[213417152] 'process raft request' (duration: 121.2264ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:48:55.195687Z","caller":"traceutil/trace.go:171","msg":"trace[1497796099] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"121.936464ms","start":"2026-06-27T08:48:55.073744Z","end":"2026-06-27T08:48:55.19568Z","steps":["trace[1497796099] 'process raft request' (duration: 120.889057ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:48:55.195789Z","caller":"traceutil/trace.go:171","msg":"trace[1463440494] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"121.969945ms","start":"2026-06-27T08:48:55.073812Z","end":"2026-06-27T08:48:55.195782Z","steps":["trace[1463440494] 'process raft request' (duration: 120.850037ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:48:55.195883Z","caller":"traceutil/trace.go:171","msg":"trace[571410568] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"107.992422ms","start":"2026-06-27T08:48:55.087884Z","end":"2026-06-27T08:48:55.195876Z","steps":["trace[571410568] 'process raft request' (duration: 106.812425ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:49:01.119137Z","caller":"traceutil/trace.go:171","msg":"trace[225873404] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"171.168358ms","start":"2026-06-27T08:49:00.947944Z","end":"2026-06-27T08:49:01.119112Z","steps":["trace[225873404] 'process raft request' (duration: 171.023927ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:49:01.366588Z","caller":"traceutil/trace.go:171","msg":"trace[203412242] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"128.382924ms","start":"2026-06-27T08:49:01.238175Z","end":"2026-06-27T08:49:01.366558Z","steps":["trace[203412242] 'read index received' (duration: 97.304917ms)","trace[203412242] 'applied index is now lower than readState.Index' (duration: 31.076737ms)"],"step_count":2} {"level":"info","ts":"2026-06-27T08:49:01.367483Z","caller":"traceutil/trace.go:171","msg":"trace[924998708] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"296.224548ms","start":"2026-06-27T08:49:01.070385Z","end":"2026-06-27T08:49:01.366609Z","steps":["trace[924998708] 'process raft request' (duration: 265.401873ms)","trace[924998708] 'compare' (duration: 29.684157ms)"],"step_count":2} {"level":"warn","ts":"2026-06-27T08:49:01.367588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.294109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-27T08:49:01.367802Z","caller":"traceutil/trace.go:171","msg":"trace[1161055661] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"129.657041ms","start":"2026-06-27T08:49:01.238115Z","end":"2026-06-27T08:49:01.367772Z","steps":["trace[1161055661] 'agreement among raft nodes before linearized reading' (duration: 128.555785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:49:01.369492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.855387ms","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-27T08:49:01.369605Z","caller":"traceutil/trace.go:171","msg":"trace[557020944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"126.050859ms","start":"2026-06-27T08:49:01.243535Z","end":"2026-06-27T08:49:01.369586Z","steps":["trace[557020944] 'agreement among raft nodes before linearized reading' (duration: 125.300405ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:49:01.490635Z","caller":"traceutil/trace.go:171","msg":"trace[1115339257] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"112.575233ms","start":"2026-06-27T08:49:01.378027Z","end":"2026-06-27T08:49:01.490602Z","steps":["trace[1115339257] 'process raft request' (duration: 88.892123ms)","trace[1115339257] 'compare' (duration: 23.556849ms)"],"step_count":2} {"level":"warn","ts":"2026-06-27T08:49:01.98895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.256492ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-27T08:49:01.989987Z","caller":"traceutil/trace.go:171","msg":"trace[269565773] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"191.143631ms","start":"2026-06-27T08:49:01.798818Z","end":"2026-06-27T08:49:01.989961Z","steps":["trace[269565773] 'read index received' (duration: 50.725951ms)","trace[269565773] 'applied index is now lower than readState.Index' (duration: 140.41599ms)"],"step_count":2} {"level":"info","ts":"2026-06-27T08:49:01.989942Z","caller":"traceutil/trace.go:171","msg":"trace[1556723174] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"334.000286ms","start":"2026-06-27T08:49:01.655871Z","end":"2026-06-27T08:49:01.989871Z","steps":["trace[1556723174] 'process raft request' (duration: 193.733688ms)","trace[1556723174] 'compare' (duration: 138.87106ms)"],"step_count":2} {"level":"warn","ts":"2026-06-27T08:49:01.99015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.347042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-27T08:49:01.990184Z","caller":"traceutil/trace.go:171","msg":"trace[1680267312] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:635; }","duration":"191.423963ms","start":"2026-06-27T08:49:01.798747Z","end":"2026-06-27T08:49:01.990171Z","steps":["trace[1680267312] 'agreement among raft nodes before linearized reading' (duration: 191.317683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:49:01.990196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T08:49:01.655849Z","time spent":"334.201829ms","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-27T08:49:01.990619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.607852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T08:49:01.990692Z","caller":"traceutil/trace.go:171","msg":"trace[1946987422] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"159.700782ms","start":"2026-06-27T08:49:01.830974Z","end":"2026-06-27T08:49:01.990675Z","steps":["trace[1946987422] 'agreement among raft nodes before linearized reading' (duration: 159.572011ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:49:25.995021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.007121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T08:49:25.995113Z","caller":"traceutil/trace.go:171","msg":"trace[1550747919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:822; }","duration":"162.165635ms","start":"2026-06-27T08:49:25.83293Z","end":"2026-06-27T08:49:25.995095Z","steps":["trace[1550747919] 'range keys from in-memory index tree' (duration: 161.921397ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:49:55.870431Z","caller":"traceutil/trace.go:171","msg":"trace[1932769353] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"222.809571ms","start":"2026-06-27T08:49:55.647597Z","end":"2026-06-27T08:49:55.870407Z","steps":["trace[1932769353] 'process raft request' (duration: 222.643797ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:49:55.870662Z","caller":"traceutil/trace.go:171","msg":"trace[1838015078] linearizableReadLoop","detail":"{readStateIndex:1261; appliedIndex:1260; }","duration":"185.106876ms","start":"2026-06-27T08:49:55.68554Z","end":"2026-06-27T08:49:55.870647Z","steps":["trace[1838015078] 'read index received' (duration: 184.632305ms)","trace[1838015078] 'applied index is now lower than readState.Index' (duration: 473.211µs)"],"step_count":2} {"level":"warn","ts":"2026-06-27T08:49:55.870829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.287ms","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-27T08:49:55.870867Z","caller":"traceutil/trace.go:171","msg":"trace[1084730129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1225; }","duration":"185.384703ms","start":"2026-06-27T08:49:55.685472Z","end":"2026-06-27T08:49:55.870856Z","steps":["trace[1084730129] 'agreement among raft nodes before linearized reading' (duration: 185.26046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:49:55.871269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.898695ms","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-27T08:49:55.871308Z","caller":"traceutil/trace.go:171","msg":"trace[1197484709] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1225; }","duration":"129.973096ms","start":"2026-06-27T08:49:55.741326Z","end":"2026-06-27T08:49:55.871299Z","steps":["trace[1197484709] 'agreement among raft nodes before linearized reading' (duration: 129.70518ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:50:43.983959Z","caller":"traceutil/trace.go:171","msg":"trace[310771899] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"489.983194ms","start":"2026-06-27T08:50:43.493948Z","end":"2026-06-27T08:50:43.983931Z","steps":["trace[310771899] 'process raft request' (duration: 489.936373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:50:43.984168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T08:50:43.493929Z","time spent":"490.152856ms","remote":"127.0.0.1:56412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-27T08:50:43.984417Z","caller":"traceutil/trace.go:171","msg":"trace[2009970733] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"490.680324ms","start":"2026-06-27T08:50:43.493701Z","end":"2026-06-27T08:50:43.984381Z","steps":["trace[2009970733] 'process raft request' (duration: 490.053404ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:50:43.984534Z","caller":"traceutil/trace.go:171","msg":"trace[600450995] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"490.737155ms","start":"2026-06-27T08:50:43.493785Z","end":"2026-06-27T08:50:43.984522Z","steps":["trace[600450995] 'process raft request' (duration: 490.053715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:50:43.984594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T08:50:43.49368Z","time spent":"490.816887ms","remote":"127.0.0.1:56540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-27T08:50:43.984618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T08:50:43.493771Z","time spent":"490.808866ms","remote":"127.0.0.1:56540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-27T08:50:43.984449Z","caller":"traceutil/trace.go:171","msg":"trace[327402693] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"490.874468ms","start":"2026-06-27T08:50:43.493545Z","end":"2026-06-27T08:50:43.984419Z","steps":["trace[327402693] 'process raft request' (duration: 408.190848ms)","trace[327402693] 'compare' (duration: 81.841707ms)"],"step_count":2} {"level":"warn","ts":"2026-06-27T08:50:43.985622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T08:50:43.493518Z","time spent":"492.023496ms","remote":"127.0.0.1:56412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-27T08:50:44.073916Z","caller":"traceutil/trace.go:171","msg":"trace[1369229784] linearizableReadLoop","detail":"{readStateIndex:1976; appliedIndex:1971; }","duration":"508.447184ms","start":"2026-06-27T08:50:43.565448Z","end":"2026-06-27T08:50:44.073895Z","steps":["trace[1369229784] 'read index received' (duration: 336.294256ms)","trace[1369229784] 'applied index is now lower than readState.Index' (duration: 172.152008ms)"],"step_count":2} {"level":"info","ts":"2026-06-27T08:50:44.074027Z","caller":"traceutil/trace.go:171","msg":"trace[2085136933] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"565.459483ms","start":"2026-06-27T08:50:43.508558Z","end":"2026-06-27T08:50:44.074017Z","steps":["trace[2085136933] 'process raft request' (duration: 565.098428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:50:44.074105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T08:50:43.508548Z","time spent":"565.508724ms","remote":"127.0.0.1:56430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-27T08:50:44.074159Z","caller":"traceutil/trace.go:171","msg":"trace[201851527] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"254.218697ms","start":"2026-06-27T08:50:43.819903Z","end":"2026-06-27T08:50:44.074122Z","steps":["trace[201851527] 'process raft request' (duration: 253.955423ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:50:44.074503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.073633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-24a151c7-c360-4873-85d2-671e8292916e\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-06-27T08:50:44.074555Z","caller":"traceutil/trace.go:171","msg":"trace[2009382445] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-24a151c7-c360-4873-85d2-671e8292916e; range_end:; response_count:1; response_revision:1907; }","duration":"509.189324ms","start":"2026-06-27T08:50:43.565354Z","end":"2026-06-27T08:50:44.074543Z","steps":["trace[2009382445] 'agreement among raft nodes before linearized reading' (duration: 509.074903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:50:44.074587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T08:50:43.565309Z","time spent":"509.271246ms","remote":"127.0.0.1:56430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3771,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-24a151c7-c360-4873-85d2-671e8292916e\" "} {"level":"info","ts":"2026-06-27T08:50:44.074516Z","caller":"traceutil/trace.go:171","msg":"trace[1283004134] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"265.491462ms","start":"2026-06-27T08:50:43.808991Z","end":"2026-06-27T08:50:44.074483Z","steps":["trace[1283004134] 'process raft request' (duration: 264.805672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:50:44.074997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.06243ms","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-27T08:50:44.075035Z","caller":"traceutil/trace.go:171","msg":"trace[2045544492] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1907; }","duration":"319.145291ms","start":"2026-06-27T08:50:43.755879Z","end":"2026-06-27T08:50:44.075025Z","steps":["trace[2045544492] 'agreement among raft nodes before linearized reading' (duration: 319.001129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:50:44.075074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T08:50:43.755856Z","time spent":"319.206352ms","remote":"127.0.0.1:56528","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-27T08:50:44.07527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.27284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-27T08:50:44.075306Z","caller":"traceutil/trace.go:171","msg":"trace[1660397222] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1907; }","duration":"106.343881ms","start":"2026-06-27T08:50:43.968952Z","end":"2026-06-27T08:50:44.075296Z","steps":["trace[1660397222] 'agreement among raft nodes before linearized reading' (duration: 106.236199ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:50:44.075489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.801042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T08:50:44.07553Z","caller":"traceutil/trace.go:171","msg":"trace[1271255272] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1907; }","duration":"219.878273ms","start":"2026-06-27T08:50:43.855638Z","end":"2026-06-27T08:50:44.075516Z","steps":["trace[1271255272] 'agreement among raft nodes before linearized reading' (duration: 219.809912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:50:44.075703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.983403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T08:50:44.075744Z","caller":"traceutil/trace.go:171","msg":"trace[1816566540] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1907; }","duration":"243.037523ms","start":"2026-06-27T08:50:43.83269Z","end":"2026-06-27T08:50:44.075727Z","steps":["trace[1816566540] 'agreement among raft nodes before linearized reading' (duration: 242.991783ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:50:44.382214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.20412ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-27T08:50:44.38232Z","caller":"traceutil/trace.go:171","msg":"trace[612183188] linearizableReadLoop","detail":"{readStateIndex:1979; appliedIndex:1978; }","duration":"214.41011ms","start":"2026-06-27T08:50:44.167893Z","end":"2026-06-27T08:50:44.382303Z","steps":["trace[612183188] 'read index received' (duration: 60.721µs)","trace[612183188] 'applied index is now lower than readState.Index' (duration: 214.348359ms)"],"step_count":2} {"level":"info","ts":"2026-06-27T08:50:44.382616Z","caller":"traceutil/trace.go:171","msg":"trace[237054685] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"302.299652ms","start":"2026-06-27T08:50:44.08026Z","end":"2026-06-27T08:50:44.38256Z","steps":["trace[237054685] 'compare' (duration: 292.797214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:50:44.382895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T08:50:44.080246Z","time spent":"302.490844ms","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-27T08:50:44.383057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.131322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-27T08:50:44.383132Z","caller":"traceutil/trace.go:171","msg":"trace[864958374] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1908; }","duration":"215.281514ms","start":"2026-06-27T08:50:44.167831Z","end":"2026-06-27T08:50:44.383112Z","steps":["trace[864958374] 'agreement among raft nodes before linearized reading' (duration: 214.902957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:50:44.383274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.867054ms","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-27T08:50:44.383376Z","caller":"traceutil/trace.go:171","msg":"trace[1341637319] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1908; }","duration":"205.003416ms","start":"2026-06-27T08:50:44.178353Z","end":"2026-06-27T08:50:44.383357Z","steps":["trace[1341637319] 'agreement among raft nodes before linearized reading' (duration: 204.744432ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:50:58.770925Z","caller":"traceutil/trace.go:171","msg":"trace[469797205] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"112.467235ms","start":"2026-06-27T08:50:58.658434Z","end":"2026-06-27T08:50:58.770902Z","steps":["trace[469797205] 'process raft request' (duration: 112.374493ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:51:18.982126Z","caller":"traceutil/trace.go:171","msg":"trace[642267070] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"126.058891ms","start":"2026-06-27T08:51:18.855984Z","end":"2026-06-27T08:51:18.982042Z","steps":["trace[642267070] 'process raft request' (duration: 125.865749ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:51:19.279699Z","caller":"traceutil/trace.go:171","msg":"trace[2033449987] linearizableReadLoop","detail":"{readStateIndex:2229; appliedIndex:2228; }","duration":"250.389615ms","start":"2026-06-27T08:51:19.029266Z","end":"2026-06-27T08:51:19.279655Z","steps":["trace[2033449987] 'read index received' (duration: 226.266623ms)","trace[2033449987] 'applied index is now lower than readState.Index' (duration: 24.121852ms)"],"step_count":2} {"level":"info","ts":"2026-06-27T08:51:19.279726Z","caller":"traceutil/trace.go:171","msg":"trace[622711099] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"267.136524ms","start":"2026-06-27T08:51:19.012541Z","end":"2026-06-27T08:51:19.279678Z","steps":["trace[622711099] 'process raft request' (duration: 243.063423ms)","trace[622711099] 'compare' (duration: 23.551803ms)"],"step_count":2} {"level":"warn","ts":"2026-06-27T08:51:19.280705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.421228ms","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-27T08:51:19.28084Z","caller":"traceutil/trace.go:171","msg":"trace[2128677358] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2150; }","duration":"251.582819ms","start":"2026-06-27T08:51:19.029197Z","end":"2026-06-27T08:51:19.28078Z","steps":["trace[2128677358] 'agreement among raft nodes before linearized reading' (duration: 250.594607ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:51:19.585256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.868134ms","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-27T08:51:19.585407Z","caller":"traceutil/trace.go:171","msg":"trace[1618771192] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2150; }","duration":"119.040466ms","start":"2026-06-27T08:51:19.466347Z","end":"2026-06-27T08:51:19.585387Z","steps":["trace[1618771192] 'range keys from in-memory index tree' (duration: 118.846843ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:51:19.603384Z","caller":"traceutil/trace.go:171","msg":"trace[1312610839] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"316.807103ms","start":"2026-06-27T08:51:19.286547Z","end":"2026-06-27T08:51:19.603355Z","steps":["trace[1312610839] 'process raft request' (duration: 316.5021ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:51:19.603373Z","caller":"traceutil/trace.go:171","msg":"trace[1331115397] linearizableReadLoop","detail":"{readStateIndex:2230; appliedIndex:2229; }","duration":"287.621239ms","start":"2026-06-27T08:51:19.315704Z","end":"2026-06-27T08:51:19.603325Z","steps":["trace[1331115397] 'read index received' (duration: 287.349066ms)","trace[1331115397] 'applied index is now lower than readState.Index' (duration: 270.463µs)"],"step_count":2} {"level":"warn","ts":"2026-06-27T08:51:19.603509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T08:51:19.286518Z","time spent":"316.926524ms","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-27T08:51:19.604028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.220346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-27T08:51:19.604099Z","caller":"traceutil/trace.go:171","msg":"trace[939531872] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2151; }","duration":"288.415709ms","start":"2026-06-27T08:51:19.315657Z","end":"2026-06-27T08:51:19.604072Z","steps":["trace[939531872] 'agreement among raft nodes before linearized reading' (duration: 287.824212ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:56:57.663988Z","caller":"traceutil/trace.go:171","msg":"trace[1133803143] transaction","detail":"{read_only:false; response_revision:4739; number_of_response:1; }","duration":"158.457385ms","start":"2026-06-27T08:56:57.505483Z","end":"2026-06-27T08:56:57.663941Z","steps":["trace[1133803143] 'process raft request' (duration: 158.308692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:57:02.534262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.615686ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-27T08:57:02.534449Z","caller":"traceutil/trace.go:171","msg":"trace[596098990] transaction","detail":"{read_only:false; response_revision:4833; number_of_response:1; }","duration":"168.257498ms","start":"2026-06-27T08:57:02.366173Z","end":"2026-06-27T08:57:02.534431Z","steps":["trace[596098990] 'process raft request' (duration: 168.196337ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:57:02.534678Z","caller":"traceutil/trace.go:171","msg":"trace[877904601] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"185.811725ms","start":"2026-06-27T08:57:02.348852Z","end":"2026-06-27T08:57:02.534663Z","steps":["trace[877904601] 'process raft request' (duration: 59.68333ms)","trace[877904601] 'compare' (duration: 125.327891ms)"],"step_count":2} {"level":"info","ts":"2026-06-27T08:57:02.534793Z","caller":"traceutil/trace.go:171","msg":"trace[263519781] linearizableReadLoop","detail":"{readStateIndex:5015; appliedIndex:5014; }","duration":"174.252549ms","start":"2026-06-27T08:57:02.360495Z","end":"2026-06-27T08:57:02.534748Z","steps":["trace[263519781] 'read index received' (duration: 48.050933ms)","trace[263519781] 'applied index is now lower than readState.Index' (duration: 126.196726ms)"],"step_count":2} {"level":"warn","ts":"2026-06-27T08:57:02.535008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.479483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-27T08:57:02.535116Z","caller":"traceutil/trace.go:171","msg":"trace[1715878104] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4833; }","duration":"174.656376ms","start":"2026-06-27T08:57:02.360436Z","end":"2026-06-27T08:57:02.535092Z","steps":["trace[1715878104] 'agreement among raft nodes before linearized reading' (duration: 174.457673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T08:57:02.535234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.463832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d161065d-81bd-4bdc-ae8f-c29131df8bc1\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-27T08:57:02.535286Z","caller":"traceutil/trace.go:171","msg":"trace[2068754971] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d161065d-81bd-4bdc-ae8f-c29131df8bc1; range_end:; response_count:1; response_revision:4833; }","duration":"145.584595ms","start":"2026-06-27T08:57:02.389684Z","end":"2026-06-27T08:57:02.535268Z","steps":["trace[2068754971] 'agreement among raft nodes before linearized reading' (duration: 145.31507ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:57:04.643967Z","caller":"traceutil/trace.go:171","msg":"trace[1108911955] transaction","detail":"{read_only:false; response_revision:4856; number_of_response:1; }","duration":"102.887493ms","start":"2026-06-27T08:57:04.541061Z","end":"2026-06-27T08:57:04.643949Z","steps":["trace[1108911955] 'process raft request' (duration: 102.797052ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:57:04.643992Z","caller":"traceutil/trace.go:171","msg":"trace[257130211] transaction","detail":"{read_only:false; response_revision:4855; number_of_response:1; }","duration":"103.466883ms","start":"2026-06-27T08:57:04.540451Z","end":"2026-06-27T08:57:04.643918Z","steps":["trace[257130211] 'process raft request' (duration: 56.905138ms)","trace[257130211] 'compare' (duration: 46.226509ms)"],"step_count":2} {"level":"warn","ts":"2026-06-27T08:57:04.644815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.132316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d161065d-81bd-4bdc-ae8f-c29131df8bc1\" ","response":"range_response_count:1 size:3952"} {"level":"info","ts":"2026-06-27T08:57:04.644904Z","caller":"traceutil/trace.go:171","msg":"trace[862846463] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d161065d-81bd-4bdc-ae8f-c29131df8bc1; range_end:; response_count:1; response_revision:4858; }","duration":"100.273028ms","start":"2026-06-27T08:57:04.544608Z","end":"2026-06-27T08:57:04.644881Z","steps":["trace[862846463] 'agreement among raft nodes before linearized reading' (duration: 99.994943ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:57:04.754744Z","caller":"traceutil/trace.go:171","msg":"trace[1786637300] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"101.770425ms","start":"2026-06-27T08:57:04.65291Z","end":"2026-06-27T08:57:04.75468Z","steps":["trace[1786637300] 'process raft request' (duration: 101.5006ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:57:16.671098Z","caller":"traceutil/trace.go:171","msg":"trace[2048243416] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"134.351971ms","start":"2026-06-27T08:57:16.536706Z","end":"2026-06-27T08:57:16.671058Z","steps":["trace[2048243416] 'process raft request' (duration: 134.165198ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T08:58:19.170741Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2898} {"level":"info","ts":"2026-06-27T08:58:19.257404Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2898,"took":"84.973684ms","hash":3556992948,"current-db-size-bytes":53415936,"current-db-size":"53 MB","current-db-size-in-use-bytes":28704768,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-27T08:58:19.257485Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3556992948,"revision":2898,"compact-revision":-1} {"level":"warn","ts":"2026-06-27T09:00:41.469744Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166491,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:41.97044Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166491,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:42.471136Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166491,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:42.972277Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166491,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:43.474165Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166491,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:43.833261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999468301s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-27T09:00:43.833381Z","caller":"traceutil/trace.go:171","msg":"trace[1833574340] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999647094s","start":"2026-06-27T09:00:41.833703Z","end":"2026-06-27T09:00:43.83335Z","steps":["trace[1833574340] 'agreement among raft nodes before linearized reading' (duration: 1.999505613s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:43.833452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:41.833675Z","time spent":"1.999764536s","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/27 09:00:43 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-27T09:00:43.974672Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166491,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:44.475163Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166491,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:44.976086Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166491,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:45.476819Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166491,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:45.833561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999721276s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-27T09:00:45.833677Z","caller":"traceutil/trace.go:171","msg":"trace[369448056] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999915949s","start":"2026-06-27T09:00:43.83374Z","end":"2026-06-27T09:00:45.833656Z","steps":["trace[369448056] 'agreement among raft nodes before linearized reading' (duration: 1.999771527s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:45.833741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:43.833707Z","time spent":"2.000023909s","remote":"127.0.0.1:56254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-27T09:00:45.977037Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166491,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:46.477635Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166491,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:46.645364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:41.647292Z","time spent":"4.998038334s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/06/27 09:00:46 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-27T09:00:46.661321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:41.663116Z","time spent":"4.998200345s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/06/27 09:00:46 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-27T09:00:46.665746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:41.667684Z","time spent":"4.998050443s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/06/27 09:00:46 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-27T09:00:46.949853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999023165s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-27T09:00:46.94998Z","caller":"traceutil/trace.go:171","msg":"trace[2125603081] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999216528s","start":"2026-06-27T09:00:41.950736Z","end":"2026-06-27T09:00:46.949953Z","steps":["trace[2125603081] 'agreement among raft nodes before linearized reading' (duration: 4.999058466s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:46.950044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:41.950711Z","time spent":"4.999319969s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} 2026/06/27 09:00:46 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-27T09:00:46.978734Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166491,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:47.032189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999519307s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-27T09:00:47.032254Z","caller":"traceutil/trace.go:171","msg":"trace[460803304] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.9996431s","start":"2026-06-27T09:00:42.032595Z","end":"2026-06-27T09:00:47.032238Z","steps":["trace[460803304] 'agreement among raft nodes before linearized reading' (duration: 4.999569889s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:47.032296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:42.032566Z","time spent":"4.999721241s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/06/27 09:00:47 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-27T09:00:47.057353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:42.059289Z","time spent":"4.998058758s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/06/27 09:00:47 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-27T09:00:47.06755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999854772s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-27T09:00:47.067603Z","caller":"traceutil/trace.go:171","msg":"trace[1589032361] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999936562s","start":"2026-06-27T09:00:42.067654Z","end":"2026-06-27T09:00:47.067591Z","steps":["trace[1589032361] 'agreement among raft nodes before linearized reading' (duration: 4.999875382s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:47.067638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:42.067644Z","time spent":"4.999986313s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} 2026/06/27 09:00:47 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-27T09:00:47.479928Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166491,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:47.611577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:40.610887Z","time spent":"7.000679769s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-06-27T09:00:47.840082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000362325s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-27T09:00:47.840162Z","caller":"traceutil/trace.go:171","msg":"trace[1902275346] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000484757s","start":"2026-06-27T09:00:45.839655Z","end":"2026-06-27T09:00:47.84014Z","steps":["trace[1902275346] 'agreement among raft nodes before linearized reading' (duration: 2.000380026s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:47.840214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:45.839647Z","time spent":"2.000555748s","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/27 09:00:47 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-27T09:00:47.969747Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"} {"level":"warn","ts":"2026-06-27T09:00:47.969938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.000444707s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-06-27T09:00:47.970193Z","caller":"traceutil/trace.go:171","msg":"trace[1254207709] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; }","duration":"7.000529228s","start":"2026-06-27T09:00:40.969447Z","end":"2026-06-27T09:00:47.969976Z","steps":["trace[1254207709] 'agreement among raft nodes before linearized reading' (duration: 7.000442557s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:47.970264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:40.969424Z","time spent":"7.000820971s","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":0,"request content":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:48.470771Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:48.971661Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:49.471948Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:49.840504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999920602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-27T09:00:49.840609Z","caller":"traceutil/trace.go:171","msg":"trace[1420939391] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000115614s","start":"2026-06-27T09:00:47.840472Z","end":"2026-06-27T09:00:49.840588Z","steps":["trace[1420939391] 'agreement among raft nodes before linearized reading' (duration: 1.999975612s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:49.840649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:47.840453Z","time spent":"2.000188835s","remote":"127.0.0.1:56254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-27T09:00:49.899729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000488248s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-27T09:00:49.899916Z","caller":"traceutil/trace.go:171","msg":"trace[59752592] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000735261s","start":"2026-06-27T09:00:47.899156Z","end":"2026-06-27T09:00:49.899891Z","steps":["trace[59752592] 'agreement among raft nodes before linearized reading' (duration: 2.000520548s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:49.900068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:47.899139Z","time spent":"2.000913503s","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/27 09:00:49 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-27T09:00:49.972587Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:50.473723Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:50.604685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"988.059277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-27T09:00:50.604787Z","caller":"traceutil/trace.go:171","msg":"trace[1117738045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"988.24833ms","start":"2026-06-27T09:00:49.616513Z","end":"2026-06-27T09:00:50.604762Z","steps":["trace[1117738045] 'agreement among raft nodes before linearized reading' (duration: 988.119648ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:50.604858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:49.61648Z","time spent":"988.360102ms","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} 2026/06/27 09:00:50 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-27T09:00:50.974438Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727231909166502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-27T09:00:51.410039Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"10.798960335s","expected-duration":"1s"} {"level":"info","ts":"2026-06-27T09:00:51.428668Z","caller":"traceutil/trace.go:171","msg":"trace[1008193707] transaction","detail":"{read_only:false; response_revision:6425; number_of_response:1; }","duration":"5.591397659s","start":"2026-06-27T09:00:45.83724Z","end":"2026-06-27T09:00:51.428637Z","steps":["trace[1008193707] 'process raft request' (duration: 5.591210697s)"],"step_count":1} {"level":"info","ts":"2026-06-27T09:00:51.428696Z","caller":"traceutil/trace.go:171","msg":"trace[1032964310] transaction","detail":"{read_only:false; response_revision:6424; number_of_response:1; }","duration":"6.590157834s","start":"2026-06-27T09:00:44.838478Z","end":"2026-06-27T09:00:51.428636Z","steps":["trace[1032964310] 'process raft request' (duration: 6.589782838s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.428798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:45.837214Z","time spent":"5.59150746s","remote":"127.0.0.1:56326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-27T09:00:51.429054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:44.838443Z","time spent":"6.590473178s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-27T09:00:51.428869Z","caller":"traceutil/trace.go:171","msg":"trace[1674530297] transaction","detail":"{read_only:false; response_revision:6426; number_of_response:1; }","duration":"5.305606707s","start":"2026-06-27T09:00:46.123253Z","end":"2026-06-27T09:00:51.42886Z","steps":["trace[1674530297] 'process raft request' (duration: 5.305315623s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.429366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:46.123213Z","time spent":"5.306034032s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-27T09:00:51.438502Z","caller":"traceutil/trace.go:171","msg":"trace[598243344] transaction","detail":"{read_only:false; response_revision:6428; number_of_response:1; }","duration":"3.639120767s","start":"2026-06-27T09:00:47.799369Z","end":"2026-06-27T09:00:51.438489Z","steps":["trace[598243344] 'process raft request' (duration: 3.638932745s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.438632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:47.79934Z","time spent":"3.639215459s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-27T09:00:51.438628Z","caller":"traceutil/trace.go:171","msg":"trace[331470864] linearizableReadLoop","detail":"{readStateIndex:6668; appliedIndex:6655; }","duration":"3.468761909s","start":"2026-06-27T09:00:47.969852Z","end":"2026-06-27T09:00:51.438614Z","steps":["trace[331470864] 'read index received' (duration: 3.440627976s)","trace[331470864] 'applied index is now lower than readState.Index' (duration: 28.132853ms)"],"step_count":2} {"level":"warn","ts":"2026-06-27T09:00:51.438936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.151273354s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-27T09:00:51.438976Z","caller":"traceutil/trace.go:171","msg":"trace[1087336514] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6430; }","duration":"3.151365576s","start":"2026-06-27T09:00:48.287598Z","end":"2026-06-27T09:00:51.438964Z","steps":["trace[1087336514] 'agreement among raft nodes before linearized reading' (duration: 3.151289965s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.439008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:48.287573Z","time spent":"3.151425486s","remote":"127.0.0.1:41938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.439363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.136976888s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-27T09:00:51.439406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.589688444s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T09:00:51.43941Z","caller":"traceutil/trace.go:171","msg":"trace[1858959674] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:6430; }","duration":"5.137069009s","start":"2026-06-27T09:00:46.302328Z","end":"2026-06-27T09:00:51.439397Z","steps":["trace[1858959674] 'agreement among raft nodes before linearized reading' (duration: 5.136999308s)"],"step_count":1} {"level":"info","ts":"2026-06-27T09:00:51.439431Z","caller":"traceutil/trace.go:171","msg":"trace[957910487] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6430; }","duration":"1.589753804s","start":"2026-06-27T09:00:49.849669Z","end":"2026-06-27T09:00:51.439423Z","steps":["trace[957910487] 'agreement among raft nodes before linearized reading' (duration: 1.589719454s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.439439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:46.302308Z","time spent":"5.13712452s","remote":"127.0.0.1:49934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.439459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:49.849635Z","time spent":"1.589817846s","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-27T09:00:51.439615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.368926418s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-27T09:00:51.439638Z","caller":"traceutil/trace.go:171","msg":"trace[547827773] transaction","detail":"{read_only:false; response_revision:6430; number_of_response:1; }","duration":"1.423518011s","start":"2026-06-27T09:00:50.016113Z","end":"2026-06-27T09:00:51.439631Z","steps":["trace[547827773] 'process raft request' (duration: 1.422414987s)"],"step_count":1} {"level":"info","ts":"2026-06-27T09:00:51.439647Z","caller":"traceutil/trace.go:171","msg":"trace[64801273] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6430; }","duration":"2.369036879s","start":"2026-06-27T09:00:49.070601Z","end":"2026-06-27T09:00:51.439638Z","steps":["trace[64801273] 'agreement among raft nodes before linearized reading' (duration: 2.368964008s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.439682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:49.070578Z","time spent":"2.369092949s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-27T09:00:51.439691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:50.016084Z","time spent":"1.423574342s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-27T09:00:51.439794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.404339452s","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-27T09:00:51.439822Z","caller":"traceutil/trace.go:171","msg":"trace[526210962] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6430; }","duration":"2.404426203s","start":"2026-06-27T09:00:49.035387Z","end":"2026-06-27T09:00:51.439814Z","steps":["trace[526210962] 'agreement among raft nodes before linearized reading' (duration: 2.404358452s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.439846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:49.035361Z","time spent":"2.404478783s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-27T09:00:51.439858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.782372505s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-27T09:00:51.439894Z","caller":"traceutil/trace.go:171","msg":"trace[1150179813] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6430; }","duration":"4.782463796s","start":"2026-06-27T09:00:46.65742Z","end":"2026-06-27T09:00:51.439884Z","steps":["trace[1150179813] 'agreement among raft nodes before linearized reading' (duration: 4.782403865s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.439919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:46.65739Z","time spent":"4.782521066s","remote":"127.0.0.1:41874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.439969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.48712271s","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-27T09:00:51.440003Z","caller":"traceutil/trace.go:171","msg":"trace[297430668] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6430; }","duration":"2.487201671s","start":"2026-06-27T09:00:48.952792Z","end":"2026-06-27T09:00:51.439994Z","steps":["trace[297430668] 'agreement among raft nodes before linearized reading' (duration: 2.4871179s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.440031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:48.952758Z","time spent":"2.487266092s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-27T09:00:51.440041Z","caller":"traceutil/trace.go:171","msg":"trace[1039751467] transaction","detail":"{read_only:false; number_of_response:1; response_revision:6430; }","duration":"832.880848ms","start":"2026-06-27T09:00:50.607151Z","end":"2026-06-27T09:00:51.440032Z","steps":["trace[1039751467] 'process raft request' (duration: 831.425929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.440083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:50.607122Z","time spent":"832.936978ms","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":48,"response count":0,"response size":473,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-27T09:00:51.440163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.486036876s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-27T09:00:51.440192Z","caller":"traceutil/trace.go:171","msg":"trace[1253679641] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:6430; }","duration":"3.486112057s","start":"2026-06-27T09:00:47.95407Z","end":"2026-06-27T09:00:51.440182Z","steps":["trace[1253679641] 'agreement among raft nodes before linearized reading' (duration: 3.486069246s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.440209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.558851551s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-27T09:00:51.440128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.496220044s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-27T09:00:51.440251Z","caller":"traceutil/trace.go:171","msg":"trace[1933705256] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:6430; }","duration":"2.496389346s","start":"2026-06-27T09:00:48.943854Z","end":"2026-06-27T09:00:51.440243Z","steps":["trace[1933705256] 'agreement among raft nodes before linearized reading' (duration: 2.496237735s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.44028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:48.94382Z","time spent":"2.496453527s","remote":"127.0.0.1:56554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":3,"response size":31,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.44034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.632425613s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-27T09:00:51.440507Z","caller":"traceutil/trace.go:171","msg":"trace[35064706] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:6430; }","duration":"2.632645556s","start":"2026-06-27T09:00:48.807851Z","end":"2026-06-27T09:00:51.440497Z","steps":["trace[35064706] 'agreement among raft nodes before linearized reading' (duration: 2.632415064s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.440546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:48.807827Z","time spent":"2.632708687s","remote":"127.0.0.1:56362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":12,"response size":31,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.440578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.772702262s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-27T09:00:51.440606Z","caller":"traceutil/trace.go:171","msg":"trace[508956560] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6430; }","duration":"4.772791424s","start":"2026-06-27T09:00:46.667807Z","end":"2026-06-27T09:00:51.440599Z","steps":["trace[508956560] 'agreement among raft nodes before linearized reading' (duration: 4.772716503s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.440627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:46.667784Z","time spent":"4.772838364s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-27T09:00:51.440747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.776876454s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-27T09:00:51.440772Z","caller":"traceutil/trace.go:171","msg":"trace[594742275] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:6430; }","duration":"4.776928815s","start":"2026-06-27T09:00:46.663836Z","end":"2026-06-27T09:00:51.440765Z","steps":["trace[594742275] 'agreement among raft nodes before linearized reading' (duration: 4.776869864s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.440789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:46.663821Z","time spent":"4.776964125s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":550,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} {"level":"info","ts":"2026-06-27T09:00:51.439614Z","caller":"traceutil/trace.go:171","msg":"trace[835381278] transaction","detail":"{read_only:false; response_revision:6429; number_of_response:1; }","duration":"2.785811339s","start":"2026-06-27T09:00:48.653794Z","end":"2026-06-27T09:00:51.439606Z","steps":["trace[835381278] 'process raft request' (duration: 2.784661264s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.440219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:47.95404Z","time spent":"3.486171128s","remote":"127.0.0.1:59466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":3,"response size":31,"request content":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.440924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:48.653766Z","time spent":"2.787121124s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-27T09:00:51.440479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.380400705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:549"} {"level":"info","ts":"2026-06-27T09:00:51.441065Z","caller":"traceutil/trace.go:171","msg":"trace[315976665] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:6430; }","duration":"4.381027092s","start":"2026-06-27T09:00:47.060024Z","end":"2026-06-27T09:00:51.441051Z","steps":["trace[315976665] 'agreement among raft nodes before linearized reading' (duration: 4.380376254s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.441107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:47.059999Z","time spent":"4.381095313s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":573,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-06-27T09:00:51.440511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.693766671s","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-27T09:00:51.4412Z","caller":"traceutil/trace.go:171","msg":"trace[978612964] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:6430; }","duration":"4.69448901s","start":"2026-06-27T09:00:46.7467Z","end":"2026-06-27T09:00:51.441189Z","steps":["trace[978612964] 'agreement among raft nodes before linearized reading' (duration: 4.693793401s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.441222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.156744369s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-27T09:00:51.44124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:46.746676Z","time spent":"4.69455171s","remote":"127.0.0.1:55436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"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-27T09:00:51.441333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.236888893s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-27T09:00:51.441356Z","caller":"traceutil/trace.go:171","msg":"trace[1977104090] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:6430; }","duration":"5.236964654s","start":"2026-06-27T09:00:46.204386Z","end":"2026-06-27T09:00:51.44135Z","steps":["trace[1977104090] 'agreement among raft nodes before linearized reading' (duration: 5.236876173s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.441376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:46.204364Z","time spent":"5.237006834s","remote":"127.0.0.1:56360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":79,"response size":31,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-06-27T09:00:51.440248Z","caller":"traceutil/trace.go:171","msg":"trace[1814536195] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6430; }","duration":"2.558936491s","start":"2026-06-27T09:00:48.8813Z","end":"2026-06-27T09:00:51.440237Z","steps":["trace[1814536195] 'agreement among raft nodes before linearized reading' (duration: 2.558876011s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.441504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.76253081s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T09:00:51.441527Z","caller":"traceutil/trace.go:171","msg":"trace[713607760] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:6430; }","duration":"5.7625541s","start":"2026-06-27T09:00:45.678965Z","end":"2026-06-27T09:00:51.441519Z","steps":["trace[713607760] 'agreement among raft nodes before linearized reading' (duration: 5.762513809s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.441548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:45.678873Z","time spent":"5.762669341s","remote":"127.0.0.1:45822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.441539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:48.881279Z","time spent":"2.560240078s","remote":"127.0.0.1:41886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.441658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.80771546s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T09:00:51.441683Z","caller":"traceutil/trace.go:171","msg":"trace[2118395676] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:6430; }","duration":"6.807801421s","start":"2026-06-27T09:00:44.633875Z","end":"2026-06-27T09:00:51.441676Z","steps":["trace[2118395676] 'agreement among raft nodes before linearized reading' (duration: 6.80776207s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.441703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:44.633847Z","time spent":"6.807851331s","remote":"127.0.0.1:34866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.441823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.891488944s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-27T09:00:51.441849Z","caller":"traceutil/trace.go:171","msg":"trace[1639448439] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:6430; }","duration":"6.891558914s","start":"2026-06-27T09:00:44.550283Z","end":"2026-06-27T09:00:51.441842Z","steps":["trace[1639448439] 'agreement among raft nodes before linearized reading' (duration: 6.891511903s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.441867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:44.55026Z","time spent":"6.891601805s","remote":"127.0.0.1:59464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":10,"response size":31,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.442035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.041145895s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T09:00:51.442066Z","caller":"traceutil/trace.go:171","msg":"trace[2075727826] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:6430; }","duration":"7.041255146s","start":"2026-06-27T09:00:44.400802Z","end":"2026-06-27T09:00:51.442058Z","steps":["trace[2075727826] 'agreement among raft nodes before linearized reading' (duration: 7.041205566s)"],"step_count":1} {"level":"info","ts":"2026-06-27T09:00:51.441247Z","caller":"traceutil/trace.go:171","msg":"trace[707732523] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:6430; }","duration":"7.156826641s","start":"2026-06-27T09:00:44.284413Z","end":"2026-06-27T09:00:51.44124Z","steps":["trace[707732523] 'agreement among raft nodes before linearized reading' (duration: 7.15677679s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.442367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:44.284388Z","time spent":"7.157965465s","remote":"127.0.0.1:56756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":6,"response size":31,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.442087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:44.400774Z","time spent":"7.041307578s","remote":"127.0.0.1:41968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.442788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.795898553s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"info","ts":"2026-06-27T09:00:51.44283Z","caller":"traceutil/trace.go:171","msg":"trace[1044777093] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:6430; }","duration":"4.795995475s","start":"2026-06-27T09:00:46.646825Z","end":"2026-06-27T09:00:51.442821Z","steps":["trace[1044777093] 'agreement among raft nodes before linearized reading' (duration: 4.795909304s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.442857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:46.646797Z","time spent":"4.796052855s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":596,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-06-27T09:00:51.439373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.482302ms","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-27T09:00:51.442938Z","caller":"traceutil/trace.go:171","msg":"trace[882501548] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:6430; }","duration":"540.095207ms","start":"2026-06-27T09:00:50.902832Z","end":"2026-06-27T09:00:51.442927Z","steps":["trace[882501548] 'agreement among raft nodes before linearized reading' (duration: 536.504781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.442966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:50.902802Z","time spent":"540.156228ms","remote":"127.0.0.1:56698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.443111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.946683696s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12210"} {"level":"info","ts":"2026-06-27T09:00:51.443149Z","caller":"traceutil/trace.go:171","msg":"trace[6579571] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6430; }","duration":"8.946760938s","start":"2026-06-27T09:00:42.496378Z","end":"2026-06-27T09:00:51.443139Z","steps":["trace[6579571] 'agreement among raft nodes before linearized reading' (duration: 8.946645956s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.4432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:42.49634Z","time spent":"8.946842138s","remote":"127.0.0.1:56430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12234,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-27T09:00:51.443345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.772063548s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T09:00:51.443391Z","caller":"traceutil/trace.go:171","msg":"trace[1574846879] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:6430; }","duration":"8.77216759s","start":"2026-06-27T09:00:42.671215Z","end":"2026-06-27T09:00:51.443383Z","steps":["trace[1574846879] 'agreement among raft nodes before linearized reading' (duration: 8.772106029s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.443413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:42.671183Z","time spent":"8.77222356s","remote":"127.0.0.1:34856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.443534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.047188783s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-27T09:00:51.443558Z","caller":"traceutil/trace.go:171","msg":"trace[1341676898] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:6430; }","duration":"8.047256735s","start":"2026-06-27T09:00:43.396295Z","end":"2026-06-27T09:00:51.443552Z","steps":["trace[1341676898] 'agreement among raft nodes before linearized reading' (duration: 8.047216714s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.443581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:43.396274Z","time spent":"8.047298115s","remote":"127.0.0.1:56638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":31,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.443708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.462484871s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-27T09:00:51.443745Z","caller":"traceutil/trace.go:171","msg":"trace[1966973002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6430; }","duration":"9.462522332s","start":"2026-06-27T09:00:41.981213Z","end":"2026-06-27T09:00:51.443736Z","steps":["trace[1966973002] 'agreement among raft nodes before linearized reading' (duration: 9.46239143s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.443771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:41.98114Z","time spent":"9.462624743s","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-27T09:00:51.44383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.515417058s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-27T09:00:51.44386Z","caller":"traceutil/trace.go:171","msg":"trace[1873751531] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:6430; }","duration":"9.515511399s","start":"2026-06-27T09:00:41.928341Z","end":"2026-06-27T09:00:51.443853Z","steps":["trace[1873751531] 'agreement among raft nodes before linearized reading' (duration: 9.515465249s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.44388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:41.928319Z","time spent":"9.51555554s","remote":"127.0.0.1:54582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-06-27T09:00:51.443914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.229518768s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T09:00:51.443955Z","caller":"traceutil/trace.go:171","msg":"trace[1784781896] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:0; response_revision:6430; }","duration":"9.229632659s","start":"2026-06-27T09:00:42.214313Z","end":"2026-06-27T09:00:51.443946Z","steps":["trace[1784781896] 'agreement among raft nodes before linearized reading' (duration: 9.229514518s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.44398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:42.214296Z","time spent":"9.22967708s","remote":"127.0.0.1:56274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":29,"request content":"key:\"/registry/masterleases/199.204.45.138\" "} {"level":"warn","ts":"2026-06-27T09:00:51.444867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.814243182s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-27T09:00:51.444975Z","caller":"traceutil/trace.go:171","msg":"trace[660572099] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:6430; }","duration":"9.814433825s","start":"2026-06-27T09:00:41.630515Z","end":"2026-06-27T09:00:51.444949Z","steps":["trace[660572099] 'agreement among raft nodes before linearized reading' (duration: 9.808136866s)"],"step_count":1} {"level":"warn","ts":"2026-06-27T09:00:51.445029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T09:00:41.63049Z","time spent":"9.814527785s","remote":"127.0.0.1:56586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":6,"response size":31,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} 2026/06/27 09:00:51 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-06-27T09:01:14.598782Z","caller":"traceutil/trace.go:171","msg":"trace[1036320002] transaction","detail":"{read_only:false; response_revision:6680; number_of_response:1; }","duration":"118.585469ms","start":"2026-06-27T09:01:14.480169Z","end":"2026-06-27T09:01:14.598755Z","steps":["trace[1036320002] 'process raft request' (duration: 93.710111ms)","trace[1036320002] 'compare' (duration: 24.746497ms)"],"step_count":2} {"level":"info","ts":"2026-06-27T09:02:01.086741Z","caller":"traceutil/trace.go:171","msg":"trace[2055880757] transaction","detail":"{read_only:false; response_revision:6978; number_of_response:1; }","duration":"124.823407ms","start":"2026-06-27T09:02:00.961891Z","end":"2026-06-27T09:02:01.086715Z","steps":["trace[2055880757] 'process raft request' (duration: 124.669885ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T09:03:19.176704Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5519} {"level":"info","ts":"2026-06-27T09:03:19.329229Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5519,"took":"150.437864ms","hash":3858235144,"current-db-size-bytes":53415936,"current-db-size":"53 MB","current-db-size-in-use-bytes":18628608,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-06-27T09:03:19.329311Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3858235144,"revision":5519,"compact-revision":2898}