{"level":"warn","ts":"2026-06-16T10:26:10.645449Z","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-16T10:26:10.645606Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210: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-16T10:26:10.645706Z","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-16T10:26:10.645722Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-06-16T10:26:10.645742Z","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-16T10:26:10.646683Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-06-16T10:26:10.646799Z","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":16,"max-cpu-available":16,"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.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210: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-16T10:26:10.651244Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.179289ms"} {"level":"info","ts":"2026-06-16T10:26:10.657137Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-06-16T10:26:10.657239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-16T10:26:10.657262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-06-16T10:26:10.657285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-16T10:26:10.657299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-06-16T10:26:10.657351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-06-16T10:26:10.663792Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-16T10:26:10.665707Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-16T10:26:10.667187Z","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-16T10:26:10.669801Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-16T10:26:10.670063Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-16T10:26:10.670216Z","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-16T10:26:10.670407Z","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-16T10:26:10.67043Z","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-16T10:26:10.672218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-06-16T10:26:10.672816Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-06-16T10:26:10.674792Z","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-16T10:26:10.674874Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-06-16T10:26:10.674948Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-06-16T10:26:10.675227Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-16T10:26:10.675265Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-16T10:26:11.258422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-16T10:26:11.258467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-16T10:26:11.258494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-06-16T10:26:11.258505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-06-16T10:26:11.258511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-06-16T10:26:11.258519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-06-16T10:26:11.258525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-06-16T10:26:11.266548Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-06-16T10:26:11.266551Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-16T10:26:11.266633Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T10:26:11.26692Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-16T10:26:11.267939Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T10:26:11.268047Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T10:26:11.268074Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T10:26:11.270088Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"info","ts":"2026-06-16T10:26:11.270473Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-16T10:26:11.270521Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-16T10:26:11.270947Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-16T10:26:28.095626Z","caller":"traceutil/trace.go:171","msg":"trace[2146960953] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"112.414524ms","start":"2026-06-16T10:26:27.98317Z","end":"2026-06-16T10:26:28.095584Z","steps":["trace[2146960953] 'process raft request' (duration: 112.22339ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:33.442725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.110914ms","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-16T10:26:33.442849Z","caller":"traceutil/trace.go:171","msg":"trace[32745871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:391; }","duration":"165.305408ms","start":"2026-06-16T10:26:33.277526Z","end":"2026-06-16T10:26:33.442832Z","steps":["trace[32745871] 'range keys from in-memory index tree' (duration: 164.9337ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:33.764785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.420652ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:26:33.765078Z","caller":"traceutil/trace.go:171","msg":"trace[1778910102] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"242.387661ms","start":"2026-06-16T10:26:33.522566Z","end":"2026-06-16T10:26:33.764953Z","steps":["trace[1778910102] 'process raft request' (duration: 28.236435ms)","trace[1778910102] 'compare' (duration: 213.30384ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:26:54.427455Z","caller":"traceutil/trace.go:171","msg":"trace[373313324] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"188.092172ms","start":"2026-06-16T10:26:54.239305Z","end":"2026-06-16T10:26:54.427397Z","steps":["trace[373313324] 'read index received' (duration: 182.890563ms)","trace[373313324] 'applied index is now lower than readState.Index' (duration: 5.200339ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:26:54.428301Z","caller":"traceutil/trace.go:171","msg":"trace[436691489] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"202.20963ms","start":"2026-06-16T10:26:54.226032Z","end":"2026-06-16T10:26:54.428242Z","steps":["trace[436691489] 'process raft request' (duration: 196.415099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:54.42861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.155881ms","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-16T10:26:54.428821Z","caller":"traceutil/trace.go:171","msg":"trace[21524333] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"189.457578ms","start":"2026-06-16T10:26:54.239268Z","end":"2026-06-16T10:26:54.428726Z","steps":["trace[21524333] 'agreement among raft nodes before linearized reading' (duration: 188.940408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:54.854484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.495312ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:26:54.854708Z","caller":"traceutil/trace.go:171","msg":"trace[1312190497] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:618; }","duration":"125.244538ms","start":"2026-06-16T10:26:54.729447Z","end":"2026-06-16T10:26:54.854692Z","steps":["trace[1312190497] 'read index received' (duration: 97.743736ms)","trace[1312190497] 'applied index is now lower than readState.Index' (duration: 27.500082ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:26:54.854799Z","caller":"traceutil/trace.go:171","msg":"trace[84371293] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"273.801559ms","start":"2026-06-16T10:26:54.580958Z","end":"2026-06-16T10:26:54.85476Z","steps":["trace[84371293] 'process raft request' (duration: 273.672327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:54.854869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.422401ms","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-16T10:26:54.854902Z","caller":"traceutil/trace.go:171","msg":"trace[23799708] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:599; }","duration":"125.501973ms","start":"2026-06-16T10:26:54.729391Z","end":"2026-06-16T10:26:54.854893Z","steps":["trace[23799708] 'agreement among raft nodes before linearized reading' (duration: 125.34511ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:54.854825Z","caller":"traceutil/trace.go:171","msg":"trace[2121357858] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"288.159533ms","start":"2026-06-16T10:26:54.566628Z","end":"2026-06-16T10:26:54.854787Z","steps":["trace[2121357858] 'process raft request' (duration: 82.249853ms)","trace[2121357858] 'compare' (duration: 205.300929ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:26:55.371577Z","caller":"traceutil/trace.go:171","msg":"trace[200711285] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"143.515436ms","start":"2026-06-16T10:26:55.228029Z","end":"2026-06-16T10:26:55.371545Z","steps":["trace[200711285] 'read index received' (duration: 141.004338ms)","trace[200711285] 'applied index is now lower than readState.Index' (duration: 2.509678ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:26:55.371655Z","caller":"traceutil/trace.go:171","msg":"trace[2144689652] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"403.164177ms","start":"2026-06-16T10:26:54.96846Z","end":"2026-06-16T10:26:55.371624Z","steps":["trace[2144689652] 'process raft request' (duration: 401.518835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:55.371725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.665748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T10:26:55.371758Z","caller":"traceutil/trace.go:171","msg":"trace[1994993241] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"143.756409ms","start":"2026-06-16T10:26:55.227991Z","end":"2026-06-16T10:26:55.371747Z","steps":["trace[1994993241] 'agreement among raft nodes before linearized reading' (duration: 143.667128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:55.371797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:54.968414Z","time spent":"403.30445ms","remote":"127.0.0.1:58024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:27:10.09544Z","caller":"traceutil/trace.go:171","msg":"trace[1122675575] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"144.25558ms","start":"2026-06-16T10:27:09.951156Z","end":"2026-06-16T10:27:10.095411Z","steps":["trace[1122675575] 'process raft request' (duration: 144.092627ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:27:37.241483Z","caller":"traceutil/trace.go:171","msg":"trace[5006144] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"154.716068ms","start":"2026-06-16T10:27:37.086733Z","end":"2026-06-16T10:27:37.241449Z","steps":["trace[5006144] 'process raft request' (duration: 154.553675ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:28:24.604511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.073137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f351820-a7d4-4bcd-b387-28b8be9c9466\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-16T10:28:24.604599Z","caller":"traceutil/trace.go:171","msg":"trace[2017146966] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5f351820-a7d4-4bcd-b387-28b8be9c9466; range_end:; response_count:1; response_revision:1829; }","duration":"235.175058ms","start":"2026-06-16T10:28:24.369405Z","end":"2026-06-16T10:28:24.60458Z","steps":["trace[2017146966] 'range keys from in-memory index tree' (duration: 234.868913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:28:24.604556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.982148ms","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-16T10:28:24.604686Z","caller":"traceutil/trace.go:171","msg":"trace[1014250623] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1829; }","duration":"152.14998ms","start":"2026-06-16T10:28:24.452526Z","end":"2026-06-16T10:28:24.604676Z","steps":["trace[1014250623] 'range keys from in-memory index tree' (duration: 151.849435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:28:25.00541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.363962ms","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-16T10:28:25.005527Z","caller":"traceutil/trace.go:171","msg":"trace[1972757574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1831; }","duration":"124.520386ms","start":"2026-06-16T10:28:24.880979Z","end":"2026-06-16T10:28:25.005499Z","steps":["trace[1972757574] 'range keys from in-memory index tree' (duration: 124.162209ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:28:25.103868Z","caller":"traceutil/trace.go:171","msg":"trace[2034540891] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"120.228673ms","start":"2026-06-16T10:28:24.983613Z","end":"2026-06-16T10:28:25.103841Z","steps":["trace[2034540891] 'process raft request' (duration: 120.06606ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:28:25.105345Z","caller":"traceutil/trace.go:171","msg":"trace[824343039] linearizableReadLoop","detail":"{readStateIndex:1906; appliedIndex:1904; }","duration":"116.323841ms","start":"2026-06-16T10:28:24.989004Z","end":"2026-06-16T10:28:25.105328Z","steps":["trace[824343039] 'read index received' (duration: 114.71208ms)","trace[824343039] 'applied index is now lower than readState.Index' (duration: 1.611251ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:28:25.105481Z","caller":"traceutil/trace.go:171","msg":"trace[349439854] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"121.748603ms","start":"2026-06-16T10:28:24.983723Z","end":"2026-06-16T10:28:25.105472Z","steps":["trace[349439854] 'process raft request' (duration: 121.459387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:28:25.105734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.705108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-16T10:28:25.10578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.563898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f351820-a7d4-4bcd-b387-28b8be9c9466\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-16T10:28:25.10581Z","caller":"traceutil/trace.go:171","msg":"trace[1497061281] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1834; }","duration":"116.805119ms","start":"2026-06-16T10:28:24.988979Z","end":"2026-06-16T10:28:25.105784Z","steps":["trace[1497061281] 'agreement among raft nodes before linearized reading' (duration: 116.583145ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:28:25.105853Z","caller":"traceutil/trace.go:171","msg":"trace[728146045] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5f351820-a7d4-4bcd-b387-28b8be9c9466; range_end:; response_count:1; response_revision:1834; }","duration":"103.728061ms","start":"2026-06-16T10:28:25.002105Z","end":"2026-06-16T10:28:25.105833Z","steps":["trace[728146045] 'agreement among raft nodes before linearized reading' (duration: 103.493117ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:28:36.544839Z","caller":"traceutil/trace.go:171","msg":"trace[1187609559] transaction","detail":"{read_only:false; response_revision:1933; number_of_response:1; }","duration":"375.440335ms","start":"2026-06-16T10:28:36.169355Z","end":"2026-06-16T10:28:36.544796Z","steps":["trace[1187609559] 'process raft request' (duration: 375.023186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:28:36.544979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:28:36.169334Z","time spent":"375.578077ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:28:36.544823Z","caller":"traceutil/trace.go:171","msg":"trace[1143306261] linearizableReadLoop","detail":"{readStateIndex:2009; appliedIndex:2008; }","duration":"358.970391ms","start":"2026-06-16T10:28:36.185563Z","end":"2026-06-16T10:28:36.544533Z","steps":["trace[1143306261] 'read index received' (duration: 358.732326ms)","trace[1143306261] 'applied index is now lower than readState.Index' (duration: 236.925µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:28:36.54503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.441091ms","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-16T10:28:36.545092Z","caller":"traceutil/trace.go:171","msg":"trace[30309204] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1933; }","duration":"359.553062ms","start":"2026-06-16T10:28:36.185525Z","end":"2026-06-16T10:28:36.545078Z","steps":["trace[30309204] 'agreement among raft nodes before linearized reading' (duration: 359.362179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:28:36.545135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:28:36.185512Z","time spent":"359.614024ms","remote":"127.0.0.1:52564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-16T10:28:36.545181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.191117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T10:28:36.545248Z","caller":"traceutil/trace.go:171","msg":"trace[1712360562] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1933; }","duration":"317.30782ms","start":"2026-06-16T10:28:36.227924Z","end":"2026-06-16T10:28:36.545231Z","steps":["trace[1712360562] 'agreement among raft nodes before linearized reading' (duration: 317.171387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:28:36.545287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:28:36.227903Z","time spent":"317.377611ms","remote":"127.0.0.1:57958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-16T10:29:13.585284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.065045ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:29:13.585759Z","caller":"traceutil/trace.go:171","msg":"trace[34768114] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"231.205794ms","start":"2026-06-16T10:29:13.35451Z","end":"2026-06-16T10:29:13.585716Z","steps":["trace[34768114] 'process raft request' (duration: 230.925249ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:29:13.585833Z","caller":"traceutil/trace.go:171","msg":"trace[1089994474] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"128.63026ms","start":"2026-06-16T10:29:13.457182Z","end":"2026-06-16T10:29:13.585812Z","steps":["trace[1089994474] 'process raft request' (duration: 128.357635ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:29:13.586065Z","caller":"traceutil/trace.go:171","msg":"trace[999026051] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"232.067781ms","start":"2026-06-16T10:29:13.353909Z","end":"2026-06-16T10:29:13.585977Z","steps":["trace[999026051] 'process raft request' (duration: 119.163281ms)","trace[999026051] 'compare' (duration: 111.789899ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:29:18.947865Z","caller":"traceutil/trace.go:171","msg":"trace[1314001409] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"108.617919ms","start":"2026-06-16T10:29:18.839211Z","end":"2026-06-16T10:29:18.947829Z","steps":["trace[1314001409] 'process raft request' (duration: 108.331544ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:29:19.431013Z","caller":"traceutil/trace.go:171","msg":"trace[508472750] linearizableReadLoop","detail":"{readStateIndex:2259; appliedIndex:2258; }","duration":"202.752143ms","start":"2026-06-16T10:29:19.228232Z","end":"2026-06-16T10:29:19.430984Z","steps":["trace[508472750] 'read index received' (duration: 202.544028ms)","trace[508472750] 'applied index is now lower than readState.Index' (duration: 206.635µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:29:19.431067Z","caller":"traceutil/trace.go:171","msg":"trace[824464951] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"228.149727ms","start":"2026-06-16T10:29:19.202887Z","end":"2026-06-16T10:29:19.431037Z","steps":["trace[824464951] 'process raft request' (duration: 227.921793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:29:19.431184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.939986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T10:29:19.43128Z","caller":"traceutil/trace.go:171","msg":"trace[240071305] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2175; }","duration":"203.076809ms","start":"2026-06-16T10:29:19.228175Z","end":"2026-06-16T10:29:19.431252Z","steps":["trace[240071305] 'agreement among raft nodes before linearized reading' (duration: 202.924776ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:29:19.457119Z","caller":"traceutil/trace.go:171","msg":"trace[1653865435] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"144.195027ms","start":"2026-06-16T10:29:19.312894Z","end":"2026-06-16T10:29:19.457089Z","steps":["trace[1653865435] 'process raft request' (duration: 144.020294ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:30:28.337627Z","caller":"traceutil/trace.go:171","msg":"trace[1776591477] linearizableReadLoop","detail":"{readStateIndex:2857; appliedIndex:2856; }","duration":"111.435244ms","start":"2026-06-16T10:30:28.226161Z","end":"2026-06-16T10:30:28.337596Z","steps":["trace[1776591477] 'read index received' (duration: 93.42026ms)","trace[1776591477] 'applied index is now lower than readState.Index' (duration: 18.013914ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:30:28.337794Z","caller":"traceutil/trace.go:171","msg":"trace[669175568] transaction","detail":"{read_only:false; response_revision:2751; number_of_response:1; }","duration":"120.061819ms","start":"2026-06-16T10:30:28.21771Z","end":"2026-06-16T10:30:28.337772Z","steps":["trace[669175568] 'process raft request' (duration: 101.81428ms)","trace[669175568] 'compare' (duration: 17.938324ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:30:28.337972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.789461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T10:30:28.338084Z","caller":"traceutil/trace.go:171","msg":"trace[963700253] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2751; }","duration":"111.937554ms","start":"2026-06-16T10:30:28.226128Z","end":"2026-06-16T10:30:28.338066Z","steps":["trace[963700253] 'agreement among raft nodes before linearized reading' (duration: 111.73879ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:33:04.449989Z","caller":"traceutil/trace.go:171","msg":"trace[1695759244] transaction","detail":"{read_only:false; response_revision:3768; number_of_response:1; }","duration":"233.452047ms","start":"2026-06-16T10:33:04.21651Z","end":"2026-06-16T10:33:04.449962Z","steps":["trace[1695759244] 'process raft request' (duration: 233.319575ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:33:04.457342Z","caller":"traceutil/trace.go:171","msg":"trace[657320560] transaction","detail":"{read_only:false; response_revision:3769; number_of_response:1; }","duration":"184.287311ms","start":"2026-06-16T10:33:04.273026Z","end":"2026-06-16T10:33:04.457313Z","steps":["trace[657320560] 'process raft request' (duration: 184.041546ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:34:26.842117Z","caller":"traceutil/trace.go:171","msg":"trace[1583981818] transaction","detail":"{read_only:false; response_revision:4812; number_of_response:1; }","duration":"125.348373ms","start":"2026-06-16T10:34:26.716743Z","end":"2026-06-16T10:34:26.842092Z","steps":["trace[1583981818] 'process raft request' (duration: 125.143459ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:34:26.846892Z","caller":"traceutil/trace.go:171","msg":"trace[123941088] transaction","detail":"{read_only:false; response_revision:4813; number_of_response:1; }","duration":"122.715503ms","start":"2026-06-16T10:34:26.724135Z","end":"2026-06-16T10:34:26.84685Z","steps":["trace[123941088] 'process raft request' (duration: 122.463907ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:34:26.846924Z","caller":"traceutil/trace.go:171","msg":"trace[669132677] transaction","detail":"{read_only:false; response_revision:4814; number_of_response:1; }","duration":"120.825257ms","start":"2026-06-16T10:34:26.726054Z","end":"2026-06-16T10:34:26.84688Z","steps":["trace[669132677] 'process raft request' (duration: 120.703595ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:34:26.847178Z","caller":"traceutil/trace.go:171","msg":"trace[2048479301] transaction","detail":"{read_only:false; response_revision:4815; number_of_response:1; }","duration":"117.88299ms","start":"2026-06-16T10:34:26.72925Z","end":"2026-06-16T10:34:26.847133Z","steps":["trace[2048479301] 'process raft request' (duration: 117.578035ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:34:29.02582Z","caller":"traceutil/trace.go:171","msg":"trace[1126493388] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"240.051932ms","start":"2026-06-16T10:34:28.785737Z","end":"2026-06-16T10:34:29.025789Z","steps":["trace[1126493388] 'process raft request' (duration: 239.875188ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:34:29.062252Z","caller":"traceutil/trace.go:171","msg":"trace[608497972] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"209.430637ms","start":"2026-06-16T10:34:28.852785Z","end":"2026-06-16T10:34:29.062215Z","steps":["trace[608497972] 'process raft request' (duration: 209.288534ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:34:29.06231Z","caller":"traceutil/trace.go:171","msg":"trace[38122332] linearizableReadLoop","detail":"{readStateIndex:5128; appliedIndex:5123; }","duration":"170.110836ms","start":"2026-06-16T10:34:28.892036Z","end":"2026-06-16T10:34:29.062147Z","steps":["trace[38122332] 'read index received' (duration: 133.714811ms)","trace[38122332] 'applied index is now lower than readState.Index' (duration: 36.395075ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:34:29.062306Z","caller":"traceutil/trace.go:171","msg":"trace[929023359] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"208.906917ms","start":"2026-06-16T10:34:28.853358Z","end":"2026-06-16T10:34:29.062265Z","steps":["trace[929023359] 'process raft request' (duration: 208.752444ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:34:29.062346Z","caller":"traceutil/trace.go:171","msg":"trace[373980168] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"209.615761ms","start":"2026-06-16T10:34:28.852696Z","end":"2026-06-16T10:34:29.062312Z","steps":["trace[373980168] 'process raft request' (duration: 209.328425ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:34:29.062332Z","caller":"traceutil/trace.go:171","msg":"trace[2013081021] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"275.929106ms","start":"2026-06-16T10:34:28.786368Z","end":"2026-06-16T10:34:29.062297Z","steps":["trace[2013081021] 'process raft request' (duration: 275.297575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:34:29.062506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.925608ms","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-16T10:34:29.062547Z","caller":"traceutil/trace.go:171","msg":"trace[1820570240] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:4939; }","duration":"131.01663ms","start":"2026-06-16T10:34:28.931517Z","end":"2026-06-16T10:34:29.062534Z","steps":["trace[1820570240] 'agreement among raft nodes before linearized reading' (duration: 130.930118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:34:29.062667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.599837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-16T10:34:29.062767Z","caller":"traceutil/trace.go:171","msg":"trace[168681895] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4939; }","duration":"170.758759ms","start":"2026-06-16T10:34:28.891983Z","end":"2026-06-16T10:34:29.062742Z","steps":["trace[168681895] 'agreement among raft nodes before linearized reading' (duration: 170.451412ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:34:42.999965Z","caller":"traceutil/trace.go:171","msg":"trace[1455504663] transaction","detail":"{read_only:false; response_revision:5196; number_of_response:1; }","duration":"101.862445ms","start":"2026-06-16T10:34:42.898076Z","end":"2026-06-16T10:34:42.999938Z","steps":["trace[1455504663] 'process raft request' (duration: 101.674171ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:36:11.392171Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2983} {"level":"info","ts":"2026-06-16T10:36:11.457812Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2983,"took":"64.184286ms","hash":2099888551,"current-db-size-bytes":58273792,"current-db-size":"58 MB","current-db-size-in-use-bytes":34357248,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-16T10:36:11.457873Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2099888551,"revision":2983,"compact-revision":-1} {"level":"info","ts":"2026-06-16T10:41:11.399724Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6105} {"level":"info","ts":"2026-06-16T10:41:11.50119Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6105,"took":"100.04526ms","hash":3644178904,"current-db-size-bytes":58273792,"current-db-size":"58 MB","current-db-size-in-use-bytes":23179264,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-06-16T10:41:11.501282Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3644178904,"revision":6105,"compact-revision":2983} {"level":"info","ts":"2026-06-16T10:41:47.549852Z","caller":"traceutil/trace.go:171","msg":"trace[1255390873] transaction","detail":"{read_only:false; response_revision:8522; number_of_response:1; }","duration":"137.223914ms","start":"2026-06-16T10:41:47.41261Z","end":"2026-06-16T10:41:47.549834Z","steps":["trace[1255390873] 'process raft request' (duration: 137.109932ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:41:56.965061Z","caller":"traceutil/trace.go:171","msg":"trace[1584700504] transaction","detail":"{read_only:false; response_revision:8609; number_of_response:1; }","duration":"317.767008ms","start":"2026-06-16T10:41:56.647265Z","end":"2026-06-16T10:41:56.965032Z","steps":["trace[1584700504] 'process raft request' (duration: 317.587635ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:41:56.965234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:41:56.647242Z","time spent":"317.90372ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:41:56.965075Z","caller":"traceutil/trace.go:171","msg":"trace[1916654903] linearizableReadLoop","detail":"{readStateIndex:8918; appliedIndex:8918; }","duration":"301.962676ms","start":"2026-06-16T10:41:56.663083Z","end":"2026-06-16T10:41:56.965046Z","steps":["trace[1916654903] 'read index received' (duration: 301.946805ms)","trace[1916654903] 'applied index is now lower than readState.Index' (duration: 9.12µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:41:56.96532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.203711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-16T10:41:56.965393Z","caller":"traceutil/trace.go:171","msg":"trace[1526825433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8609; }","duration":"302.336483ms","start":"2026-06-16T10:41:56.663042Z","end":"2026-06-16T10:41:56.965378Z","steps":["trace[1526825433] 'agreement among raft nodes before linearized reading' (duration: 302.089278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:41:56.965693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:41:56.663028Z","time spent":"302.403574ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-16T10:41:56.98074Z","caller":"traceutil/trace.go:171","msg":"trace[1057973276] transaction","detail":"{read_only:false; response_revision:8613; number_of_response:1; }","duration":"148.040805ms","start":"2026-06-16T10:41:56.832683Z","end":"2026-06-16T10:41:56.980724Z","steps":["trace[1057973276] 'process raft request' (duration: 148.003734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:41:56.980917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.081433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-16T10:41:56.981038Z","caller":"traceutil/trace.go:171","msg":"trace[221948615] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:8613; }","duration":"219.259597ms","start":"2026-06-16T10:41:56.761755Z","end":"2026-06-16T10:41:56.981015Z","steps":["trace[221948615] 'agreement among raft nodes before linearized reading' (duration: 218.97238ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:41:56.981066Z","caller":"traceutil/trace.go:171","msg":"trace[1698157999] transaction","detail":"{read_only:false; response_revision:8611; number_of_response:1; }","duration":"210.950298ms","start":"2026-06-16T10:41:56.7701Z","end":"2026-06-16T10:41:56.98105Z","steps":["trace[1698157999] 'process raft request' (duration: 210.494209ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:41:56.981096Z","caller":"traceutil/trace.go:171","msg":"trace[1568296254] transaction","detail":"{read_only:false; response_revision:8612; number_of_response:1; }","duration":"207.312849ms","start":"2026-06-16T10:41:56.773766Z","end":"2026-06-16T10:41:56.981079Z","steps":["trace[1568296254] 'process raft request' (duration: 206.87613ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:41:56.981182Z","caller":"traceutil/trace.go:171","msg":"trace[308423255] transaction","detail":"{read_only:false; response_revision:8610; number_of_response:1; }","duration":"211.142312ms","start":"2026-06-16T10:41:56.77002Z","end":"2026-06-16T10:41:56.981162Z","steps":["trace[308423255] 'process raft request' (duration: 210.458388ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:41:57.626974Z","caller":"traceutil/trace.go:171","msg":"trace[1239528725] transaction","detail":"{read_only:false; response_revision:8617; number_of_response:1; }","duration":"129.800698ms","start":"2026-06-16T10:41:57.497139Z","end":"2026-06-16T10:41:57.626939Z","steps":["trace[1239528725] 'process raft request' (duration: 116.942013ms)","trace[1239528725] 'compare' (duration: 12.484818ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:41:57.931778Z","caller":"traceutil/trace.go:171","msg":"trace[1471500473] linearizableReadLoop","detail":"{readStateIndex:8928; appliedIndex:8927; }","duration":"162.148936ms","start":"2026-06-16T10:41:57.769604Z","end":"2026-06-16T10:41:57.931753Z","steps":["trace[1471500473] 'read index received' (duration: 161.848491ms)","trace[1471500473] 'applied index is now lower than readState.Index' (duration: 299.175µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:41:57.932063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.443812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-16T10:41:57.932086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.718364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-16T10:41:57.932118Z","caller":"traceutil/trace.go:171","msg":"trace[373030948] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8619; }","duration":"162.516723ms","start":"2026-06-16T10:41:57.769589Z","end":"2026-06-16T10:41:57.932106Z","steps":["trace[373030948] 'agreement among raft nodes before linearized reading' (duration: 162.327149ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:41:57.932145Z","caller":"traceutil/trace.go:171","msg":"trace[918299134] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8619; }","duration":"143.829546ms","start":"2026-06-16T10:41:57.7883Z","end":"2026-06-16T10:41:57.93213Z","steps":["trace[918299134] 'agreement among raft nodes before linearized reading' (duration: 143.675583ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:41:57.931977Z","caller":"traceutil/trace.go:171","msg":"trace[1839080295] transaction","detail":"{read_only:false; response_revision:8619; number_of_response:1; }","duration":"216.618075ms","start":"2026-06-16T10:41:57.715191Z","end":"2026-06-16T10:41:57.931809Z","steps":["trace[1839080295] 'process raft request' (duration: 216.390001ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:42:33.126649Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002440.wal"} {"level":"info","ts":"2026-06-16T10:43:53.386801Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1cac722af8b2b8a6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T10:43:53.400495Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-16T10:43:53.400573Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-16T10:46:11.405984Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8273} {"level":"info","ts":"2026-06-16T10:46:11.484351Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8273,"took":"75.966801ms","hash":2390361148,"current-db-size-bytes":58273792,"current-db-size":"58 MB","current-db-size-in-use-bytes":25346048,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-06-16T10:46:11.484437Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2390361148,"revision":8273,"compact-revision":6105} {"level":"info","ts":"2026-06-16T10:47:00.650622Z","caller":"traceutil/trace.go:171","msg":"trace[1580064603] transaction","detail":"{read_only:false; response_revision:11231; number_of_response:1; }","duration":"191.991369ms","start":"2026-06-16T10:47:00.458605Z","end":"2026-06-16T10:47:00.650597Z","steps":["trace[1580064603] 'process raft request' (duration: 191.849236ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:51:11.413416Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10761} {"level":"info","ts":"2026-06-16T10:51:11.493713Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10761,"took":"77.904933ms","hash":3388123861,"current-db-size-bytes":58273792,"current-db-size":"58 MB","current-db-size-in-use-bytes":26955776,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-16T10:51:11.493765Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3388123861,"revision":10761,"compact-revision":8273} {"level":"info","ts":"2026-06-16T10:53:13.15476Z","caller":"traceutil/trace.go:171","msg":"trace[419289147] transaction","detail":"{read_only:false; response_revision:13737; number_of_response:1; }","duration":"142.597313ms","start":"2026-06-16T10:53:13.012135Z","end":"2026-06-16T10:53:13.154733Z","steps":["trace[419289147] 'process raft request' (duration: 142.42742ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:53:29.69778Z","caller":"traceutil/trace.go:171","msg":"trace[877139262] linearizableReadLoop","detail":"{readStateIndex:14316; appliedIndex:14315; }","duration":"219.709042ms","start":"2026-06-16T10:53:29.478049Z","end":"2026-06-16T10:53:29.697758Z","steps":["trace[877139262] 'read index received' (duration: 219.573579ms)","trace[877139262] 'applied index is now lower than readState.Index' (duration: 134.673µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:53:29.697867Z","caller":"traceutil/trace.go:171","msg":"trace[1093705874] transaction","detail":"{read_only:false; response_revision:13838; number_of_response:1; }","duration":"253.383827ms","start":"2026-06-16T10:53:29.444439Z","end":"2026-06-16T10:53:29.697823Z","steps":["trace[1093705874] 'process raft request' (duration: 253.180953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:53:29.697991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.923106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1857"} {"level":"info","ts":"2026-06-16T10:53:29.698018Z","caller":"traceutil/trace.go:171","msg":"trace[136286208] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:13838; }","duration":"219.997736ms","start":"2026-06-16T10:53:29.478012Z","end":"2026-06-16T10:53:29.698009Z","steps":["trace[136286208] 'agreement among raft nodes before linearized reading' (duration: 219.876534ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:53:29.851897Z","caller":"traceutil/trace.go:171","msg":"trace[557374462] transaction","detail":"{read_only:false; response_revision:13842; number_of_response:1; }","duration":"293.1471ms","start":"2026-06-16T10:53:29.558726Z","end":"2026-06-16T10:53:29.851873Z","steps":["trace[557374462] 'process raft request' (duration: 293.090999ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:53:29.852064Z","caller":"traceutil/trace.go:171","msg":"trace[170446346] transaction","detail":"{read_only:false; response_revision:13839; number_of_response:1; }","duration":"356.664447ms","start":"2026-06-16T10:53:29.49539Z","end":"2026-06-16T10:53:29.852054Z","steps":["trace[170446346] 'process raft request' (duration: 354.778181ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:53:29.85209Z","caller":"traceutil/trace.go:171","msg":"trace[2022892560] transaction","detail":"{read_only:false; response_revision:13841; number_of_response:1; }","duration":"298.284248ms","start":"2026-06-16T10:53:29.553773Z","end":"2026-06-16T10:53:29.852057Z","steps":["trace[2022892560] 'process raft request' (duration: 298.012092ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:53:29.852079Z","caller":"traceutil/trace.go:171","msg":"trace[1191473485] transaction","detail":"{read_only:false; response_revision:13840; number_of_response:1; }","duration":"299.586103ms","start":"2026-06-16T10:53:29.552456Z","end":"2026-06-16T10:53:29.852042Z","steps":["trace[1191473485] 'process raft request' (duration: 299.269867ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:53:29.852154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:53:29.495373Z","time spent":"356.712688ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:53:29.85426Z","caller":"traceutil/trace.go:171","msg":"trace[19054000] linearizableReadLoop","detail":"{readStateIndex:14321; appliedIndex:14316; }","duration":"156.377598ms","start":"2026-06-16T10:53:29.697866Z","end":"2026-06-16T10:53:29.854243Z","steps":["trace[19054000] 'read index received' (duration: 152.193397ms)","trace[19054000] 'applied index is now lower than readState.Index' (duration: 4.183051ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:53:29.854603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.059735ms","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-16T10:53:29.854653Z","caller":"traceutil/trace.go:171","msg":"trace[341389078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13842; }","duration":"368.119926ms","start":"2026-06-16T10:53:29.486521Z","end":"2026-06-16T10:53:29.854641Z","steps":["trace[341389078] 'agreement among raft nodes before linearized reading' (duration: 367.977984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:53:29.854684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:53:29.486466Z","time spent":"368.209948ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-16T10:53:29.854811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.189027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-16T10:53:29.85484Z","caller":"traceutil/trace.go:171","msg":"trace[1863612009] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:13842; }","duration":"369.250079ms","start":"2026-06-16T10:53:29.485579Z","end":"2026-06-16T10:53:29.854829Z","steps":["trace[1863612009] 'agreement among raft nodes before linearized reading' (duration: 369.173727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:53:29.854865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:53:29.485562Z","time spent":"369.297819ms","remote":"127.0.0.1:58220","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":"warn","ts":"2026-06-16T10:53:29.855071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.793048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-514e4384-7134-4931-a3f6-e8e727d1baad\" ","response":"range_response_count:1 size:1319"} {"level":"info","ts":"2026-06-16T10:53:29.855131Z","caller":"traceutil/trace.go:171","msg":"trace[6478974] range","detail":"{range_begin:/registry/persistentvolumes/pvc-514e4384-7134-4931-a3f6-e8e727d1baad; range_end:; response_count:1; response_revision:13842; }","duration":"153.88894ms","start":"2026-06-16T10:53:29.701223Z","end":"2026-06-16T10:53:29.855112Z","steps":["trace[6478974] 'agreement among raft nodes before linearized reading' (duration: 153.731467ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:55:18.306173Z","caller":"traceutil/trace.go:171","msg":"trace[1513703303] transaction","detail":"{read_only:false; response_revision:15088; number_of_response:1; }","duration":"109.586748ms","start":"2026-06-16T10:55:18.196563Z","end":"2026-06-16T10:55:18.30615Z","steps":["trace[1513703303] 'process raft request' (duration: 109.234011ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:55:18.461723Z","caller":"traceutil/trace.go:171","msg":"trace[318391515] linearizableReadLoop","detail":"{readStateIndex:15601; appliedIndex:15599; }","duration":"233.492277ms","start":"2026-06-16T10:55:18.228209Z","end":"2026-06-16T10:55:18.461701Z","steps":["trace[318391515] 'read index received' (duration: 77.603809ms)","trace[318391515] 'applied index is now lower than readState.Index' (duration: 155.887718ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:55:18.461925Z","caller":"traceutil/trace.go:171","msg":"trace[1366640261] transaction","detail":"{read_only:false; response_revision:15089; number_of_response:1; }","duration":"253.514198ms","start":"2026-06-16T10:55:18.208399Z","end":"2026-06-16T10:55:18.461913Z","steps":["trace[1366640261] 'process raft request' (duration: 253.07698ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:55:18.462076Z","caller":"traceutil/trace.go:171","msg":"trace[861897904] transaction","detail":"{read_only:false; response_revision:15090; number_of_response:1; }","duration":"223.707231ms","start":"2026-06-16T10:55:18.238361Z","end":"2026-06-16T10:55:18.462068Z","steps":["trace[861897904] 'process raft request' (duration: 223.230571ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:55:18.462171Z","caller":"traceutil/trace.go:171","msg":"trace[1280055374] transaction","detail":"{read_only:false; response_revision:15091; number_of_response:1; }","duration":"222.184213ms","start":"2026-06-16T10:55:18.239979Z","end":"2026-06-16T10:55:18.462163Z","steps":["trace[1280055374] 'process raft request' (duration: 221.655942ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:55:18.462253Z","caller":"traceutil/trace.go:171","msg":"trace[569178997] transaction","detail":"{read_only:false; response_revision:15092; number_of_response:1; }","duration":"222.208304ms","start":"2026-06-16T10:55:18.240039Z","end":"2026-06-16T10:55:18.462247Z","steps":["trace[569178997] 'process raft request' (duration: 221.627302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:55:18.462356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.1313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T10:55:18.462377Z","caller":"traceutil/trace.go:171","msg":"trace[812142162] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15092; }","duration":"234.202872ms","start":"2026-06-16T10:55:18.228168Z","end":"2026-06-16T10:55:18.462371Z","steps":["trace[812142162] 'agreement among raft nodes before linearized reading' (duration: 234.150141ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:56:11.419357Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12872} {"level":"info","ts":"2026-06-16T10:56:11.493664Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12872,"took":"71.39682ms","hash":1191607168,"current-db-size-bytes":58273792,"current-db-size":"58 MB","current-db-size-in-use-bytes":30355456,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-16T10:56:11.493901Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1191607168,"revision":12872,"compact-revision":10761} {"level":"info","ts":"2026-06-16T10:58:16.00844Z","caller":"traceutil/trace.go:171","msg":"trace[1469522780] transaction","detail":"{read_only:false; response_revision:16506; number_of_response:1; }","duration":"108.436756ms","start":"2026-06-16T10:58:15.899976Z","end":"2026-06-16T10:58:16.008412Z","steps":["trace[1469522780] 'process raft request' (duration: 108.252032ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:00:56.508864Z","caller":"traceutil/trace.go:171","msg":"trace[1059839795] transaction","detail":"{read_only:false; response_revision:17732; number_of_response:1; }","duration":"127.367121ms","start":"2026-06-16T11:00:56.381457Z","end":"2026-06-16T11:00:56.508824Z","steps":["trace[1059839795] 'process raft request' (duration: 127.145637ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:01:03.311109Z","caller":"traceutil/trace.go:171","msg":"trace[777468899] transaction","detail":"{read_only:false; response_revision:17771; number_of_response:1; }","duration":"224.029086ms","start":"2026-06-16T11:01:03.087049Z","end":"2026-06-16T11:01:03.311078Z","steps":["trace[777468899] 'process raft request' (duration: 223.800432ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:01:03.571085Z","caller":"traceutil/trace.go:171","msg":"trace[1139897305] linearizableReadLoop","detail":"{readStateIndex:18370; appliedIndex:18369; }","duration":"239.338589ms","start":"2026-06-16T11:01:03.331725Z","end":"2026-06-16T11:01:03.571064Z","steps":["trace[1139897305] 'read index received' (duration: 195.348699ms)","trace[1139897305] 'applied index is now lower than readState.Index' (duration: 43.98926ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:01:03.571098Z","caller":"traceutil/trace.go:171","msg":"trace[1630277989] transaction","detail":"{read_only:false; response_revision:17772; number_of_response:1; }","duration":"242.081332ms","start":"2026-06-16T11:01:03.329Z","end":"2026-06-16T11:01:03.571082Z","steps":["trace[1630277989] 'process raft request' (duration: 198.081471ms)","trace[1630277989] 'compare' (duration: 43.877639ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:01:03.571332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.589044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-heat-server\" ","response":"range_response_count:1 size:9566"} {"level":"info","ts":"2026-06-16T11:01:03.571423Z","caller":"traceutil/trace.go:171","msg":"trace[3865075] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-heat-server; range_end:; response_count:1; response_revision:17772; }","duration":"239.737567ms","start":"2026-06-16T11:01:03.331664Z","end":"2026-06-16T11:01:03.571402Z","steps":["trace[3865075] 'agreement among raft nodes before linearized reading' (duration: 239.466642ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:01:11.425201Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15427} {"level":"info","ts":"2026-06-16T11:01:11.514925Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15427,"took":"87.315617ms","hash":1598072506,"current-db-size-bytes":58273792,"current-db-size":"58 MB","current-db-size-in-use-bytes":32243712,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-16T11:01:11.515017Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1598072506,"revision":15427,"compact-revision":12872} {"level":"info","ts":"2026-06-16T11:04:17.175038Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1cac722af8b2b8a6","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T11:04:17.181438Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-16T11:04:17.181525Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-16T11:06:11.436263Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17831} {"level":"info","ts":"2026-06-16T11:06:11.545515Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17831,"took":"106.139197ms","hash":1726732943,"current-db-size-bytes":58273792,"current-db-size":"58 MB","current-db-size-in-use-bytes":30433280,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-16T11:06:11.545587Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1726732943,"revision":17831,"compact-revision":15427} {"level":"info","ts":"2026-06-16T11:06:29.13689Z","caller":"traceutil/trace.go:171","msg":"trace[208007547] transaction","detail":"{read_only:false; response_revision:20310; number_of_response:1; }","duration":"220.765294ms","start":"2026-06-16T11:06:28.916095Z","end":"2026-06-16T11:06:29.13686Z","steps":["trace[208007547] 'process raft request' (duration: 220.253395ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:06:29.13714Z","caller":"traceutil/trace.go:171","msg":"trace[1554439081] transaction","detail":"{read_only:false; response_revision:20311; number_of_response:1; }","duration":"218.805787ms","start":"2026-06-16T11:06:28.918311Z","end":"2026-06-16T11:06:29.137117Z","steps":["trace[1554439081] 'process raft request' (duration: 218.493311ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:06:29.137275Z","caller":"traceutil/trace.go:171","msg":"trace[1706010259] transaction","detail":"{read_only:false; response_revision:20312; number_of_response:1; }","duration":"215.27166ms","start":"2026-06-16T11:06:28.921982Z","end":"2026-06-16T11:06:29.137254Z","steps":["trace[1706010259] 'process raft request' (duration: 215.064816ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:06:29.203203Z","caller":"traceutil/trace.go:171","msg":"trace[407201378] transaction","detail":"{read_only:false; response_revision:20313; number_of_response:1; }","duration":"124.335503ms","start":"2026-06-16T11:06:29.078842Z","end":"2026-06-16T11:06:29.203178Z","steps":["trace[407201378] 'process raft request' (duration: 123.743962ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:06:29.360185Z","caller":"traceutil/trace.go:171","msg":"trace[1482853605] transaction","detail":"{read_only:false; response_revision:20315; number_of_response:1; }","duration":"114.412643ms","start":"2026-06-16T11:06:29.245751Z","end":"2026-06-16T11:06:29.360164Z","steps":["trace[1482853605] 'process raft request' (duration: 114.296071ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:06:29.778566Z","caller":"traceutil/trace.go:171","msg":"trace[215981648] transaction","detail":"{read_only:false; response_revision:20316; number_of_response:1; }","duration":"141.719896ms","start":"2026-06-16T11:06:29.63678Z","end":"2026-06-16T11:06:29.7785Z","steps":["trace[215981648] 'process raft request' (duration: 141.554363ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:06:29.785152Z","caller":"traceutil/trace.go:171","msg":"trace[1502769616] transaction","detail":"{read_only:false; response_revision:20317; number_of_response:1; }","duration":"138.216278ms","start":"2026-06-16T11:06:29.64691Z","end":"2026-06-16T11:06:29.785126Z","steps":["trace[1502769616] 'process raft request' (duration: 138.097396ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:11:11.441507Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20221} {"level":"info","ts":"2026-06-16T11:11:11.552838Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20221,"took":"107.460431ms","hash":1137859595,"current-db-size-bytes":58273792,"current-db-size":"58 MB","current-db-size-in-use-bytes":42688512,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-06-16T11:11:11.553077Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1137859595,"revision":20221,"compact-revision":17831} {"level":"info","ts":"2026-06-16T11:13:51.619128Z","caller":"traceutil/trace.go:171","msg":"trace[1587246192] transaction","detail":"{read_only:false; response_revision:24843; number_of_response:1; }","duration":"126.185328ms","start":"2026-06-16T11:13:51.492917Z","end":"2026-06-16T11:13:51.619102Z","steps":["trace[1587246192] 'process raft request' (duration: 126.010814ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:52.150083Z","caller":"traceutil/trace.go:171","msg":"trace[2049173422] transaction","detail":"{read_only:false; response_revision:24845; number_of_response:1; }","duration":"108.766786ms","start":"2026-06-16T11:13:52.0413Z","end":"2026-06-16T11:13:52.150067Z","steps":["trace[2049173422] 'process raft request' (duration: 108.656984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:13:52.356282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.481252ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T11:13:52.356445Z","caller":"traceutil/trace.go:171","msg":"trace[1212381151] linearizableReadLoop","detail":"{readStateIndex:25659; appliedIndex:25657; }","duration":"281.46848ms","start":"2026-06-16T11:13:52.07496Z","end":"2026-06-16T11:13:52.356428Z","steps":["trace[1212381151] 'read index received' (duration: 75.020451ms)","trace[1212381151] 'applied index is now lower than readState.Index' (duration: 206.447199ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:13:52.356682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.2314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T11:13:52.35668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.688754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T11:13:52.356714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.993503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:13:52.356733Z","caller":"traceutil/trace.go:171","msg":"trace[872567696] transaction","detail":"{read_only:false; response_revision:24847; number_of_response:1; }","duration":"219.182243ms","start":"2026-06-16T11:13:52.137539Z","end":"2026-06-16T11:13:52.356722Z","steps":["trace[872567696] 'process raft request' (duration: 218.824076ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:52.356749Z","caller":"traceutil/trace.go:171","msg":"trace[523222932] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:24847; }","duration":"134.342404ms","start":"2026-06-16T11:13:52.222391Z","end":"2026-06-16T11:13:52.356734Z","steps":["trace[523222932] 'agreement among raft nodes before linearized reading' (duration: 134.234921ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:52.356772Z","caller":"traceutil/trace.go:171","msg":"trace[719298777] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24847; }","duration":"128.088584ms","start":"2026-06-16T11:13:52.228671Z","end":"2026-06-16T11:13:52.35676Z","steps":["trace[719298777] 'agreement among raft nodes before linearized reading' (duration: 127.966841ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:52.356764Z","caller":"traceutil/trace.go:171","msg":"trace[535985562] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24847; }","duration":"281.799598ms","start":"2026-06-16T11:13:52.074945Z","end":"2026-06-16T11:13:52.356744Z","steps":["trace[535985562] 'agreement among raft nodes before linearized reading' (duration: 281.657994ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:52.356677Z","caller":"traceutil/trace.go:171","msg":"trace[146135497] transaction","detail":"{read_only:false; response_revision:24846; number_of_response:1; }","duration":"314.000922ms","start":"2026-06-16T11:13:52.042662Z","end":"2026-06-16T11:13:52.356663Z","steps":["trace[146135497] 'process raft request' (duration: 197.062491ms)","trace[146135497] 'compare' (duration: 116.234137ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:13:52.356891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:52.042643Z","time spent":"314.222097ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:13:52.871224Z","caller":"traceutil/trace.go:171","msg":"trace[2033912463] transaction","detail":"{read_only:false; response_revision:24848; number_of_response:1; }","duration":"325.482441ms","start":"2026-06-16T11:13:52.545716Z","end":"2026-06-16T11:13:52.871199Z","steps":["trace[2033912463] 'process raft request' (duration: 325.303527ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:13:52.871435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:52.545696Z","time spent":"325.639403ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:13:52.875196Z","caller":"traceutil/trace.go:171","msg":"trace[1005898745] transaction","detail":"{read_only:false; response_revision:24849; number_of_response:1; }","duration":"294.958739ms","start":"2026-06-16T11:13:52.580213Z","end":"2026-06-16T11:13:52.875172Z","steps":["trace[1005898745] 'process raft request' (duration: 294.309826ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:52.875354Z","caller":"traceutil/trace.go:171","msg":"trace[931353309] transaction","detail":"{read_only:false; response_revision:24850; number_of_response:1; }","duration":"190.495855ms","start":"2026-06-16T11:13:52.68485Z","end":"2026-06-16T11:13:52.875346Z","steps":["trace[931353309] 'process raft request' (duration: 189.766421ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:52.875437Z","caller":"traceutil/trace.go:171","msg":"trace[579938853] transaction","detail":"{read_only:false; response_revision:24851; number_of_response:1; }","duration":"152.422709ms","start":"2026-06-16T11:13:52.723008Z","end":"2026-06-16T11:13:52.875431Z","steps":["trace[579938853] 'process raft request' (duration: 151.632333ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:52.875609Z","caller":"traceutil/trace.go:171","msg":"trace[1022996732] transaction","detail":"{read_only:false; response_revision:24852; number_of_response:1; }","duration":"144.60459ms","start":"2026-06-16T11:13:52.730994Z","end":"2026-06-16T11:13:52.875599Z","steps":["trace[1022996732] 'process raft request' (duration: 143.671782ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:57.148823Z","caller":"traceutil/trace.go:171","msg":"trace[2087387119] transaction","detail":"{read_only:false; response_revision:24883; number_of_response:1; }","duration":"261.611572ms","start":"2026-06-16T11:13:56.887179Z","end":"2026-06-16T11:13:57.148791Z","steps":["trace[2087387119] 'process raft request' (duration: 261.370497ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:57.450624Z","caller":"traceutil/trace.go:171","msg":"trace[821870384] transaction","detail":"{read_only:false; response_revision:24890; number_of_response:1; }","duration":"180.596817ms","start":"2026-06-16T11:13:57.270004Z","end":"2026-06-16T11:13:57.450601Z","steps":["trace[821870384] 'process raft request' (duration: 180.550686ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:57.450838Z","caller":"traceutil/trace.go:171","msg":"trace[564377880] transaction","detail":"{read_only:false; response_revision:24889; number_of_response:1; }","duration":"213.221619ms","start":"2026-06-16T11:13:57.237607Z","end":"2026-06-16T11:13:57.450829Z","steps":["trace[564377880] 'process raft request' (duration: 212.807621ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:57.450798Z","caller":"traceutil/trace.go:171","msg":"trace[634902196] linearizableReadLoop","detail":"{readStateIndex:25701; appliedIndex:25696; }","duration":"557.384466ms","start":"2026-06-16T11:13:56.89338Z","end":"2026-06-16T11:13:57.450765Z","steps":["trace[634902196] 'read index received' (duration: 255.168979ms)","trace[634902196] 'applied index is now lower than readState.Index' (duration: 302.212517ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:13:57.450814Z","caller":"traceutil/trace.go:171","msg":"trace[151441173] transaction","detail":"{read_only:false; response_revision:24888; number_of_response:1; }","duration":"428.235512ms","start":"2026-06-16T11:13:57.022535Z","end":"2026-06-16T11:13:57.45077Z","steps":["trace[151441173] 'process raft request' (duration: 427.818734ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:57.450732Z","caller":"traceutil/trace.go:171","msg":"trace[1739064091] transaction","detail":"{read_only:false; response_revision:24886; number_of_response:1; }","duration":"560.807561ms","start":"2026-06-16T11:13:56.889905Z","end":"2026-06-16T11:13:57.450713Z","steps":["trace[1739064091] 'process raft request' (duration: 560.386483ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:57.450811Z","caller":"traceutil/trace.go:171","msg":"trace[567792869] transaction","detail":"{read_only:false; response_revision:24884; number_of_response:1; }","duration":"561.441383ms","start":"2026-06-16T11:13:56.889324Z","end":"2026-06-16T11:13:57.450765Z","steps":["trace[567792869] 'process raft request' (duration: 470.940446ms)","trace[567792869] 'compare' (duration: 89.650881ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:13:57.451003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:57.022508Z","time spent":"428.396134ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:13:57.45102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.209874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T11:13:57.45104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.995849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-16T11:13:57.451027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:56.889895Z","time spent":"561.053315ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:13:57.451049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:56.889291Z","time spent":"561.704037ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:13:57.451076Z","caller":"traceutil/trace.go:171","msg":"trace[1974033876] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:24890; }","duration":"120.100371ms","start":"2026-06-16T11:13:57.330966Z","end":"2026-06-16T11:13:57.451067Z","steps":["trace[1974033876] 'agreement among raft nodes before linearized reading' (duration: 119.985909ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:57.45107Z","caller":"traceutil/trace.go:171","msg":"trace[1317802256] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:24890; }","duration":"544.298955ms","start":"2026-06-16T11:13:56.906756Z","end":"2026-06-16T11:13:57.451055Z","steps":["trace[1317802256] 'agreement among raft nodes before linearized reading' (duration: 544.193233ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:57.450786Z","caller":"traceutil/trace.go:171","msg":"trace[1706832025] transaction","detail":"{read_only:false; response_revision:24885; number_of_response:1; }","duration":"561.31667ms","start":"2026-06-16T11:13:56.889457Z","end":"2026-06-16T11:13:57.450774Z","steps":["trace[1706832025] 'process raft request' (duration: 560.79929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:13:57.45112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.726322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-06-16T11:13:57.45114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:56.906746Z","time spent":"544.374577ms","remote":"127.0.0.1:54078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true "} {"level":"info","ts":"2026-06-16T11:13:57.451187Z","caller":"traceutil/trace.go:171","msg":"trace[126235094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24890; }","duration":"557.823653ms","start":"2026-06-16T11:13:56.893342Z","end":"2026-06-16T11:13:57.451166Z","steps":["trace[126235094] 'agreement among raft nodes before linearized reading' (duration: 557.570678ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:57.450775Z","caller":"traceutil/trace.go:171","msg":"trace[1500141450] transaction","detail":"{read_only:false; response_revision:24887; number_of_response:1; }","duration":"560.805431ms","start":"2026-06-16T11:13:56.88995Z","end":"2026-06-16T11:13:57.450756Z","steps":["trace[1500141450] 'process raft request' (duration: 560.380223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:13:57.45124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:56.89333Z","time spent":"557.897385ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-16T11:13:57.451321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:56.889924Z","time spent":"561.34747ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:13:57.451433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.792357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T11:13:57.451571Z","caller":"traceutil/trace.go:171","msg":"trace[1021890709] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:24890; }","duration":"369.99558ms","start":"2026-06-16T11:13:57.081517Z","end":"2026-06-16T11:13:57.451512Z","steps":["trace[1021890709] 'agreement among raft nodes before linearized reading' (duration: 369.45877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:13:57.451661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:57.081497Z","time spent":"370.147163ms","remote":"127.0.0.1:58748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":76,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-06-16T11:13:57.451237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:56.889423Z","time spent":"561.729848ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:13:57.810846Z","caller":"traceutil/trace.go:171","msg":"trace[943786555] transaction","detail":"{read_only:false; response_revision:24892; number_of_response:1; }","duration":"165.61926ms","start":"2026-06-16T11:13:57.645202Z","end":"2026-06-16T11:13:57.810822Z","steps":["trace[943786555] 'process raft request' (duration: 165.474937ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:57.981756Z","caller":"traceutil/trace.go:171","msg":"trace[2116615067] transaction","detail":"{read_only:false; response_revision:24893; number_of_response:1; }","duration":"229.949478ms","start":"2026-06-16T11:13:57.751779Z","end":"2026-06-16T11:13:57.981729Z","steps":["trace[2116615067] 'process raft request' (duration: 229.773234ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:57.992413Z","caller":"traceutil/trace.go:171","msg":"trace[2041496708] transaction","detail":"{read_only:false; response_revision:24894; number_of_response:1; }","duration":"114.938493ms","start":"2026-06-16T11:13:57.877453Z","end":"2026-06-16T11:13:57.992391Z","steps":["trace[2041496708] 'process raft request' (duration: 114.356532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:13:58.321195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.271233ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T11:13:58.321286Z","caller":"traceutil/trace.go:171","msg":"trace[135651904] linearizableReadLoop","detail":"{readStateIndex:25709; appliedIndex:25708; }","duration":"150.036984ms","start":"2026-06-16T11:13:58.171234Z","end":"2026-06-16T11:13:58.321271Z","steps":["trace[135651904] 'read index received' (duration: 44.391µs)","trace[135651904] 'applied index is now lower than readState.Index' (duration: 149.991333ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:13:58.321369Z","caller":"traceutil/trace.go:171","msg":"trace[518761835] transaction","detail":"{read_only:false; response_revision:24895; number_of_response:1; }","duration":"324.761707ms","start":"2026-06-16T11:13:57.996597Z","end":"2026-06-16T11:13:58.321359Z","steps":["trace[518761835] 'process raft request' (duration: 103.25137ms)","trace[518761835] 'compare' (duration: 221.13489ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:13:58.321418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:57.996577Z","time spent":"324.812348ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:13:58.321771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.545413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-16T11:13:58.321797Z","caller":"traceutil/trace.go:171","msg":"trace[979767399] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24895; }","duration":"150.608024ms","start":"2026-06-16T11:13:58.17118Z","end":"2026-06-16T11:13:58.321788Z","steps":["trace[979767399] 'agreement among raft nodes before linearized reading' (duration: 150.38627ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:13:58.321806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.157884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T11:13:58.321865Z","caller":"traceutil/trace.go:171","msg":"trace[1429191588] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:24895; }","duration":"130.226776ms","start":"2026-06-16T11:13:58.191623Z","end":"2026-06-16T11:13:58.32185Z","steps":["trace[1429191588] 'agreement among raft nodes before linearized reading' (duration: 130.109173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:13:58.639526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.615059ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T11:13:58.639666Z","caller":"traceutil/trace.go:171","msg":"trace[1259928469] linearizableReadLoop","detail":"{readStateIndex:25710; appliedIndex:25709; }","duration":"256.433802ms","start":"2026-06-16T11:13:58.383211Z","end":"2026-06-16T11:13:58.639644Z","steps":["trace[1259928469] 'read index received' (duration: 89.588539ms)","trace[1259928469] 'applied index is now lower than readState.Index' (duration: 166.842893ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:13:58.639827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.631186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-16T11:13:58.639865Z","caller":"traceutil/trace.go:171","msg":"trace[4105671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24896; }","duration":"256.707918ms","start":"2026-06-16T11:13:58.383147Z","end":"2026-06-16T11:13:58.639855Z","steps":["trace[4105671] 'agreement among raft nodes before linearized reading' (duration: 256.557335ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:58.639708Z","caller":"traceutil/trace.go:171","msg":"trace[1880495806] transaction","detail":"{read_only:false; response_revision:24896; number_of_response:1; }","duration":"313.606775ms","start":"2026-06-16T11:13:58.326063Z","end":"2026-06-16T11:13:58.63967Z","steps":["trace[1880495806] 'process raft request' (duration: 146.70916ms)","trace[1880495806] 'compare' (duration: 166.336904ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:13:58.640425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:58.32605Z","time spent":"314.332599ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:13:58.938603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.56409ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T11:13:58.938682Z","caller":"traceutil/trace.go:171","msg":"trace[1092722588] linearizableReadLoop","detail":"{readStateIndex:25711; appliedIndex:25710; }","duration":"222.854962ms","start":"2026-06-16T11:13:58.715814Z","end":"2026-06-16T11:13:58.938669Z","steps":["trace[1092722588] 'read index received' (duration: 69.144619ms)","trace[1092722588] 'applied index is now lower than readState.Index' (duration: 153.709323ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:13:58.938738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.921483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:13:58.938759Z","caller":"traceutil/trace.go:171","msg":"trace[493990856] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/applicationcredentials/; range_end:/registry/openstack.k-orc.cloud/applicationcredentials0; response_count:0; response_revision:24897; }","duration":"222.968193ms","start":"2026-06-16T11:13:58.715781Z","end":"2026-06-16T11:13:58.938749Z","steps":["trace[493990856] 'agreement among raft nodes before linearized reading' (duration: 222.919093ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:58.93892Z","caller":"traceutil/trace.go:171","msg":"trace[1033189467] transaction","detail":"{read_only:false; response_revision:24897; number_of_response:1; }","duration":"295.337045ms","start":"2026-06-16T11:13:58.643553Z","end":"2026-06-16T11:13:58.93889Z","steps":["trace[1033189467] 'process raft request' (duration: 141.411798ms)","trace[1033189467] 'compare' (duration: 153.125852ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:13:59.260842Z","caller":"traceutil/trace.go:171","msg":"trace[1192838393] transaction","detail":"{read_only:false; response_revision:24898; number_of_response:1; }","duration":"100.690841ms","start":"2026-06-16T11:13:59.160136Z","end":"2026-06-16T11:13:59.260827Z","steps":["trace[1192838393] 'process raft request' (duration: 100.364655ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:59.811003Z","caller":"traceutil/trace.go:171","msg":"trace[1645997094] transaction","detail":"{read_only:false; response_revision:24899; number_of_response:1; }","duration":"353.116648ms","start":"2026-06-16T11:13:59.457866Z","end":"2026-06-16T11:13:59.810982Z","steps":["trace[1645997094] 'process raft request' (duration: 352.985575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:13:59.811134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:59.457845Z","time spent":"353.21739ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:13:59.970728Z","caller":"traceutil/trace.go:171","msg":"trace[443551181] transaction","detail":"{read_only:false; response_revision:24900; number_of_response:1; }","duration":"512.837626ms","start":"2026-06-16T11:13:59.457866Z","end":"2026-06-16T11:13:59.970704Z","steps":["trace[443551181] 'process raft request' (duration: 512.652922ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:13:59.970941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:59.457846Z","time spent":"512.953119ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:13:59.971069Z","caller":"traceutil/trace.go:171","msg":"trace[1494260745] transaction","detail":"{read_only:false; response_revision:24901; number_of_response:1; }","duration":"513.107642ms","start":"2026-06-16T11:13:59.457936Z","end":"2026-06-16T11:13:59.971043Z","steps":["trace[1494260745] 'process raft request' (duration: 512.725294ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:59.971103Z","caller":"traceutil/trace.go:171","msg":"trace[1402291079] transaction","detail":"{read_only:false; response_revision:24902; number_of_response:1; }","duration":"513.144463ms","start":"2026-06-16T11:13:59.457938Z","end":"2026-06-16T11:13:59.971082Z","steps":["trace[1402291079] 'process raft request' (duration: 513.030891ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:13:59.97121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:59.457927Z","time spent":"513.203864ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:13:59.971228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:59.457911Z","time spent":"513.249894ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:13:59.97134Z","caller":"traceutil/trace.go:171","msg":"trace[520613152] transaction","detail":"{read_only:false; response_revision:24905; number_of_response:1; }","duration":"511.605543ms","start":"2026-06-16T11:13:59.45972Z","end":"2026-06-16T11:13:59.971325Z","steps":["trace[520613152] 'process raft request' (duration: 511.470931ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:13:59.971325Z","caller":"traceutil/trace.go:171","msg":"trace[1014542780] transaction","detail":"{read_only:false; response_revision:24904; number_of_response:1; }","duration":"512.288636ms","start":"2026-06-16T11:13:59.459024Z","end":"2026-06-16T11:13:59.971312Z","steps":["trace[1014542780] 'process raft request' (duration: 512.102402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:13:59.97141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:59.459708Z","time spent":"511.670624ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:13:59.971463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:59.459011Z","time spent":"512.380427ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:13:59.97123Z","caller":"traceutil/trace.go:171","msg":"trace[2005088821] transaction","detail":"{read_only:false; response_revision:24903; number_of_response:1; }","duration":"512.822575ms","start":"2026-06-16T11:13:59.458341Z","end":"2026-06-16T11:13:59.971163Z","steps":["trace[2005088821] 'process raft request' (duration: 512.709843ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:13:59.972027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:59.45833Z","time spent":"513.656102ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:14:00.122031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.792057ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-16T11:14:00.122239Z","caller":"traceutil/trace.go:171","msg":"trace[71599494] linearizableReadLoop","detail":"{readStateIndex:25719; appliedIndex:25712; }","duration":"628.83684ms","start":"2026-06-16T11:13:59.493388Z","end":"2026-06-16T11:14:00.122225Z","steps":["trace[71599494] 'read index received' (duration: 317.498388ms)","trace[71599494] 'applied index is now lower than readState.Index' (duration: 311.337672ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:00.122526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.132905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-16T11:14:00.122557Z","caller":"traceutil/trace.go:171","msg":"trace[1317167174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24905; }","duration":"629.203637ms","start":"2026-06-16T11:13:59.493345Z","end":"2026-06-16T11:14:00.122549Z","steps":["trace[1317167174] 'agreement among raft nodes before linearized reading' (duration: 629.090925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:00.122593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:59.493329Z","time spent":"629.254878ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-16T11:14:00.122662Z","caller":"traceutil/trace.go:171","msg":"trace[37963859] transaction","detail":"{read_only:false; response_revision:24906; number_of_response:1; }","duration":"259.265778ms","start":"2026-06-16T11:13:59.863376Z","end":"2026-06-16T11:14:00.122642Z","steps":["trace[37963859] 'process raft request' (duration: 258.735388ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:00.182403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.058372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T11:14:00.182487Z","caller":"traceutil/trace.go:171","msg":"trace[975013567] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24906; }","duration":"368.206506ms","start":"2026-06-16T11:13:59.814258Z","end":"2026-06-16T11:14:00.182464Z","steps":["trace[975013567] 'agreement among raft nodes before linearized reading' (duration: 308.829703ms)","trace[975013567] 'range keys from in-memory index tree' (duration: 59.138508ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:00.182534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:59.81424Z","time spent":"368.283597ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-16T11:14:00.182524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.629246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:00.182633Z","caller":"traceutil/trace.go:171","msg":"trace[1571964667] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:24906; }","duration":"485.775589ms","start":"2026-06-16T11:13:59.696823Z","end":"2026-06-16T11:14:00.182598Z","steps":["trace[1571964667] 'agreement among raft nodes before linearized reading' (duration: 427.1089ms)","trace[1571964667] 'count revisions from in-memory index tree' (duration: 58.491497ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:00.182634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.07645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:00.182711Z","caller":"traceutil/trace.go:171","msg":"trace[358132335] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:24906; }","duration":"503.305715ms","start":"2026-06-16T11:13:59.679383Z","end":"2026-06-16T11:14:00.182688Z","steps":["trace[358132335] 'agreement among raft nodes before linearized reading' (duration: 443.234869ms)","trace[358132335] 'count revisions from in-memory index tree' (duration: 59.844812ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:00.182769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.481018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T11:14:00.182778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:59.679365Z","time spent":"503.400056ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true "} {"level":"info","ts":"2026-06-16T11:14:00.182831Z","caller":"traceutil/trace.go:171","msg":"trace[511228311] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:24906; }","duration":"404.569429ms","start":"2026-06-16T11:13:59.77824Z","end":"2026-06-16T11:14:00.18281Z","steps":["trace[511228311] 'agreement among raft nodes before linearized reading' (duration: 344.447412ms)","trace[511228311] 'count revisions from in-memory index tree' (duration: 60.028275ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:00.182882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:59.778222Z","time spent":"404.647061ms","remote":"127.0.0.1:54258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":0,"response size":29,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true "} {"level":"warn","ts":"2026-06-16T11:14:00.183507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:13:59.696813Z","time spent":"486.672976ms","remote":"127.0.0.1:58794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-06-16T11:14:00.497036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.420511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-16T11:14:00.497097Z","caller":"traceutil/trace.go:171","msg":"trace[1988970143] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24908; }","duration":"171.515983ms","start":"2026-06-16T11:14:00.325568Z","end":"2026-06-16T11:14:00.497084Z","steps":["trace[1988970143] 'range keys from in-memory index tree' (duration: 171.229988ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:00.66085Z","caller":"traceutil/trace.go:171","msg":"trace[1872595589] transaction","detail":"{read_only:false; response_revision:24909; number_of_response:1; }","duration":"160.501062ms","start":"2026-06-16T11:14:00.500331Z","end":"2026-06-16T11:14:00.660832Z","steps":["trace[1872595589] 'process raft request' (duration: 160.057734ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:00.809158Z","caller":"traceutil/trace.go:171","msg":"trace[263227783] transaction","detail":"{read_only:false; response_revision:24910; number_of_response:1; }","duration":"144.563119ms","start":"2026-06-16T11:14:00.664573Z","end":"2026-06-16T11:14:00.809136Z","steps":["trace[263227783] 'process raft request' (duration: 120.647312ms)","trace[263227783] 'compare' (duration: 23.647532ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:01.078236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.952441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-16T11:14:01.078305Z","caller":"traceutil/trace.go:171","msg":"trace[1715938840] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24910; }","duration":"129.064153ms","start":"2026-06-16T11:14:00.949223Z","end":"2026-06-16T11:14:01.078287Z","steps":["trace[1715938840] 'range keys from in-memory index tree' (duration: 128.802308ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:01.219017Z","caller":"traceutil/trace.go:171","msg":"trace[259348030] transaction","detail":"{read_only:false; response_revision:24911; number_of_response:1; }","duration":"131.02604ms","start":"2026-06-16T11:14:01.087959Z","end":"2026-06-16T11:14:01.218985Z","steps":["trace[259348030] 'process raft request' (duration: 130.766765ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:01.22008Z","caller":"traceutil/trace.go:171","msg":"trace[1703659440] transaction","detail":"{read_only:false; response_revision:24912; number_of_response:1; }","duration":"131.464878ms","start":"2026-06-16T11:14:01.088587Z","end":"2026-06-16T11:14:01.220051Z","steps":["trace[1703659440] 'process raft request' (duration: 131.338085ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:01.391837Z","caller":"traceutil/trace.go:171","msg":"trace[1827700564] transaction","detail":"{read_only:false; response_revision:24913; number_of_response:1; }","duration":"126.948143ms","start":"2026-06-16T11:14:01.264859Z","end":"2026-06-16T11:14:01.391807Z","steps":["trace[1827700564] 'process raft request' (duration: 125.461944ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:02.117861Z","caller":"traceutil/trace.go:171","msg":"trace[1457083365] transaction","detail":"{read_only:false; response_revision:24915; number_of_response:1; }","duration":"141.935029ms","start":"2026-06-16T11:14:01.975859Z","end":"2026-06-16T11:14:02.117794Z","steps":["trace[1457083365] 'process raft request' (duration: 141.738795ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:02.449496Z","caller":"traceutil/trace.go:171","msg":"trace[1012900733] linearizableReadLoop","detail":"{readStateIndex:25735; appliedIndex:25729; }","duration":"451.056597ms","start":"2026-06-16T11:14:01.998365Z","end":"2026-06-16T11:14:02.449421Z","steps":["trace[1012900733] 'read index received' (duration: 119.226176ms)","trace[1012900733] 'applied index is now lower than readState.Index' (duration: 331.829701ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:02.449743Z","caller":"traceutil/trace.go:171","msg":"trace[1313194741] transaction","detail":"{read_only:false; response_revision:24916; number_of_response:1; }","duration":"473.143527ms","start":"2026-06-16T11:14:01.976586Z","end":"2026-06-16T11:14:02.449729Z","steps":["trace[1313194741] 'process raft request' (duration: 381.362587ms)","trace[1313194741] 'compare' (duration: 91.053196ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:02.449849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:01.976576Z","time spent":"473.205058ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:14:02.450016Z","caller":"traceutil/trace.go:171","msg":"trace[1097571754] transaction","detail":"{read_only:false; response_revision:24917; number_of_response:1; }","duration":"473.24243ms","start":"2026-06-16T11:14:01.976764Z","end":"2026-06-16T11:14:02.450007Z","steps":["trace[1097571754] 'process raft request' (duration: 472.489825ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:02.450078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:01.976735Z","time spent":"473.310571ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:14:02.450196Z","caller":"traceutil/trace.go:171","msg":"trace[1217845194] transaction","detail":"{read_only:false; response_revision:24918; number_of_response:1; }","duration":"472.281463ms","start":"2026-06-16T11:14:01.977904Z","end":"2026-06-16T11:14:02.450186Z","steps":["trace[1217845194] 'process raft request' (duration: 471.395175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:02.45025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:01.977894Z","time spent":"472.329763ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:14:02.450447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.491115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:02.450546Z","caller":"traceutil/trace.go:171","msg":"trace[2541427] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:24920; }","duration":"277.636738ms","start":"2026-06-16T11:14:02.172886Z","end":"2026-06-16T11:14:02.450523Z","steps":["trace[2541427] 'agreement among raft nodes before linearized reading' (duration: 277.440194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:02.450963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.597187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-06-16T11:14:02.451011Z","caller":"traceutil/trace.go:171","msg":"trace[1410365727] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24920; }","duration":"452.663688ms","start":"2026-06-16T11:14:01.998334Z","end":"2026-06-16T11:14:02.450998Z","steps":["trace[1410365727] 'agreement among raft nodes before linearized reading' (duration: 452.535466ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:02.451047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:01.998323Z","time spent":"452.716769ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":585,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-06-16T11:14:02.451165Z","caller":"traceutil/trace.go:171","msg":"trace[711154637] transaction","detail":"{read_only:false; response_revision:24919; number_of_response:1; }","duration":"472.720951ms","start":"2026-06-16T11:14:01.978434Z","end":"2026-06-16T11:14:02.451155Z","steps":["trace[711154637] 'process raft request' (duration: 470.901736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:02.451226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:01.978419Z","time spent":"472.774902ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:14:02.451341Z","caller":"traceutil/trace.go:171","msg":"trace[622048305] transaction","detail":"{read_only:false; response_revision:24920; number_of_response:1; }","duration":"472.555677ms","start":"2026-06-16T11:14:01.978776Z","end":"2026-06-16T11:14:02.451332Z","steps":["trace[622048305] 'process raft request' (duration: 470.6085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:02.451396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:01.978764Z","time spent":"472.604528ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:14:02.45182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.763408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T11:14:02.451943Z","caller":"traceutil/trace.go:171","msg":"trace[382728831] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24920; }","duration":"236.849649ms","start":"2026-06-16T11:14:02.215003Z","end":"2026-06-16T11:14:02.451852Z","steps":["trace[382728831] 'agreement among raft nodes before linearized reading' (duration: 236.719996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:02.452444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.414514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-16T11:14:02.452485Z","caller":"traceutil/trace.go:171","msg":"trace[1812618348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24920; }","duration":"265.484775ms","start":"2026-06-16T11:14:02.186991Z","end":"2026-06-16T11:14:02.452476Z","steps":["trace[1812618348] 'agreement among raft nodes before linearized reading' (duration: 265.388743ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:02.809243Z","caller":"traceutil/trace.go:171","msg":"trace[717972486] transaction","detail":"{read_only:false; response_revision:24924; number_of_response:1; }","duration":"117.743617ms","start":"2026-06-16T11:14:02.691474Z","end":"2026-06-16T11:14:02.809217Z","steps":["trace[717972486] 'process raft request' (duration: 117.524663ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:02.80987Z","caller":"traceutil/trace.go:171","msg":"trace[272153007] linearizableReadLoop","detail":"{readStateIndex:25739; appliedIndex:25739; }","duration":"117.731396ms","start":"2026-06-16T11:14:02.692119Z","end":"2026-06-16T11:14:02.80985Z","steps":["trace[272153007] 'read index received' (duration: 117.725316ms)","trace[272153007] 'applied index is now lower than readState.Index' (duration: 4.93µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:02.810071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.929421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-16T11:14:02.810134Z","caller":"traceutil/trace.go:171","msg":"trace[2028161401] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24924; }","duration":"118.024162ms","start":"2026-06-16T11:14:02.692093Z","end":"2026-06-16T11:14:02.810117Z","steps":["trace[2028161401] 'agreement among raft nodes before linearized reading' (duration: 117.830498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:03.073241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.412066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T11:14:03.073349Z","caller":"traceutil/trace.go:171","msg":"trace[105024740] linearizableReadLoop","detail":"{readStateIndex:25740; appliedIndex:25739; }","duration":"184.273596ms","start":"2026-06-16T11:14:02.889059Z","end":"2026-06-16T11:14:03.073333Z","steps":["trace[105024740] 'read index received' (duration: 39.687867ms)","trace[105024740] 'applied index is now lower than readState.Index' (duration: 144.584329ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:03.073378Z","caller":"traceutil/trace.go:171","msg":"trace[1719092813] transaction","detail":"{read_only:false; response_revision:24925; number_of_response:1; }","duration":"255.113088ms","start":"2026-06-16T11:14:02.818235Z","end":"2026-06-16T11:14:03.073348Z","steps":["trace[1719092813] 'process raft request' (duration: 110.496478ms)","trace[1719092813] 'compare' (duration: 144.232363ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:03.073457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.372318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:03.073494Z","caller":"traceutil/trace.go:171","msg":"trace[450495830] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24925; }","duration":"184.453159ms","start":"2026-06-16T11:14:02.88903Z","end":"2026-06-16T11:14:03.073483Z","steps":["trace[450495830] 'agreement among raft nodes before linearized reading' (duration: 184.367838ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:03.228655Z","caller":"traceutil/trace.go:171","msg":"trace[1957275323] linearizableReadLoop","detail":"{readStateIndex:25741; appliedIndex:25740; }","duration":"155.260422ms","start":"2026-06-16T11:14:03.073375Z","end":"2026-06-16T11:14:03.228635Z","steps":["trace[1957275323] 'read index received' (duration: 155.038438ms)","trace[1957275323] 'applied index is now lower than readState.Index' (duration: 221.174µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:03.228764Z","caller":"traceutil/trace.go:171","msg":"trace[1336938652] transaction","detail":"{read_only:false; response_revision:24926; number_of_response:1; }","duration":"230.279194ms","start":"2026-06-16T11:14:02.998434Z","end":"2026-06-16T11:14:03.228713Z","steps":["trace[1336938652] 'process raft request' (duration: 230.040999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:03.228863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.255417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T11:14:03.228918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.73771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-16T11:14:03.228963Z","caller":"traceutil/trace.go:171","msg":"trace[1363572497] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:24926; }","duration":"168.835912ms","start":"2026-06-16T11:14:03.060116Z","end":"2026-06-16T11:14:03.228952Z","steps":["trace[1363572497] 'agreement among raft nodes before linearized reading' (duration: 168.650499ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:03.228925Z","caller":"traceutil/trace.go:171","msg":"trace[1669216063] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24926; }","duration":"139.36958ms","start":"2026-06-16T11:14:03.089541Z","end":"2026-06-16T11:14:03.22891Z","steps":["trace[1669216063] 'agreement among raft nodes before linearized reading' (duration: 139.261648ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:03.361933Z","caller":"traceutil/trace.go:171","msg":"trace[614855982] linearizableReadLoop","detail":"{readStateIndex:25742; appliedIndex:25741; }","duration":"120.944158ms","start":"2026-06-16T11:14:03.240964Z","end":"2026-06-16T11:14:03.361908Z","steps":["trace[614855982] 'read index received' (duration: 90.217192ms)","trace[614855982] 'applied index is now lower than readState.Index' (duration: 30.726166ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:03.362037Z","caller":"traceutil/trace.go:171","msg":"trace[1073678985] transaction","detail":"{read_only:false; response_revision:24927; number_of_response:1; }","duration":"126.400812ms","start":"2026-06-16T11:14:03.235561Z","end":"2026-06-16T11:14:03.361962Z","steps":["trace[1073678985] 'process raft request' (duration: 95.683506ms)","trace[1073678985] 'compare' (duration: 30.521333ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:03.362114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.123251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-06-16T11:14:03.362156Z","caller":"traceutil/trace.go:171","msg":"trace[331196248] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:24927; }","duration":"121.213323ms","start":"2026-06-16T11:14:03.240926Z","end":"2026-06-16T11:14:03.36214Z","steps":["trace[331196248] 'agreement among raft nodes before linearized reading' (duration: 121.06634ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:11.052128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.530692ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T11:14:11.052602Z","caller":"traceutil/trace.go:171","msg":"trace[958171620] transaction","detail":"{read_only:false; response_revision:24984; number_of_response:1; }","duration":"538.387683ms","start":"2026-06-16T11:14:10.514188Z","end":"2026-06-16T11:14:11.052576Z","steps":["trace[958171620] 'process raft request' (duration: 256.326751ms)","trace[958171620] 'compare' (duration: 281.368539ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:11.052703Z","caller":"traceutil/trace.go:171","msg":"trace[186766800] linearizableReadLoop","detail":"{readStateIndex:25802; appliedIndex:25800; }","duration":"511.50333ms","start":"2026-06-16T11:14:10.541175Z","end":"2026-06-16T11:14:11.052678Z","steps":["trace[186766800] 'read index received' (duration: 229.350947ms)","trace[186766800] 'applied index is now lower than readState.Index' (duration: 282.151473ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:11.052727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:10.51416Z","time spent":"538.499735ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:14:11.052815Z","caller":"traceutil/trace.go:171","msg":"trace[57541067] transaction","detail":"{read_only:false; response_revision:24985; number_of_response:1; }","duration":"538.141489ms","start":"2026-06-16T11:14:10.514631Z","end":"2026-06-16T11:14:11.052772Z","steps":["trace[57541067] 'process raft request' (duration: 537.597769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:11.052887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.708254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:11.052929Z","caller":"traceutil/trace.go:171","msg":"trace[2075940363] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:24985; }","duration":"511.758274ms","start":"2026-06-16T11:14:10.541158Z","end":"2026-06-16T11:14:11.052917Z","steps":["trace[2075940363] 'agreement among raft nodes before linearized reading' (duration: 511.674043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:11.052979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:10.541099Z","time spent":"511.868317ms","remote":"127.0.0.1:33812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-06-16T11:14:11.052988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:10.514617Z","time spent":"538.289341ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:14:11.053072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.820709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T11:14:11.05311Z","caller":"traceutil/trace.go:171","msg":"trace[333362893] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:24985; }","duration":"464.909561ms","start":"2026-06-16T11:14:10.588189Z","end":"2026-06-16T11:14:11.053099Z","steps":["trace[333362893] 'agreement among raft nodes before linearized reading' (duration: 464.791169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:11.053133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:10.588166Z","time spent":"464.962202ms","remote":"127.0.0.1:58116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":90,"response size":31,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-06-16T11:14:11.053315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.232903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-16T11:14:11.05341Z","caller":"traceutil/trace.go:171","msg":"trace[586147282] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24985; }","duration":"198.360165ms","start":"2026-06-16T11:14:10.855027Z","end":"2026-06-16T11:14:11.053387Z","steps":["trace[586147282] 'agreement among raft nodes before linearized reading' (duration: 198.07015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:11.619873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.858776ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T11:14:11.619979Z","caller":"traceutil/trace.go:171","msg":"trace[902471382] linearizableReadLoop","detail":"{readStateIndex:25804; appliedIndex:25803; }","duration":"225.803319ms","start":"2026-06-16T11:14:11.394159Z","end":"2026-06-16T11:14:11.619962Z","steps":["trace[902471382] 'read index received' (duration: 35.09µs)","trace[902471382] 'applied index is now lower than readState.Index' (duration: 225.766989ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:11.620056Z","caller":"traceutil/trace.go:171","msg":"trace[499320484] transaction","detail":"{read_only:false; response_revision:24987; number_of_response:1; }","duration":"488.502801ms","start":"2026-06-16T11:14:11.131542Z","end":"2026-06-16T11:14:11.620044Z","steps":["trace[499320484] 'process raft request' (duration: 204.395861ms)","trace[499320484] 'compare' (duration: 283.53164ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:11.620115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:11.131526Z","time spent":"488.555992ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:14:11.620453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.280888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-16T11:14:11.620523Z","caller":"traceutil/trace.go:171","msg":"trace[556136599] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24987; }","duration":"226.39821ms","start":"2026-06-16T11:14:11.394107Z","end":"2026-06-16T11:14:11.620505Z","steps":["trace[556136599] 'agreement among raft nodes before linearized reading' (duration: 226.153156ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:11.640643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.919645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/projects/\" range_end:\"/registry/openstack.k-orc.cloud/projects0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:11.640726Z","caller":"traceutil/trace.go:171","msg":"trace[1584158871] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/projects/; range_end:/registry/openstack.k-orc.cloud/projects0; response_count:0; response_revision:24988; }","duration":"244.056967ms","start":"2026-06-16T11:14:11.396654Z","end":"2026-06-16T11:14:11.640711Z","steps":["trace[1584158871] 'agreement among raft nodes before linearized reading' (duration: 243.904094ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:11.640883Z","caller":"traceutil/trace.go:171","msg":"trace[1116257256] transaction","detail":"{read_only:false; response_revision:24988; number_of_response:1; }","duration":"200.164559ms","start":"2026-06-16T11:14:11.440693Z","end":"2026-06-16T11:14:11.640858Z","steps":["trace[1116257256] 'process raft request' (duration: 199.741971ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:11.910668Z","caller":"traceutil/trace.go:171","msg":"trace[1849500760] linearizableReadLoop","detail":"{readStateIndex:25806; appliedIndex:25805; }","duration":"219.849296ms","start":"2026-06-16T11:14:11.690794Z","end":"2026-06-16T11:14:11.910644Z","steps":["trace[1849500760] 'read index received' (duration: 219.784395ms)","trace[1849500760] 'applied index is now lower than readState.Index' (duration: 63.621µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:11.910721Z","caller":"traceutil/trace.go:171","msg":"trace[357999666] transaction","detail":"{read_only:false; response_revision:24989; number_of_response:1; }","duration":"284.835855ms","start":"2026-06-16T11:14:11.625831Z","end":"2026-06-16T11:14:11.910666Z","steps":["trace[357999666] 'process raft request' (duration: 284.686553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:11.910834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.016879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:11.910962Z","caller":"traceutil/trace.go:171","msg":"trace[1996176804] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:24989; }","duration":"220.196562ms","start":"2026-06-16T11:14:11.690739Z","end":"2026-06-16T11:14:11.910936Z","steps":["trace[1996176804] 'agreement among raft nodes before linearized reading' (duration: 219.995189ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:12.216785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.635966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:12.21695Z","caller":"traceutil/trace.go:171","msg":"trace[2095886376] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:24990; }","duration":"137.806429ms","start":"2026-06-16T11:14:12.079085Z","end":"2026-06-16T11:14:12.216891Z","steps":["trace[2095886376] 'count revisions from in-memory index tree' (duration: 137.558445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:12.217062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.925942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:12.217157Z","caller":"traceutil/trace.go:171","msg":"trace[1133995392] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:24990; }","duration":"139.075834ms","start":"2026-06-16T11:14:12.078058Z","end":"2026-06-16T11:14:12.217133Z","steps":["trace[1133995392] 'count revisions from in-memory index tree' (duration: 138.855561ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:12.820304Z","caller":"traceutil/trace.go:171","msg":"trace[1288531869] transaction","detail":"{read_only:false; response_revision:24993; number_of_response:1; }","duration":"334.38376ms","start":"2026-06-16T11:14:12.48589Z","end":"2026-06-16T11:14:12.820273Z","steps":["trace[1288531869] 'process raft request' (duration: 331.303042ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:12.820454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:12.485856Z","time spent":"334.521712ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:14:12.82065Z","caller":"traceutil/trace.go:171","msg":"trace[985376597] transaction","detail":"{read_only:false; response_revision:24996; number_of_response:1; }","duration":"330.297443ms","start":"2026-06-16T11:14:12.490329Z","end":"2026-06-16T11:14:12.820627Z","steps":["trace[985376597] 'process raft request' (duration: 330.254981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:12.82078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:12.490314Z","time spent":"330.395234ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:14:12.820898Z","caller":"traceutil/trace.go:171","msg":"trace[715201179] transaction","detail":"{read_only:false; response_revision:24995; number_of_response:1; }","duration":"331.414895ms","start":"2026-06-16T11:14:12.489474Z","end":"2026-06-16T11:14:12.820889Z","steps":["trace[715201179] 'process raft request' (duration: 331.070767ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:12.82095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:12.489457Z","time spent":"331.460755ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:14:12.821506Z","caller":"traceutil/trace.go:171","msg":"trace[330350762] transaction","detail":"{read_only:false; response_revision:24994; number_of_response:1; }","duration":"334.636665ms","start":"2026-06-16T11:14:12.486718Z","end":"2026-06-16T11:14:12.821355Z","steps":["trace[330350762] 'process raft request' (duration: 333.513463ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:12.821827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:12.486709Z","time spent":"334.872561ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:14:19.123879Z","caller":"traceutil/trace.go:171","msg":"trace[431741512] linearizableReadLoop","detail":"{readStateIndex:25916; appliedIndex:25915; }","duration":"298.574707ms","start":"2026-06-16T11:14:18.82527Z","end":"2026-06-16T11:14:19.123844Z","steps":["trace[431741512] 'read index received' (duration: 298.25194ms)","trace[431741512] 'applied index is now lower than readState.Index' (duration: 321.177µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:19.123964Z","caller":"traceutil/trace.go:171","msg":"trace[1497431379] transaction","detail":"{read_only:false; response_revision:25098; number_of_response:1; }","duration":"342.863623ms","start":"2026-06-16T11:14:18.781068Z","end":"2026-06-16T11:14:19.123931Z","steps":["trace[1497431379] 'process raft request' (duration: 342.536046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:19.124133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:18.781048Z","time spent":"342.984095ms","remote":"127.0.0.1:58134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3743,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:14:19.124136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.821153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-27c55eaa-3ba4-489d-9236-3ff6cbdc090b\" ","response":"range_response_count:1 size:3761"} {"level":"info","ts":"2026-06-16T11:14:19.124205Z","caller":"traceutil/trace.go:171","msg":"trace[1041979383] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-27c55eaa-3ba4-489d-9236-3ff6cbdc090b; range_end:; response_count:1; response_revision:25098; }","duration":"298.924975ms","start":"2026-06-16T11:14:18.82526Z","end":"2026-06-16T11:14:19.124185Z","steps":["trace[1041979383] 'agreement among raft nodes before linearized reading' (duration: 298.774532ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:19.423051Z","caller":"traceutil/trace.go:171","msg":"trace[436465915] transaction","detail":"{read_only:false; response_revision:25099; number_of_response:1; }","duration":"583.845821ms","start":"2026-06-16T11:14:18.83918Z","end":"2026-06-16T11:14:19.423026Z","steps":["trace[436465915] 'process raft request' (duration: 528.400323ms)","trace[436465915] 'compare' (duration: 55.204633ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:19.423189Z","caller":"traceutil/trace.go:171","msg":"trace[2042030746] transaction","detail":"{read_only:false; response_revision:25100; number_of_response:1; }","duration":"583.252599ms","start":"2026-06-16T11:14:18.839893Z","end":"2026-06-16T11:14:19.423145Z","steps":["trace[2042030746] 'process raft request' (duration: 583.081876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:19.423189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:18.839149Z","time spent":"583.968562ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:14:19.423241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:18.83987Z","time spent":"583.344201ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:14:19.423613Z","caller":"traceutil/trace.go:171","msg":"trace[342240648] transaction","detail":"{read_only:false; response_revision:25101; number_of_response:1; }","duration":"581.854212ms","start":"2026-06-16T11:14:18.841751Z","end":"2026-06-16T11:14:19.423605Z","steps":["trace[342240648] 'process raft request' (duration: 581.361112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:19.423675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:18.841739Z","time spent":"581.901664ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:14:19.423732Z","caller":"traceutil/trace.go:171","msg":"trace[1888616419] linearizableReadLoop","detail":"{readStateIndex:25920; appliedIndex:25916; }","duration":"299.706119ms","start":"2026-06-16T11:14:19.123992Z","end":"2026-06-16T11:14:19.423698Z","steps":["trace[1888616419] 'read index received' (duration: 243.586498ms)","trace[1888616419] 'applied index is now lower than readState.Index' (duration: 56.118681ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:19.423764Z","caller":"traceutil/trace.go:171","msg":"trace[1575871856] transaction","detail":"{read_only:false; response_revision:25102; number_of_response:1; }","duration":"581.911644ms","start":"2026-06-16T11:14:18.841825Z","end":"2026-06-16T11:14:19.423736Z","steps":["trace[1575871856] 'process raft request' (duration: 581.751341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:19.423903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.226223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-06-16T11:14:19.423932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.756503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-16T11:14:19.423964Z","caller":"traceutil/trace.go:171","msg":"trace[1663250613] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25102; }","duration":"329.845194ms","start":"2026-06-16T11:14:19.094111Z","end":"2026-06-16T11:14:19.423956Z","steps":["trace[1663250613] 'agreement among raft nodes before linearized reading' (duration: 329.708512ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:19.423957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.576262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T11:14:19.423984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:19.09409Z","time spent":"329.890436ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-16T11:14:19.423936Z","caller":"traceutil/trace.go:171","msg":"trace[1487724924] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25102; }","duration":"328.261675ms","start":"2026-06-16T11:14:19.095666Z","end":"2026-06-16T11:14:19.423927Z","steps":["trace[1487724924] 'agreement among raft nodes before linearized reading' (duration: 328.064571ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:19.423976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.356741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:19.423997Z","caller":"traceutil/trace.go:171","msg":"trace[100126775] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25102; }","duration":"195.620173ms","start":"2026-06-16T11:14:19.228366Z","end":"2026-06-16T11:14:19.423986Z","steps":["trace[100126775] 'agreement among raft nodes before linearized reading' (duration: 195.549271ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:19.423985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:18.841797Z","time spent":"582.070097ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:14:19.424017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:19.095586Z","time spent":"328.422468ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-16T11:14:19.424026Z","caller":"traceutil/trace.go:171","msg":"trace[1137230254] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25102; }","duration":"258.462553ms","start":"2026-06-16T11:14:19.16555Z","end":"2026-06-16T11:14:19.424012Z","steps":["trace[1137230254] 'agreement among raft nodes before linearized reading' (duration: 258.378412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:19.424022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.525479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-16T11:14:19.424068Z","caller":"traceutil/trace.go:171","msg":"trace[1445530250] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25102; }","duration":"274.63275ms","start":"2026-06-16T11:14:19.149422Z","end":"2026-06-16T11:14:19.424055Z","steps":["trace[1445530250] 'agreement among raft nodes before linearized reading' (duration: 274.464667ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:19.67899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.839557ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T11:14:19.679181Z","caller":"traceutil/trace.go:171","msg":"trace[49436161] linearizableReadLoop","detail":"{readStateIndex:25923; appliedIndex:25921; }","duration":"247.828679ms","start":"2026-06-16T11:14:19.431335Z","end":"2026-06-16T11:14:19.679164Z","steps":["trace[49436161] 'read index received' (duration: 81.391933ms)","trace[49436161] 'applied index is now lower than readState.Index' (duration: 166.435786ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:19.679241Z","caller":"traceutil/trace.go:171","msg":"trace[1673647518] transaction","detail":"{read_only:false; response_revision:25104; number_of_response:1; }","duration":"248.888019ms","start":"2026-06-16T11:14:19.430343Z","end":"2026-06-16T11:14:19.679231Z","steps":["trace[1673647518] 'process raft request' (duration: 138.734626ms)","trace[1673647518] 'compare' (duration: 109.544121ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:19.679266Z","caller":"traceutil/trace.go:171","msg":"trace[874863985] transaction","detail":"{read_only:false; response_revision:25105; number_of_response:1; }","duration":"248.801457ms","start":"2026-06-16T11:14:19.430445Z","end":"2026-06-16T11:14:19.679246Z","steps":["trace[874863985] 'process raft request' (duration: 248.631784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:19.679479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.138905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:19.679524Z","caller":"traceutil/trace.go:171","msg":"trace[132312552] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25105; }","duration":"248.217137ms","start":"2026-06-16T11:14:19.431293Z","end":"2026-06-16T11:14:19.67951Z","steps":["trace[132312552] 'agreement among raft nodes before linearized reading' (duration: 248.129665ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:19.722741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.31085ms","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:6"} {"level":"info","ts":"2026-06-16T11:14:19.722813Z","caller":"traceutil/trace.go:171","msg":"trace[793362602] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:25106; }","duration":"257.405261ms","start":"2026-06-16T11:14:19.465392Z","end":"2026-06-16T11:14:19.722798Z","steps":["trace[793362602] 'agreement among raft nodes before linearized reading' (duration: 257.280099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:19.722739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.934126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs/\" range_end:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:19.722941Z","caller":"traceutil/trace.go:171","msg":"trace[713579068] range","detail":"{range_begin:/registry/runtime.cluster.x-k8s.io/extensionconfigs/; range_end:/registry/runtime.cluster.x-k8s.io/extensionconfigs0; response_count:0; response_revision:25106; }","duration":"101.179751ms","start":"2026-06-16T11:14:19.621733Z","end":"2026-06-16T11:14:19.722913Z","steps":["trace[713579068] 'agreement among raft nodes before linearized reading' (duration: 100.915656ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:20.076217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.120357ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-16T11:14:20.076512Z","caller":"traceutil/trace.go:171","msg":"trace[1756540599] linearizableReadLoop","detail":"{readStateIndex:25925; appliedIndex:25924; }","duration":"353.936024ms","start":"2026-06-16T11:14:19.722546Z","end":"2026-06-16T11:14:20.076482Z","steps":["trace[1756540599] 'read index received' (duration: 129.623414ms)","trace[1756540599] 'applied index is now lower than readState.Index' (duration: 224.30695ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:20.076523Z","caller":"traceutil/trace.go:171","msg":"trace[564490357] transaction","detail":"{read_only:false; response_revision:25107; number_of_response:1; }","duration":"349.843655ms","start":"2026-06-16T11:14:19.726654Z","end":"2026-06-16T11:14:20.076497Z","steps":["trace[564490357] 'process raft request' (duration: 349.652882ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:20.076632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:19.726598Z","time spent":"349.979978ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:14:20.125407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.121497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:20.125478Z","caller":"traceutil/trace.go:171","msg":"trace[310385489] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25107; }","duration":"442.257519ms","start":"2026-06-16T11:14:19.683198Z","end":"2026-06-16T11:14:20.125456Z","steps":["trace[310385489] 'agreement among raft nodes before linearized reading' (duration: 393.366977ms)","trace[310385489] 'range keys from in-memory index tree' (duration: 48.77323ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:20.125512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:19.68318Z","time spent":"442.32473ms","remote":"127.0.0.1:58222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" "} {"level":"info","ts":"2026-06-16T11:14:20.159422Z","caller":"traceutil/trace.go:171","msg":"trace[1411389904] transaction","detail":"{read_only:false; response_revision:25108; number_of_response:1; }","duration":"213.374041ms","start":"2026-06-16T11:14:19.946022Z","end":"2026-06-16T11:14:20.159396Z","steps":["trace[1411389904] 'process raft request' (duration: 212.980544ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:20.159447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.242801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-16T11:14:20.159507Z","caller":"traceutil/trace.go:171","msg":"trace[1063528925] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25108; }","duration":"210.333994ms","start":"2026-06-16T11:14:19.94916Z","end":"2026-06-16T11:14:20.159494Z","steps":["trace[1063528925] 'agreement among raft nodes before linearized reading' (duration: 210.11892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:20.159559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.569392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-06-16T11:14:20.159647Z","caller":"traceutil/trace.go:171","msg":"trace[837312196] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25108; }","duration":"357.692075ms","start":"2026-06-16T11:14:19.801934Z","end":"2026-06-16T11:14:20.159626Z","steps":["trace[837312196] 'agreement among raft nodes before linearized reading' (duration: 357.43163ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:20.159693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:14:19.801918Z","time spent":"357.766086ms","remote":"127.0.0.1:40634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":3332,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"info","ts":"2026-06-16T11:14:22.212887Z","caller":"traceutil/trace.go:171","msg":"trace[890313294] transaction","detail":"{read_only:false; response_revision:25125; number_of_response:1; }","duration":"128.213557ms","start":"2026-06-16T11:14:22.084642Z","end":"2026-06-16T11:14:22.212856Z","steps":["trace[890313294] 'process raft request' (duration: 127.995782ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:26.838586Z","caller":"traceutil/trace.go:171","msg":"trace[3884482] transaction","detail":"{read_only:false; response_revision:25181; number_of_response:1; }","duration":"261.749314ms","start":"2026-06-16T11:14:26.576812Z","end":"2026-06-16T11:14:26.838561Z","steps":["trace[3884482] 'process raft request' (duration: 261.599571ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:27.059057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.13781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:27.059145Z","caller":"traceutil/trace.go:171","msg":"trace[2110435864] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:25181; }","duration":"122.236562ms","start":"2026-06-16T11:14:26.936888Z","end":"2026-06-16T11:14:27.059124Z","steps":["trace[2110435864] 'count revisions from in-memory index tree' (duration: 122.026799ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:30.277186Z","caller":"traceutil/trace.go:171","msg":"trace[716877435] linearizableReadLoop","detail":"{readStateIndex:26031; appliedIndex:26030; }","duration":"102.758171ms","start":"2026-06-16T11:14:30.174401Z","end":"2026-06-16T11:14:30.277159Z","steps":["trace[716877435] 'read index received' (duration: 102.603019ms)","trace[716877435] 'applied index is now lower than readState.Index' (duration: 154.112µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:30.27721Z","caller":"traceutil/trace.go:171","msg":"trace[1439982116] transaction","detail":"{read_only:false; response_revision:25210; number_of_response:1; }","duration":"129.043142ms","start":"2026-06-16T11:14:30.148141Z","end":"2026-06-16T11:14:30.277184Z","steps":["trace[1439982116] 'process raft request' (duration: 128.829578ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:30.277313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.896854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:30.277344Z","caller":"traceutil/trace.go:171","msg":"trace[334320904] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25210; }","duration":"103.005036ms","start":"2026-06-16T11:14:30.174331Z","end":"2026-06-16T11:14:30.277336Z","steps":["trace[334320904] 'agreement among raft nodes before linearized reading' (duration: 102.921624ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:33.585351Z","caller":"traceutil/trace.go:171","msg":"trace[2071035597] transaction","detail":"{read_only:false; response_revision:25234; number_of_response:1; }","duration":"113.758631ms","start":"2026-06-16T11:14:33.471567Z","end":"2026-06-16T11:14:33.585326Z","steps":["trace[2071035597] 'process raft request' (duration: 101.245241ms)","trace[2071035597] 'compare' (duration: 12.373687ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:33.585538Z","caller":"traceutil/trace.go:171","msg":"trace[471660062] transaction","detail":"{read_only:false; response_revision:25235; number_of_response:1; }","duration":"113.835212ms","start":"2026-06-16T11:14:33.471696Z","end":"2026-06-16T11:14:33.585531Z","steps":["trace[471660062] 'process raft request' (duration: 113.597858ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:33.585799Z","caller":"traceutil/trace.go:171","msg":"trace[200279870] transaction","detail":"{read_only:false; response_revision:25236; number_of_response:1; }","duration":"113.095618ms","start":"2026-06-16T11:14:33.47268Z","end":"2026-06-16T11:14:33.585776Z","steps":["trace[200279870] 'process raft request' (duration: 112.826273ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:50.515881Z","caller":"traceutil/trace.go:171","msg":"trace[1545428849] transaction","detail":"{read_only:false; response_revision:25373; number_of_response:1; }","duration":"131.683862ms","start":"2026-06-16T11:14:50.384175Z","end":"2026-06-16T11:14:50.515859Z","steps":["trace[1545428849] 'process raft request' (duration: 131.548469ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:50.516166Z","caller":"traceutil/trace.go:171","msg":"trace[113732693] linearizableReadLoop","detail":"{readStateIndex:26199; appliedIndex:26199; }","duration":"130.894337ms","start":"2026-06-16T11:14:50.385234Z","end":"2026-06-16T11:14:50.516129Z","steps":["trace[113732693] 'read index received' (duration: 130.879667ms)","trace[113732693] 'applied index is now lower than readState.Index' (duration: 12.25µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:50.516404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.145032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3308"} {"level":"info","ts":"2026-06-16T11:14:50.516461Z","caller":"traceutil/trace.go:171","msg":"trace[1445443641] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25373; }","duration":"131.242894ms","start":"2026-06-16T11:14:50.385202Z","end":"2026-06-16T11:14:50.516445Z","steps":["trace[1445443641] 'agreement among raft nodes before linearized reading' (duration: 131.055601ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:50.526396Z","caller":"traceutil/trace.go:171","msg":"trace[466928337] transaction","detail":"{read_only:false; response_revision:25374; number_of_response:1; }","duration":"139.094633ms","start":"2026-06-16T11:14:50.38727Z","end":"2026-06-16T11:14:50.526365Z","steps":["trace[466928337] 'process raft request' (duration: 138.836558ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:50.700664Z","caller":"traceutil/trace.go:171","msg":"trace[1756846378] linearizableReadLoop","detail":"{readStateIndex:26202; appliedIndex:26200; }","duration":"169.869461ms","start":"2026-06-16T11:14:50.53076Z","end":"2026-06-16T11:14:50.70063Z","steps":["trace[1756846378] 'read index received' (duration: 109.411748ms)","trace[1756846378] 'applied index is now lower than readState.Index' (duration: 60.456443ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:50.700835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.055296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:50.700885Z","caller":"traceutil/trace.go:171","msg":"trace[473456126] range","detail":"{range_begin:/registry/resourcequotas/openstack/; range_end:/registry/resourcequotas/openstack0; response_count:0; response_revision:25376; }","duration":"170.128797ms","start":"2026-06-16T11:14:50.530743Z","end":"2026-06-16T11:14:50.700871Z","steps":["trace[473456126] 'agreement among raft nodes before linearized reading' (duration: 170.021915ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:50.701Z","caller":"traceutil/trace.go:171","msg":"trace[1679981859] transaction","detail":"{read_only:false; response_revision:25375; number_of_response:1; }","duration":"170.939272ms","start":"2026-06-16T11:14:50.530045Z","end":"2026-06-16T11:14:50.700985Z","steps":["trace[1679981859] 'process raft request' (duration: 110.154652ms)","trace[1679981859] 'compare' (duration: 59.947413ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:50.70109Z","caller":"traceutil/trace.go:171","msg":"trace[1256844894] transaction","detail":"{read_only:false; response_revision:25376; number_of_response:1; }","duration":"170.624167ms","start":"2026-06-16T11:14:50.530454Z","end":"2026-06-16T11:14:50.701078Z","steps":["trace[1256844894] 'process raft request' (duration: 170.113866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:51.203539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.533417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T11:14:51.203646Z","caller":"traceutil/trace.go:171","msg":"trace[751349800] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:25377; }","duration":"199.69191ms","start":"2026-06-16T11:14:51.003929Z","end":"2026-06-16T11:14:51.203621Z","steps":["trace[751349800] 'count revisions from in-memory index tree' (duration: 199.414045ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:51.814843Z","caller":"traceutil/trace.go:171","msg":"trace[1165887622] transaction","detail":"{read_only:false; response_revision:25378; number_of_response:1; }","duration":"193.557773ms","start":"2026-06-16T11:14:51.621266Z","end":"2026-06-16T11:14:51.814824Z","steps":["trace[1165887622] 'process raft request' (duration: 193.435351ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:51.839876Z","caller":"traceutil/trace.go:171","msg":"trace[1118120659] transaction","detail":"{read_only:false; response_revision:25379; number_of_response:1; }","duration":"200.802502ms","start":"2026-06-16T11:14:51.63905Z","end":"2026-06-16T11:14:51.839852Z","steps":["trace[1118120659] 'process raft request' (duration: 200.65504ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:51.840147Z","caller":"traceutil/trace.go:171","msg":"trace[82780829] linearizableReadLoop","detail":"{readStateIndex:26207; appliedIndex:26203; }","duration":"184.252705ms","start":"2026-06-16T11:14:51.655871Z","end":"2026-06-16T11:14:51.840124Z","steps":["trace[82780829] 'read index received' (duration: 158.828471ms)","trace[82780829] 'applied index is now lower than readState.Index' (duration: 25.423374ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:51.840231Z","caller":"traceutil/trace.go:171","msg":"trace[61983609] transaction","detail":"{read_only:false; response_revision:25381; number_of_response:1; }","duration":"193.532332ms","start":"2026-06-16T11:14:51.646688Z","end":"2026-06-16T11:14:51.84022Z","steps":["trace[61983609] 'process raft request' (duration: 193.331879ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:51.840287Z","caller":"traceutil/trace.go:171","msg":"trace[711401762] transaction","detail":"{read_only:false; response_revision:25380; number_of_response:1; }","duration":"196.797665ms","start":"2026-06-16T11:14:51.643461Z","end":"2026-06-16T11:14:51.840259Z","steps":["trace[711401762] 'process raft request' (duration: 196.363797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:51.840358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.47616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-16T11:14:51.840388Z","caller":"traceutil/trace.go:171","msg":"trace[1493454778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25381; }","duration":"184.562881ms","start":"2026-06-16T11:14:51.655818Z","end":"2026-06-16T11:14:51.840381Z","steps":["trace[1493454778] 'agreement among raft nodes before linearized reading' (duration: 184.407938ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:52.092706Z","caller":"traceutil/trace.go:171","msg":"trace[544180113] transaction","detail":"{read_only:false; response_revision:25384; number_of_response:1; }","duration":"231.487627ms","start":"2026-06-16T11:14:51.861194Z","end":"2026-06-16T11:14:52.092682Z","steps":["trace[544180113] 'process raft request' (duration: 231.238932ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:52.092924Z","caller":"traceutil/trace.go:171","msg":"trace[808343954] transaction","detail":"{read_only:false; response_revision:25385; number_of_response:1; }","duration":"230.888295ms","start":"2026-06-16T11:14:51.862014Z","end":"2026-06-16T11:14:52.092903Z","steps":["trace[808343954] 'process raft request' (duration: 230.61418ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:53.167301Z","caller":"traceutil/trace.go:171","msg":"trace[1712852299] linearizableReadLoop","detail":"{readStateIndex:26217; appliedIndex:26216; }","duration":"163.119043ms","start":"2026-06-16T11:14:53.00416Z","end":"2026-06-16T11:14:53.167279Z","steps":["trace[1712852299] 'read index received' (duration: 102.448815ms)","trace[1712852299] 'applied index is now lower than readState.Index' (duration: 60.669238ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:53.167325Z","caller":"traceutil/trace.go:171","msg":"trace[1470771800] transaction","detail":"{read_only:false; response_revision:25391; number_of_response:1; }","duration":"180.438322ms","start":"2026-06-16T11:14:52.986859Z","end":"2026-06-16T11:14:53.167297Z","steps":["trace[1470771800] 'process raft request' (duration: 119.746274ms)","trace[1470771800] 'compare' (duration: 60.578406ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:53.167426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.271685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:53.167488Z","caller":"traceutil/trace.go:171","msg":"trace[424114692] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:25391; }","duration":"163.369287ms","start":"2026-06-16T11:14:53.004105Z","end":"2026-06-16T11:14:53.167474Z","steps":["trace[424114692] 'agreement among raft nodes before linearized reading' (duration: 163.258835ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:54.090296Z","caller":"traceutil/trace.go:171","msg":"trace[2020210595] transaction","detail":"{read_only:false; response_revision:25394; number_of_response:1; }","duration":"245.973222ms","start":"2026-06-16T11:14:53.844287Z","end":"2026-06-16T11:14:54.09026Z","steps":["trace[2020210595] 'process raft request' (duration: 147.555195ms)","trace[2020210595] 'compare' (duration: 98.107932ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:54.090359Z","caller":"traceutil/trace.go:171","msg":"trace[1069519404] linearizableReadLoop","detail":"{readStateIndex:26223; appliedIndex:26219; }","duration":"179.482836ms","start":"2026-06-16T11:14:53.910842Z","end":"2026-06-16T11:14:54.090325Z","steps":["trace[1069519404] 'read index received' (duration: 81.082657ms)","trace[1069519404] 'applied index is now lower than readState.Index' (duration: 98.398659ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:54.090415Z","caller":"traceutil/trace.go:171","msg":"trace[1586937971] transaction","detail":"{read_only:false; response_revision:25396; number_of_response:1; }","duration":"245.087397ms","start":"2026-06-16T11:14:53.845263Z","end":"2026-06-16T11:14:54.09035Z","steps":["trace[1586937971] 'process raft request' (duration: 244.928633ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:54.090497Z","caller":"traceutil/trace.go:171","msg":"trace[550269097] transaction","detail":"{read_only:false; response_revision:25397; number_of_response:1; }","duration":"228.847368ms","start":"2026-06-16T11:14:53.861578Z","end":"2026-06-16T11:14:54.090426Z","steps":["trace[550269097] 'process raft request' (duration: 228.674943ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:54.090502Z","caller":"traceutil/trace.go:171","msg":"trace[1129948109] transaction","detail":"{read_only:false; response_revision:25395; number_of_response:1; }","duration":"245.851251ms","start":"2026-06-16T11:14:53.84461Z","end":"2026-06-16T11:14:54.090461Z","steps":["trace[1129948109] 'process raft request' (duration: 245.507374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:14:54.090826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.904363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-16T11:14:54.090926Z","caller":"traceutil/trace.go:171","msg":"trace[1171568331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25397; }","duration":"180.094748ms","start":"2026-06-16T11:14:53.910813Z","end":"2026-06-16T11:14:54.090908Z","steps":["trace[1171568331] 'agreement among raft nodes before linearized reading' (duration: 179.70832ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:54.282527Z","caller":"traceutil/trace.go:171","msg":"trace[1829702378] transaction","detail":"{read_only:false; response_revision:25400; number_of_response:1; }","duration":"113.821872ms","start":"2026-06-16T11:14:54.168685Z","end":"2026-06-16T11:14:54.282507Z","steps":["trace[1829702378] 'process raft request' (duration: 113.70405ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:14:54.718295Z","caller":"traceutil/trace.go:171","msg":"trace[1240587675] linearizableReadLoop","detail":"{readStateIndex:26228; appliedIndex:26227; }","duration":"114.633447ms","start":"2026-06-16T11:14:54.603641Z","end":"2026-06-16T11:14:54.718274Z","steps":["trace[1240587675] 'read index received' (duration: 100.314314ms)","trace[1240587675] 'applied index is now lower than readState.Index' (duration: 14.318243ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:14:54.718422Z","caller":"traceutil/trace.go:171","msg":"trace[1679195312] transaction","detail":"{read_only:false; response_revision:25402; number_of_response:1; }","duration":"120.610311ms","start":"2026-06-16T11:14:54.597801Z","end":"2026-06-16T11:14:54.718411Z","steps":["trace[1679195312] 'process raft request' (duration: 106.244477ms)","trace[1679195312] 'compare' (duration: 14.14021ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:14:54.718555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.888682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:14:54.718641Z","caller":"traceutil/trace.go:171","msg":"trace[1882454744] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:25402; }","duration":"115.017255ms","start":"2026-06-16T11:14:54.603607Z","end":"2026-06-16T11:14:54.718625Z","steps":["trace[1882454744] 'agreement among raft nodes before linearized reading' (duration: 114.869862ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:15:03.510744Z","caller":"traceutil/trace.go:171","msg":"trace[1346392289] linearizableReadLoop","detail":"{readStateIndex:26307; appliedIndex:26306; }","duration":"282.170093ms","start":"2026-06-16T11:15:03.228546Z","end":"2026-06-16T11:15:03.510716Z","steps":["trace[1346392289] 'read index received' (duration: 281.957699ms)","trace[1346392289] 'applied index is now lower than readState.Index' (duration: 211.224µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:15:03.510791Z","caller":"traceutil/trace.go:171","msg":"trace[112675205] transaction","detail":"{read_only:false; response_revision:25479; number_of_response:1; }","duration":"313.205465ms","start":"2026-06-16T11:15:03.197563Z","end":"2026-06-16T11:15:03.510768Z","steps":["trace[112675205] 'process raft request' (duration: 312.994211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:03.510894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:15:03.197536Z","time spent":"313.299858ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:15:03.510904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.348846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:15:03.510942Z","caller":"traceutil/trace.go:171","msg":"trace[1573856768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25479; }","duration":"282.441108ms","start":"2026-06-16T11:15:03.228487Z","end":"2026-06-16T11:15:03.510928Z","steps":["trace[1573856768] 'agreement among raft nodes before linearized reading' (duration: 282.331906ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:15:03.725899Z","caller":"traceutil/trace.go:171","msg":"trace[3740634] linearizableReadLoop","detail":"{readStateIndex:26308; appliedIndex:26307; }","duration":"214.085004ms","start":"2026-06-16T11:15:03.511792Z","end":"2026-06-16T11:15:03.725877Z","steps":["trace[3740634] 'read index received' (duration: 117.131324ms)","trace[3740634] 'applied index is now lower than readState.Index' (duration: 96.95277ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:15:03.725981Z","caller":"traceutil/trace.go:171","msg":"trace[226490000] transaction","detail":"{read_only:false; response_revision:25480; number_of_response:1; }","duration":"315.331407ms","start":"2026-06-16T11:15:03.410616Z","end":"2026-06-16T11:15:03.725948Z","steps":["trace[226490000] 'process raft request' (duration: 218.384328ms)","trace[226490000] 'compare' (duration: 96.594422ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:15:03.726042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.230827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:15:03.726103Z","caller":"traceutil/trace.go:171","msg":"trace[1551749597] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25480; }","duration":"214.317549ms","start":"2026-06-16T11:15:03.511759Z","end":"2026-06-16T11:15:03.726077Z","steps":["trace[1551749597] 'agreement among raft nodes before linearized reading' (duration: 214.212857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:03.72613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:15:03.410599Z","time spent":"315.459689ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:15:04.055677Z","caller":"traceutil/trace.go:171","msg":"trace[1006644805] transaction","detail":"{read_only:false; response_revision:25481; number_of_response:1; }","duration":"155.792224ms","start":"2026-06-16T11:15:03.899864Z","end":"2026-06-16T11:15:04.055656Z","steps":["trace[1006644805] 'process raft request' (duration: 155.153542ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:15:04.243036Z","caller":"traceutil/trace.go:171","msg":"trace[940818414] transaction","detail":"{read_only:false; response_revision:25482; number_of_response:1; }","duration":"115.33778ms","start":"2026-06-16T11:15:04.127663Z","end":"2026-06-16T11:15:04.243001Z","steps":["trace[940818414] 'process raft request' (duration: 43.620902ms)","trace[940818414] 'compare' (duration: 71.315181ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:15:04.273891Z","caller":"traceutil/trace.go:171","msg":"trace[1565298894] transaction","detail":"{read_only:false; response_revision:25484; number_of_response:1; }","duration":"143.0915ms","start":"2026-06-16T11:15:04.130772Z","end":"2026-06-16T11:15:04.273863Z","steps":["trace[1565298894] 'process raft request' (duration: 143.012239ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:15:04.274138Z","caller":"traceutil/trace.go:171","msg":"trace[874428641] transaction","detail":"{read_only:false; response_revision:25485; number_of_response:1; }","duration":"143.06871ms","start":"2026-06-16T11:15:04.131052Z","end":"2026-06-16T11:15:04.274121Z","steps":["trace[874428641] 'process raft request' (duration: 142.772465ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:15:04.273909Z","caller":"traceutil/trace.go:171","msg":"trace[1503218033] transaction","detail":"{read_only:false; response_revision:25483; number_of_response:1; }","duration":"143.286014ms","start":"2026-06-16T11:15:04.130605Z","end":"2026-06-16T11:15:04.273891Z","steps":["trace[1503218033] 'process raft request' (duration: 143.011649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:04.448682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.178629ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T11:15:04.448758Z","caller":"traceutil/trace.go:171","msg":"trace[144102118] linearizableReadLoop","detail":"{readStateIndex:26314; appliedIndex:26313; }","duration":"163.220024ms","start":"2026-06-16T11:15:04.285525Z","end":"2026-06-16T11:15:04.448745Z","steps":["trace[144102118] 'read index received' (duration: 60.80989ms)","trace[144102118] 'applied index is now lower than readState.Index' (duration: 102.408934ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:15:04.448882Z","caller":"traceutil/trace.go:171","msg":"trace[1398864542] transaction","detail":"{read_only:false; response_revision:25486; number_of_response:1; }","duration":"169.652177ms","start":"2026-06-16T11:15:04.279202Z","end":"2026-06-16T11:15:04.448855Z","steps":["trace[1398864542] 'process raft request' (duration: 67.225503ms)","trace[1398864542] 'compare' (duration: 102.000336ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:15:04.448939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.408728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-16T11:15:04.448972Z","caller":"traceutil/trace.go:171","msg":"trace[1800853880] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25486; }","duration":"163.464509ms","start":"2026-06-16T11:15:04.285498Z","end":"2026-06-16T11:15:04.448962Z","steps":["trace[1800853880] 'agreement among raft nodes before linearized reading' (duration: 163.321096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:04.448972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.950441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T11:15:04.449046Z","caller":"traceutil/trace.go:171","msg":"trace[1102826915] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25486; }","duration":"128.062373ms","start":"2026-06-16T11:15:04.320966Z","end":"2026-06-16T11:15:04.449029Z","steps":["trace[1102826915] 'agreement among raft nodes before linearized reading' (duration: 127.87929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:04.774738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.500731ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T11:15:04.774942Z","caller":"traceutil/trace.go:171","msg":"trace[1270646347] linearizableReadLoop","detail":"{readStateIndex:26316; appliedIndex:26314; }","duration":"255.378834ms","start":"2026-06-16T11:15:04.519544Z","end":"2026-06-16T11:15:04.774923Z","steps":["trace[1270646347] 'read index received' (duration: 49.655558ms)","trace[1270646347] 'applied index is now lower than readState.Index' (duration: 205.722366ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:15:04.774987Z","caller":"traceutil/trace.go:171","msg":"trace[1947649759] transaction","detail":"{read_only:false; response_revision:25487; number_of_response:1; }","duration":"321.110778ms","start":"2026-06-16T11:15:04.453835Z","end":"2026-06-16T11:15:04.774945Z","steps":["trace[1947649759] 'process raft request' (duration: 115.30516ms)","trace[1947649759] 'compare' (duration: 205.297097ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:15:04.775018Z","caller":"traceutil/trace.go:171","msg":"trace[266220205] transaction","detail":"{read_only:false; response_revision:25488; number_of_response:1; }","duration":"320.146679ms","start":"2026-06-16T11:15:04.454834Z","end":"2026-06-16T11:15:04.77498Z","steps":["trace[266220205] 'process raft request' (duration: 320.028587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:04.775116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.576038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-16T11:15:04.775151Z","caller":"traceutil/trace.go:171","msg":"trace[1184840702] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25488; }","duration":"255.643149ms","start":"2026-06-16T11:15:04.519497Z","end":"2026-06-16T11:15:04.77514Z","steps":["trace[1184840702] 'agreement among raft nodes before linearized reading' (duration: 255.507717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:04.775194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:15:04.454815Z","time spent":"320.281012ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:15:04.77519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:15:04.453806Z","time spent":"321.266141ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:15:05.041523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.055124ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T11:15:05.041775Z","caller":"traceutil/trace.go:171","msg":"trace[1265058431] linearizableReadLoop","detail":"{readStateIndex:26318; appliedIndex:26316; }","duration":"266.78244ms","start":"2026-06-16T11:15:04.774972Z","end":"2026-06-16T11:15:05.041755Z","steps":["trace[1265058431] 'read index received' (duration: 106.642745ms)","trace[1265058431] 'applied index is now lower than readState.Index' (duration: 160.138465ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:15:05.041898Z","caller":"traceutil/trace.go:171","msg":"trace[850162447] transaction","detail":"{read_only:false; response_revision:25490; number_of_response:1; }","duration":"295.181312ms","start":"2026-06-16T11:15:04.746702Z","end":"2026-06-16T11:15:05.041883Z","steps":["trace[850162447] 'process raft request' (duration: 294.941287ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:15:05.041925Z","caller":"traceutil/trace.go:171","msg":"trace[759669477] transaction","detail":"{read_only:false; response_revision:25489; number_of_response:1; }","duration":"450.359164ms","start":"2026-06-16T11:15:04.591527Z","end":"2026-06-16T11:15:05.041887Z","steps":["trace[759669477] 'process raft request' (duration: 289.836491ms)","trace[759669477] 'compare' (duration: 159.83534ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:15:05.04206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:15:04.591503Z","time spent":"450.489356ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:15:05.042237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.664154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-16T11:15:05.042296Z","caller":"traceutil/trace.go:171","msg":"trace[1377524642] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:1; response_revision:25490; }","duration":"369.761235ms","start":"2026-06-16T11:15:04.67252Z","end":"2026-06-16T11:15:05.042281Z","steps":["trace[1377524642] 'agreement among raft nodes before linearized reading' (duration: 369.550511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:05.042333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.24374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-16T11:15:05.04235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.09689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-16T11:15:05.042458Z","caller":"traceutil/trace.go:171","msg":"trace[637932499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25490; }","duration":"266.407513ms","start":"2026-06-16T11:15:04.776034Z","end":"2026-06-16T11:15:05.042442Z","steps":["trace[637932499] 'agreement among raft nodes before linearized reading' (duration: 266.145968ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:15:05.042483Z","caller":"traceutil/trace.go:171","msg":"trace[1505708479] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25490; }","duration":"252.250184ms","start":"2026-06-16T11:15:04.790211Z","end":"2026-06-16T11:15:05.042461Z","steps":["trace[1505708479] 'agreement among raft nodes before linearized reading' (duration: 251.976999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:05.042352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:15:04.672503Z","time spent":"369.832817ms","remote":"127.0.0.1:57970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":163,"request content":"key:\"/registry/masterleases/199.204.45.210\" "} {"level":"warn","ts":"2026-06-16T11:15:05.043085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.780896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-16T11:15:05.043212Z","caller":"traceutil/trace.go:171","msg":"trace[420602591] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25490; }","duration":"260.955199ms","start":"2026-06-16T11:15:04.782235Z","end":"2026-06-16T11:15:05.04319Z","steps":["trace[420602591] 'agreement among raft nodes before linearized reading' (duration: 259.961231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:05.412488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.39403ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-06-16T11:15:05.412565Z","caller":"traceutil/trace.go:171","msg":"trace[192506477] linearizableReadLoop","detail":"{readStateIndex:26319; appliedIndex:26318; }","duration":"368.155224ms","start":"2026-06-16T11:15:05.044398Z","end":"2026-06-16T11:15:05.412554Z","steps":["trace[192506477] 'read index received' (duration: 142.729864ms)","trace[192506477] 'applied index is now lower than readState.Index' (duration: 225.4243ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:15:05.412591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:15:05.043416Z","time spent":"369.164334ms","remote":"127.0.0.1:57970","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-16T11:15:05.412766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.352988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18557"} {"level":"info","ts":"2026-06-16T11:15:05.412814Z","caller":"traceutil/trace.go:171","msg":"trace[1661548414] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25490; }","duration":"368.42678ms","start":"2026-06-16T11:15:05.044374Z","end":"2026-06-16T11:15:05.412801Z","steps":["trace[1661548414] 'agreement among raft nodes before linearized reading' (duration: 368.221416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:05.41285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:15:05.04435Z","time spent":"368.491951ms","remote":"127.0.0.1:58128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18580,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-06-16T11:15:05.485122Z","caller":"traceutil/trace.go:171","msg":"trace[818378487] transaction","detail":"{read_only:false; response_revision:25491; number_of_response:1; }","duration":"439.383285ms","start":"2026-06-16T11:15:05.045701Z","end":"2026-06-16T11:15:05.485084Z","steps":["trace[818378487] 'process raft request' (duration: 439.080099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:05.485168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.821629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:15:05.485241Z","caller":"traceutil/trace.go:171","msg":"trace[855296147] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25492; }","duration":"259.978071ms","start":"2026-06-16T11:15:05.225245Z","end":"2026-06-16T11:15:05.485223Z","steps":["trace[855296147] 'agreement among raft nodes before linearized reading' (duration: 259.794298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:05.485292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:15:05.045685Z","time spent":"439.523567ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:15:05.485422Z","caller":"traceutil/trace.go:171","msg":"trace[1589843815] transaction","detail":"{read_only:false; response_revision:25492; number_of_response:1; }","duration":"434.611014ms","start":"2026-06-16T11:15:05.050783Z","end":"2026-06-16T11:15:05.485394Z","steps":["trace[1589843815] 'process raft request' (duration: 434.203766ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:05.485613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:15:05.050768Z","time spent":"434.767016ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T11:15:05.904982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.384939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18557"} {"level":"info","ts":"2026-06-16T11:15:05.905073Z","caller":"traceutil/trace.go:171","msg":"trace[9203439] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25493; }","duration":"391.49726ms","start":"2026-06-16T11:15:05.513552Z","end":"2026-06-16T11:15:05.905049Z","steps":["trace[9203439] 'range keys from in-memory index tree' (duration: 391.185094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:05.905115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:15:05.513544Z","time spent":"391.561801ms","remote":"127.0.0.1:58128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18580,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-16T11:15:05.906688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.092559ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T11:15:05.906838Z","caller":"traceutil/trace.go:171","msg":"trace[1281818831] transaction","detail":"{read_only:false; response_revision:25494; number_of_response:1; }","duration":"391.237906ms","start":"2026-06-16T11:15:05.515569Z","end":"2026-06-16T11:15:05.906807Z","steps":["trace[1281818831] 'process raft request' (duration: 190.913813ms)","trace[1281818831] 'compare' (duration: 199.230062ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:15:05.90702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:15:05.515556Z","time spent":"391.367559ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:15:05.907569Z","caller":"traceutil/trace.go:171","msg":"trace[1586265374] linearizableReadLoop","detail":"{readStateIndex:26323; appliedIndex:26322; }","duration":"365.406993ms","start":"2026-06-16T11:15:05.541381Z","end":"2026-06-16T11:15:05.906788Z","steps":["trace[1586265374] 'read index received' (duration: 165.05967ms)","trace[1586265374] 'applied index is now lower than readState.Index' (duration: 200.345733ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:15:05.907876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.491463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-06-16T11:15:05.907936Z","caller":"traceutil/trace.go:171","msg":"trace[210554530] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25494; }","duration":"366.569885ms","start":"2026-06-16T11:15:05.541346Z","end":"2026-06-16T11:15:05.907916Z","steps":["trace[210554530] 'agreement among raft nodes before linearized reading' (duration: 366.186048ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:15:05.90797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:15:05.541335Z","time spent":"366.628086ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":380,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "} {"level":"info","ts":"2026-06-16T11:15:06.199888Z","caller":"traceutil/trace.go:171","msg":"trace[294226592] linearizableReadLoop","detail":"{readStateIndex:26324; appliedIndex:26323; }","duration":"106.536323ms","start":"2026-06-16T11:15:06.093331Z","end":"2026-06-16T11:15:06.199867Z","steps":["trace[294226592] 'read index received' (duration: 106.326579ms)","trace[294226592] 'applied index is now lower than readState.Index' (duration: 208.534µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:15:06.20003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.684515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/images/\" range_end:\"/registry/openstack.k-orc.cloud/images0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T11:15:06.200066Z","caller":"traceutil/trace.go:171","msg":"trace[471506525] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/images/; range_end:/registry/openstack.k-orc.cloud/images0; response_count:0; response_revision:25495; }","duration":"106.768017ms","start":"2026-06-16T11:15:06.09328Z","end":"2026-06-16T11:15:06.200048Z","steps":["trace[471506525] 'agreement among raft nodes before linearized reading' (duration: 106.668685ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:15:06.200037Z","caller":"traceutil/trace.go:171","msg":"trace[268805822] transaction","detail":"{read_only:false; response_revision:25495; number_of_response:1; }","duration":"138.854429ms","start":"2026-06-16T11:15:06.06115Z","end":"2026-06-16T11:15:06.200005Z","steps":["trace[268805822] 'process raft request' (duration: 138.577894ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:15:06.386116Z","caller":"traceutil/trace.go:171","msg":"trace[539314006] transaction","detail":"{read_only:false; response_revision:25496; number_of_response:1; }","duration":"137.657677ms","start":"2026-06-16T11:15:06.248428Z","end":"2026-06-16T11:15:06.386086Z","steps":["trace[539314006] 'process raft request' (duration: 51.731837ms)","trace[539314006] 'compare' (duration: 85.597634ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:15:06.386161Z","caller":"traceutil/trace.go:171","msg":"trace[1601868147] transaction","detail":"{read_only:false; response_revision:25497; number_of_response:1; }","duration":"106.841689ms","start":"2026-06-16T11:15:06.279296Z","end":"2026-06-16T11:15:06.386137Z","steps":["trace[1601868147] 'process raft request' (duration: 106.699906ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:15:06.386432Z","caller":"traceutil/trace.go:171","msg":"trace[945839821] transaction","detail":"{read_only:false; response_revision:25498; number_of_response:1; }","duration":"106.498622ms","start":"2026-06-16T11:15:06.279829Z","end":"2026-06-16T11:15:06.386328Z","steps":["trace[945839821] 'process raft request' (duration: 106.271568ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:15:06.386762Z","caller":"traceutil/trace.go:171","msg":"trace[1033027125] transaction","detail":"{read_only:false; response_revision:25499; number_of_response:1; }","duration":"106.845189ms","start":"2026-06-16T11:15:06.279891Z","end":"2026-06-16T11:15:06.386737Z","steps":["trace[1033027125] 'process raft request' (duration: 106.36156ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:15:40.421173Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006887.wal"} {"level":"info","ts":"2026-06-16T11:16:11.445837Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23215} {"level":"info","ts":"2026-06-16T11:16:11.587174Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23215,"took":"135.7818ms","hash":2193801060,"current-db-size-bytes":59539456,"current-db-size":"60 MB","current-db-size-in-use-bytes":35790848,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-06-16T11:16:11.587242Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2193801060,"revision":23215,"compact-revision":20221} {"level":"info","ts":"2026-06-16T11:18:48.864851Z","caller":"traceutil/trace.go:171","msg":"trace[787617948] transaction","detail":"{read_only:false; response_revision:27663; number_of_response:1; }","duration":"173.752035ms","start":"2026-06-16T11:18:48.691064Z","end":"2026-06-16T11:18:48.864816Z","steps":["trace[787617948] 'process raft request' (duration: 173.516991ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:18:48.887455Z","caller":"traceutil/trace.go:171","msg":"trace[1820785943] transaction","detail":"{read_only:false; response_revision:27664; number_of_response:1; }","duration":"100.265753ms","start":"2026-06-16T11:18:48.787165Z","end":"2026-06-16T11:18:48.887431Z","steps":["trace[1820785943] 'process raft request' (duration: 100.062269ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:19:19.098488Z","caller":"traceutil/trace.go:171","msg":"trace[2025030948] transaction","detail":"{read_only:false; response_revision:27995; number_of_response:1; }","duration":"100.886496ms","start":"2026-06-16T11:19:18.997569Z","end":"2026-06-16T11:19:19.098456Z","steps":["trace[2025030948] 'process raft request' (duration: 100.622491ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:21:11.459119Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26178} {"level":"info","ts":"2026-06-16T11:21:11.603888Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26178,"took":"141.407718ms","hash":59923371,"current-db-size-bytes":59539456,"current-db-size":"60 MB","current-db-size-in-use-bytes":34701312,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-16T11:21:11.603972Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":59923371,"revision":26178,"compact-revision":23215} {"level":"info","ts":"2026-06-16T11:21:39.846976Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1cac722af8b2b8a6","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T11:21:39.852283Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-16T11:21:39.85239Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-16T11:24:16.588499Z","caller":"traceutil/trace.go:171","msg":"trace[1569015974] transaction","detail":"{read_only:false; response_revision:30220; number_of_response:1; }","duration":"126.535865ms","start":"2026-06-16T11:24:16.461934Z","end":"2026-06-16T11:24:16.58847Z","steps":["trace[1569015974] 'process raft request' (duration: 47.119219ms)","trace[1569015974] 'compare' (duration: 79.080409ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:26:11.464799Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28871} {"level":"info","ts":"2026-06-16T11:26:11.600097Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28871,"took":"130.908908ms","hash":2911111944,"current-db-size-bytes":59539456,"current-db-size":"60 MB","current-db-size-in-use-bytes":30433280,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-16T11:26:11.600156Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2911111944,"revision":28871,"compact-revision":26178} {"level":"info","ts":"2026-06-16T11:31:11.470748Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31094} {"level":"info","ts":"2026-06-16T11:31:11.625918Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31094,"took":"151.96837ms","hash":325558783,"current-db-size-bytes":59539456,"current-db-size":"60 MB","current-db-size-in-use-bytes":30502912,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-16T11:31:11.625999Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":325558783,"revision":31094,"compact-revision":28871} {"level":"info","ts":"2026-06-16T11:36:11.478202Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33357} {"level":"info","ts":"2026-06-16T11:36:11.630786Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33357,"took":"147.902262ms","hash":2736746743,"current-db-size-bytes":60579840,"current-db-size":"61 MB","current-db-size-in-use-bytes":31932416,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-16T11:36:11.630865Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2736746743,"revision":33357,"compact-revision":31094} {"level":"info","ts":"2026-06-16T11:41:11.484432Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35654} {"level":"info","ts":"2026-06-16T11:41:11.627705Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35654,"took":"139.136476ms","hash":2804684120,"current-db-size-bytes":60579840,"current-db-size":"61 MB","current-db-size-in-use-bytes":31285248,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-16T11:41:11.627758Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2804684120,"revision":35654,"compact-revision":33357} {"level":"info","ts":"2026-06-16T11:43:10.647754Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1cac722af8b2b8a6","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T11:43:10.652654Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-16T11:43:10.652987Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-16T11:46:11.491756Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37879} {"level":"info","ts":"2026-06-16T11:46:11.617161Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37879,"took":"121.994858ms","hash":2163344305,"current-db-size-bytes":60579840,"current-db-size":"61 MB","current-db-size-in-use-bytes":32235520,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-16T11:46:11.617221Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2163344305,"revision":37879,"compact-revision":35654}