{"level":"warn","ts":"2026-06-15T20:00:26.347628Z","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-15T20:00:26.347735Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.113: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.113:2380","--initial-cluster=instance=https://199.204.45.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.113: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-15T20:00:26.347818Z","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-15T20:00:26.347833Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-06-15T20:00:26.34786Z","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-15T20:00:26.348507Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"]} {"level":"info","ts":"2026-06-15T20:00:26.348598Z","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.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.113: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-15T20:00:26.352538Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.668492ms"} {"level":"info","ts":"2026-06-15T20:00:26.358241Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"} {"level":"info","ts":"2026-06-15T20:00:26.358341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"} {"level":"info","ts":"2026-06-15T20:00:26.358377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"} {"level":"info","ts":"2026-06-15T20:00:26.35839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a31e123290fcf0df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-15T20:00:26.358407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"} {"level":"info","ts":"2026-06-15T20:00:26.358457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"warn","ts":"2026-06-15T20:00:26.363486Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-15T20:00:26.364838Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-15T20:00:26.365701Z","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-15T20:00:26.367528Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a31e123290fcf0df","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-15T20:00:26.367722Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a31e123290fcf0df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-15T20:00:26.367826Z","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-15T20:00:26.367865Z","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-15T20:00:26.367874Z","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-15T20:00:26.369619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"info","ts":"2026-06-15T20:00:26.370342Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","added-peer-id":"a31e123290fcf0df","added-peer-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-06-15T20:00:26.371605Z","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-15T20:00:26.371727Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-06-15T20:00:26.371749Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-06-15T20:00:26.371896Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a31e123290fcf0df","initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-15T20:00:26.371938Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-15T20:00:26.659248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"} {"level":"info","ts":"2026-06-15T20:00:26.659329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"} {"level":"info","ts":"2026-06-15T20:00:26.659355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"} {"level":"info","ts":"2026-06-15T20:00:26.659376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"} {"level":"info","ts":"2026-06-15T20:00:26.659388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-06-15T20:00:26.659404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"} {"level":"info","ts":"2026-06-15T20:00:26.659418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-06-15T20:00:26.660248Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T20:00:26.661113Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a31e123290fcf0df","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.113:2379]}","request-path":"/0/members/a31e123290fcf0df/attributes","cluster-id":"37661d6ee45ed9e8","publish-timeout":"7s"} {"level":"info","ts":"2026-06-15T20:00:26.661344Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T20:00:26.661514Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T20:00:26.661583Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T20:00:26.661727Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T20:00:26.661766Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T20:00:26.665072Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"} {"level":"info","ts":"2026-06-15T20:00:26.665462Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-15T20:00:26.66575Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-15T20:00:26.665814Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-15T20:00:40.752233Z","caller":"traceutil/trace.go:171","msg":"trace[1107442650] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"125.234376ms","start":"2026-06-15T20:00:40.626966Z","end":"2026-06-15T20:00:40.752201Z","steps":["trace[1107442650] 'process raft request' (duration: 125.002471ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:05.519331Z","caller":"traceutil/trace.go:171","msg":"trace[587512063] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"161.736126ms","start":"2026-06-15T20:01:05.357562Z","end":"2026-06-15T20:01:05.519298Z","steps":["trace[587512063] 'process raft request' (duration: 161.626323ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:05.528958Z","caller":"traceutil/trace.go:171","msg":"trace[2132446743] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"163.048777ms","start":"2026-06-15T20:01:05.365879Z","end":"2026-06-15T20:01:05.528927Z","steps":["trace[2132446743] 'process raft request' (duration: 162.812031ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:05.529061Z","caller":"traceutil/trace.go:171","msg":"trace[1318337874] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"163.13663ms","start":"2026-06-15T20:01:05.365904Z","end":"2026-06-15T20:01:05.529041Z","steps":["trace[1318337874] 'process raft request' (duration: 162.963456ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:05.529152Z","caller":"traceutil/trace.go:171","msg":"trace[868868571] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"149.519327ms","start":"2026-06-15T20:01:05.379623Z","end":"2026-06-15T20:01:05.529143Z","steps":["trace[868868571] 'process raft request' (duration: 149.296462ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:05.529209Z","caller":"traceutil/trace.go:171","msg":"trace[909206251] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"145.865091ms","start":"2026-06-15T20:01:05.383334Z","end":"2026-06-15T20:01:05.529199Z","steps":["trace[909206251] 'process raft request' (duration: 145.633416ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:05.529226Z","caller":"traceutil/trace.go:171","msg":"trace[999976786] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"145.877792ms","start":"2026-06-15T20:01:05.383341Z","end":"2026-06-15T20:01:05.529219Z","steps":["trace[999976786] 'process raft request' (duration: 145.766129ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:05.529293Z","caller":"traceutil/trace.go:171","msg":"trace[1845925513] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"145.887051ms","start":"2026-06-15T20:01:05.383397Z","end":"2026-06-15T20:01:05.529284Z","steps":["trace[1845925513] 'process raft request' (duration: 145.757598ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:05.529367Z","caller":"traceutil/trace.go:171","msg":"trace[1139804986] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"138.387354ms","start":"2026-06-15T20:01:05.390973Z","end":"2026-06-15T20:01:05.52936Z","steps":["trace[1139804986] 'process raft request' (duration: 138.276222ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:05.529424Z","caller":"traceutil/trace.go:171","msg":"trace[1605426063] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"131.622614ms","start":"2026-06-15T20:01:05.397795Z","end":"2026-06-15T20:01:05.529417Z","steps":["trace[1605426063] 'process raft request' (duration: 131.517152ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:05.529367Z","caller":"traceutil/trace.go:171","msg":"trace[1706537921] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"144.742055ms","start":"2026-06-15T20:01:05.384594Z","end":"2026-06-15T20:01:05.529336Z","steps":["trace[1706537921] 'process raft request' (duration: 144.599751ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:05.534372Z","caller":"traceutil/trace.go:171","msg":"trace[1813969613] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"113.378063ms","start":"2026-06-15T20:01:05.420978Z","end":"2026-06-15T20:01:05.534356Z","steps":["trace[1813969613] 'process raft request' (duration: 113.22821ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:01:11.879968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.734064ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T20:01:11.880304Z","caller":"traceutil/trace.go:171","msg":"trace[217264103] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"246.503962ms","start":"2026-06-15T20:01:11.633751Z","end":"2026-06-15T20:01:11.880255Z","steps":["trace[217264103] 'process raft request' (duration: 114.530019ms)","trace[217264103] 'compare' (duration: 130.55144ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:01:11.880676Z","caller":"traceutil/trace.go:171","msg":"trace[1337881215] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"246.131724ms","start":"2026-06-15T20:01:11.634497Z","end":"2026-06-15T20:01:11.880629Z","steps":["trace[1337881215] 'process raft request' (duration: 245.727634ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:11.880721Z","caller":"traceutil/trace.go:171","msg":"trace[1006041125] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"179.940127ms","start":"2026-06-15T20:01:11.700716Z","end":"2026-06-15T20:01:11.880656Z","steps":["trace[1006041125] 'process raft request' (duration: 179.63175ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:11.880649Z","caller":"traceutil/trace.go:171","msg":"trace[758055280] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:620; }","duration":"166.896708ms","start":"2026-06-15T20:01:11.713714Z","end":"2026-06-15T20:01:11.880611Z","steps":["trace[758055280] 'read index received' (duration: 34.65934ms)","trace[758055280] 'applied index is now lower than readState.Index' (duration: 132.235758ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:01:11.881006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.254736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-s8t9h\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-15T20:01:11.881093Z","caller":"traceutil/trace.go:171","msg":"trace[1043621144] range","detail":"{range_begin:/registry/pods/kube-system/cilium-s8t9h; range_end:; response_count:1; response_revision:605; }","duration":"167.39199ms","start":"2026-06-15T20:01:11.713682Z","end":"2026-06-15T20:01:11.881074Z","steps":["trace[1043621144] 'agreement among raft nodes before linearized reading' (duration: 167.112103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:01:12.461341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.3954ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:01:12.461534Z","caller":"traceutil/trace.go:171","msg":"trace[1747100326] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:606; }","duration":"205.620586ms","start":"2026-06-15T20:01:12.255894Z","end":"2026-06-15T20:01:12.461514Z","steps":["trace[1747100326] 'range keys from in-memory index tree' (duration: 205.374069ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:12.473625Z","caller":"traceutil/trace.go:171","msg":"trace[1118386000] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"184.468915ms","start":"2026-06-15T20:01:12.289137Z","end":"2026-06-15T20:01:12.473606Z","steps":["trace[1118386000] 'process raft request' (duration: 183.238665ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:01:26.928487Z","caller":"traceutil/trace.go:171","msg":"trace[118681537] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"105.781483ms","start":"2026-06-15T20:01:26.822675Z","end":"2026-06-15T20:01:26.928456Z","steps":["trace[118681537] 'process raft request' (duration: 105.528527ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:02:45.338892Z","caller":"traceutil/trace.go:171","msg":"trace[1978396725] linearizableReadLoop","detail":"{readStateIndex:1901; appliedIndex:1900; }","duration":"126.090626ms","start":"2026-06-15T20:02:45.212773Z","end":"2026-06-15T20:02:45.338864Z","steps":["trace[1978396725] 'read index received' (duration: 125.78915ms)","trace[1978396725] 'applied index is now lower than readState.Index' (duration: 300.416µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:02:45.339114Z","caller":"traceutil/trace.go:171","msg":"trace[424609650] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"143.835574ms","start":"2026-06-15T20:02:45.195218Z","end":"2026-06-15T20:02:45.339054Z","steps":["trace[424609650] 'process raft request' (duration: 143.440575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:02:45.339176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.381342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-31cd2c40-e9df-4ccf-91b1-764c50e3724d\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-15T20:02:45.339428Z","caller":"traceutil/trace.go:171","msg":"trace[415222479] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-31cd2c40-e9df-4ccf-91b1-764c50e3724d; range_end:; response_count:1; response_revision:1833; }","duration":"126.671149ms","start":"2026-06-15T20:02:45.212707Z","end":"2026-06-15T20:02:45.339379Z","steps":["trace[415222479] 'agreement among raft nodes before linearized reading' (duration: 126.28236ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:03:31.677116Z","caller":"traceutil/trace.go:171","msg":"trace[593283528] linearizableReadLoop","detail":"{readStateIndex:2216; appliedIndex:2215; }","duration":"104.94144ms","start":"2026-06-15T20:03:31.57214Z","end":"2026-06-15T20:03:31.677082Z","steps":["trace[593283528] 'read index received' (duration: 104.704974ms)","trace[593283528] 'applied index is now lower than readState.Index' (duration: 235.086µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:03:31.677176Z","caller":"traceutil/trace.go:171","msg":"trace[2116959685] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"163.627349ms","start":"2026-06-15T20:03:31.51351Z","end":"2026-06-15T20:03:31.677137Z","steps":["trace[2116959685] 'process raft request' (duration: 163.390473ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:31.677477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.146215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:03:31.677553Z","caller":"traceutil/trace.go:171","msg":"trace[28846729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2139; }","duration":"105.466932ms","start":"2026-06-15T20:03:31.572068Z","end":"2026-06-15T20:03:31.677535Z","steps":["trace[28846729] 'agreement among raft nodes before linearized reading' (duration: 105.169805ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:03:31.807922Z","caller":"traceutil/trace.go:171","msg":"trace[1128934563] linearizableReadLoop","detail":"{readStateIndex:2217; appliedIndex:2216; }","duration":"130.688294ms","start":"2026-06-15T20:03:31.677206Z","end":"2026-06-15T20:03:31.807894Z","steps":["trace[1128934563] 'read index received' (duration: 129.410943ms)","trace[1128934563] 'applied index is now lower than readState.Index' (duration: 1.276201ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:03:31.808045Z","caller":"traceutil/trace.go:171","msg":"trace[1034479799] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"147.493755ms","start":"2026-06-15T20:03:31.660492Z","end":"2026-06-15T20:03:31.807986Z","steps":["trace[1034479799] 'process raft request' (duration: 146.264785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:31.80828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.083917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-15T20:03:31.808375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.522099ms","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-15T20:03:31.808427Z","caller":"traceutil/trace.go:171","msg":"trace[1109164554] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2140; }","duration":"137.309482ms","start":"2026-06-15T20:03:31.67109Z","end":"2026-06-15T20:03:31.808399Z","steps":["trace[1109164554] 'agreement among raft nodes before linearized reading' (duration: 136.924713ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:03:31.808575Z","caller":"traceutil/trace.go:171","msg":"trace[161139564] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2140; }","duration":"140.650971ms","start":"2026-06-15T20:03:31.667769Z","end":"2026-06-15T20:03:31.80842Z","steps":["trace[161139564] 'agreement among raft nodes before linearized reading' (duration: 140.264472ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:04:25.982266Z","caller":"traceutil/trace.go:171","msg":"trace[1650957540] transaction","detail":"{read_only:false; response_revision:2607; number_of_response:1; }","duration":"111.335959ms","start":"2026-06-15T20:04:25.870894Z","end":"2026-06-15T20:04:25.98223Z","steps":["trace[1650957540] 'process raft request' (duration: 110.776856ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:04:58.400701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.966217ms","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-15T20:04:58.400827Z","caller":"traceutil/trace.go:171","msg":"trace[1784519377] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2803; }","duration":"113.131521ms","start":"2026-06-15T20:04:58.287678Z","end":"2026-06-15T20:04:58.400809Z","steps":["trace[1784519377] 'range keys from in-memory index tree' (duration: 112.817443ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:04:58.411452Z","caller":"traceutil/trace.go:171","msg":"trace[102462232] transaction","detail":"{read_only:false; response_revision:2804; number_of_response:1; }","duration":"120.486216ms","start":"2026-06-15T20:04:58.290932Z","end":"2026-06-15T20:04:58.411418Z","steps":["trace[102462232] 'process raft request' (duration: 120.298702ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:05:03.709893Z","caller":"traceutil/trace.go:171","msg":"trace[956013328] linearizableReadLoop","detail":"{readStateIndex:2940; appliedIndex:2939; }","duration":"154.549997ms","start":"2026-06-15T20:05:03.55531Z","end":"2026-06-15T20:05:03.70986Z","steps":["trace[956013328] 'read index received' (duration: 154.26392ms)","trace[956013328] 'applied index is now lower than readState.Index' (duration: 284.867µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:05:03.70995Z","caller":"traceutil/trace.go:171","msg":"trace[1936642657] transaction","detail":"{read_only:false; response_revision:2836; number_of_response:1; }","duration":"171.01236ms","start":"2026-06-15T20:05:03.538892Z","end":"2026-06-15T20:05:03.709905Z","steps":["trace[1936642657] 'process raft request' (duration: 170.776154ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:03.710122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.465254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:05:03.710166Z","caller":"traceutil/trace.go:171","msg":"trace[1782381295] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2836; }","duration":"138.657568ms","start":"2026-06-15T20:05:03.571496Z","end":"2026-06-15T20:05:03.710154Z","steps":["trace[1782381295] 'agreement among raft nodes before linearized reading' (duration: 138.567756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:03.710169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.855384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-06-15T20:05:03.710267Z","caller":"traceutil/trace.go:171","msg":"trace[66434761] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2836; }","duration":"154.999827ms","start":"2026-06-15T20:05:03.555244Z","end":"2026-06-15T20:05:03.710244Z","steps":["trace[66434761] 'agreement among raft nodes before linearized reading' (duration: 154.752342ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:07:33.994942Z","caller":"traceutil/trace.go:171","msg":"trace[602755328] transaction","detail":"{read_only:false; response_revision:3827; number_of_response:1; }","duration":"153.524735ms","start":"2026-06-15T20:07:33.841368Z","end":"2026-06-15T20:07:33.994893Z","steps":["trace[602755328] 'process raft request' (duration: 77.890152ms)","trace[602755328] 'compare' (duration: 75.393438ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:09:21.619073Z","caller":"traceutil/trace.go:171","msg":"trace[1955073040] linearizableReadLoop","detail":"{readStateIndex:5623; appliedIndex:5622; }","duration":"117.193706ms","start":"2026-06-15T20:09:21.501854Z","end":"2026-06-15T20:09:21.619048Z","steps":["trace[1955073040] 'read index received' (duration: 117.087404ms)","trace[1955073040] 'applied index is now lower than readState.Index' (duration: 105.132µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:09:21.61911Z","caller":"traceutil/trace.go:171","msg":"trace[1483796462] transaction","detail":"{read_only:false; response_revision:5423; number_of_response:1; }","duration":"184.735589ms","start":"2026-06-15T20:09:21.434343Z","end":"2026-06-15T20:09:21.619078Z","steps":["trace[1483796462] 'process raft request' (duration: 184.540385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:09:21.619401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.511643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-06-15T20:09:21.619441Z","caller":"traceutil/trace.go:171","msg":"trace[997620737] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5423; }","duration":"117.622225ms","start":"2026-06-15T20:09:21.50181Z","end":"2026-06-15T20:09:21.619432Z","steps":["trace[997620737] 'agreement among raft nodes before linearized reading' (duration: 117.36368ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:21.832981Z","caller":"traceutil/trace.go:171","msg":"trace[1008717479] transaction","detail":"{read_only:false; response_revision:5425; number_of_response:1; }","duration":"183.956202ms","start":"2026-06-15T20:09:21.648987Z","end":"2026-06-15T20:09:21.832943Z","steps":["trace[1008717479] 'process raft request' (duration: 138.344017ms)","trace[1008717479] 'compare' (duration: 45.300308ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:09:21.981137Z","caller":"traceutil/trace.go:171","msg":"trace[565330520] transaction","detail":"{read_only:false; response_revision:5426; number_of_response:1; }","duration":"143.205813ms","start":"2026-06-15T20:09:21.837897Z","end":"2026-06-15T20:09:21.981103Z","steps":["trace[565330520] 'process raft request' (duration: 140.220898ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:21.992162Z","caller":"traceutil/trace.go:171","msg":"trace[1233248603] transaction","detail":"{read_only:false; response_revision:5428; number_of_response:1; }","duration":"152.808962ms","start":"2026-06-15T20:09:21.839337Z","end":"2026-06-15T20:09:21.992146Z","steps":["trace[1233248603] 'process raft request' (duration: 152.676119ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:21.99218Z","caller":"traceutil/trace.go:171","msg":"trace[1364833300] transaction","detail":"{read_only:false; response_revision:5429; number_of_response:1; }","duration":"152.814972ms","start":"2026-06-15T20:09:21.839341Z","end":"2026-06-15T20:09:21.992156Z","steps":["trace[1364833300] 'process raft request' (duration: 152.72957ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:21.992221Z","caller":"traceutil/trace.go:171","msg":"trace[883643584] transaction","detail":"{read_only:false; response_revision:5427; number_of_response:1; }","duration":"153.232471ms","start":"2026-06-15T20:09:21.838939Z","end":"2026-06-15T20:09:21.992172Z","steps":["trace[883643584] 'process raft request' (duration: 152.960556ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:21.992509Z","caller":"traceutil/trace.go:171","msg":"trace[2057136896] transaction","detail":"{read_only:false; response_revision:5430; number_of_response:1; }","duration":"153.021487ms","start":"2026-06-15T20:09:21.839471Z","end":"2026-06-15T20:09:21.992492Z","steps":["trace[2057136896] 'process raft request' (duration: 152.628949ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:21.992566Z","caller":"traceutil/trace.go:171","msg":"trace[244421330] transaction","detail":"{read_only:false; response_revision:5432; number_of_response:1; }","duration":"152.362332ms","start":"2026-06-15T20:09:21.840182Z","end":"2026-06-15T20:09:21.992544Z","steps":["trace[244421330] 'process raft request' (duration: 152.278611ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:21.992528Z","caller":"traceutil/trace.go:171","msg":"trace[1222826855] transaction","detail":"{read_only:false; response_revision:5431; number_of_response:1; }","duration":"152.747461ms","start":"2026-06-15T20:09:21.839757Z","end":"2026-06-15T20:09:21.992504Z","steps":["trace[1222826855] 'process raft request' (duration: 152.588767ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:21.992665Z","caller":"traceutil/trace.go:171","msg":"trace[569245451] transaction","detail":"{read_only:false; response_revision:5433; number_of_response:1; }","duration":"152.20369ms","start":"2026-06-15T20:09:21.840453Z","end":"2026-06-15T20:09:21.992657Z","steps":["trace[569245451] 'process raft request' (duration: 152.040675ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:21.992797Z","caller":"traceutil/trace.go:171","msg":"trace[1597846490] transaction","detail":"{read_only:false; response_revision:5434; number_of_response:1; }","duration":"147.430426ms","start":"2026-06-15T20:09:21.845357Z","end":"2026-06-15T20:09:21.992787Z","steps":["trace[1597846490] 'process raft request' (duration: 147.272232ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:21.992795Z","caller":"traceutil/trace.go:171","msg":"trace[936386707] linearizableReadLoop","detail":"{readStateIndex:5631; appliedIndex:5625; }","duration":"152.891265ms","start":"2026-06-15T20:09:21.839885Z","end":"2026-06-15T20:09:21.992776Z","steps":["trace[936386707] 'read index received' (duration: 138.250095ms)","trace[936386707] 'applied index is now lower than readState.Index' (duration: 14.64015ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:09:21.993031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.11669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-0\" ","response":"range_response_count:1 size:5885"} {"level":"info","ts":"2026-06-15T20:09:21.993101Z","caller":"traceutil/trace.go:171","msg":"trace[275154358] range","detail":"{range_begin:/registry/pods/monitoring/loki-0; range_end:; response_count:1; response_revision:5434; }","duration":"153.233902ms","start":"2026-06-15T20:09:21.839849Z","end":"2026-06-15T20:09:21.993083Z","steps":["trace[275154358] 'agreement among raft nodes before linearized reading' (duration: 152.981137ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:10:26.861213Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2962} {"level":"info","ts":"2026-06-15T20:10:26.932896Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2962,"took":"69.497667ms","hash":3785786681,"current-db-size-bytes":57270272,"current-db-size":"57 MB","current-db-size-in-use-bytes":33738752,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-15T20:10:26.932983Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3785786681,"revision":2962,"compact-revision":-1} {"level":"warn","ts":"2026-06-15T20:15:17.920074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.273661ms","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-15T20:15:17.920182Z","caller":"traceutil/trace.go:171","msg":"trace[1139315332] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8201; }","duration":"137.447605ms","start":"2026-06-15T20:15:17.78271Z","end":"2026-06-15T20:15:17.920158Z","steps":["trace[1139315332] 'range keys from in-memory index tree' (duration: 137.081387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:15:17.920189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.541789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:15:17.920253Z","caller":"traceutil/trace.go:171","msg":"trace[2046870724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8201; }","duration":"348.639601ms","start":"2026-06-15T20:15:17.571603Z","end":"2026-06-15T20:15:17.920243Z","steps":["trace[2046870724] 'range keys from in-memory index tree' (duration: 348.457067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:15:17.920276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:15:17.571582Z","time spent":"348.687882ms","remote":"127.0.0.1:44184","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-15T20:15:17.920566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.550148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-15T20:15:17.920706Z","caller":"traceutil/trace.go:171","msg":"trace[1938330824] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8201; }","duration":"143.739102ms","start":"2026-06-15T20:15:17.776937Z","end":"2026-06-15T20:15:17.920676Z","steps":["trace[1938330824] 'range keys from in-memory index tree' (duration: 143.239671ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:15:26.867146Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6035} {"level":"info","ts":"2026-06-15T20:15:26.962502Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6035,"took":"93.32481ms","hash":2298642794,"current-db-size-bytes":57270272,"current-db-size":"57 MB","current-db-size-in-use-bytes":22892544,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-06-15T20:15:26.96261Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2298642794,"revision":6035,"compact-revision":2962} {"level":"info","ts":"2026-06-15T20:15:29.27081Z","caller":"traceutil/trace.go:171","msg":"trace[6537999] transaction","detail":"{read_only:false; response_revision:8264; number_of_response:1; }","duration":"192.547229ms","start":"2026-06-15T20:15:29.078228Z","end":"2026-06-15T20:15:29.270775Z","steps":["trace[6537999] 'process raft request' (duration: 192.298554ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:15:57.062672Z","caller":"traceutil/trace.go:171","msg":"trace[21302652] transaction","detail":"{read_only:false; response_revision:8468; number_of_response:1; }","duration":"262.282834ms","start":"2026-06-15T20:15:56.800373Z","end":"2026-06-15T20:15:57.062656Z","steps":["trace[21302652] 'process raft request' (duration: 262.008998ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:16:09.704386Z","caller":"traceutil/trace.go:171","msg":"trace[1049709287] linearizableReadLoop","detail":"{readStateIndex:8876; appliedIndex:8875; }","duration":"135.225062ms","start":"2026-06-15T20:16:09.569137Z","end":"2026-06-15T20:16:09.704362Z","steps":["trace[1049709287] 'read index received' (duration: 59.610472ms)","trace[1049709287] 'applied index is now lower than readState.Index' (duration: 75.61352ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:16:09.704487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.335765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:16:09.704509Z","caller":"traceutil/trace.go:171","msg":"trace[444385721] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8574; }","duration":"135.401096ms","start":"2026-06-15T20:16:09.569101Z","end":"2026-06-15T20:16:09.704502Z","steps":["trace[444385721] 'agreement among raft nodes before linearized reading' (duration: 135.343135ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:16:09.704588Z","caller":"traceutil/trace.go:171","msg":"trace[755959479] transaction","detail":"{read_only:false; response_revision:8574; number_of_response:1; }","duration":"166.294641ms","start":"2026-06-15T20:16:09.538268Z","end":"2026-06-15T20:16:09.704562Z","steps":["trace[755959479] 'process raft request' (duration: 90.521807ms)","trace[755959479] 'compare' (duration: 75.377345ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:16:10.446283Z","caller":"traceutil/trace.go:171","msg":"trace[241150267] linearizableReadLoop","detail":"{readStateIndex:8881; appliedIndex:8880; }","duration":"102.808144ms","start":"2026-06-15T20:16:10.34344Z","end":"2026-06-15T20:16:10.446248Z","steps":["trace[241150267] 'read index received' (duration: 102.489687ms)","trace[241150267] 'applied index is now lower than readState.Index' (duration: 317.217µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:16:10.446488Z","caller":"traceutil/trace.go:171","msg":"trace[1523886889] transaction","detail":"{read_only:false; response_revision:8578; number_of_response:1; }","duration":"104.115274ms","start":"2026-06-15T20:16:10.342359Z","end":"2026-06-15T20:16:10.446474Z","steps":["trace[1523886889] 'process raft request' (duration: 103.661493ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:16:10.446845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.376687ms","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-15T20:16:10.446895Z","caller":"traceutil/trace.go:171","msg":"trace[256725323] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8578; }","duration":"103.457718ms","start":"2026-06-15T20:16:10.343427Z","end":"2026-06-15T20:16:10.446885Z","steps":["trace[256725323] 'agreement among raft nodes before linearized reading' (duration: 103.246074ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:16:59.34861Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024a9.wal"} {"level":"info","ts":"2026-06-15T20:18:12.1923Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a31e123290fcf0df","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-15T20:18:12.199071Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-15T20:18:12.199159Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-15T20:20:26.873246Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8254} {"level":"info","ts":"2026-06-15T20:20:26.957813Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8254,"took":"81.236351ms","hash":4101400682,"current-db-size-bytes":57270272,"current-db-size":"57 MB","current-db-size-in-use-bytes":25944064,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-15T20:20:26.957883Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4101400682,"revision":8254,"compact-revision":6035} {"level":"info","ts":"2026-06-15T20:21:01.972662Z","caller":"traceutil/trace.go:171","msg":"trace[766493298] transaction","detail":"{read_only:false; response_revision:11121; number_of_response:1; }","duration":"116.264204ms","start":"2026-06-15T20:21:01.856359Z","end":"2026-06-15T20:21:01.972623Z","steps":["trace[766493298] 'process raft request' (duration: 116.001318ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:25:26.884912Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10748} {"level":"info","ts":"2026-06-15T20:25:26.970311Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10748,"took":"82.890203ms","hash":636957413,"current-db-size-bytes":57270272,"current-db-size":"57 MB","current-db-size-in-use-bytes":28086272,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-15T20:25:26.970379Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":636957413,"revision":10748,"compact-revision":8254} {"level":"info","ts":"2026-06-15T20:27:24.596392Z","caller":"traceutil/trace.go:171","msg":"trace[1888872751] linearizableReadLoop","detail":"{readStateIndex:14176; appliedIndex:14175; }","duration":"103.673344ms","start":"2026-06-15T20:27:24.492696Z","end":"2026-06-15T20:27:24.596369Z","steps":["trace[1888872751] 'read index received' (duration: 103.468039ms)","trace[1888872751] 'applied index is now lower than readState.Index' (duration: 203.715µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:27:24.596456Z","caller":"traceutil/trace.go:171","msg":"trace[1900634856] transaction","detail":"{read_only:false; response_revision:13709; number_of_response:1; }","duration":"141.63148ms","start":"2026-06-15T20:27:24.454774Z","end":"2026-06-15T20:27:24.596405Z","steps":["trace[1900634856] 'process raft request' (duration: 141.411895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:27:24.596737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.024072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-d7rc5\" ","response":"range_response_count:1 size:12599"} {"level":"info","ts":"2026-06-15T20:27:24.596816Z","caller":"traceutil/trace.go:171","msg":"trace[127768143] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-d7rc5; range_end:; response_count:1; response_revision:13709; }","duration":"104.117314ms","start":"2026-06-15T20:27:24.492681Z","end":"2026-06-15T20:27:24.596798Z","steps":["trace[127768143] 'agreement among raft nodes before linearized reading' (duration: 103.865949ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:27:24.898731Z","caller":"traceutil/trace.go:171","msg":"trace[1141178328] linearizableReadLoop","detail":"{readStateIndex:14177; appliedIndex:14176; }","duration":"238.060186ms","start":"2026-06-15T20:27:24.660648Z","end":"2026-06-15T20:27:24.898708Z","steps":["trace[1141178328] 'read index received' (duration: 237.847011ms)","trace[1141178328] 'applied index is now lower than readState.Index' (duration: 212.005µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:27:24.898867Z","caller":"traceutil/trace.go:171","msg":"trace[1790064308] transaction","detail":"{read_only:false; response_revision:13710; number_of_response:1; }","duration":"291.961869ms","start":"2026-06-15T20:27:24.606806Z","end":"2026-06-15T20:27:24.898767Z","steps":["trace[1790064308] 'process raft request' (duration: 291.728483ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:27:24.899729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.062018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:86 size:929839"} {"level":"info","ts":"2026-06-15T20:27:24.899819Z","caller":"traceutil/trace.go:171","msg":"trace[1999189243] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:86; response_revision:13710; }","duration":"239.214532ms","start":"2026-06-15T20:27:24.660586Z","end":"2026-06-15T20:27:24.899801Z","steps":["trace[1999189243] 'agreement among raft nodes before linearized reading' (duration: 238.216111ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:27:25.104767Z","caller":"traceutil/trace.go:171","msg":"trace[374364487] transaction","detail":"{read_only:false; response_revision:13711; number_of_response:1; }","duration":"155.42354ms","start":"2026-06-15T20:27:24.949081Z","end":"2026-06-15T20:27:25.104504Z","steps":["trace[374364487] 'process raft request' (duration: 155.201126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:29:06.737576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.163103ms","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-15T20:29:06.737691Z","caller":"traceutil/trace.go:171","msg":"trace[1250931313] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14917; }","duration":"139.367348ms","start":"2026-06-15T20:29:06.598292Z","end":"2026-06-15T20:29:06.737659Z","steps":["trace[1250931313] 'range keys from in-memory index tree' (duration: 139.002189ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:29:06.737685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.950909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k5qf4\" ","response":"range_response_count:1 size:6522"} {"level":"warn","ts":"2026-06-15T20:29:06.737688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.714367ms","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-15T20:29:06.737757Z","caller":"traceutil/trace.go:171","msg":"trace[1546263497] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k5qf4; range_end:; response_count:1; response_revision:14917; }","duration":"145.059952ms","start":"2026-06-15T20:29:06.59268Z","end":"2026-06-15T20:29:06.73774Z","steps":["trace[1546263497] 'range keys from in-memory index tree' (duration: 144.856527ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:29:06.737763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.07472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-15T20:29:06.737776Z","caller":"traceutil/trace.go:171","msg":"trace[646835574] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14917; }","duration":"140.905541ms","start":"2026-06-15T20:29:06.596848Z","end":"2026-06-15T20:29:06.737753Z","steps":["trace[646835574] 'range keys from in-memory index tree' (duration: 140.501182ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:29:06.737822Z","caller":"traceutil/trace.go:171","msg":"trace[89636362] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14917; }","duration":"144.166622ms","start":"2026-06-15T20:29:06.593635Z","end":"2026-06-15T20:29:06.737801Z","steps":["trace[89636362] 'range keys from in-memory index tree' (duration: 143.666692ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:30:26.893207Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12922} {"level":"info","ts":"2026-06-15T20:30:26.976339Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12922,"took":"78.837828ms","hash":1814452791,"current-db-size-bytes":57270272,"current-db-size":"57 MB","current-db-size-in-use-bytes":31424512,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-15T20:30:26.976389Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1814452791,"revision":12922,"compact-revision":10748} {"level":"info","ts":"2026-06-15T20:34:48.61198Z","caller":"traceutil/trace.go:171","msg":"trace[2145984396] transaction","detail":"{read_only:false; response_revision:17514; number_of_response:1; }","duration":"103.750699ms","start":"2026-06-15T20:34:48.508181Z","end":"2026-06-15T20:34:48.611931Z","steps":["trace[2145984396] 'process raft request' (duration: 103.142216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:34:49.03127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.570663ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:34:49.031444Z","caller":"traceutil/trace.go:171","msg":"trace[219394419] transaction","detail":"{read_only:false; response_revision:17518; number_of_response:1; }","duration":"254.318297ms","start":"2026-06-15T20:34:48.777108Z","end":"2026-06-15T20:34:49.031426Z","steps":["trace[219394419] 'process raft request' (duration: 21.495498ms)","trace[219394419] 'compare' (duration: 232.295258ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:34:49.050246Z","caller":"traceutil/trace.go:171","msg":"trace[1529305275] linearizableReadLoop","detail":"{readStateIndex:18107; appliedIndex:18103; }","duration":"256.34155ms","start":"2026-06-15T20:34:48.793879Z","end":"2026-06-15T20:34:49.05022Z","steps":["trace[1529305275] 'read index received' (duration: 4.716223ms)","trace[1529305275] 'applied index is now lower than readState.Index' (duration: 251.624087ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:34:49.050343Z","caller":"traceutil/trace.go:171","msg":"trace[1351965875] transaction","detail":"{read_only:false; response_revision:17519; number_of_response:1; }","duration":"271.599132ms","start":"2026-06-15T20:34:48.778722Z","end":"2026-06-15T20:34:49.050321Z","steps":["trace[1351965875] 'process raft request' (duration: 271.288456ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:34:49.050331Z","caller":"traceutil/trace.go:171","msg":"trace[1671518165] transaction","detail":"{read_only:false; response_revision:17520; number_of_response:1; }","duration":"271.477499ms","start":"2026-06-15T20:34:48.778802Z","end":"2026-06-15T20:34:49.05028Z","steps":["trace[1671518165] 'process raft request' (duration: 271.333226ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:34:49.050381Z","caller":"traceutil/trace.go:171","msg":"trace[1238139495] transaction","detail":"{read_only:false; response_revision:17521; number_of_response:1; }","duration":"263.070217ms","start":"2026-06-15T20:34:48.787273Z","end":"2026-06-15T20:34:49.050343Z","steps":["trace[1238139495] 'process raft request' (duration: 262.900923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:34:49.050452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.576137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"} {"level":"info","ts":"2026-06-15T20:34:49.050487Z","caller":"traceutil/trace.go:171","msg":"trace[201952734] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:17521; }","duration":"256.684249ms","start":"2026-06-15T20:34:48.793792Z","end":"2026-06-15T20:34:49.050476Z","steps":["trace[201952734] 'agreement among raft nodes before linearized reading' (duration: 256.533724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:34:49.445778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.905574ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:34:49.445891Z","caller":"traceutil/trace.go:171","msg":"trace[1157451686] linearizableReadLoop","detail":"{readStateIndex:18108; appliedIndex:18107; }","duration":"395.567592ms","start":"2026-06-15T20:34:49.050307Z","end":"2026-06-15T20:34:49.445875Z","steps":["trace[1157451686] 'read index received' (duration: 81.122286ms)","trace[1157451686] 'applied index is now lower than readState.Index' (duration: 314.444076ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:34:49.445986Z","caller":"traceutil/trace.go:171","msg":"trace[298179647] transaction","detail":"{read_only:false; response_revision:17522; number_of_response:1; }","duration":"461.626449ms","start":"2026-06-15T20:34:48.984348Z","end":"2026-06-15T20:34:49.445975Z","steps":["trace[298179647] 'process raft request' (duration: 147.43918ms)","trace[298179647] 'compare' (duration: 313.791181ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:34:49.44611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.676812ms","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-15T20:34:49.446196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:34:48.984317Z","time spent":"461.700231ms","remote":"127.0.0.1:44444","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-15T20:34:49.446595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.938325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-594e6242-1472-4f22-8673-841f6e537328\" ","response":"range_response_count:1 size:1318"} {"level":"info","ts":"2026-06-15T20:34:49.446641Z","caller":"traceutil/trace.go:171","msg":"trace[1132350630] range","detail":"{range_begin:/registry/persistentvolumes/pvc-594e6242-1472-4f22-8673-841f6e537328; range_end:; response_count:1; response_revision:17522; }","duration":"393.021845ms","start":"2026-06-15T20:34:49.053606Z","end":"2026-06-15T20:34:49.446628Z","steps":["trace[1132350630] 'agreement among raft nodes before linearized reading' (duration: 392.879162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:34:49.446676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:34:49.053587Z","time spent":"393.082417ms","remote":"127.0.0.1:44312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1341,"request content":"key:\"/registry/persistentvolumes/pvc-594e6242-1472-4f22-8673-841f6e537328\" "} {"level":"warn","ts":"2026-06-15T20:34:49.446685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.90426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-15T20:34:49.44686Z","caller":"traceutil/trace.go:171","msg":"trace[483604158] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:17522; }","duration":"425.164736ms","start":"2026-06-15T20:34:49.021669Z","end":"2026-06-15T20:34:49.446834Z","steps":["trace[483604158] 'agreement among raft nodes before linearized reading' (duration: 424.563113ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:34:49.446204Z","caller":"traceutil/trace.go:171","msg":"trace[2126678837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17522; }","duration":"507.832825ms","start":"2026-06-15T20:34:48.938353Z","end":"2026-06-15T20:34:49.446186Z","steps":["trace[2126678837] 'agreement among raft nodes before linearized reading' (duration: 507.61795ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:34:49.446925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:34:48.938316Z","time spent":"508.598383ms","remote":"127.0.0.1:44444","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-15T20:34:49.446931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:34:49.021644Z","time spent":"425.273849ms","remote":"127.0.0.1:44250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":181,"response size":32,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-06-15T20:34:49.447163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.882595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-hlmdk\" ","response":"range_response_count:1 size:20865"} {"level":"info","ts":"2026-06-15T20:34:49.447202Z","caller":"traceutil/trace.go:171","msg":"trace[801620406] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-hlmdk; range_end:; response_count:1; response_revision:17522; }","duration":"218.944616ms","start":"2026-06-15T20:34:49.228246Z","end":"2026-06-15T20:34:49.447191Z","steps":["trace[801620406] 'agreement among raft nodes before linearized reading' (duration: 218.830604ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:34:49.447694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.940037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" ","response":"range_response_count:1 size:3226"} {"level":"warn","ts":"2026-06-15T20:34:49.44777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.21305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-8vpkk\" ","response":"range_response_count:1 size:9800"} {"level":"info","ts":"2026-06-15T20:34:49.44781Z","caller":"traceutil/trace.go:171","msg":"trace[847910257] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat; range_end:; response_count:1; response_revision:17522; }","duration":"389.092351ms","start":"2026-06-15T20:34:49.058688Z","end":"2026-06-15T20:34:49.447781Z","steps":["trace[847910257] 'agreement among raft nodes before linearized reading' (duration: 388.747284ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:34:49.447816Z","caller":"traceutil/trace.go:171","msg":"trace[599537677] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-8vpkk; range_end:; response_count:1; response_revision:17522; }","duration":"393.275681ms","start":"2026-06-15T20:34:49.054525Z","end":"2026-06-15T20:34:49.447801Z","steps":["trace[599537677] 'agreement among raft nodes before linearized reading' (duration: 393.004886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:34:49.447868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:34:49.058677Z","time spent":"389.179403ms","remote":"127.0.0.1:55348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":3249,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" "} {"level":"warn","ts":"2026-06-15T20:34:49.447895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:34:49.054516Z","time spent":"393.371643ms","remote":"127.0.0.1:44350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9823,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-8vpkk\" "} {"level":"info","ts":"2026-06-15T20:35:26.900747Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15459} {"level":"info","ts":"2026-06-15T20:35:26.997291Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15459,"took":"92.922933ms","hash":1402166668,"current-db-size-bytes":57270272,"current-db-size":"57 MB","current-db-size-in-use-bytes":34033664,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-15T20:35:26.997417Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1402166668,"revision":15459,"compact-revision":12922} {"level":"info","ts":"2026-06-15T20:38:18.06879Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a31e123290fcf0df","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-15T20:38:18.074411Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-15T20:38:18.074543Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"warn","ts":"2026-06-15T20:39:35.098585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.016458ms","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-15T20:39:35.098717Z","caller":"traceutil/trace.go:171","msg":"trace[1817478701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19794; }","duration":"131.165462ms","start":"2026-06-15T20:39:34.967527Z","end":"2026-06-15T20:39:35.098692Z","steps":["trace[1817478701] 'range keys from in-memory index tree' (duration: 130.715962ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:39:35.236603Z","caller":"traceutil/trace.go:171","msg":"trace[187794216] transaction","detail":"{read_only:false; response_revision:19795; number_of_response:1; }","duration":"133.326929ms","start":"2026-06-15T20:39:35.103188Z","end":"2026-06-15T20:39:35.236515Z","steps":["trace[187794216] 'process raft request' (duration: 133.107584ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:39:51.515512Z","caller":"traceutil/trace.go:171","msg":"trace[1913924494] transaction","detail":"{read_only:false; response_revision:19878; number_of_response:1; }","duration":"120.55844ms","start":"2026-06-15T20:39:51.39493Z","end":"2026-06-15T20:39:51.515489Z","steps":["trace[1913924494] 'process raft request' (duration: 117.638996ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:39:52.118666Z","caller":"traceutil/trace.go:171","msg":"trace[1389405961] transaction","detail":"{read_only:false; response_revision:19880; number_of_response:1; }","duration":"114.192331ms","start":"2026-06-15T20:39:52.00444Z","end":"2026-06-15T20:39:52.118633Z","steps":["trace[1389405961] 'process raft request' (duration: 113.989877ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:39:52.300543Z","caller":"traceutil/trace.go:171","msg":"trace[1007321443] transaction","detail":"{read_only:false; response_revision:19881; number_of_response:1; }","duration":"115.52579ms","start":"2026-06-15T20:39:52.184983Z","end":"2026-06-15T20:39:52.300509Z","steps":["trace[1007321443] 'process raft request' (duration: 73.039443ms)","trace[1007321443] 'compare' (duration: 42.297953ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:39:52.330581Z","caller":"traceutil/trace.go:171","msg":"trace[513467237] transaction","detail":"{read_only:false; response_revision:19882; number_of_response:1; }","duration":"143.714445ms","start":"2026-06-15T20:39:52.186824Z","end":"2026-06-15T20:39:52.330539Z","steps":["trace[513467237] 'process raft request' (duration: 143.509891ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:40:26.905977Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18042} {"level":"info","ts":"2026-06-15T20:40:27.023695Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18042,"took":"113.068846ms","hash":2717155166,"current-db-size-bytes":57270272,"current-db-size":"57 MB","current-db-size-in-use-bytes":31531008,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-15T20:40:27.023768Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2717155166,"revision":18042,"compact-revision":15459} {"level":"info","ts":"2026-06-15T20:44:41.867443Z","caller":"traceutil/trace.go:171","msg":"trace[2115098531] transaction","detail":"{read_only:false; response_revision:23049; number_of_response:1; }","duration":"102.25919ms","start":"2026-06-15T20:44:41.76515Z","end":"2026-06-15T20:44:41.86741Z","steps":["trace[2115098531] 'process raft request' (duration: 102.058626ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:45:26.91321Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20352} {"level":"info","ts":"2026-06-15T20:45:27.021764Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20352,"took":"104.722324ms","hash":1354686972,"current-db-size-bytes":57270272,"current-db-size":"57 MB","current-db-size-in-use-bytes":44564480,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-06-15T20:45:27.022056Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1354686972,"revision":20352,"compact-revision":18042} {"level":"info","ts":"2026-06-15T20:46:37.598293Z","caller":"traceutil/trace.go:171","msg":"trace[1690503628] transaction","detail":"{read_only:false; response_revision:24219; number_of_response:1; }","duration":"107.776565ms","start":"2026-06-15T20:46:37.49048Z","end":"2026-06-15T20:46:37.598256Z","steps":["trace[1690503628] 'process raft request' (duration: 107.553969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:38.157654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.891395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:46:38.157752Z","caller":"traceutil/trace.go:171","msg":"trace[793420468] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0; response_count:0; response_revision:24220; }","duration":"164.061618ms","start":"2026-06-15T20:46:37.993669Z","end":"2026-06-15T20:46:38.157731Z","steps":["trace[793420468] 'count revisions from in-memory index tree' (duration: 163.783392ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:38.188606Z","caller":"traceutil/trace.go:171","msg":"trace[302094341] transaction","detail":"{read_only:false; response_revision:24221; number_of_response:1; }","duration":"165.923289ms","start":"2026-06-15T20:46:38.022655Z","end":"2026-06-15T20:46:38.188578Z","steps":["trace[302094341] 'process raft request' (duration: 165.699755ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:38.300548Z","caller":"traceutil/trace.go:171","msg":"trace[372187608] transaction","detail":"{read_only:false; response_revision:24222; number_of_response:1; }","duration":"277.671849ms","start":"2026-06-15T20:46:38.022855Z","end":"2026-06-15T20:46:38.300527Z","steps":["trace[372187608] 'process raft request' (duration: 269.842969ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:38.300716Z","caller":"traceutil/trace.go:171","msg":"trace[1645030282] linearizableReadLoop","detail":"{readStateIndex:25006; appliedIndex:25004; }","duration":"274.864048ms","start":"2026-06-15T20:46:38.025844Z","end":"2026-06-15T20:46:38.300708Z","steps":["trace[1645030282] 'read index received' (duration: 162.503194ms)","trace[1645030282] 'applied index is now lower than readState.Index' (duration: 112.359954ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:38.300784Z","caller":"traceutil/trace.go:171","msg":"trace[2030496743] transaction","detail":"{read_only:false; response_revision:24223; number_of_response:1; }","duration":"132.308627ms","start":"2026-06-15T20:46:38.16846Z","end":"2026-06-15T20:46:38.300769Z","steps":["trace[2030496743] 'process raft request' (duration: 132.020801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:38.300834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.972271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:46:38.300858Z","caller":"traceutil/trace.go:171","msg":"trace[1713092964] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:24223; }","duration":"275.063543ms","start":"2026-06-15T20:46:38.025786Z","end":"2026-06-15T20:46:38.30085Z","steps":["trace[1713092964] 'agreement among raft nodes before linearized reading' (duration: 274.973211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:38.301004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.538513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-15T20:46:38.301059Z","caller":"traceutil/trace.go:171","msg":"trace[653128105] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24223; }","duration":"132.628884ms","start":"2026-06-15T20:46:38.168415Z","end":"2026-06-15T20:46:38.301044Z","steps":["trace[653128105] 'agreement among raft nodes before linearized reading' (duration: 132.463051ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:38.596723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.595903ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:46:38.596817Z","caller":"traceutil/trace.go:171","msg":"trace[751405705] transaction","detail":"{read_only:false; response_revision:24224; number_of_response:1; }","duration":"292.667026ms","start":"2026-06-15T20:46:38.30413Z","end":"2026-06-15T20:46:38.596797Z","steps":["trace[751405705] 'process raft request' (duration: 177.91868ms)","trace[751405705] 'compare' (duration: 114.370268ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:38.752167Z","caller":"traceutil/trace.go:171","msg":"trace[462529063] transaction","detail":"{read_only:false; response_revision:24225; number_of_response:1; }","duration":"447.244337ms","start":"2026-06-15T20:46:38.304891Z","end":"2026-06-15T20:46:38.752136Z","steps":["trace[462529063] 'process raft request' (duration: 392.618349ms)","trace[462529063] 'compare' (duration: 54.429964ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:38.752413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:38.304878Z","time spent":"447.374571ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:46:38.752555Z","caller":"traceutil/trace.go:171","msg":"trace[712626632] linearizableReadLoop","detail":"{readStateIndex:25012; appliedIndex:25007; }","duration":"322.750701ms","start":"2026-06-15T20:46:38.429785Z","end":"2026-06-15T20:46:38.752535Z","steps":["trace[712626632] 'read index received' (duration: 52.279957ms)","trace[712626632] 'applied index is now lower than readState.Index' (duration: 270.469764ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:38.752696Z","caller":"traceutil/trace.go:171","msg":"trace[647950738] transaction","detail":"{read_only:false; response_revision:24226; number_of_response:1; }","duration":"447.648497ms","start":"2026-06-15T20:46:38.305009Z","end":"2026-06-15T20:46:38.752658Z","steps":["trace[647950738] 'process raft request' (duration: 447.079244ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:38.752781Z","caller":"traceutil/trace.go:171","msg":"trace[148990863] transaction","detail":"{read_only:false; response_revision:24228; number_of_response:1; }","duration":"441.241119ms","start":"2026-06-15T20:46:38.311523Z","end":"2026-06-15T20:46:38.752764Z","steps":["trace[148990863] 'process raft request' (duration: 440.971583ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:38.752881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:38.304981Z","time spent":"447.79361ms","remote":"127.0.0.1:44444","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-15T20:46:38.752909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.728879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-15T20:46:38.752968Z","caller":"traceutil/trace.go:171","msg":"trace[1167559777] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:24228; }","duration":"299.792261ms","start":"2026-06-15T20:46:38.453159Z","end":"2026-06-15T20:46:38.752951Z","steps":["trace[1167559777] 'agreement among raft nodes before linearized reading' (duration: 299.696779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:38.752961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:38.311514Z","time spent":"441.341981ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:46:38.753221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.40571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" ","response":"range_response_count:1 size:1850"} {"level":"info","ts":"2026-06-15T20:46:38.753181Z","caller":"traceutil/trace.go:171","msg":"trace[1691561233] transaction","detail":"{read_only:false; response_revision:24227; number_of_response:1; }","duration":"447.34192ms","start":"2026-06-15T20:46:38.305822Z","end":"2026-06-15T20:46:38.753163Z","steps":["trace[1691561233] 'process raft request' (duration: 446.580364ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:38.753249Z","caller":"traceutil/trace.go:171","msg":"trace[1952651002] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:24228; }","duration":"149.466162ms","start":"2026-06-15T20:46:38.603775Z","end":"2026-06-15T20:46:38.753242Z","steps":["trace[1952651002] 'agreement among raft nodes before linearized reading' (duration: 149.351939ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:38.753341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:38.305811Z","time spent":"447.482234ms","remote":"127.0.0.1:44444","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-15T20:46:38.753415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.71933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-15T20:46:38.753414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.788958ms","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-15T20:46:38.753439Z","caller":"traceutil/trace.go:171","msg":"trace[1084884659] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24228; }","duration":"294.768191ms","start":"2026-06-15T20:46:38.458663Z","end":"2026-06-15T20:46:38.753431Z","steps":["trace[1084884659] 'agreement among raft nodes before linearized reading' (duration: 294.687159ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:38.753452Z","caller":"traceutil/trace.go:171","msg":"trace[2115701982] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24228; }","duration":"258.869461ms","start":"2026-06-15T20:46:38.494572Z","end":"2026-06-15T20:46:38.753441Z","steps":["trace[2115701982] 'agreement among raft nodes before linearized reading' (duration: 258.697947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:38.753513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.342065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:46:38.753579Z","caller":"traceutil/trace.go:171","msg":"trace[566207622] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24228; }","duration":"181.473148ms","start":"2026-06-15T20:46:38.572091Z","end":"2026-06-15T20:46:38.753564Z","steps":["trace[566207622] 'agreement among raft nodes before linearized reading' (duration: 181.324245ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:38.75354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.986416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routers/\" range_end:\"/registry/openstack.k-orc.cloud/routers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-15T20:46:38.75361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.112988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-15T20:46:38.753671Z","caller":"traceutil/trace.go:171","msg":"trace[1092343369] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routers/; range_end:/registry/openstack.k-orc.cloud/routers0; response_count:0; response_revision:24228; }","duration":"323.907216ms","start":"2026-06-15T20:46:38.429725Z","end":"2026-06-15T20:46:38.753632Z","steps":["trace[1092343369] 'agreement among raft nodes before linearized reading' (duration: 323.006077ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:38.75372Z","caller":"traceutil/trace.go:171","msg":"trace[1643351299] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24228; }","duration":"180.266771ms","start":"2026-06-15T20:46:38.573416Z","end":"2026-06-15T20:46:38.753683Z","steps":["trace[1643351299] 'agreement among raft nodes before linearized reading' (duration: 179.951314ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:38.753739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:38.429696Z","time spent":"324.018848ms","remote":"127.0.0.1:37818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/routers/\" range_end:\"/registry/openstack.k-orc.cloud/routers0\" count_only:true "} {"level":"warn","ts":"2026-06-15T20:46:39.084437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.850181ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:46:39.084676Z","caller":"traceutil/trace.go:171","msg":"trace[1656108398] transaction","detail":"{read_only:false; response_revision:24230; number_of_response:1; }","duration":"326.540512ms","start":"2026-06-15T20:46:38.758112Z","end":"2026-06-15T20:46:39.084653Z","steps":["trace[1656108398] 'process raft request' (duration: 326.43984ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:39.084668Z","caller":"traceutil/trace.go:171","msg":"trace[907162508] transaction","detail":"{read_only:false; response_revision:24229; number_of_response:1; }","duration":"327.006772ms","start":"2026-06-15T20:46:38.757621Z","end":"2026-06-15T20:46:39.084628Z","steps":["trace[907162508] 'process raft request' (duration: 135.864795ms)","trace[907162508] 'compare' (duration: 190.706978ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:39.084763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:38.758092Z","time spent":"326.635244ms","remote":"127.0.0.1:44444","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-15T20:46:39.084816Z","caller":"traceutil/trace.go:171","msg":"trace[177918212] transaction","detail":"{read_only:false; response_revision:24231; number_of_response:1; }","duration":"326.44833ms","start":"2026-06-15T20:46:38.758324Z","end":"2026-06-15T20:46:39.084773Z","steps":["trace[177918212] 'process raft request' (duration: 326.284746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:39.084933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:38.7576Z","time spent":"327.176327ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:46:39.085014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:38.7583Z","time spent":"326.610753ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:46:39.727183Z","caller":"traceutil/trace.go:171","msg":"trace[51613027] transaction","detail":"{read_only:false; response_revision:24232; number_of_response:1; }","duration":"338.140635ms","start":"2026-06-15T20:46:39.388958Z","end":"2026-06-15T20:46:39.727098Z","steps":["trace[51613027] 'process raft request' (duration: 337.675135ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:39.727055Z","caller":"traceutil/trace.go:171","msg":"trace[1971708096] linearizableReadLoop","detail":"{readStateIndex:25016; appliedIndex:25015; }","duration":"124.58849ms","start":"2026-06-15T20:46:39.602426Z","end":"2026-06-15T20:46:39.727015Z","steps":["trace[1971708096] 'read index received' (duration: 123.879395ms)","trace[1971708096] 'applied index is now lower than readState.Index' (duration: 706.795µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:39.72745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:39.388918Z","time spent":"338.405611ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:46:39.727497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.860306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:46:39.727559Z","caller":"traceutil/trace.go:171","msg":"trace[1419365512] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:24232; }","duration":"118.976829ms","start":"2026-06-15T20:46:39.608559Z","end":"2026-06-15T20:46:39.727536Z","steps":["trace[1419365512] 'agreement among raft nodes before linearized reading' (duration: 118.847256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:39.727602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.086541ms","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-15T20:46:39.727745Z","caller":"traceutil/trace.go:171","msg":"trace[1578813521] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24232; }","duration":"125.337787ms","start":"2026-06-15T20:46:39.602373Z","end":"2026-06-15T20:46:39.72771Z","steps":["trace[1578813521] 'agreement among raft nodes before linearized reading' (duration: 124.847536ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:39.874508Z","caller":"traceutil/trace.go:171","msg":"trace[1355458362] transaction","detail":"{read_only:false; response_revision:24233; number_of_response:1; }","duration":"142.299945ms","start":"2026-06-15T20:46:39.732157Z","end":"2026-06-15T20:46:39.874457Z","steps":["trace[1355458362] 'process raft request' (duration: 121.229807ms)","trace[1355458362] 'compare' (duration: 20.811583ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:40.072305Z","caller":"traceutil/trace.go:171","msg":"trace[511043813] transaction","detail":"{read_only:false; response_revision:24234; number_of_response:1; }","duration":"161.298669ms","start":"2026-06-15T20:46:39.910956Z","end":"2026-06-15T20:46:40.072255Z","steps":["trace[511043813] 'process raft request' (duration: 116.572866ms)","trace[511043813] 'compare' (duration: 44.411756ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:40.439388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.933719ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:46:40.439613Z","caller":"traceutil/trace.go:171","msg":"trace[388039532] transaction","detail":"{read_only:false; response_revision:24237; number_of_response:1; }","duration":"133.29642ms","start":"2026-06-15T20:46:40.3063Z","end":"2026-06-15T20:46:40.439597Z","steps":["trace[388039532] 'process raft request' (duration: 133.180677ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:40.439582Z","caller":"traceutil/trace.go:171","msg":"trace[129441382] transaction","detail":"{read_only:false; response_revision:24236; number_of_response:1; }","duration":"245.113142ms","start":"2026-06-15T20:46:40.194404Z","end":"2026-06-15T20:46:40.439517Z","steps":["trace[129441382] 'process raft request' (duration: 107.968209ms)","trace[129441382] 'compare' (duration: 136.673313ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:40.439651Z","caller":"traceutil/trace.go:171","msg":"trace[639757989] linearizableReadLoop","detail":"{readStateIndex:25021; appliedIndex:25020; }","duration":"235.300709ms","start":"2026-06-15T20:46:40.204325Z","end":"2026-06-15T20:46:40.439625Z","steps":["trace[639757989] 'read index received' (duration: 98.021552ms)","trace[639757989] 'applied index is now lower than readState.Index' (duration: 137.276276ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:40.439869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.518253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:423"} {"level":"info","ts":"2026-06-15T20:46:40.439916Z","caller":"traceutil/trace.go:171","msg":"trace[1646184188] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:24237; }","duration":"235.612144ms","start":"2026-06-15T20:46:40.204293Z","end":"2026-06-15T20:46:40.439905Z","steps":["trace[1646184188] 'agreement among raft nodes before linearized reading' (duration: 235.41358ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:40.49315Z","caller":"traceutil/trace.go:171","msg":"trace[671609410] transaction","detail":"{read_only:false; response_revision:24238; number_of_response:1; }","duration":"186.480907ms","start":"2026-06-15T20:46:40.306639Z","end":"2026-06-15T20:46:40.49312Z","steps":["trace[671609410] 'process raft request' (duration: 186.225612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:46.243135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.565207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/groups/\" range_end:\"/registry/openstack.k-orc.cloud/groups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:46:46.243268Z","caller":"traceutil/trace.go:171","msg":"trace[804771281] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/groups/; range_end:/registry/openstack.k-orc.cloud/groups0; response_count:0; response_revision:24276; }","duration":"111.734621ms","start":"2026-06-15T20:46:46.131503Z","end":"2026-06-15T20:46:46.243238Z","steps":["trace[804771281] 'count revisions from in-memory index tree' (duration: 111.390502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:46.243646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.088604ms","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-15T20:46:46.243725Z","caller":"traceutil/trace.go:171","msg":"trace[217650246] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24276; }","duration":"138.219477ms","start":"2026-06-15T20:46:46.105488Z","end":"2026-06-15T20:46:46.243707Z","steps":["trace[217650246] 'range keys from in-memory index tree' (duration: 137.817909ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:46.370981Z","caller":"traceutil/trace.go:171","msg":"trace[2036258092] transaction","detail":"{read_only:false; response_revision:24277; number_of_response:1; }","duration":"123.430804ms","start":"2026-06-15T20:46:46.247522Z","end":"2026-06-15T20:46:46.370953Z","steps":["trace[2036258092] 'process raft request' (duration: 123.253921ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:46.590466Z","caller":"traceutil/trace.go:171","msg":"trace[936368156] transaction","detail":"{read_only:false; response_revision:24278; number_of_response:1; }","duration":"126.784677ms","start":"2026-06-15T20:46:46.46364Z","end":"2026-06-15T20:46:46.590425Z","steps":["trace[936368156] 'process raft request' (duration: 59.580695ms)","trace[936368156] 'compare' (duration: 66.913336ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:46.590539Z","caller":"traceutil/trace.go:171","msg":"trace[1560232371] transaction","detail":"{read_only:false; response_revision:24279; number_of_response:1; }","duration":"124.795174ms","start":"2026-06-15T20:46:46.465716Z","end":"2026-06-15T20:46:46.590512Z","steps":["trace[1560232371] 'process raft request' (duration: 124.62943ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:46.919107Z","caller":"traceutil/trace.go:171","msg":"trace[1603300735] transaction","detail":"{read_only:false; response_revision:24281; number_of_response:1; }","duration":"295.814705ms","start":"2026-06-15T20:46:46.623271Z","end":"2026-06-15T20:46:46.919085Z","steps":["trace[1603300735] 'process raft request' (duration: 286.108504ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:46.93017Z","caller":"traceutil/trace.go:171","msg":"trace[2026724615] linearizableReadLoop","detail":"{readStateIndex:25070; appliedIndex:25066; }","duration":"141.334205ms","start":"2026-06-15T20:46:46.788809Z","end":"2026-06-15T20:46:46.930143Z","steps":["trace[2026724615] 'read index received' (duration: 120.585043ms)","trace[2026724615] 'applied index is now lower than readState.Index' (duration: 20.748152ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:46.930394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.566779ms","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-15T20:46:46.930437Z","caller":"traceutil/trace.go:171","msg":"trace[797381948] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24284; }","duration":"141.679822ms","start":"2026-06-15T20:46:46.788745Z","end":"2026-06-15T20:46:46.930425Z","steps":["trace[797381948] 'agreement among raft nodes before linearized reading' (duration: 141.499858ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:46.93047Z","caller":"traceutil/trace.go:171","msg":"trace[1033945144] transaction","detail":"{read_only:false; response_revision:24282; number_of_response:1; }","duration":"147.841486ms","start":"2026-06-15T20:46:46.782595Z","end":"2026-06-15T20:46:46.930437Z","steps":["trace[1033945144] 'process raft request' (duration: 147.285604ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:46.930458Z","caller":"traceutil/trace.go:171","msg":"trace[668899941] transaction","detail":"{read_only:false; response_revision:24283; number_of_response:1; }","duration":"147.429978ms","start":"2026-06-15T20:46:46.78299Z","end":"2026-06-15T20:46:46.93042Z","steps":["trace[668899941] 'process raft request' (duration: 147.07774ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:46.930532Z","caller":"traceutil/trace.go:171","msg":"trace[1389906626] transaction","detail":"{read_only:false; response_revision:24284; number_of_response:1; }","duration":"146.563728ms","start":"2026-06-15T20:46:46.783938Z","end":"2026-06-15T20:46:46.930502Z","steps":["trace[1389906626] 'process raft request' (duration: 146.168229ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:47.099093Z","caller":"traceutil/trace.go:171","msg":"trace[1833632825] transaction","detail":"{read_only:false; response_revision:24285; number_of_response:1; }","duration":"164.181422ms","start":"2026-06-15T20:46:46.934888Z","end":"2026-06-15T20:46:47.099069Z","steps":["trace[1833632825] 'process raft request' (duration: 125.987861ms)","trace[1833632825] 'compare' (duration: 37.802293ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:47.397767Z","caller":"traceutil/trace.go:171","msg":"trace[2097014297] linearizableReadLoop","detail":"{readStateIndex:25072; appliedIndex:25071; }","duration":"274.389949ms","start":"2026-06-15T20:46:47.123348Z","end":"2026-06-15T20:46:47.397738Z","steps":["trace[2097014297] 'read index received' (duration: 274.123903ms)","trace[2097014297] 'applied index is now lower than readState.Index' (duration: 264.936µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:47.398104Z","caller":"traceutil/trace.go:171","msg":"trace[1029030408] transaction","detail":"{read_only:false; response_revision:24286; number_of_response:1; }","duration":"277.459025ms","start":"2026-06-15T20:46:47.120611Z","end":"2026-06-15T20:46:47.39807Z","steps":["trace[1029030408] 'process raft request' (duration: 276.940224ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:47.398319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.93613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-15T20:46:47.398415Z","caller":"traceutil/trace.go:171","msg":"trace[749197307] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24286; }","duration":"275.074163ms","start":"2026-06-15T20:46:47.123313Z","end":"2026-06-15T20:46:47.398387Z","steps":["trace[749197307] 'agreement among raft nodes before linearized reading' (duration: 274.772927ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:47.436361Z","caller":"traceutil/trace.go:171","msg":"trace[601654745] transaction","detail":"{read_only:false; response_revision:24287; number_of_response:1; }","duration":"154.098662ms","start":"2026-06-15T20:46:47.282225Z","end":"2026-06-15T20:46:47.436323Z","steps":["trace[601654745] 'process raft request' (duration: 153.894888ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:47.436472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.362973ms","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-15T20:46:47.436558Z","caller":"traceutil/trace.go:171","msg":"trace[184071568] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24287; }","duration":"311.519026ms","start":"2026-06-15T20:46:47.125018Z","end":"2026-06-15T20:46:47.436537Z","steps":["trace[184071568] 'agreement among raft nodes before linearized reading' (duration: 311.26416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:47.436606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:47.124987Z","time spent":"311.609459ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-15T20:46:47.752824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.147944ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:46:47.752936Z","caller":"traceutil/trace.go:171","msg":"trace[1754006731] linearizableReadLoop","detail":"{readStateIndex:25075; appliedIndex:25074; }","duration":"294.27794ms","start":"2026-06-15T20:46:47.458641Z","end":"2026-06-15T20:46:47.752919Z","steps":["trace[1754006731] 'read index received' (duration: 133.832841ms)","trace[1754006731] 'applied index is now lower than readState.Index' (duration: 160.443439ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:47.753042Z","caller":"traceutil/trace.go:171","msg":"trace[2125429350] transaction","detail":"{read_only:false; response_revision:24289; number_of_response:1; }","duration":"312.259852ms","start":"2026-06-15T20:46:47.440765Z","end":"2026-06-15T20:46:47.753025Z","steps":["trace[2125429350] 'process raft request' (duration: 151.798992ms)","trace[2125429350] 'compare' (duration: 159.886537ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:47.753136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:47.440751Z","time spent":"312.337663ms","remote":"127.0.0.1:44444","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-15T20:46:47.75325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.485241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-15T20:46:47.753296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.6272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18433"} {"level":"info","ts":"2026-06-15T20:46:47.75333Z","caller":"traceutil/trace.go:171","msg":"trace[895306140] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24289; }","duration":"182.631134ms","start":"2026-06-15T20:46:47.570678Z","end":"2026-06-15T20:46:47.753309Z","steps":["trace[895306140] 'agreement among raft nodes before linearized reading' (duration: 182.45673ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:47.753369Z","caller":"traceutil/trace.go:171","msg":"trace[1206146460] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24289; }","duration":"294.729522ms","start":"2026-06-15T20:46:47.45862Z","end":"2026-06-15T20:46:47.75335Z","steps":["trace[1206146460] 'agreement among raft nodes before linearized reading' (duration: 294.496516ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:48.131895Z","caller":"traceutil/trace.go:171","msg":"trace[2103560188] transaction","detail":"{read_only:false; response_revision:24290; number_of_response:1; }","duration":"163.345313ms","start":"2026-06-15T20:46:47.968503Z","end":"2026-06-15T20:46:48.131849Z","steps":["trace[2103560188] 'process raft request' (duration: 163.152219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:48.405791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.580635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-15T20:46:48.405898Z","caller":"traceutil/trace.go:171","msg":"trace[130917845] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:24290; }","duration":"139.75547ms","start":"2026-06-15T20:46:48.266119Z","end":"2026-06-15T20:46:48.405874Z","steps":["trace[130917845] 'count revisions from in-memory index tree' (duration: 139.473363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:48.406001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.993014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:46:48.406075Z","caller":"traceutil/trace.go:171","msg":"trace[872871929] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0; response_count:0; response_revision:24290; }","duration":"128.083336ms","start":"2026-06-15T20:46:48.277973Z","end":"2026-06-15T20:46:48.406056Z","steps":["trace[872871929] 'count revisions from in-memory index tree' (duration: 127.917953ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:48.626203Z","caller":"traceutil/trace.go:171","msg":"trace[1822442443] transaction","detail":"{read_only:false; response_revision:24291; number_of_response:1; }","duration":"215.208261ms","start":"2026-06-15T20:46:48.410967Z","end":"2026-06-15T20:46:48.626175Z","steps":["trace[1822442443] 'process raft request' (duration: 214.888704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:48.919818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.465785ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:46:48.920196Z","caller":"traceutil/trace.go:171","msg":"trace[335149055] linearizableReadLoop","detail":"{readStateIndex:25080; appliedIndex:25077; }","duration":"160.866179ms","start":"2026-06-15T20:46:48.75931Z","end":"2026-06-15T20:46:48.920176Z","steps":["trace[335149055] 'read index received' (duration: 8.918194ms)","trace[335149055] 'applied index is now lower than readState.Index' (duration: 151.946555ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:48.920379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.064483ms","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-15T20:46:48.920412Z","caller":"traceutil/trace.go:171","msg":"trace[894813228] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24294; }","duration":"161.149105ms","start":"2026-06-15T20:46:48.759249Z","end":"2026-06-15T20:46:48.920398Z","steps":["trace[894813228] 'agreement among raft nodes before linearized reading' (duration: 161.000461ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:48.920637Z","caller":"traceutil/trace.go:171","msg":"trace[677429746] transaction","detail":"{read_only:false; response_revision:24293; number_of_response:1; }","duration":"324.683973ms","start":"2026-06-15T20:46:48.595942Z","end":"2026-06-15T20:46:48.920626Z","steps":["trace[677429746] 'process raft request' (duration: 323.981468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:48.920698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:48.59592Z","time spent":"324.740123ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:46:48.920755Z","caller":"traceutil/trace.go:171","msg":"trace[537949473] transaction","detail":"{read_only:false; response_revision:24294; number_of_response:1; }","duration":"324.760513ms","start":"2026-06-15T20:46:48.595956Z","end":"2026-06-15T20:46:48.920717Z","steps":["trace[537949473] 'process raft request' (duration: 324.14994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:48.920935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:48.595934Z","time spent":"324.901757ms","remote":"127.0.0.1:44444","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-15T20:46:48.920922Z","caller":"traceutil/trace.go:171","msg":"trace[598823773] transaction","detail":"{read_only:false; response_revision:24292; number_of_response:1; }","duration":"324.932468ms","start":"2026-06-15T20:46:48.595942Z","end":"2026-06-15T20:46:48.920875Z","steps":["trace[598823773] 'process raft request' (duration: 172.314679ms)","trace[598823773] 'compare' (duration: 151.002024ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:48.92116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:48.59592Z","time spent":"325.107601ms","remote":"127.0.0.1:44444","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-15T20:46:49.244429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.174938ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:46:49.244827Z","caller":"traceutil/trace.go:171","msg":"trace[44491681] transaction","detail":"{read_only:false; response_revision:24296; number_of_response:1; }","duration":"318.395776ms","start":"2026-06-15T20:46:48.926373Z","end":"2026-06-15T20:46:49.244769Z","steps":["trace[44491681] 'process raft request' (duration: 166.716377ms)","trace[44491681] 'compare' (duration: 150.951674ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:49.245019Z","caller":"traceutil/trace.go:171","msg":"trace[1329730094] transaction","detail":"{read_only:false; response_revision:24297; number_of_response:1; }","duration":"310.141976ms","start":"2026-06-15T20:46:48.934854Z","end":"2026-06-15T20:46:49.244995Z","steps":["trace[1329730094] 'process raft request' (duration: 309.700177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:49.245071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:48.926351Z","time spent":"318.5956ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:46:49.245124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:48.934837Z","time spent":"310.240598ms","remote":"127.0.0.1:44444","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-15T20:46:49.245317Z","caller":"traceutil/trace.go:171","msg":"trace[787417660] transaction","detail":"{read_only:false; response_revision:24298; number_of_response:1; }","duration":"309.632305ms","start":"2026-06-15T20:46:48.935661Z","end":"2026-06-15T20:46:49.245293Z","steps":["trace[787417660] 'process raft request' (duration: 309.277667ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:49.245435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:48.935645Z","time spent":"309.724046ms","remote":"127.0.0.1:44444","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-15T20:46:49.245511Z","caller":"traceutil/trace.go:171","msg":"trace[802297617] transaction","detail":"{read_only:false; response_revision:24299; number_of_response:1; }","duration":"308.072961ms","start":"2026-06-15T20:46:48.937418Z","end":"2026-06-15T20:46:49.245491Z","steps":["trace[802297617] 'process raft request' (duration: 307.879837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:49.245602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:48.937387Z","time spent":"308.170023ms","remote":"127.0.0.1:44444","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-15T20:46:49.245492Z","caller":"traceutil/trace.go:171","msg":"trace[1261987926] linearizableReadLoop","detail":"{readStateIndex:25085; appliedIndex:25081; }","duration":"176.56554ms","start":"2026-06-15T20:46:49.068899Z","end":"2026-06-15T20:46:49.245465Z","steps":["trace[1261987926] 'read index received' (duration: 24.150255ms)","trace[1261987926] 'applied index is now lower than readState.Index' (duration: 152.413535ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:49.245678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.779136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-15T20:46:49.245707Z","caller":"traceutil/trace.go:171","msg":"trace[583676965] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:24299; }","duration":"176.811466ms","start":"2026-06-15T20:46:49.06889Z","end":"2026-06-15T20:46:49.245701Z","steps":["trace[583676965] 'agreement among raft nodes before linearized reading' (duration: 176.696984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:49.245897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.929689ms","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-15T20:46:49.24594Z","caller":"traceutil/trace.go:171","msg":"trace[1807842668] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24299; }","duration":"143.026091ms","start":"2026-06-15T20:46:49.102903Z","end":"2026-06-15T20:46:49.245929Z","steps":["trace[1807842668] 'agreement among raft nodes before linearized reading' (duration: 142.829427ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:49.408515Z","caller":"traceutil/trace.go:171","msg":"trace[601234963] transaction","detail":"{read_only:false; response_revision:24300; number_of_response:1; }","duration":"158.248732ms","start":"2026-06-15T20:46:49.250243Z","end":"2026-06-15T20:46:49.408492Z","steps":["trace[601234963] 'process raft request' (duration: 156.188998ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:49.873393Z","caller":"traceutil/trace.go:171","msg":"trace[1050631358] linearizableReadLoop","detail":"{readStateIndex:25088; appliedIndex:25087; }","duration":"301.066798ms","start":"2026-06-15T20:46:49.572298Z","end":"2026-06-15T20:46:49.873365Z","steps":["trace[1050631358] 'read index received' (duration: 300.865393ms)","trace[1050631358] 'applied index is now lower than readState.Index' (duration: 200.045µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:49.873536Z","caller":"traceutil/trace.go:171","msg":"trace[1852987883] transaction","detail":"{read_only:false; response_revision:24302; number_of_response:1; }","duration":"404.511948ms","start":"2026-06-15T20:46:49.468978Z","end":"2026-06-15T20:46:49.87349Z","steps":["trace[1852987883] 'process raft request' (duration: 404.215632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:49.873625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.159358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-15T20:46:49.8736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.282473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:46:49.873668Z","caller":"traceutil/trace.go:171","msg":"trace[1816126222] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:24302; }","duration":"254.225659ms","start":"2026-06-15T20:46:49.619429Z","end":"2026-06-15T20:46:49.873655Z","steps":["trace[1816126222] 'agreement among raft nodes before linearized reading' (duration: 254.156417ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:49.873685Z","caller":"traceutil/trace.go:171","msg":"trace[2103331961] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24302; }","duration":"301.439256ms","start":"2026-06-15T20:46:49.572227Z","end":"2026-06-15T20:46:49.873666Z","steps":["trace[2103331961] 'agreement among raft nodes before linearized reading' (duration: 301.274443ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:49.873774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:49.5722Z","time spent":"301.520107ms","remote":"127.0.0.1:44184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T20:46:49.873786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:49.468932Z","time spent":"404.697112ms","remote":"127.0.0.1:44444","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-15T20:46:49.873841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.195068ms","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":"warn","ts":"2026-06-15T20:46:49.873873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.753406ms","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-15T20:46:49.873938Z","caller":"traceutil/trace.go:171","msg":"trace[1831573012] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:24302; }","duration":"257.868609ms","start":"2026-06-15T20:46:49.616052Z","end":"2026-06-15T20:46:49.87392Z","steps":["trace[1831573012] 'agreement among raft nodes before linearized reading' (duration: 257.51617ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:49.873899Z","caller":"traceutil/trace.go:171","msg":"trace[156777621] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24302; }","duration":"116.2855ms","start":"2026-06-15T20:46:49.757596Z","end":"2026-06-15T20:46:49.873881Z","steps":["trace[156777621] 'agreement among raft nodes before linearized reading' (duration: 116.002723ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:50.207413Z","caller":"traceutil/trace.go:171","msg":"trace[1931489843] transaction","detail":"{read_only:false; response_revision:24304; number_of_response:1; }","duration":"109.652806ms","start":"2026-06-15T20:46:50.097729Z","end":"2026-06-15T20:46:50.207382Z","steps":["trace[1931489843] 'process raft request' (duration: 109.173114ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:50.220711Z","caller":"traceutil/trace.go:171","msg":"trace[66841178] linearizableReadLoop","detail":"{readStateIndex:25091; appliedIndex:25089; }","duration":"111.580336ms","start":"2026-06-15T20:46:50.10911Z","end":"2026-06-15T20:46:50.22069Z","steps":["trace[66841178] 'read index received' (duration: 98.026262ms)","trace[66841178] 'applied index is now lower than readState.Index' (duration: 13.552964ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:50.220867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.732309ms","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-15T20:46:50.220912Z","caller":"traceutil/trace.go:171","msg":"trace[703212440] 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:24304; }","duration":"111.834993ms","start":"2026-06-15T20:46:50.109064Z","end":"2026-06-15T20:46:50.220899Z","steps":["trace[703212440] 'agreement among raft nodes before linearized reading' (duration: 111.727461ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:50.448953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.501278ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:46:50.449243Z","caller":"traceutil/trace.go:171","msg":"trace[930073019] linearizableReadLoop","detail":"{readStateIndex:25093; appliedIndex:25091; }","duration":"221.244512ms","start":"2026-06-15T20:46:50.227977Z","end":"2026-06-15T20:46:50.449221Z","steps":["trace[930073019] 'read index received' (duration: 62.366417ms)","trace[930073019] 'applied index is now lower than readState.Index' (duration: 158.876935ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:50.449397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.405466ms","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-15T20:46:50.449449Z","caller":"traceutil/trace.go:171","msg":"trace[1455231585] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24307; }","duration":"221.508588ms","start":"2026-06-15T20:46:50.227927Z","end":"2026-06-15T20:46:50.449435Z","steps":["trace[1455231585] 'agreement among raft nodes before linearized reading' (duration: 221.369855ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:50.449664Z","caller":"traceutil/trace.go:171","msg":"trace[987683750] transaction","detail":"{read_only:false; response_revision:24305; number_of_response:1; }","duration":"228.05046ms","start":"2026-06-15T20:46:50.221576Z","end":"2026-06-15T20:46:50.449627Z","steps":["trace[987683750] 'process raft request' (duration: 68.753895ms)","trace[987683750] 'compare' (duration: 158.210152ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:50.449684Z","caller":"traceutil/trace.go:171","msg":"trace[848929575] transaction","detail":"{read_only:false; response_revision:24307; number_of_response:1; }","duration":"198.080739ms","start":"2026-06-15T20:46:50.251567Z","end":"2026-06-15T20:46:50.449648Z","steps":["trace[848929575] 'process raft request' (duration: 197.596098ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:50.449781Z","caller":"traceutil/trace.go:171","msg":"trace[1778084248] transaction","detail":"{read_only:false; response_revision:24306; number_of_response:1; }","duration":"225.691959ms","start":"2026-06-15T20:46:50.224046Z","end":"2026-06-15T20:46:50.449738Z","steps":["trace[1778084248] 'process raft request' (duration: 225.032544ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:50.992783Z","caller":"traceutil/trace.go:171","msg":"trace[1566895566] linearizableReadLoop","detail":"{readStateIndex:25095; appliedIndex:25094; }","duration":"163.728572ms","start":"2026-06-15T20:46:50.829025Z","end":"2026-06-15T20:46:50.992753Z","steps":["trace[1566895566] 'read index received' (duration: 163.688751ms)","trace[1566895566] 'applied index is now lower than readState.Index' (duration: 37.251µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:50.992781Z","caller":"traceutil/trace.go:171","msg":"trace[183470965] transaction","detail":"{read_only:false; response_revision:24308; number_of_response:1; }","duration":"257.245236ms","start":"2026-06-15T20:46:50.735503Z","end":"2026-06-15T20:46:50.992749Z","steps":["trace[183470965] 'process raft request' (duration: 257.061992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:50.993079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.034098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:46:50.993118Z","caller":"traceutil/trace.go:171","msg":"trace[2011186221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24308; }","duration":"164.127861ms","start":"2026-06-15T20:46:50.82898Z","end":"2026-06-15T20:46:50.993108Z","steps":["trace[2011186221] 'agreement among raft nodes before linearized reading' (duration: 164.025298ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:51.27636Z","caller":"traceutil/trace.go:171","msg":"trace[117035199] transaction","detail":"{read_only:false; response_revision:24313; number_of_response:1; }","duration":"263.536212ms","start":"2026-06-15T20:46:51.012799Z","end":"2026-06-15T20:46:51.276335Z","steps":["trace[117035199] 'process raft request' (duration: 263.349478ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:51.595993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.670934ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:46:51.596181Z","caller":"traceutil/trace.go:171","msg":"trace[2129074966] linearizableReadLoop","detail":"{readStateIndex:25103; appliedIndex:25100; }","duration":"284.16529ms","start":"2026-06-15T20:46:51.312Z","end":"2026-06-15T20:46:51.596165Z","steps":["trace[2129074966] 'read index received' (duration: 117.439264ms)","trace[2129074966] 'applied index is now lower than readState.Index' (duration: 166.724856ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:51.596272Z","caller":"traceutil/trace.go:171","msg":"trace[1111023475] transaction","detail":"{read_only:false; response_revision:24315; number_of_response:1; }","duration":"344.606935ms","start":"2026-06-15T20:46:51.251639Z","end":"2026-06-15T20:46:51.596246Z","steps":["trace[1111023475] 'process raft request' (duration: 344.438772ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:51.596279Z","caller":"traceutil/trace.go:171","msg":"trace[1384858824] transaction","detail":"{read_only:false; response_revision:24314; number_of_response:1; }","duration":"344.968183ms","start":"2026-06-15T20:46:51.251255Z","end":"2026-06-15T20:46:51.596223Z","steps":["trace[1384858824] 'process raft request' (duration: 177.966851ms)","trace[1384858824] 'compare' (duration: 166.556662ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:51.596448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:51.251536Z","time spent":"344.812149ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:46:51.596471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:51.251229Z","time spent":"345.133587ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:46:51.596531Z","caller":"traceutil/trace.go:171","msg":"trace[607551058] transaction","detail":"{read_only:false; response_revision:24316; number_of_response:1; }","duration":"344.677187ms","start":"2026-06-15T20:46:51.251822Z","end":"2026-06-15T20:46:51.596499Z","steps":["trace[607551058] 'process raft request' (duration: 344.304389ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:51.596589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.569909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-15T20:46:51.596651Z","caller":"traceutil/trace.go:171","msg":"trace[97880645] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24316; }","duration":"284.699203ms","start":"2026-06-15T20:46:51.311936Z","end":"2026-06-15T20:46:51.596635Z","steps":["trace[97880645] 'agreement among raft nodes before linearized reading' (duration: 284.569909ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:51.596723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:51.251773Z","time spent":"344.859271ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:46:51.596785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.98275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T20:46:51.596821Z","caller":"traceutil/trace.go:171","msg":"trace[503280539] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24316; }","duration":"154.067541ms","start":"2026-06-15T20:46:51.442744Z","end":"2026-06-15T20:46:51.596812Z","steps":["trace[503280539] 'agreement among raft nodes before linearized reading' (duration: 153.910528ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:51.596858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.003802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-15T20:46:51.596935Z","caller":"traceutil/trace.go:171","msg":"trace[526044894] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24316; }","duration":"184.154886ms","start":"2026-06-15T20:46:51.412761Z","end":"2026-06-15T20:46:51.596916Z","steps":["trace[526044894] 'agreement among raft nodes before linearized reading' (duration: 183.89574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:51.597017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.363199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:46:51.597056Z","caller":"traceutil/trace.go:171","msg":"trace[733482168] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:24316; }","duration":"137.761547ms","start":"2026-06-15T20:46:51.459285Z","end":"2026-06-15T20:46:51.597047Z","steps":["trace[733482168] 'agreement among raft nodes before linearized reading' (duration: 137.367739ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:51.75493Z","caller":"traceutil/trace.go:171","msg":"trace[877664287] transaction","detail":"{read_only:false; response_revision:24318; number_of_response:1; }","duration":"151.884514ms","start":"2026-06-15T20:46:51.603018Z","end":"2026-06-15T20:46:51.754902Z","steps":["trace[877664287] 'process raft request' (duration: 151.832982ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:51.755348Z","caller":"traceutil/trace.go:171","msg":"trace[1403762252] transaction","detail":"{read_only:false; response_revision:24317; number_of_response:1; }","duration":"152.616329ms","start":"2026-06-15T20:46:51.602696Z","end":"2026-06-15T20:46:51.755313Z","steps":["trace[1403762252] 'process raft request' (duration: 130.10408ms)","trace[1403762252] 'compare' (duration: 21.901016ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:52.098861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.480104ms","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-15T20:46:52.098999Z","caller":"traceutil/trace.go:171","msg":"trace[2034388292] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24318; }","duration":"196.668507ms","start":"2026-06-15T20:46:51.902285Z","end":"2026-06-15T20:46:52.098953Z","steps":["trace[2034388292] 'range keys from in-memory index tree' (duration: 196.258949ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:52.099041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.14734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-15T20:46:52.099119Z","caller":"traceutil/trace.go:171","msg":"trace[1615276427] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24318; }","duration":"221.310523ms","start":"2026-06-15T20:46:51.877785Z","end":"2026-06-15T20:46:52.099096Z","steps":["trace[1615276427] 'range keys from in-memory index tree' (duration: 220.902325ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:52.298073Z","caller":"traceutil/trace.go:171","msg":"trace[338921465] transaction","detail":"{read_only:false; response_revision:24319; number_of_response:1; }","duration":"193.651722ms","start":"2026-06-15T20:46:52.104395Z","end":"2026-06-15T20:46:52.298046Z","steps":["trace[338921465] 'process raft request' (duration: 193.487928ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:52.3495Z","caller":"traceutil/trace.go:171","msg":"trace[1713549690] transaction","detail":"{read_only:false; response_revision:24320; number_of_response:1; }","duration":"244.948267ms","start":"2026-06-15T20:46:52.104497Z","end":"2026-06-15T20:46:52.349445Z","steps":["trace[1713549690] 'process raft request' (duration: 222.475198ms)","trace[1713549690] 'compare' (duration: 22.245144ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:52.673887Z","caller":"traceutil/trace.go:171","msg":"trace[47215578] linearizableReadLoop","detail":"{readStateIndex:25108; appliedIndex:25107; }","duration":"220.803223ms","start":"2026-06-15T20:46:52.453058Z","end":"2026-06-15T20:46:52.673861Z","steps":["trace[47215578] 'read index received' (duration: 152.191271ms)","trace[47215578] 'applied index is now lower than readState.Index' (duration: 68.610712ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:52.673962Z","caller":"traceutil/trace.go:171","msg":"trace[2119795798] transaction","detail":"{read_only:false; response_revision:24321; number_of_response:1; }","duration":"231.541196ms","start":"2026-06-15T20:46:52.442378Z","end":"2026-06-15T20:46:52.673919Z","steps":["trace[2119795798] 'process raft request' (duration: 162.907594ms)","trace[2119795798] 'compare' (duration: 68.465958ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:52.674133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.062118ms","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-15T20:46:52.674601Z","caller":"traceutil/trace.go:171","msg":"trace[2060641328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24321; }","duration":"221.568579ms","start":"2026-06-15T20:46:52.453003Z","end":"2026-06-15T20:46:52.674572Z","steps":["trace[2060641328] 'agreement among raft nodes before linearized reading' (duration: 220.993157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:52.704873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.089108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:46:52.704951Z","caller":"traceutil/trace.go:171","msg":"trace[619665524] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24322; }","duration":"135.231871ms","start":"2026-06-15T20:46:52.569701Z","end":"2026-06-15T20:46:52.704933Z","steps":["trace[619665524] 'agreement among raft nodes before linearized reading' (duration: 135.083198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:59.083397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.349307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-90b3600a-3c56-47e7-a18b-bb4f1124edcd\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-06-15T20:46:59.083515Z","caller":"traceutil/trace.go:171","msg":"trace[873755638] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-90b3600a-3c56-47e7-a18b-bb4f1124edcd; range_end:; response_count:1; response_revision:24423; }","duration":"200.523411ms","start":"2026-06-15T20:46:58.882959Z","end":"2026-06-15T20:46:59.083483Z","steps":["trace[873755638] 'range keys from in-memory index tree' (duration: 200.091152ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:59.141308Z","caller":"traceutil/trace.go:171","msg":"trace[1632572123] transaction","detail":"{read_only:false; response_revision:24424; number_of_response:1; }","duration":"107.464718ms","start":"2026-06-15T20:46:59.033813Z","end":"2026-06-15T20:46:59.141278Z","steps":["trace[1632572123] 'process raft request' (duration: 107.258664ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:59.391623Z","caller":"traceutil/trace.go:171","msg":"trace[762617594] linearizableReadLoop","detail":"{readStateIndex:25216; appliedIndex:25212; }","duration":"207.346271ms","start":"2026-06-15T20:46:59.184255Z","end":"2026-06-15T20:46:59.391601Z","steps":["trace[762617594] 'read index received' (duration: 182.819807ms)","trace[762617594] 'applied index is now lower than readState.Index' (duration: 24.525224ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:46:59.391781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.509804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:46:59.39182Z","caller":"traceutil/trace.go:171","msg":"trace[783601303] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:24428; }","duration":"207.601726ms","start":"2026-06-15T20:46:59.184207Z","end":"2026-06-15T20:46:59.391809Z","steps":["trace[783601303] 'agreement among raft nodes before linearized reading' (duration: 207.486064ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:59.391795Z","caller":"traceutil/trace.go:171","msg":"trace[988961463] transaction","detail":"{read_only:false; response_revision:24426; number_of_response:1; }","duration":"354.945451ms","start":"2026-06-15T20:46:59.036808Z","end":"2026-06-15T20:46:59.391753Z","steps":["trace[988961463] 'process raft request' (duration: 354.540252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:59.392022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:59.036769Z","time spent":"355.129395ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:46:59.392118Z","caller":"traceutil/trace.go:171","msg":"trace[120744126] transaction","detail":"{read_only:false; response_revision:24427; number_of_response:1; }","duration":"355.139054ms","start":"2026-06-15T20:46:59.036969Z","end":"2026-06-15T20:46:59.392108Z","steps":["trace[120744126] 'process raft request' (duration: 354.517671ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:59.392056Z","caller":"traceutil/trace.go:171","msg":"trace[784739918] transaction","detail":"{read_only:false; response_revision:24425; number_of_response:1; }","duration":"356.924443ms","start":"2026-06-15T20:46:59.035101Z","end":"2026-06-15T20:46:59.392026Z","steps":["trace[784739918] 'process raft request' (duration: 331.98967ms)","trace[784739918] 'compare' (duration: 23.85988ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:59.392022Z","caller":"traceutil/trace.go:171","msg":"trace[1726753496] transaction","detail":"{read_only:false; response_revision:24428; number_of_response:1; }","duration":"303.715946ms","start":"2026-06-15T20:46:59.088273Z","end":"2026-06-15T20:46:59.391989Z","steps":["trace[1726753496] 'process raft request' (duration: 303.250866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:59.392271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:59.03692Z","time spent":"355.241468ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:46:59.392301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:59.035061Z","time spent":"357.130517ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:46:59.39236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:59.088247Z","time spent":"303.976601ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:46:59.75114Z","caller":"traceutil/trace.go:171","msg":"trace[434090864] transaction","detail":"{read_only:false; response_revision:24429; number_of_response:1; }","duration":"126.595833ms","start":"2026-06-15T20:46:59.62452Z","end":"2026-06-15T20:46:59.751116Z","steps":["trace[434090864] 'process raft request' (duration: 126.43033ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:59.968953Z","caller":"traceutil/trace.go:171","msg":"trace[1993172693] linearizableReadLoop","detail":"{readStateIndex:25219; appliedIndex:25216; }","duration":"269.750987ms","start":"2026-06-15T20:46:59.699177Z","end":"2026-06-15T20:46:59.968928Z","steps":["trace[1993172693] 'read index received' (duration: 51.839527ms)","trace[1993172693] 'applied index is now lower than readState.Index' (duration: 217.90833ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:46:59.969002Z","caller":"traceutil/trace.go:171","msg":"trace[1460308233] transaction","detail":"{read_only:false; response_revision:24431; number_of_response:1; }","duration":"343.132523ms","start":"2026-06-15T20:46:59.625835Z","end":"2026-06-15T20:46:59.968968Z","steps":["trace[1460308233] 'process raft request' (duration: 343.044701ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:59.969134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:59.625827Z","time spent":"343.232096ms","remote":"127.0.0.1:44444","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-15T20:46:59.969143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.930421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:46:59.969184Z","caller":"traceutil/trace.go:171","msg":"trace[964340939] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:24431; }","duration":"270.033253ms","start":"2026-06-15T20:46:59.699137Z","end":"2026-06-15T20:46:59.96917Z","steps":["trace[964340939] 'agreement among raft nodes before linearized reading' (duration: 269.937831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:59.96926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.180322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-90b3600a-3c56-47e7-a18b-bb4f1124edcd\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-06-15T20:46:59.9693Z","caller":"traceutil/trace.go:171","msg":"trace[1628835210] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-90b3600a-3c56-47e7-a18b-bb4f1124edcd; range_end:; response_count:1; response_revision:24431; }","duration":"256.288674ms","start":"2026-06-15T20:46:59.713Z","end":"2026-06-15T20:46:59.969289Z","steps":["trace[1628835210] 'agreement among raft nodes before linearized reading' (duration: 256.090169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:59.969339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.102336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3236"} {"level":"info","ts":"2026-06-15T20:46:59.969359Z","caller":"traceutil/trace.go:171","msg":"trace[856931527] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:24431; }","duration":"105.150787ms","start":"2026-06-15T20:46:59.864201Z","end":"2026-06-15T20:46:59.969352Z","steps":["trace[856931527] 'agreement among raft nodes before linearized reading' (duration: 105.037654ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:59.96936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.82756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T20:46:59.969427Z","caller":"traceutil/trace.go:171","msg":"trace[1185020666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24431; }","duration":"167.966223ms","start":"2026-06-15T20:46:59.801445Z","end":"2026-06-15T20:46:59.969412Z","steps":["trace[1185020666] 'agreement among raft nodes before linearized reading' (duration: 167.722518ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:59.969408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.709218ms","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-15T20:46:59.969515Z","caller":"traceutil/trace.go:171","msg":"trace[1064431224] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24431; }","duration":"167.850401ms","start":"2026-06-15T20:46:59.801631Z","end":"2026-06-15T20:46:59.969482Z","steps":["trace[1064431224] 'agreement among raft nodes before linearized reading' (duration: 167.506633ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:46:59.969015Z","caller":"traceutil/trace.go:171","msg":"trace[1094385346] transaction","detail":"{read_only:false; response_revision:24430; number_of_response:1; }","duration":"343.763258ms","start":"2026-06-15T20:46:59.625197Z","end":"2026-06-15T20:46:59.968961Z","steps":["trace[1094385346] 'process raft request' (duration: 343.524612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:46:59.969668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:46:59.625173Z","time spent":"344.441262ms","remote":"127.0.0.1:44444","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-15T20:46:59.969712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.092609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:31 size:268836"} {"level":"info","ts":"2026-06-15T20:46:59.969764Z","caller":"traceutil/trace.go:171","msg":"trace[741265945] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:31; response_revision:24431; }","duration":"250.168511ms","start":"2026-06-15T20:46:59.719582Z","end":"2026-06-15T20:46:59.969751Z","steps":["trace[741265945] 'agreement among raft nodes before linearized reading' (duration: 249.62962ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:00.08472Z","caller":"traceutil/trace.go:171","msg":"trace[1837266215] transaction","detail":"{read_only:false; response_revision:24432; number_of_response:1; }","duration":"108.896217ms","start":"2026-06-15T20:46:59.975787Z","end":"2026-06-15T20:47:00.084684Z","steps":["trace[1837266215] 'process raft request' (duration: 28.119081ms)","trace[1837266215] 'compare' (duration: 80.639333ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:00.263728Z","caller":"traceutil/trace.go:171","msg":"trace[1273423046] transaction","detail":"{read_only:false; response_revision:24433; number_of_response:1; }","duration":"287.460152ms","start":"2026-06-15T20:46:59.976228Z","end":"2026-06-15T20:47:00.263688Z","steps":["trace[1273423046] 'process raft request' (duration: 270.409971ms)","trace[1273423046] 'compare' (duration: 16.668593ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:00.263997Z","caller":"traceutil/trace.go:171","msg":"trace[1962676272] linearizableReadLoop","detail":"{readStateIndex:25222; appliedIndex:25219; }","duration":"285.56185ms","start":"2026-06-15T20:46:59.978404Z","end":"2026-06-15T20:47:00.263966Z","steps":["trace[1962676272] 'read index received' (duration: 25.518545ms)","trace[1962676272] 'applied index is now lower than readState.Index' (duration: 260.041605ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:00.264134Z","caller":"traceutil/trace.go:171","msg":"trace[1154454642] transaction","detail":"{read_only:false; response_revision:24434; number_of_response:1; }","duration":"287.553425ms","start":"2026-06-15T20:46:59.976549Z","end":"2026-06-15T20:47:00.264102Z","steps":["trace[1154454642] 'process raft request' (duration: 287.061533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:00.264625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.198175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila-nodes\" ","response":"range_response_count:1 size:1258"} {"level":"info","ts":"2026-06-15T20:47:00.264712Z","caller":"traceutil/trace.go:171","msg":"trace[1533836448] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila-nodes; range_end:; response_count:1; response_revision:24434; }","duration":"286.331048ms","start":"2026-06-15T20:46:59.978368Z","end":"2026-06-15T20:47:00.264699Z","steps":["trace[1533836448] 'agreement among raft nodes before linearized reading' (duration: 285.844117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:00.264835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.302304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-90b3600a-3c56-47e7-a18b-bb4f1124edcd\" ","response":"range_response_count:1 size:3764"} {"level":"warn","ts":"2026-06-15T20:47:00.264961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.205137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.113\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-15T20:47:00.264989Z","caller":"traceutil/trace.go:171","msg":"trace[347815912] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-90b3600a-3c56-47e7-a18b-bb4f1124edcd; range_end:; response_count:1; response_revision:24434; }","duration":"176.506509ms","start":"2026-06-15T20:47:00.088404Z","end":"2026-06-15T20:47:00.26491Z","steps":["trace[347815912] 'agreement among raft nodes before linearized reading' (duration: 176.317565ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:00.265018Z","caller":"traceutil/trace.go:171","msg":"trace[1846521108] range","detail":"{range_begin:/registry/masterleases/199.204.45.113; range_end:; response_count:1; response_revision:24434; }","duration":"167.36558ms","start":"2026-06-15T20:47:00.097637Z","end":"2026-06-15T20:47:00.265002Z","steps":["trace[1846521108] 'agreement among raft nodes before linearized reading' (duration: 167.114145ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:02.100984Z","caller":"traceutil/trace.go:171","msg":"trace[314443702] transaction","detail":"{read_only:false; response_revision:24451; number_of_response:1; }","duration":"124.722952ms","start":"2026-06-15T20:47:01.976235Z","end":"2026-06-15T20:47:02.100958Z","steps":["trace[314443702] 'process raft request' (duration: 124.559439ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:02.124085Z","caller":"traceutil/trace.go:171","msg":"trace[2073678110] transaction","detail":"{read_only:false; response_revision:24452; number_of_response:1; }","duration":"144.211716ms","start":"2026-06-15T20:47:01.979838Z","end":"2026-06-15T20:47:02.12405Z","steps":["trace[2073678110] 'process raft request' (duration: 143.95906ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:05.285932Z","caller":"traceutil/trace.go:171","msg":"trace[1097202980] transaction","detail":"{read_only:false; response_revision:24491; number_of_response:1; }","duration":"123.099527ms","start":"2026-06-15T20:47:05.162799Z","end":"2026-06-15T20:47:05.285898Z","steps":["trace[1097202980] 'process raft request' (duration: 122.904313ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:05.507382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.898957ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-15T20:47:05.632212Z","caller":"traceutil/trace.go:171","msg":"trace[257875367] transaction","detail":"{read_only:false; response_revision:24493; number_of_response:1; }","duration":"219.351792ms","start":"2026-06-15T20:47:05.412832Z","end":"2026-06-15T20:47:05.632184Z","steps":["trace[257875367] 'process raft request' (duration: 219.165028ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:05.632439Z","caller":"traceutil/trace.go:171","msg":"trace[753886273] transaction","detail":"{read_only:false; response_revision:24494; number_of_response:1; }","duration":"214.813443ms","start":"2026-06-15T20:47:05.417579Z","end":"2026-06-15T20:47:05.632392Z","steps":["trace[753886273] 'process raft request' (duration: 214.562318ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:05.632534Z","caller":"traceutil/trace.go:171","msg":"trace[1347958545] transaction","detail":"{read_only:false; response_revision:24495; number_of_response:1; }","duration":"172.687687ms","start":"2026-06-15T20:47:05.459819Z","end":"2026-06-15T20:47:05.632507Z","steps":["trace[1347958545] 'process raft request' (duration: 172.500873ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:05.632849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.552918ms","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-15T20:47:05.632458Z","caller":"traceutil/trace.go:171","msg":"trace[302658068] linearizableReadLoop","detail":"{readStateIndex:25284; appliedIndex:25281; }","duration":"215.14605ms","start":"2026-06-15T20:47:05.417289Z","end":"2026-06-15T20:47:05.632435Z","steps":["trace[302658068] 'read index received' (duration: 85.448619ms)","trace[302658068] 'applied index is now lower than readState.Index' (duration: 129.695971ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:05.632936Z","caller":"traceutil/trace.go:171","msg":"trace[962094638] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24495; }","duration":"215.688911ms","start":"2026-06-15T20:47:05.417226Z","end":"2026-06-15T20:47:05.632915Z","steps":["trace[962094638] 'agreement among raft nodes before linearized reading' (duration: 215.438956ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:05.63307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.828744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:47:05.633116Z","caller":"traceutil/trace.go:171","msg":"trace[227462391] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:24495; }","duration":"129.901825ms","start":"2026-06-15T20:47:05.503201Z","end":"2026-06-15T20:47:05.633103Z","steps":["trace[227462391] 'agreement among raft nodes before linearized reading' (duration: 129.795503ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:33.572758Z","caller":"traceutil/trace.go:171","msg":"trace[87930143] transaction","detail":"{read_only:false; response_revision:24719; number_of_response:1; }","duration":"178.356149ms","start":"2026-06-15T20:47:33.394355Z","end":"2026-06-15T20:47:33.572711Z","steps":["trace[87930143] 'process raft request' (duration: 178.143485ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:33.828992Z","caller":"traceutil/trace.go:171","msg":"trace[229132609] transaction","detail":"{read_only:false; response_revision:24720; number_of_response:1; }","duration":"230.929362ms","start":"2026-06-15T20:47:33.598024Z","end":"2026-06-15T20:47:33.828954Z","steps":["trace[229132609] 'process raft request' (duration: 201.277868ms)","trace[229132609] 'compare' (duration: 29.472021ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:33.829009Z","caller":"traceutil/trace.go:171","msg":"trace[1324663628] linearizableReadLoop","detail":"{readStateIndex:25517; appliedIndex:25516; }","duration":"205.925399ms","start":"2026-06-15T20:47:33.623057Z","end":"2026-06-15T20:47:33.828982Z","steps":["trace[1324663628] 'read index received' (duration: 176.321776ms)","trace[1324663628] 'applied index is now lower than readState.Index' (duration: 29.602203ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:47:33.829307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.221005ms","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-15T20:47:33.82936Z","caller":"traceutil/trace.go:171","msg":"trace[601155241] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:24721; }","duration":"206.293877ms","start":"2026-06-15T20:47:33.62305Z","end":"2026-06-15T20:47:33.829344Z","steps":["trace[601155241] 'agreement among raft nodes before linearized reading' (duration: 206.046611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:33.858875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.410998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-06-15T20:47:33.858946Z","caller":"traceutil/trace.go:171","msg":"trace[743509469] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24723; }","duration":"102.525601ms","start":"2026-06-15T20:47:33.756404Z","end":"2026-06-15T20:47:33.85893Z","steps":["trace[743509469] 'agreement among raft nodes before linearized reading' (duration: 102.284536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:33.858645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.34523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:47:33.859537Z","caller":"traceutil/trace.go:171","msg":"trace[1772458758] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:24723; }","duration":"162.225619ms","start":"2026-06-15T20:47:33.69727Z","end":"2026-06-15T20:47:33.859495Z","steps":["trace[1772458758] 'agreement among raft nodes before linearized reading' (duration: 161.298539ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:34.159611Z","caller":"traceutil/trace.go:171","msg":"trace[1928434419] transaction","detail":"{read_only:false; response_revision:24724; number_of_response:1; }","duration":"295.554308ms","start":"2026-06-15T20:47:33.864037Z","end":"2026-06-15T20:47:34.159591Z","steps":["trace[1928434419] 'process raft request' (duration: 295.327584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:34.520037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.574115ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:47:34.520213Z","caller":"traceutil/trace.go:171","msg":"trace[1590988949] transaction","detail":"{read_only:false; response_revision:24726; number_of_response:1; }","duration":"310.636867ms","start":"2026-06-15T20:47:34.209561Z","end":"2026-06-15T20:47:34.520198Z","steps":["trace[1590988949] 'process raft request' (duration: 310.580876ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:34.520199Z","caller":"traceutil/trace.go:171","msg":"trace[1083043431] transaction","detail":"{read_only:false; response_revision:24725; number_of_response:1; }","duration":"640.791978ms","start":"2026-06-15T20:47:33.879344Z","end":"2026-06-15T20:47:34.520136Z","steps":["trace[1083043431] 'process raft request' (duration: 336.032869ms)","trace[1083043431] 'compare' (duration: 304.467003ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:47:34.520332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:47:34.209524Z","time spent":"310.765719ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:47:34.520422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:47:33.879328Z","time spent":"640.976782ms","remote":"127.0.0.1:44444","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-15T20:47:34.520582Z","caller":"traceutil/trace.go:171","msg":"trace[1866729045] linearizableReadLoop","detail":"{readStateIndex:25522; appliedIndex:25520; }","duration":"581.58179ms","start":"2026-06-15T20:47:33.938976Z","end":"2026-06-15T20:47:34.520558Z","steps":["trace[1866729045] 'read index received' (duration: 220.435535ms)","trace[1866729045] 'applied index is now lower than readState.Index' (duration: 361.144895ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:47:34.520779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.811475ms","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-15T20:47:34.52081Z","caller":"traceutil/trace.go:171","msg":"trace[1699938579] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24726; }","duration":"581.884627ms","start":"2026-06-15T20:47:33.938917Z","end":"2026-06-15T20:47:34.520801Z","steps":["trace[1699938579] 'agreement among raft nodes before linearized reading' (duration: 581.823856ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:34.520831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:47:33.938874Z","time spent":"581.952739ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-06-15T20:47:34.524668Z","caller":"traceutil/trace.go:171","msg":"trace[1456370109] transaction","detail":"{read_only:false; response_revision:24727; number_of_response:1; }","duration":"293.229947ms","start":"2026-06-15T20:47:34.2314Z","end":"2026-06-15T20:47:34.52463Z","steps":["trace[1456370109] 'process raft request' (duration: 293.031893ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:34.524816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.968022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:47:34.524892Z","caller":"traceutil/trace.go:171","msg":"trace[301442173] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:24727; }","duration":"236.129696ms","start":"2026-06-15T20:47:34.288748Z","end":"2026-06-15T20:47:34.524878Z","steps":["trace[301442173] 'agreement among raft nodes before linearized reading' (duration: 235.988282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:34.525199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.89551ms","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-15T20:47:34.525237Z","caller":"traceutil/trace.go:171","msg":"trace[714089265] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24727; }","duration":"103.987302ms","start":"2026-06-15T20:47:34.421244Z","end":"2026-06-15T20:47:34.525231Z","steps":["trace[714089265] 'agreement among raft nodes before linearized reading' (duration: 103.90283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:34.52532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.242683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T20:47:34.525342Z","caller":"traceutil/trace.go:171","msg":"trace[234661935] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24727; }","duration":"227.344315ms","start":"2026-06-15T20:47:34.297993Z","end":"2026-06-15T20:47:34.525337Z","steps":["trace[234661935] 'agreement among raft nodes before linearized reading' (duration: 227.291854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:34.525376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.792239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"} {"level":"info","ts":"2026-06-15T20:47:34.525417Z","caller":"traceutil/trace.go:171","msg":"trace[1067458370] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24727; }","duration":"252.884171ms","start":"2026-06-15T20:47:34.272519Z","end":"2026-06-15T20:47:34.525404Z","steps":["trace[1067458370] 'agreement among raft nodes before linearized reading' (duration: 252.615786ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:34.898689Z","caller":"traceutil/trace.go:171","msg":"trace[2144928109] transaction","detail":"{read_only:false; response_revision:24729; number_of_response:1; }","duration":"368.102397ms","start":"2026-06-15T20:47:34.530547Z","end":"2026-06-15T20:47:34.89865Z","steps":["trace[2144928109] 'process raft request' (duration: 339.049695ms)","trace[2144928109] 'compare' (duration: 28.859748ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:34.898724Z","caller":"traceutil/trace.go:171","msg":"trace[1902220967] transaction","detail":"{read_only:false; response_revision:24730; number_of_response:1; }","duration":"367.660587ms","start":"2026-06-15T20:47:34.531036Z","end":"2026-06-15T20:47:34.898696Z","steps":["trace[1902220967] 'process raft request' (duration: 367.547354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:34.898845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:47:34.530536Z","time spent":"368.225549ms","remote":"127.0.0.1:44444","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-15T20:47:34.898873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:47:34.531027Z","time spent":"367.762159ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:47:34.898955Z","caller":"traceutil/trace.go:171","msg":"trace[1845697984] linearizableReadLoop","detail":"{readStateIndex:25528; appliedIndex:25525; }","duration":"302.174463ms","start":"2026-06-15T20:47:34.596752Z","end":"2026-06-15T20:47:34.898927Z","steps":["trace[1845697984] 'read index received' (duration: 272.827485ms)","trace[1845697984] 'applied index is now lower than readState.Index' (duration: 29.345888ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:34.899292Z","caller":"traceutil/trace.go:171","msg":"trace[1778392223] transaction","detail":"{read_only:false; response_revision:24731; number_of_response:1; }","duration":"366.466711ms","start":"2026-06-15T20:47:34.532802Z","end":"2026-06-15T20:47:34.899268Z","steps":["trace[1778392223] 'process raft request' (duration: 365.844488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:34.899292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.871762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:47:34.899353Z","caller":"traceutil/trace.go:171","msg":"trace[724084781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24731; }","duration":"327.983594ms","start":"2026-06-15T20:47:34.571353Z","end":"2026-06-15T20:47:34.899337Z","steps":["trace[724084781] 'agreement among raft nodes before linearized reading' (duration: 327.868471ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:34.899385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:47:34.571334Z","time spent":"328.044906ms","remote":"127.0.0.1:44184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T20:47:34.899377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.862566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"warn","ts":"2026-06-15T20:47:34.899416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:47:34.532791Z","time spent":"366.545234ms","remote":"127.0.0.1:44444","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-15T20:47:34.899427Z","caller":"traceutil/trace.go:171","msg":"trace[731331939] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24731; }","duration":"347.963118ms","start":"2026-06-15T20:47:34.55145Z","end":"2026-06-15T20:47:34.899413Z","steps":["trace[731331939] 'agreement among raft nodes before linearized reading' (duration: 347.808805ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:34.899422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.876893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5684"} {"level":"warn","ts":"2026-06-15T20:47:34.899465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:47:34.551431Z","time spent":"348.0252ms","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-06-15T20:47:34.899471Z","caller":"traceutil/trace.go:171","msg":"trace[907416465] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:24731; }","duration":"288.969445ms","start":"2026-06-15T20:47:34.610488Z","end":"2026-06-15T20:47:34.899458Z","steps":["trace[907416465] 'agreement among raft nodes before linearized reading' (duration: 288.787971ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:35.110205Z","caller":"traceutil/trace.go:171","msg":"trace[534074272] linearizableReadLoop","detail":"{readStateIndex:25529; appliedIndex:25528; }","duration":"149.169744ms","start":"2026-06-15T20:47:34.961011Z","end":"2026-06-15T20:47:35.110181Z","steps":["trace[534074272] 'read index received' (duration: 71.304271ms)","trace[534074272] 'applied index is now lower than readState.Index' (duration: 77.864403ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:35.110222Z","caller":"traceutil/trace.go:171","msg":"trace[1712271860] transaction","detail":"{read_only:false; response_revision:24732; number_of_response:1; }","duration":"206.246116ms","start":"2026-06-15T20:47:34.903946Z","end":"2026-06-15T20:47:35.110192Z","steps":["trace[1712271860] 'process raft request' (duration: 128.388413ms)","trace[1712271860] 'compare' (duration: 77.73574ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:47:35.110463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.426121ms","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-15T20:47:35.110558Z","caller":"traceutil/trace.go:171","msg":"trace[858799788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24732; }","duration":"149.571234ms","start":"2026-06-15T20:47:34.960966Z","end":"2026-06-15T20:47:35.110538Z","steps":["trace[858799788] 'agreement among raft nodes before linearized reading' (duration: 149.287537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:35.375237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.569185ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:47:35.375379Z","caller":"traceutil/trace.go:171","msg":"trace[907070814] linearizableReadLoop","detail":"{readStateIndex:25530; appliedIndex:25529; }","duration":"246.86413ms","start":"2026-06-15T20:47:35.128491Z","end":"2026-06-15T20:47:35.375355Z","steps":["trace[907070814] 'read index received' (duration: 119.031079ms)","trace[907070814] 'applied index is now lower than readState.Index' (duration: 127.831111ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:35.375395Z","caller":"traceutil/trace.go:171","msg":"trace[1050487422] transaction","detail":"{read_only:false; response_revision:24733; number_of_response:1; }","duration":"260.66268ms","start":"2026-06-15T20:47:35.114709Z","end":"2026-06-15T20:47:35.375372Z","steps":["trace[1050487422] 'process raft request' (duration: 132.837799ms)","trace[1050487422] 'compare' (duration: 127.237638ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:47:35.375484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.989932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/servergroups/\" range_end:\"/registry/openstack.k-orc.cloud/servergroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:47:35.375534Z","caller":"traceutil/trace.go:171","msg":"trace[1951067661] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/servergroups/; range_end:/registry/openstack.k-orc.cloud/servergroups0; response_count:0; response_revision:24733; }","duration":"247.086234ms","start":"2026-06-15T20:47:35.128433Z","end":"2026-06-15T20:47:35.375519Z","steps":["trace[1951067661] 'agreement among raft nodes before linearized reading' (duration: 246.996532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:35.553952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.151462ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-15T20:47:35.851603Z","caller":"traceutil/trace.go:171","msg":"trace[1850743824] transaction","detail":"{read_only:false; response_revision:24735; number_of_response:1; }","duration":"193.004708ms","start":"2026-06-15T20:47:35.658545Z","end":"2026-06-15T20:47:35.85155Z","steps":["trace[1850743824] 'process raft request' (duration: 192.834245ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:36.274189Z","caller":"traceutil/trace.go:171","msg":"trace[695045073] transaction","detail":"{read_only:false; response_revision:24739; number_of_response:1; }","duration":"105.991896ms","start":"2026-06-15T20:47:36.168172Z","end":"2026-06-15T20:47:36.274164Z","steps":["trace[695045073] 'process raft request' (duration: 105.833372ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:36.508116Z","caller":"traceutil/trace.go:171","msg":"trace[533406428] transaction","detail":"{read_only:false; response_revision:24740; number_of_response:1; }","duration":"200.796057ms","start":"2026-06-15T20:47:36.307299Z","end":"2026-06-15T20:47:36.508095Z","steps":["trace[533406428] 'process raft request' (duration: 127.632785ms)","trace[533406428] 'compare' (duration: 72.898766ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:47:36.799704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.437646ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:47:36.799949Z","caller":"traceutil/trace.go:171","msg":"trace[1049821169] transaction","detail":"{read_only:false; response_revision:24741; number_of_response:1; }","duration":"274.548411ms","start":"2026-06-15T20:47:36.52538Z","end":"2026-06-15T20:47:36.799929Z","steps":["trace[1049821169] 'process raft request' (duration: 93.774268ms)","trace[1049821169] 'compare' (duration: 180.041177ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:36.800226Z","caller":"traceutil/trace.go:171","msg":"trace[1040835585] transaction","detail":"{read_only:false; response_revision:24742; number_of_response:1; }","duration":"272.296392ms","start":"2026-06-15T20:47:36.52791Z","end":"2026-06-15T20:47:36.800206Z","steps":["trace[1040835585] 'process raft request' (duration: 271.915574ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:36.800267Z","caller":"traceutil/trace.go:171","msg":"trace[1993671633] linearizableReadLoop","detail":"{readStateIndex:25541; appliedIndex:25538; }","duration":"254.659459ms","start":"2026-06-15T20:47:36.545584Z","end":"2026-06-15T20:47:36.800243Z","steps":["trace[1993671633] 'read index received' (duration: 73.636501ms)","trace[1993671633] 'applied index is now lower than readState.Index' (duration: 181.021528ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:36.800316Z","caller":"traceutil/trace.go:171","msg":"trace[362011008] transaction","detail":"{read_only:false; response_revision:24743; number_of_response:1; }","duration":"268.49677ms","start":"2026-06-15T20:47:36.531759Z","end":"2026-06-15T20:47:36.800256Z","steps":["trace[362011008] 'process raft request' (duration: 268.411269ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:36.800462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.575985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:47:36.800497Z","caller":"traceutil/trace.go:171","msg":"trace[971342101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24743; }","duration":"230.664557ms","start":"2026-06-15T20:47:36.569821Z","end":"2026-06-15T20:47:36.800486Z","steps":["trace[971342101] 'agreement among raft nodes before linearized reading' (duration: 230.572015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:36.800479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.877624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:47:36.800551Z","caller":"traceutil/trace.go:171","msg":"trace[1558987039] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:24743; }","duration":"254.995286ms","start":"2026-06-15T20:47:36.545536Z","end":"2026-06-15T20:47:36.800531Z","steps":["trace[1558987039] 'agreement among raft nodes before linearized reading' (duration: 254.823043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:36.800597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.11018ms","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-15T20:47:36.800671Z","caller":"traceutil/trace.go:171","msg":"trace[627112775] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24743; }","duration":"198.216182ms","start":"2026-06-15T20:47:36.602434Z","end":"2026-06-15T20:47:36.800651Z","steps":["trace[627112775] 'agreement among raft nodes before linearized reading' (duration: 197.982607ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:37.095423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.069044ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:47:37.095677Z","caller":"traceutil/trace.go:171","msg":"trace[932389426] linearizableReadLoop","detail":"{readStateIndex:25542; appliedIndex:25541; }","duration":"192.779173ms","start":"2026-06-15T20:47:36.902875Z","end":"2026-06-15T20:47:37.095654Z","steps":["trace[932389426] 'read index received' (duration: 65.494065ms)","trace[932389426] 'applied index is now lower than readState.Index' (duration: 127.283128ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:37.095834Z","caller":"traceutil/trace.go:171","msg":"trace[1608241736] transaction","detail":"{read_only:false; response_revision:24744; number_of_response:1; }","duration":"289.853784ms","start":"2026-06-15T20:47:36.805945Z","end":"2026-06-15T20:47:37.095799Z","steps":["trace[1608241736] 'process raft request' (duration: 162.322791ms)","trace[1608241736] 'compare' (duration: 126.92551ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:47:37.095982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.09867ms","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-15T20:47:37.096027Z","caller":"traceutil/trace.go:171","msg":"trace[1713805668] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24744; }","duration":"193.211273ms","start":"2026-06-15T20:47:36.902804Z","end":"2026-06-15T20:47:37.096015Z","steps":["trace[1713805668] 'agreement among raft nodes before linearized reading' (duration: 193.046779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:37.096271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.530312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T20:47:37.096353Z","caller":"traceutil/trace.go:171","msg":"trace[1166028285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24744; }","duration":"189.635464ms","start":"2026-06-15T20:47:36.906702Z","end":"2026-06-15T20:47:37.096337Z","steps":["trace[1166028285] 'agreement among raft nodes before linearized reading' (duration: 189.369079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:37.411468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.291159ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:47:37.411636Z","caller":"traceutil/trace.go:171","msg":"trace[110369998] transaction","detail":"{read_only:false; response_revision:24747; number_of_response:1; }","duration":"226.898296ms","start":"2026-06-15T20:47:37.184719Z","end":"2026-06-15T20:47:37.411617Z","steps":["trace[110369998] 'process raft request' (duration: 82.346041ms)","trace[110369998] 'compare' (duration: 144.098675ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:47:37.688459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.785145ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:47:37.688605Z","caller":"traceutil/trace.go:171","msg":"trace[852889313] transaction","detail":"{read_only:false; response_revision:24748; number_of_response:1; }","duration":"272.969448ms","start":"2026-06-15T20:47:37.415611Z","end":"2026-06-15T20:47:37.68858Z","steps":["trace[852889313] 'process raft request' (duration: 141.936878ms)","trace[852889313] 'compare' (duration: 130.642242ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:37.754089Z","caller":"traceutil/trace.go:171","msg":"trace[1841846556] transaction","detail":"{read_only:false; response_revision:24749; number_of_response:1; }","duration":"116.263818ms","start":"2026-06-15T20:47:37.637797Z","end":"2026-06-15T20:47:37.754061Z","steps":["trace[1841846556] 'process raft request' (duration: 116.070624ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:37.89702Z","caller":"traceutil/trace.go:171","msg":"trace[1029124078] linearizableReadLoop","detail":"{readStateIndex:25548; appliedIndex:25546; }","duration":"156.261559ms","start":"2026-06-15T20:47:37.740731Z","end":"2026-06-15T20:47:37.896992Z","steps":["trace[1029124078] 'read index received' (duration: 13.171487ms)","trace[1029124078] 'applied index is now lower than readState.Index' (duration: 143.088842ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:37.897038Z","caller":"traceutil/trace.go:171","msg":"trace[499437453] transaction","detail":"{read_only:false; response_revision:24750; number_of_response:1; }","duration":"158.965107ms","start":"2026-06-15T20:47:37.738035Z","end":"2026-06-15T20:47:37.897Z","steps":["trace[499437453] 'process raft request' (duration: 145.456233ms)","trace[499437453] 'compare' (duration: 13.379461ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:47:37.897179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.419783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:47:37.897238Z","caller":"traceutil/trace.go:171","msg":"trace[290432817] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0; response_count:0; response_revision:24750; }","duration":"156.541225ms","start":"2026-06-15T20:47:37.74068Z","end":"2026-06-15T20:47:37.897221Z","steps":["trace[290432817] 'agreement among raft nodes before linearized reading' (duration: 156.413562ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:38.093885Z","caller":"traceutil/trace.go:171","msg":"trace[1401024008] transaction","detail":"{read_only:false; response_revision:24752; number_of_response:1; }","duration":"204.551959ms","start":"2026-06-15T20:47:37.889307Z","end":"2026-06-15T20:47:38.093859Z","steps":["trace[1401024008] 'process raft request' (duration: 204.410265ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:38.093985Z","caller":"traceutil/trace.go:171","msg":"trace[129845666] transaction","detail":"{read_only:false; response_revision:24751; number_of_response:1; }","duration":"204.99741ms","start":"2026-06-15T20:47:37.888945Z","end":"2026-06-15T20:47:38.093942Z","steps":["trace[129845666] 'process raft request' (duration: 113.09874ms)","trace[129845666] 'compare' (duration: 91.357197ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:38.0942Z","caller":"traceutil/trace.go:171","msg":"trace[1079517445] transaction","detail":"{read_only:false; response_revision:24753; number_of_response:1; }","duration":"204.217292ms","start":"2026-06-15T20:47:37.889972Z","end":"2026-06-15T20:47:38.094189Z","steps":["trace[1079517445] 'process raft request' (duration: 203.855324ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:38.094274Z","caller":"traceutil/trace.go:171","msg":"trace[1024568103] linearizableReadLoop","detail":"{readStateIndex:25551; appliedIndex:25548; }","duration":"197.098828ms","start":"2026-06-15T20:47:37.897092Z","end":"2026-06-15T20:47:38.094191Z","steps":["trace[1024568103] 'read index received' (duration: 104.955293ms)","trace[1024568103] 'applied index is now lower than readState.Index' (duration: 92.141535ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:47:38.094368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.44218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:47:38.094479Z","caller":"traceutil/trace.go:171","msg":"trace[1177148389] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:24753; }","duration":"263.584023ms","start":"2026-06-15T20:47:37.830845Z","end":"2026-06-15T20:47:38.094429Z","steps":["trace[1177148389] 'agreement among raft nodes before linearized reading' (duration: 263.44511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:39.040475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.039333ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:47:39.040659Z","caller":"traceutil/trace.go:171","msg":"trace[991519014] linearizableReadLoop","detail":"{readStateIndex:25555; appliedIndex:25553; }","duration":"155.652226ms","start":"2026-06-15T20:47:38.884971Z","end":"2026-06-15T20:47:39.040623Z","steps":["trace[991519014] 'read index received' (duration: 17.350157ms)","trace[991519014] 'applied index is now lower than readState.Index' (duration: 138.300839ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:39.040914Z","caller":"traceutil/trace.go:171","msg":"trace[1441027938] transaction","detail":"{read_only:false; response_revision:24756; number_of_response:1; }","duration":"236.381772ms","start":"2026-06-15T20:47:38.804519Z","end":"2026-06-15T20:47:39.040901Z","steps":["trace[1441027938] 'process raft request' (duration: 97.825658ms)","trace[1441027938] 'compare' (duration: 137.534011ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:39.041081Z","caller":"traceutil/trace.go:171","msg":"trace[1701038465] transaction","detail":"{read_only:false; response_revision:24757; number_of_response:1; }","duration":"234.873368ms","start":"2026-06-15T20:47:38.806198Z","end":"2026-06-15T20:47:39.041072Z","steps":["trace[1701038465] 'process raft request' (duration: 234.364627ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:39.041312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.30063ms","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-15T20:47:39.041388Z","caller":"traceutil/trace.go:171","msg":"trace[573681399] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:24757; }","duration":"156.444873ms","start":"2026-06-15T20:47:38.884928Z","end":"2026-06-15T20:47:39.041373Z","steps":["trace[573681399] 'agreement among raft nodes before linearized reading' (duration: 156.283279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:39.297603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.543254ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:47:39.298034Z","caller":"traceutil/trace.go:171","msg":"trace[817866657] linearizableReadLoop","detail":"{readStateIndex:25556; appliedIndex:25555; }","duration":"114.324886ms","start":"2026-06-15T20:47:39.183694Z","end":"2026-06-15T20:47:39.298019Z","steps":["trace[817866657] 'read index received' (duration: 44.281µs)","trace[817866657] 'applied index is now lower than readState.Index' (duration: 114.279425ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:39.298125Z","caller":"traceutil/trace.go:171","msg":"trace[1099613784] transaction","detail":"{read_only:false; response_revision:24758; number_of_response:1; }","duration":"193.279894ms","start":"2026-06-15T20:47:39.104836Z","end":"2026-06-15T20:47:39.298116Z","steps":["trace[1099613784] 'process raft request' (duration: 48.094577ms)","trace[1099613784] 'compare' (duration: 144.431661ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:47:39.298227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.497569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:47:39.298299Z","caller":"traceutil/trace.go:171","msg":"trace[127027809] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:24758; }","duration":"114.637212ms","start":"2026-06-15T20:47:39.183645Z","end":"2026-06-15T20:47:39.298282Z","steps":["trace[127027809] 'agreement among raft nodes before linearized reading' (duration: 114.485359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:39.298305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.459177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T20:47:39.298363Z","caller":"traceutil/trace.go:171","msg":"trace[1487742147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24758; }","duration":"113.53789ms","start":"2026-06-15T20:47:39.18481Z","end":"2026-06-15T20:47:39.298348Z","steps":["trace[1487742147] 'agreement among raft nodes before linearized reading' (duration: 113.338205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:39.298336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.306646ms","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-15T20:47:39.298419Z","caller":"traceutil/trace.go:171","msg":"trace[1751820929] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24758; }","duration":"114.410859ms","start":"2026-06-15T20:47:39.183989Z","end":"2026-06-15T20:47:39.2984Z","steps":["trace[1751820929] 'agreement among raft nodes before linearized reading' (duration: 114.163413ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:39.425883Z","caller":"traceutil/trace.go:171","msg":"trace[47602308] transaction","detail":"{read_only:false; response_revision:24760; number_of_response:1; }","duration":"107.156391ms","start":"2026-06-15T20:47:39.318691Z","end":"2026-06-15T20:47:39.425847Z","steps":["trace[47602308] 'process raft request' (duration: 103.093873ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:39.657242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.335166ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T20:47:39.657725Z","caller":"traceutil/trace.go:171","msg":"trace[1075747069] transaction","detail":"{read_only:false; response_revision:24761; number_of_response:1; }","duration":"227.618571ms","start":"2026-06-15T20:47:39.430086Z","end":"2026-06-15T20:47:39.657704Z","steps":["trace[1075747069] 'process raft request' (duration: 119.722354ms)","trace[1075747069] 'compare' (duration: 107.206932ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:39.881052Z","caller":"traceutil/trace.go:171","msg":"trace[855919346] transaction","detail":"{read_only:false; response_revision:24763; number_of_response:1; }","duration":"122.053896ms","start":"2026-06-15T20:47:39.758974Z","end":"2026-06-15T20:47:39.881028Z","steps":["trace[855919346] 'process raft request' (duration: 39.820237ms)","trace[855919346] 'compare' (duration: 82.142966ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:47:40.116294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.41933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:47:40.116353Z","caller":"traceutil/trace.go:171","msg":"trace[1107674189] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24763; }","duration":"132.526283ms","start":"2026-06-15T20:47:39.983815Z","end":"2026-06-15T20:47:40.116341Z","steps":["trace[1107674189] 'range keys from in-memory index tree' (duration: 132.352118ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:40.260019Z","caller":"traceutil/trace.go:171","msg":"trace[1068262134] linearizableReadLoop","detail":"{readStateIndex:25565; appliedIndex:25564; }","duration":"126.333007ms","start":"2026-06-15T20:47:40.133655Z","end":"2026-06-15T20:47:40.259988Z","steps":["trace[1068262134] 'read index received' (duration: 110.593875ms)","trace[1068262134] 'applied index is now lower than readState.Index' (duration: 15.737532ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:47:40.260206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.530631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5684"} {"level":"info","ts":"2026-06-15T20:47:40.260262Z","caller":"traceutil/trace.go:171","msg":"trace[771304407] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:24766; }","duration":"126.626614ms","start":"2026-06-15T20:47:40.13362Z","end":"2026-06-15T20:47:40.260246Z","steps":["trace[771304407] 'agreement among raft nodes before linearized reading' (duration: 126.44601ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:40.458669Z","caller":"traceutil/trace.go:171","msg":"trace[477262054] transaction","detail":"{read_only:false; response_revision:24767; number_of_response:1; }","duration":"197.22482ms","start":"2026-06-15T20:47:40.261407Z","end":"2026-06-15T20:47:40.458632Z","steps":["trace[477262054] 'process raft request' (duration: 106.752422ms)","trace[477262054] 'compare' (duration: 90.276214ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:41.171425Z","caller":"traceutil/trace.go:171","msg":"trace[1428361719] transaction","detail":"{read_only:false; response_revision:24771; number_of_response:1; }","duration":"124.912006ms","start":"2026-06-15T20:47:41.046475Z","end":"2026-06-15T20:47:41.171387Z","steps":["trace[1428361719] 'process raft request' (duration: 109.720906ms)","trace[1428361719] 'compare' (duration: 14.899454ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:41.171606Z","caller":"traceutil/trace.go:171","msg":"trace[2056782920] transaction","detail":"{read_only:false; response_revision:24772; number_of_response:1; }","duration":"124.890696ms","start":"2026-06-15T20:47:41.046658Z","end":"2026-06-15T20:47:41.171548Z","steps":["trace[2056782920] 'process raft request' (duration: 124.677141ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:41.543951Z","caller":"traceutil/trace.go:171","msg":"trace[1211745725] transaction","detail":"{read_only:false; response_revision:24773; number_of_response:1; }","duration":"172.257596ms","start":"2026-06-15T20:47:41.371664Z","end":"2026-06-15T20:47:41.543921Z","steps":["trace[1211745725] 'process raft request' (duration: 172.00287ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:41.551069Z","caller":"traceutil/trace.go:171","msg":"trace[1480404472] linearizableReadLoop","detail":"{readStateIndex:25573; appliedIndex:25571; }","duration":"118.892576ms","start":"2026-06-15T20:47:41.432152Z","end":"2026-06-15T20:47:41.551044Z","steps":["trace[1480404472] 'read index received' (duration: 111.473115ms)","trace[1480404472] 'applied index is now lower than readState.Index' (duration: 7.418111ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:47:41.551184Z","caller":"traceutil/trace.go:171","msg":"trace[1411746389] transaction","detail":"{read_only:false; response_revision:24774; number_of_response:1; }","duration":"178.509213ms","start":"2026-06-15T20:47:41.372626Z","end":"2026-06-15T20:47:41.551136Z","steps":["trace[1411746389] 'process raft request' (duration: 178.282078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:47:41.551424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.256815ms","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-15T20:47:41.55147Z","caller":"traceutil/trace.go:171","msg":"trace[105023629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24774; }","duration":"119.358076ms","start":"2026-06-15T20:47:41.432098Z","end":"2026-06-15T20:47:41.551456Z","steps":["trace[105023629] 'agreement among raft nodes before linearized reading' (duration: 119.06929ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:47:41.659334Z","caller":"traceutil/trace.go:171","msg":"trace[1225259763] transaction","detail":"{read_only:false; response_revision:24775; number_of_response:1; }","duration":"103.063761ms","start":"2026-06-15T20:47:41.556236Z","end":"2026-06-15T20:47:41.6593Z","steps":["trace[1225259763] 'process raft request' (duration: 63.897749ms)","trace[1225259763] 'compare' (duration: 39.015189ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:48:02.348204Z","caller":"traceutil/trace.go:171","msg":"trace[1577182771] transaction","detail":"{read_only:false; response_revision:24937; number_of_response:1; }","duration":"129.63803ms","start":"2026-06-15T20:48:02.218535Z","end":"2026-06-15T20:48:02.348173Z","steps":["trace[1577182771] 'process raft request' (duration: 129.407584ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:48:02.380447Z","caller":"traceutil/trace.go:171","msg":"trace[1978087377] transaction","detail":"{read_only:false; response_revision:24938; number_of_response:1; }","duration":"156.465243ms","start":"2026-06-15T20:48:02.223954Z","end":"2026-06-15T20:48:02.38042Z","steps":["trace[1978087377] 'process raft request' (duration: 156.229548ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:48:02.380641Z","caller":"traceutil/trace.go:171","msg":"trace[1966831114] transaction","detail":"{read_only:false; response_revision:24939; number_of_response:1; }","duration":"153.311655ms","start":"2026-06-15T20:48:02.227277Z","end":"2026-06-15T20:48:02.380589Z","steps":["trace[1966831114] 'process raft request' (duration: 153.07776ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:48:07.819394Z","caller":"traceutil/trace.go:171","msg":"trace[1382199751] transaction","detail":"{read_only:false; response_revision:24976; number_of_response:1; }","duration":"100.65986ms","start":"2026-06-15T20:48:07.718704Z","end":"2026-06-15T20:48:07.819364Z","steps":["trace[1382199751] 'process raft request' (duration: 94.844504ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:49:03.189235Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000671f.wal"} {"level":"info","ts":"2026-06-15T20:50:26.919099Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23499} {"level":"info","ts":"2026-06-15T20:50:27.057395Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23499,"took":"132.88817ms","hash":1858208153,"current-db-size-bytes":58966016,"current-db-size":"59 MB","current-db-size-in-use-bytes":37355520,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-06-15T20:50:27.057473Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1858208153,"revision":23499,"compact-revision":20352} {"level":"info","ts":"2026-06-15T20:55:26.924957Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26397} {"level":"info","ts":"2026-06-15T20:55:27.062984Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26397,"took":"135.024996ms","hash":1266814812,"current-db-size-bytes":58966016,"current-db-size":"59 MB","current-db-size-in-use-bytes":33026048,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-15T20:55:27.063108Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1266814812,"revision":26397,"compact-revision":23499} {"level":"info","ts":"2026-06-15T20:55:53.064346Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a31e123290fcf0df","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-15T20:55:53.069435Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-15T20:55:53.069545Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-15T21:00:26.934145Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28896} {"level":"info","ts":"2026-06-15T21:00:27.067469Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28896,"took":"128.459732ms","hash":1812145975,"current-db-size-bytes":58966016,"current-db-size":"59 MB","current-db-size-in-use-bytes":31502336,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-15T21:00:27.067541Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1812145975,"revision":28896,"compact-revision":26397} {"level":"info","ts":"2026-06-15T21:05:26.942959Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31180} {"level":"info","ts":"2026-06-15T21:05:27.076563Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31180,"took":"129.132466ms","hash":2870033239,"current-db-size-bytes":58966016,"current-db-size":"59 MB","current-db-size-in-use-bytes":31756288,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-15T21:05:27.076631Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2870033239,"revision":31180,"compact-revision":28896} {"level":"info","ts":"2026-06-15T21:10:26.950082Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33505} {"level":"info","ts":"2026-06-15T21:10:27.095112Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33505,"took":"140.85209ms","hash":1052117350,"current-db-size-bytes":60231680,"current-db-size":"60 MB","current-db-size-in-use-bytes":33607680,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-15T21:10:27.095188Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1052117350,"revision":33505,"compact-revision":31180} {"level":"info","ts":"2026-06-15T21:15:26.956768Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35774} {"level":"info","ts":"2026-06-15T21:15:27.10187Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35774,"took":"140.430211ms","hash":467650455,"current-db-size-bytes":62844928,"current-db-size":"63 MB","current-db-size-in-use-bytes":31842304,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-15T21:15:27.10193Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":467650455,"revision":35774,"compact-revision":33505} {"level":"info","ts":"2026-06-15T21:17:09.428028Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a31e123290fcf0df","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-15T21:17:09.433238Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-15T21:17:09.433398Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-15T21:20:26.962676Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":38005} {"level":"info","ts":"2026-06-15T21:20:27.088399Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":38005,"took":"120.942288ms","hash":784518639,"current-db-size-bytes":62844928,"current-db-size":"63 MB","current-db-size-in-use-bytes":31842304,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-15T21:20:27.088476Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":784518639,"revision":38005,"compact-revision":35774}