{"level":"warn","ts":"2026-10-27T20:48:56.818556Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-27T20:48:56.818777Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.214: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://162.253.55.214:2380","--initial-cluster=instance=https://162.253.55.214:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.214:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.214: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-10-27T20:48:56.818947Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-27T20:48:56.818972Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.214:2380"]}
{"level":"info","ts":"2026-10-27T20:48:56.819027Z","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-10-27T20:48:56.820534Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"]}
{"level":"info","ts":"2026-10-27T20:48:56.820778Z","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://162.253.55.214:2380"],"listen-peer-urls":["https://162.253.55.214:2380"],"advertise-client-urls":["https://162.253.55.214:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.214: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-10-27T20:48:56.831561Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.098155ms"}
{"level":"info","ts":"2026-10-27T20:48:56.864157Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"86f12f2ae020828","cluster-id":"dfe59afaaa064e4a"}
{"level":"info","ts":"2026-10-27T20:48:56.864269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=()"}
{"level":"info","ts":"2026-10-27T20:48:56.864291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became follower at term 0"}
{"level":"info","ts":"2026-10-27T20:48:56.864313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 86f12f2ae020828 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-27T20:48:56.864324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became follower at term 1"}
{"level":"info","ts":"2026-10-27T20:48:56.864373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=(607725308229060648)"}
{"level":"warn","ts":"2026-10-27T20:48:56.879754Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-27T20:48:56.884082Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-27T20:48:56.886388Z","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-10-27T20:48:56.890542Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"86f12f2ae020828","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-27T20:48:56.89245Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"86f12f2ae020828","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-27T20:48:56.892558Z","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-10-27T20:48:56.892781Z","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-10-27T20:48:56.892885Z","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-10-27T20:48:56.894007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=(607725308229060648)"}
{"level":"info","ts":"2026-10-27T20:48:56.89423Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfe59afaaa064e4a","local-member-id":"86f12f2ae020828","added-peer-id":"86f12f2ae020828","added-peer-peer-urls":["https://162.253.55.214:2380"]}
{"level":"info","ts":"2026-10-27T20:48:56.89836Z","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-10-27T20:48:56.898523Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.214:2380"}
{"level":"info","ts":"2026-10-27T20:48:56.899818Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.214:2380"}
{"level":"info","ts":"2026-10-27T20:48:56.900323Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"86f12f2ae020828","initial-advertise-peer-urls":["https://162.253.55.214:2380"],"listen-peer-urls":["https://162.253.55.214:2380"],"advertise-client-urls":["https://162.253.55.214:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-27T20:48:56.900453Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-27T20:48:57.665494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 is starting a new election at term 1"}
{"level":"info","ts":"2026-10-27T20:48:57.665615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-27T20:48:57.665694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 received MsgPreVoteResp from 86f12f2ae020828 at term 1"}
{"level":"info","ts":"2026-10-27T20:48:57.665721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became candidate at term 2"}
{"level":"info","ts":"2026-10-27T20:48:57.665733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 received MsgVoteResp from 86f12f2ae020828 at term 2"}
{"level":"info","ts":"2026-10-27T20:48:57.665748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became leader at term 2"}
{"level":"info","ts":"2026-10-27T20:48:57.665765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 86f12f2ae020828 elected leader 86f12f2ae020828 at term 2"}
{"level":"info","ts":"2026-10-27T20:48:57.667195Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"86f12f2ae020828","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.214:2379]}","request-path":"/0/members/86f12f2ae020828/attributes","cluster-id":"dfe59afaaa064e4a","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-27T20:48:57.667246Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-27T20:48:57.667386Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-27T20:48:57.667339Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-27T20:48:57.667733Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-27T20:48:57.667775Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-27T20:48:57.66883Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfe59afaaa064e4a","local-member-id":"86f12f2ae020828","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-27T20:48:57.669012Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-27T20:48:57.669052Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-27T20:48:57.671332Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.214:2379"}
{"level":"info","ts":"2026-10-27T20:48:57.67169Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-27T20:49:31.289044Z","caller":"traceutil/trace.go:171","msg":"trace[1816167912] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"215.470602ms","start":"2026-10-27T20:49:31.073552Z","end":"2026-10-27T20:49:31.289022Z","steps":["trace[1816167912] 'process raft request'  (duration: 215.270868ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:31.301825Z","caller":"traceutil/trace.go:171","msg":"trace[886552121] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"214.46132ms","start":"2026-10-27T20:49:31.087345Z","end":"2026-10-27T20:49:31.301807Z","steps":["trace[886552121] 'process raft request'  (duration: 214.326347ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:31.302111Z","caller":"traceutil/trace.go:171","msg":"trace[497464879] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"188.833054ms","start":"2026-10-27T20:49:31.113266Z","end":"2026-10-27T20:49:31.302099Z","steps":["trace[497464879] 'process raft request'  (duration: 188.560738ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:31.302315Z","caller":"traceutil/trace.go:171","msg":"trace[252570722] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"179.737117ms","start":"2026-10-27T20:49:31.122478Z","end":"2026-10-27T20:49:31.302215Z","steps":["trace[252570722] 'process raft request'  (duration: 179.537383ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:31.302254Z","caller":"traceutil/trace.go:171","msg":"trace[64993092] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"202.835438ms","start":"2026-10-27T20:49:31.099369Z","end":"2026-10-27T20:49:31.302205Z","steps":["trace[64993092] 'process raft request'  (duration: 202.385228ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:31.302355Z","caller":"traceutil/trace.go:171","msg":"trace[1033892425] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"194.318653ms","start":"2026-10-27T20:49:31.108018Z","end":"2026-10-27T20:49:31.302336Z","steps":["trace[1033892425] 'process raft request'  (duration: 193.772261ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:31.302418Z","caller":"traceutil/trace.go:171","msg":"trace[533233983] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"146.525057ms","start":"2026-10-27T20:49:31.155879Z","end":"2026-10-27T20:49:31.302405Z","steps":["trace[533233983] 'process raft request'  (duration: 146.260131ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:31.30249Z","caller":"traceutil/trace.go:171","msg":"trace[687822277] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"185.224516ms","start":"2026-10-27T20:49:31.117259Z","end":"2026-10-27T20:49:31.302483Z","steps":["trace[687822277] 'process raft request'  (duration: 184.631833ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:31.302451Z","caller":"traceutil/trace.go:171","msg":"trace[189109230] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"164.632649ms","start":"2026-10-27T20:49:31.137759Z","end":"2026-10-27T20:49:31.302392Z","steps":["trace[189109230] 'process raft request'  (duration: 164.341173ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:31.302501Z","caller":"traceutil/trace.go:171","msg":"trace[1155536358] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"184.97308ms","start":"2026-10-27T20:49:31.117514Z","end":"2026-10-27T20:49:31.302487Z","steps":["trace[1155536358] 'process raft request'  (duration: 184.463509ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:31.302512Z","caller":"traceutil/trace.go:171","msg":"trace[392102600] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"165.386466ms","start":"2026-10-27T20:49:31.137115Z","end":"2026-10-27T20:49:31.302502Z","steps":["trace[392102600] 'process raft request'  (duration: 164.945746ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:31.439449Z","caller":"traceutil/trace.go:171","msg":"trace[1922628552] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"104.009235ms","start":"2026-10-27T20:49:31.335407Z","end":"2026-10-27T20:49:31.439416Z","steps":["trace[1922628552] 'process raft request'  (duration: 103.736729ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:31.518386Z","caller":"traceutil/trace.go:171","msg":"trace[1016717002] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"134.739102ms","start":"2026-10-27T20:49:31.383611Z","end":"2026-10-27T20:49:31.51835Z","steps":["trace[1016717002] 'process raft request'  (duration: 109.138167ms)","trace[1016717002] 'compare'  (duration: 25.007702ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:49:31.518426Z","caller":"traceutil/trace.go:171","msg":"trace[1144513442] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"106.509809ms","start":"2026-10-27T20:49:31.411899Z","end":"2026-10-27T20:49:31.518408Z","steps":["trace[1144513442] 'process raft request'  (duration: 106.259404ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:31.705928Z","caller":"traceutil/trace.go:171","msg":"trace[1770018560] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"119.522381ms","start":"2026-10-27T20:49:31.586386Z","end":"2026-10-27T20:49:31.705908Z","steps":["trace[1770018560] 'process raft request'  (duration: 79.960244ms)","trace[1770018560] 'compare'  (duration: 39.426964ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:49:31.731325Z","caller":"traceutil/trace.go:171","msg":"trace[2053341092] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"114.706688ms","start":"2026-10-27T20:49:31.616579Z","end":"2026-10-27T20:49:31.731285Z","steps":["trace[2053341092] 'process raft request'  (duration: 114.308129ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:31.897255Z","caller":"traceutil/trace.go:171","msg":"trace[134038304] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"103.814601ms","start":"2026-10-27T20:49:31.793409Z","end":"2026-10-27T20:49:31.897224Z","steps":["trace[134038304] 'process raft request'  (duration: 63.848204ms)","trace[134038304] 'compare'  (duration: 39.792163ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T20:49:38.908472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.996829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-27T20:49:38.908648Z","caller":"traceutil/trace.go:171","msg":"trace[2042181283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"316.220853ms","start":"2026-10-27T20:49:38.592402Z","end":"2026-10-27T20:49:38.908623Z","steps":["trace[2042181283] 'range keys from in-memory index tree'  (duration: 315.917587ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:49:38.908722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T20:49:38.592381Z","time spent":"316.326016ms","remote":"127.0.0.1:56776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-10-27T20:49:38.912399Z","caller":"traceutil/trace.go:171","msg":"trace[1260498945] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"298.424349ms","start":"2026-10-27T20:49:38.613904Z","end":"2026-10-27T20:49:38.912328Z","steps":["trace[1260498945] 'process raft request'  (duration: 290.465458ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:49:54.415332Z","caller":"traceutil/trace.go:171","msg":"trace[1354390269] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"256.785673ms","start":"2026-10-27T20:49:54.158466Z","end":"2026-10-27T20:49:54.415252Z","steps":["trace[1354390269] 'process raft request'  (duration: 195.668258ms)","trace[1354390269] 'compare'  (duration: 60.781178ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:50:25.52355Z","caller":"traceutil/trace.go:171","msg":"trace[1278255363] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"200.875189ms","start":"2026-10-27T20:50:25.32264Z","end":"2026-10-27T20:50:25.523515Z","steps":["trace[1278255363] 'process raft request'  (duration: 200.671375ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:50:25.561147Z","caller":"traceutil/trace.go:171","msg":"trace[521631791] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"119.408552ms","start":"2026-10-27T20:50:25.441704Z","end":"2026-10-27T20:50:25.561113Z","steps":["trace[521631791] 'process raft request'  (duration: 119.204017ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:51:28.620147Z","caller":"traceutil/trace.go:171","msg":"trace[1063521977] linearizableReadLoop","detail":"{readStateIndex:1997; appliedIndex:1996; }","duration":"312.456475ms","start":"2026-10-27T20:51:28.307665Z","end":"2026-10-27T20:51:28.620122Z","steps":["trace[1063521977] 'read index received'  (duration: 312.122318ms)","trace[1063521977] 'applied index is now lower than readState.Index'  (duration: 333.047µs)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:51:28.620229Z","caller":"traceutil/trace.go:171","msg":"trace[1157000056] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"316.001507ms","start":"2026-10-27T20:51:28.304188Z","end":"2026-10-27T20:51:28.620189Z","steps":["trace[1157000056] 'process raft request'  (duration: 315.748142ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:51:28.620396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.708461ms","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-10-27T20:51:28.620478Z","caller":"traceutil/trace.go:171","msg":"trace[477129854] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1920; }","duration":"312.825983ms","start":"2026-10-27T20:51:28.307633Z","end":"2026-10-27T20:51:28.620459Z","steps":["trace[477129854] 'agreement among raft nodes before linearized reading'  (duration: 312.603488ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:51:28.620515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T20:51:28.307619Z","time spent":"312.888094ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-10-27T20:51:28.62042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.335942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-10-27T20:51:28.620577Z","caller":"traceutil/trace.go:171","msg":"trace[617574453] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1920; }","duration":"273.551677ms","start":"2026-10-27T20:51:28.347014Z","end":"2026-10-27T20:51:28.620566Z","steps":["trace[617574453] 'agreement among raft nodes before linearized reading'  (duration: 273.279611ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:51:28.620797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T20:51:28.304159Z","time spent":"316.14264ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1852 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-10-27T20:51:28.74267Z","caller":"traceutil/trace.go:171","msg":"trace[1143164025] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"114.758867ms","start":"2026-10-27T20:51:28.627887Z","end":"2026-10-27T20:51:28.742646Z","steps":["trace[1143164025] 'process raft request'  (duration: 114.697396ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:51:28.742696Z","caller":"traceutil/trace.go:171","msg":"trace[1016700125] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"117.490282ms","start":"2026-10-27T20:51:28.625169Z","end":"2026-10-27T20:51:28.742659Z","steps":["trace[1016700125] 'process raft request'  (duration: 117.36787ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:51:28.742935Z","caller":"traceutil/trace.go:171","msg":"trace[1597839389] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"117.786628ms","start":"2026-10-27T20:51:28.625114Z","end":"2026-10-27T20:51:28.742901Z","steps":["trace[1597839389] 'process raft request'  (duration: 90.881363ms)","trace[1597839389] 'compare'  (duration: 26.367654ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T20:52:21.20997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.622049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-10-27T20:52:21.210105Z","caller":"traceutil/trace.go:171","msg":"trace[30288469] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:2260; }","duration":"187.788343ms","start":"2026-10-27T20:52:21.02229Z","end":"2026-10-27T20:52:21.210078Z","steps":["trace[30288469] 'range keys from in-memory index tree'  (duration: 187.517067ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:52:21.210192Z","caller":"traceutil/trace.go:171","msg":"trace[207144985] linearizableReadLoop","detail":"{readStateIndex:2351; appliedIndex:2350; }","duration":"180.796154ms","start":"2026-10-27T20:52:21.029328Z","end":"2026-10-27T20:52:21.210124Z","steps":["trace[207144985] 'read index received'  (duration: 152.114305ms)","trace[207144985] 'applied index is now lower than readState.Index'  (duration: 28.680329ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:52:21.210262Z","caller":"traceutil/trace.go:171","msg":"trace[1209597100] transaction","detail":"{read_only:false; response_revision:2261; number_of_response:1; }","duration":"185.828333ms","start":"2026-10-27T20:52:21.024385Z","end":"2026-10-27T20:52:21.210213Z","steps":["trace[1209597100] 'process raft request'  (duration: 157.067523ms)","trace[1209597100] 'compare'  (duration: 28.512585ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T20:52:21.21045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.1134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-10-27T20:52:21.210528Z","caller":"traceutil/trace.go:171","msg":"trace[2003280833] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2261; }","duration":"181.212032ms","start":"2026-10-27T20:52:21.029302Z","end":"2026-10-27T20:52:21.210514Z","steps":["trace[2003280833] 'agreement among raft nodes before linearized reading'  (duration: 181.024019ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:52:21.210615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.301038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-10-27T20:52:21.210697Z","caller":"traceutil/trace.go:171","msg":"trace[1174875290] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2261; }","duration":"158.44198ms","start":"2026-10-27T20:52:21.052232Z","end":"2026-10-27T20:52:21.210674Z","steps":["trace[1174875290] 'agreement among raft nodes before linearized reading'  (duration: 158.150275ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:52:21.409217Z","caller":"traceutil/trace.go:171","msg":"trace[1171892598] transaction","detail":"{read_only:false; response_revision:2262; number_of_response:1; }","duration":"193.386723ms","start":"2026-10-27T20:52:21.215805Z","end":"2026-10-27T20:52:21.409191Z","steps":["trace[1171892598] 'process raft request'  (duration: 132.915065ms)","trace[1171892598] 'compare'  (duration: 60.314795ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:52:21.409601Z","caller":"traceutil/trace.go:171","msg":"trace[283132870] transaction","detail":"{read_only:false; response_revision:2263; number_of_response:1; }","duration":"192.144899ms","start":"2026-10-27T20:52:21.217428Z","end":"2026-10-27T20:52:21.409573Z","steps":["trace[283132870] 'process raft request'  (duration: 191.730201ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:52:21.758541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.000811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-27T20:52:21.7587Z","caller":"traceutil/trace.go:171","msg":"trace[528927058] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2263; }","duration":"165.246195ms","start":"2026-10-27T20:52:21.593423Z","end":"2026-10-27T20:52:21.758669Z","steps":["trace[528927058] 'range keys from in-memory index tree'  (duration: 164.871148ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:52:21.758789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.563351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-10-27T20:52:21.758913Z","caller":"traceutil/trace.go:171","msg":"trace[659639832] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2263; }","duration":"224.718844ms","start":"2026-10-27T20:52:21.534144Z","end":"2026-10-27T20:52:21.758863Z","steps":["trace[659639832] 'range keys from in-memory index tree'  (duration: 224.131032ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:53:10.478592Z","caller":"traceutil/trace.go:171","msg":"trace[313176948] transaction","detail":"{read_only:false; response_revision:2658; number_of_response:1; }","duration":"203.545935ms","start":"2026-10-27T20:53:10.275017Z","end":"2026-10-27T20:53:10.478563Z","steps":["trace[313176948] 'process raft request'  (duration: 203.374452ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:53:10.527626Z","caller":"traceutil/trace.go:171","msg":"trace[1480394991] transaction","detail":"{read_only:false; response_revision:2659; number_of_response:1; }","duration":"133.637673ms","start":"2026-10-27T20:53:10.393954Z","end":"2026-10-27T20:53:10.527592Z","steps":["trace[1480394991] 'process raft request'  (duration: 133.053822ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:53:12.660847Z","caller":"traceutil/trace.go:171","msg":"trace[1495058559] transaction","detail":"{read_only:false; response_revision:2704; number_of_response:1; }","duration":"143.479893ms","start":"2026-10-27T20:53:12.517329Z","end":"2026-10-27T20:53:12.660809Z","steps":["trace[1495058559] 'process raft request'  (duration: 96.010069ms)","trace[1495058559] 'compare'  (duration: 47.223429ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:53:12.660876Z","caller":"traceutil/trace.go:171","msg":"trace[53899050] linearizableReadLoop","detail":"{readStateIndex:2813; appliedIndex:2811; }","duration":"113.720413ms","start":"2026-10-27T20:53:12.547111Z","end":"2026-10-27T20:53:12.660831Z","steps":["trace[53899050] 'read index received'  (duration: 66.241609ms)","trace[53899050] 'applied index is now lower than readState.Index'  (duration: 47.477664ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:53:12.66098Z","caller":"traceutil/trace.go:171","msg":"trace[1754816782] transaction","detail":"{read_only:false; response_revision:2705; number_of_response:1; }","duration":"125.87426ms","start":"2026-10-27T20:53:12.53506Z","end":"2026-10-27T20:53:12.660935Z","steps":["trace[1754816782] 'process raft request'  (duration: 125.701507ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:53:12.661098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.969308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-10-27T20:53:12.66116Z","caller":"traceutil/trace.go:171","msg":"trace[1757416442] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2705; }","duration":"114.084731ms","start":"2026-10-27T20:53:12.547061Z","end":"2026-10-27T20:53:12.661146Z","steps":["trace[1757416442] 'agreement among raft nodes before linearized reading'  (duration: 113.885037ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:53:20.190794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.948304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-10-27T20:53:20.190932Z","caller":"traceutil/trace.go:171","msg":"trace[1727652958] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2753; }","duration":"147.138146ms","start":"2026-10-27T20:53:20.043766Z","end":"2026-10-27T20:53:20.190904Z","steps":["trace[1727652958] 'range keys from in-memory index tree'  (duration: 146.690928ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:53:24.131877Z","caller":"traceutil/trace.go:171","msg":"trace[605685281] transaction","detail":"{read_only:false; response_revision:2772; number_of_response:1; }","duration":"238.18379ms","start":"2026-10-27T20:53:23.893636Z","end":"2026-10-27T20:53:24.13182Z","steps":["trace[605685281] 'process raft request'  (duration: 191.878872ms)","trace[605685281] 'compare'  (duration: 46.021132ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:53:25.014788Z","caller":"traceutil/trace.go:171","msg":"trace[672984377] linearizableReadLoop","detail":"{readStateIndex:2887; appliedIndex:2886; }","duration":"125.644356ms","start":"2026-10-27T20:53:24.889122Z","end":"2026-10-27T20:53:25.014767Z","steps":["trace[672984377] 'read index received'  (duration: 125.508633ms)","trace[672984377] 'applied index is now lower than readState.Index'  (duration: 134.903µs)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:53:25.014857Z","caller":"traceutil/trace.go:171","msg":"trace[996596944] transaction","detail":"{read_only:false; response_revision:2777; number_of_response:1; }","duration":"152.421286ms","start":"2026-10-27T20:53:24.862386Z","end":"2026-10-27T20:53:25.014807Z","steps":["trace[996596944] 'process raft request'  (duration: 152.252282ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:53:25.015139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.997313ms","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-10-27T20:53:25.015216Z","caller":"traceutil/trace.go:171","msg":"trace[1901367421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2777; }","duration":"126.139816ms","start":"2026-10-27T20:53:24.889053Z","end":"2026-10-27T20:53:25.015193Z","steps":["trace[1901367421] 'agreement among raft nodes before linearized reading'  (duration: 125.83675ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:53:25.203233Z","caller":"traceutil/trace.go:171","msg":"trace[747335871] transaction","detail":"{read_only:false; response_revision:2778; number_of_response:1; }","duration":"183.587429ms","start":"2026-10-27T20:53:25.019617Z","end":"2026-10-27T20:53:25.203204Z","steps":["trace[747335871] 'process raft request'  (duration: 104.108978ms)","trace[747335871] 'compare'  (duration: 79.393729ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:53:27.114406Z","caller":"traceutil/trace.go:171","msg":"trace[296007069] linearizableReadLoop","detail":"{readStateIndex:2906; appliedIndex:2905; }","duration":"297.799339ms","start":"2026-10-27T20:53:26.816583Z","end":"2026-10-27T20:53:27.114382Z","steps":["trace[296007069] 'read index received'  (duration: 297.686507ms)","trace[296007069] 'applied index is now lower than readState.Index'  (duration: 111.832µs)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:53:27.114493Z","caller":"traceutil/trace.go:171","msg":"trace[1412003996] transaction","detail":"{read_only:false; response_revision:2795; number_of_response:1; }","duration":"304.698903ms","start":"2026-10-27T20:53:26.809758Z","end":"2026-10-27T20:53:27.114457Z","steps":["trace[1412003996] 'process raft request'  (duration: 304.453189ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:53:27.114535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.932242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-27T20:53:27.114573Z","caller":"traceutil/trace.go:171","msg":"trace[1407710236] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2795; }","duration":"298.030144ms","start":"2026-10-27T20:53:26.816532Z","end":"2026-10-27T20:53:27.114562Z","steps":["trace[1407710236] 'agreement among raft nodes before linearized reading'  (duration: 297.943432ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:53:27.114638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T20:53:26.809731Z","time spent":"304.830165ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2776 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-10-27T20:53:27.225192Z","caller":"traceutil/trace.go:171","msg":"trace[966936468] transaction","detail":"{read_only:false; response_revision:2796; number_of_response:1; }","duration":"272.237523ms","start":"2026-10-27T20:53:26.952917Z","end":"2026-10-27T20:53:27.225154Z","steps":["trace[966936468] 'process raft request'  (duration: 269.981529ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:53:53.907719Z","caller":"traceutil/trace.go:171","msg":"trace[1867870146] transaction","detail":"{read_only:false; response_revision:2953; number_of_response:1; }","duration":"167.572242ms","start":"2026-10-27T20:53:53.740077Z","end":"2026-10-27T20:53:53.907649Z","steps":["trace[1867870146] 'process raft request'  (duration: 133.65787ms)","trace[1867870146] 'compare'  (duration: 33.415782ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T20:54:50.498683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.573441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12429"}
{"level":"info","ts":"2026-10-27T20:54:50.498809Z","caller":"traceutil/trace.go:171","msg":"trace[147792499] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3258; }","duration":"153.744733ms","start":"2026-10-27T20:54:50.345043Z","end":"2026-10-27T20:54:50.498788Z","steps":["trace[147792499] 'range keys from in-memory index tree'  (duration: 153.395077ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:58:49.101227Z","caller":"traceutil/trace.go:171","msg":"trace[1316106076] transaction","detail":"{read_only:false; response_revision:5187; number_of_response:1; }","duration":"114.759129ms","start":"2026-10-27T20:58:48.986441Z","end":"2026-10-27T20:58:49.1012Z","steps":["trace[1316106076] 'process raft request'  (duration: 114.602246ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:58:52.154069Z","caller":"traceutil/trace.go:171","msg":"trace[577974268] linearizableReadLoop","detail":"{readStateIndex:5467; appliedIndex:5466; }","duration":"176.061148ms","start":"2026-10-27T20:58:51.977981Z","end":"2026-10-27T20:58:52.154042Z","steps":["trace[577974268] 'read index received'  (duration: 175.757352ms)","trace[577974268] 'applied index is now lower than readState.Index'  (duration: 302.596µs)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:58:52.15413Z","caller":"traceutil/trace.go:171","msg":"trace[1176083560] transaction","detail":"{read_only:false; response_revision:5262; number_of_response:1; }","duration":"195.053136ms","start":"2026-10-27T20:58:51.959038Z","end":"2026-10-27T20:58:52.154091Z","steps":["trace[1176083560] 'process raft request'  (duration: 194.681619ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:58:52.154257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.248641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-27T20:58:52.154307Z","caller":"traceutil/trace.go:171","msg":"trace[386759740] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:5262; }","duration":"176.364794ms","start":"2026-10-27T20:58:51.977929Z","end":"2026-10-27T20:58:52.154294Z","steps":["trace[386759740] 'agreement among raft nodes before linearized reading'  (duration: 176.262732ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:58:52.155961Z","caller":"traceutil/trace.go:171","msg":"trace[1192389940] transaction","detail":"{read_only:false; response_revision:5263; number_of_response:1; }","duration":"111.441227ms","start":"2026-10-27T20:58:52.044502Z","end":"2026-10-27T20:58:52.155943Z","steps":["trace[1192389940] 'process raft request'  (duration: 110.695683ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:58:56.53308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.049486ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734188858 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/replicasets/monitoring/loki-gateway-cf54cb88c\" mod_revision:5389 > success:<request_put:<key:\"/registry/replicasets/monitoring/loki-gateway-cf54cb88c\" value_size:4081 >> failure:<request_range:<key:\"/registry/replicasets/monitoring/loki-gateway-cf54cb88c\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-27T20:58:56.533318Z","caller":"traceutil/trace.go:171","msg":"trace[720311950] transaction","detail":"{read_only:false; response_revision:5401; number_of_response:1; }","duration":"239.349183ms","start":"2026-10-27T20:58:56.293948Z","end":"2026-10-27T20:58:56.533297Z","steps":["trace[720311950] 'process raft request'  (duration: 239.224661ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:58:56.533306Z","caller":"traceutil/trace.go:171","msg":"trace[1412745712] transaction","detail":"{read_only:false; response_revision:5400; number_of_response:1; }","duration":"239.484586ms","start":"2026-10-27T20:58:56.293789Z","end":"2026-10-27T20:58:56.533273Z","steps":["trace[1412745712] 'process raft request'  (duration: 49.678817ms)","trace[1412745712] 'compare'  (duration: 187.899154ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:58:56.533375Z","caller":"traceutil/trace.go:171","msg":"trace[250704703] transaction","detail":"{read_only:false; response_revision:5402; number_of_response:1; }","duration":"226.086581ms","start":"2026-10-27T20:58:56.307259Z","end":"2026-10-27T20:58:56.533346Z","steps":["trace[250704703] 'process raft request'  (duration: 225.982179ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:58:56.533582Z","caller":"traceutil/trace.go:171","msg":"trace[1389551506] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"224.248158ms","start":"2026-10-27T20:58:56.309312Z","end":"2026-10-27T20:58:56.53356Z","steps":["trace[1389551506] 'process raft request'  (duration: 223.959142ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:58:56.533729Z","caller":"traceutil/trace.go:171","msg":"trace[139514500] transaction","detail":"{read_only:false; response_revision:5406; number_of_response:1; }","duration":"175.273573ms","start":"2026-10-27T20:58:56.358439Z","end":"2026-10-27T20:58:56.533713Z","steps":["trace[139514500] 'process raft request'  (duration: 175.12133ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:58:56.533728Z","caller":"traceutil/trace.go:171","msg":"trace[300112591] transaction","detail":"{read_only:false; response_revision:5405; number_of_response:1; }","duration":"223.137008ms","start":"2026-10-27T20:58:56.310575Z","end":"2026-10-27T20:58:56.533712Z","steps":["trace[300112591] 'process raft request'  (duration: 222.760661ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:58:56.533728Z","caller":"traceutil/trace.go:171","msg":"trace[1976515202] transaction","detail":"{read_only:false; response_revision:5404; number_of_response:1; }","duration":"224.131385ms","start":"2026-10-27T20:58:56.309566Z","end":"2026-10-27T20:58:56.533697Z","steps":["trace[1976515202] 'process raft request'  (duration: 223.739738ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:58:56.533781Z","caller":"traceutil/trace.go:171","msg":"trace[1000966359] linearizableReadLoop","detail":"{readStateIndex:5612; appliedIndex:5610; }","duration":"235.89322ms","start":"2026-10-27T20:58:56.297859Z","end":"2026-10-27T20:58:56.533752Z","steps":["trace[1000966359] 'read index received'  (duration: 6.448828ms)","trace[1000966359] 'applied index is now lower than readState.Index'  (duration: 229.441112ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T20:58:56.534323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.926811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-27T20:58:56.534364Z","caller":"traceutil/trace.go:171","msg":"trace[1390091322] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:5406; }","duration":"235.999562ms","start":"2026-10-27T20:58:56.298354Z","end":"2026-10-27T20:58:56.534353Z","steps":["trace[1390091322] 'agreement among raft nodes before linearized reading'  (duration: 235.917391ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:58:56.534588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.099586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-gateway-cf54cb88c-lmkvq\" ","response":"range_response_count:1 size:3534"}
{"level":"info","ts":"2026-10-27T20:58:56.534626Z","caller":"traceutil/trace.go:171","msg":"trace[1933947486] range","detail":"{range_begin:/registry/pods/monitoring/loki-gateway-cf54cb88c-lmkvq; range_end:; response_count:1; response_revision:5406; }","duration":"223.158317ms","start":"2026-10-27T20:58:56.311459Z","end":"2026-10-27T20:58:56.534617Z","steps":["trace[1933947486] 'agreement among raft nodes before linearized reading'  (duration: 223.056455ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:58:56.534748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.199982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-10-27T20:58:56.534607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.255163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-dlwfn\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-10-27T20:58:56.534805Z","caller":"traceutil/trace.go:171","msg":"trace[1530502629] range","detail":"{range_begin:/registry/pods/openstack/keepalived-dlwfn; range_end:; response_count:1; response_revision:5406; }","duration":"163.489767ms","start":"2026-10-27T20:58:56.371305Z","end":"2026-10-27T20:58:56.534794Z","steps":["trace[1530502629] 'agreement among raft nodes before linearized reading'  (duration: 163.181422ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:58:56.534804Z","caller":"traceutil/trace.go:171","msg":"trace[1323021684] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5406; }","duration":"151.272664ms","start":"2026-10-27T20:58:56.383517Z","end":"2026-10-27T20:58:56.53479Z","steps":["trace[1323021684] 'agreement among raft nodes before linearized reading'  (duration: 151.153282ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:58:56.536733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.859364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/monitoring/loki-gateway\" ","response":"range_response_count:1 size:4305"}
{"level":"info","ts":"2026-10-27T20:58:56.536802Z","caller":"traceutil/trace.go:171","msg":"trace[947804532] range","detail":"{range_begin:/registry/deployments/monitoring/loki-gateway; range_end:; response_count:1; response_revision:5406; }","duration":"238.984407ms","start":"2026-10-27T20:58:56.297802Z","end":"2026-10-27T20:58:56.536786Z","steps":["trace[947804532] 'agreement among raft nodes before linearized reading'  (duration: 236.024453ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:58:57.701827Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2972}
{"level":"info","ts":"2026-10-27T20:58:57.772128Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2972,"took":"69.221404ms","hash":3143701417,"current-db-size-bytes":52297728,"current-db-size":"52 MB","current-db-size-in-use-bytes":29618176,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-27T20:58:57.772168Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3143701417,"revision":2972,"compact-revision":-1}
{"level":"info","ts":"2026-10-27T20:58:58.823481Z","caller":"traceutil/trace.go:171","msg":"trace[669411768] transaction","detail":"{read_only:false; response_revision:5469; number_of_response:1; }","duration":"109.084853ms","start":"2026-10-27T20:58:58.714378Z","end":"2026-10-27T20:58:58.823463Z","steps":["trace[669411768] 'process raft request'  (duration: 108.950391ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:58:59.014141Z","caller":"traceutil/trace.go:171","msg":"trace[1938346132] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5469; }","duration":"144.611023ms","start":"2026-10-27T20:58:58.869516Z","end":"2026-10-27T20:58:59.014127Z","steps":["trace[1938346132] 'process raft request'  (duration: 144.557002ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:58:59.098088Z","caller":"traceutil/trace.go:171","msg":"trace[73943604] transaction","detail":"{read_only:false; response_revision:5470; number_of_response:1; }","duration":"128.547909ms","start":"2026-10-27T20:58:58.969508Z","end":"2026-10-27T20:58:59.098056Z","steps":["trace[73943604] 'process raft request'  (duration: 128.287104ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:59:01.571353Z","caller":"traceutil/trace.go:171","msg":"trace[885464270] transaction","detail":"{read_only:false; response_revision:5503; number_of_response:1; }","duration":"184.271186ms","start":"2026-10-27T20:59:01.38705Z","end":"2026-10-27T20:59:01.571321Z","steps":["trace[885464270] 'process raft request'  (duration: 184.035662ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:59:01.865382Z","caller":"traceutil/trace.go:171","msg":"trace[1281749629] linearizableReadLoop","detail":"{readStateIndex:5720; appliedIndex:5719; }","duration":"177.96139ms","start":"2026-10-27T20:59:01.687398Z","end":"2026-10-27T20:59:01.865359Z","steps":["trace[1281749629] 'read index received'  (duration: 177.719316ms)","trace[1281749629] 'applied index is now lower than readState.Index'  (duration: 240.704µs)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:59:01.865435Z","caller":"traceutil/trace.go:171","msg":"trace[538957275] transaction","detail":"{read_only:false; response_revision:5504; number_of_response:1; }","duration":"190.00478ms","start":"2026-10-27T20:59:01.675404Z","end":"2026-10-27T20:59:01.865409Z","steps":["trace[538957275] 'process raft request'  (duration: 189.811236ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:59:01.865661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.210575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12429"}
{"level":"info","ts":"2026-10-27T20:59:01.865733Z","caller":"traceutil/trace.go:171","msg":"trace[1508201418] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5504; }","duration":"178.345668ms","start":"2026-10-27T20:59:01.687371Z","end":"2026-10-27T20:59:01.865717Z","steps":["trace[1508201418] 'agreement among raft nodes before linearized reading'  (duration: 178.090983ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:59:02.063162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.817242ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734189065 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5493 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-27T20:59:02.0633Z","caller":"traceutil/trace.go:171","msg":"trace[528381807] linearizableReadLoop","detail":"{readStateIndex:5721; appliedIndex:5720; }","duration":"192.625098ms","start":"2026-10-27T20:59:01.870653Z","end":"2026-10-27T20:59:02.063278Z","steps":["trace[528381807] 'read index received'  (duration: 34.555471ms)","trace[528381807] 'applied index is now lower than readState.Index'  (duration: 158.067637ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:59:02.06336Z","caller":"traceutil/trace.go:171","msg":"trace[159526175] transaction","detail":"{read_only:false; response_revision:5505; number_of_response:1; }","duration":"192.940534ms","start":"2026-10-27T20:59:01.870379Z","end":"2026-10-27T20:59:02.06332Z","steps":["trace[159526175] 'process raft request'  (duration: 34.890387ms)","trace[159526175] 'compare'  (duration: 157.70522ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T20:59:02.063439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.76285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/goldpinger-clusterrole\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-27T20:59:02.063498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.379284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:16489"}
{"level":"info","ts":"2026-10-27T20:59:02.063512Z","caller":"traceutil/trace.go:171","msg":"trace[840957854] range","detail":"{range_begin:/registry/clusterroles/goldpinger-clusterrole; range_end:; response_count:0; response_revision:5505; }","duration":"192.904243ms","start":"2026-10-27T20:59:01.87059Z","end":"2026-10-27T20:59:02.063494Z","steps":["trace[840957854] 'agreement among raft nodes before linearized reading'  (duration: 192.7694ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:59:02.063533Z","caller":"traceutil/trace.go:171","msg":"trace[1673713063] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5505; }","duration":"192.437194ms","start":"2026-10-27T20:59:01.871083Z","end":"2026-10-27T20:59:02.06352Z","steps":["trace[1673713063] 'agreement among raft nodes before linearized reading'  (duration: 192.306232ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:59:02.476317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.290259ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734189071 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/namespaces/monitoring\" mod_revision:0 > success:<request_put:<key:\"/registry/namespaces/monitoring\" value_size:318 >> failure:<>>","response":"size:5"}
{"level":"info","ts":"2026-10-27T20:59:02.47652Z","caller":"traceutil/trace.go:171","msg":"trace[1772038067] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5505; }","duration":"387.911524ms","start":"2026-10-27T20:59:02.088572Z","end":"2026-10-27T20:59:02.476483Z","steps":["trace[1772038067] 'process raft request'  (duration: 245.376511ms)","trace[1772038067] 'compare'  (duration: 142.235208ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T20:59:02.476713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T20:59:02.088555Z","time spent":"388.076238ms","remote":"127.0.0.1:56914","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/namespaces/monitoring\" mod_revision:0 > success:<request_put:<key:\"/registry/namespaces/monitoring\" value_size:318 >> failure:<>"}
{"level":"info","ts":"2026-10-27T20:59:02.476807Z","caller":"traceutil/trace.go:171","msg":"trace[2110175868] linearizableReadLoop","detail":"{readStateIndex:5722; appliedIndex:5721; }","duration":"347.968565ms","start":"2026-10-27T20:59:02.128803Z","end":"2026-10-27T20:59:02.476772Z","steps":["trace[2110175868] 'read index received'  (duration: 205.161057ms)","trace[2110175868] 'applied index is now lower than readState.Index'  (duration: 142.804718ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:59:02.476882Z","caller":"traceutil/trace.go:171","msg":"trace[1524277368] transaction","detail":"{read_only:false; response_revision:5507; number_of_response:1; }","duration":"191.189251ms","start":"2026-10-27T20:59:02.28564Z","end":"2026-10-27T20:59:02.476829Z","steps":["trace[1524277368] 'process raft request'  (duration: 190.941817ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:59:02.476913Z","caller":"traceutil/trace.go:171","msg":"trace[1703800184] transaction","detail":"{read_only:false; response_revision:5506; number_of_response:1; }","duration":"279.654917ms","start":"2026-10-27T20:59:02.197228Z","end":"2026-10-27T20:59:02.476883Z","steps":["trace[1703800184] 'process raft request'  (duration: 279.2411ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:59:02.476991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.164159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-27T20:59:02.477071Z","caller":"traceutil/trace.go:171","msg":"trace[1798662286] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5507; }","duration":"348.286301ms","start":"2026-10-27T20:59:02.128764Z","end":"2026-10-27T20:59:02.477051Z","steps":["trace[1798662286] 'agreement among raft nodes before linearized reading'  (duration: 348.134168ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:59:02.477108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.827443ms","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-10-27T20:59:02.477115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T20:59:02.128747Z","time spent":"348.359423ms","remote":"127.0.0.1:57204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-10-27T20:59:02.477141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.587413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-10-27T20:59:02.477146Z","caller":"traceutil/trace.go:171","msg":"trace[1247564278] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5507; }","duration":"260.911615ms","start":"2026-10-27T20:59:02.216224Z","end":"2026-10-27T20:59:02.477136Z","steps":["trace[1247564278] 'agreement among raft nodes before linearized reading'  (duration: 260.729742ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:59:02.477176Z","caller":"traceutil/trace.go:171","msg":"trace[394458830] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5507; }","duration":"258.655794ms","start":"2026-10-27T20:59:02.218509Z","end":"2026-10-27T20:59:02.477165Z","steps":["trace[394458830] 'agreement among raft nodes before linearized reading'  (duration: 258.517141ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:59:02.477177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.170778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"warn","ts":"2026-10-27T20:59:02.477209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.393296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-27T20:59:02.477228Z","caller":"traceutil/trace.go:171","msg":"trace[1282260939] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5507; }","duration":"112.25918ms","start":"2026-10-27T20:59:02.364952Z","end":"2026-10-27T20:59:02.477212Z","steps":["trace[1282260939] 'agreement among raft nodes before linearized reading'  (duration: 112.062017ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:59:02.477259Z","caller":"traceutil/trace.go:171","msg":"trace[308496314] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:5507; }","duration":"260.483547ms","start":"2026-10-27T20:59:02.216764Z","end":"2026-10-27T20:59:02.477248Z","steps":["trace[308496314] 'agreement among raft nodes before linearized reading'  (duration: 260.384105ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:59:13.81696Z","caller":"traceutil/trace.go:171","msg":"trace[497145613] transaction","detail":"{read_only:false; response_revision:5704; number_of_response:1; }","duration":"100.171478ms","start":"2026-10-27T20:59:13.716765Z","end":"2026-10-27T20:59:13.816936Z","steps":["trace[497145613] 'process raft request'  (duration: 99.917093ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:59:16.196634Z","caller":"traceutil/trace.go:171","msg":"trace[1516131472] transaction","detail":"{read_only:false; response_revision:5744; number_of_response:1; }","duration":"117.585415ms","start":"2026-10-27T20:59:16.079022Z","end":"2026-10-27T20:59:16.196607Z","steps":["trace[1516131472] 'process raft request'  (duration: 117.35169ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:59:16.894525Z","caller":"traceutil/trace.go:171","msg":"trace[299672232] transaction","detail":"{read_only:false; response_revision:5759; number_of_response:1; }","duration":"245.753752ms","start":"2026-10-27T20:59:16.648748Z","end":"2026-10-27T20:59:16.894502Z","steps":["trace[299672232] 'process raft request'  (duration: 211.115701ms)","trace[299672232] 'compare'  (duration: 34.469888ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:59:16.894647Z","caller":"traceutil/trace.go:171","msg":"trace[514484567] linearizableReadLoop","detail":"{readStateIndex:5983; appliedIndex:5982; }","duration":"237.668625ms","start":"2026-10-27T20:59:16.656943Z","end":"2026-10-27T20:59:16.894612Z","steps":["trace[514484567] 'read index received'  (duration: 202.987443ms)","trace[514484567] 'applied index is now lower than readState.Index'  (duration: 34.678472ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T20:59:16.894858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.889499ms","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-10-27T20:59:16.894894Z","caller":"traceutil/trace.go:171","msg":"trace[1961218198] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5760; }","duration":"237.984881ms","start":"2026-10-27T20:59:16.656898Z","end":"2026-10-27T20:59:16.894883Z","steps":["trace[1961218198] 'agreement among raft nodes before linearized reading'  (duration: 237.840949ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:59:16.894957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.454151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-10-27T20:59:16.895003Z","caller":"traceutil/trace.go:171","msg":"trace[1054952085] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5760; }","duration":"186.558163ms","start":"2026-10-27T20:59:16.708431Z","end":"2026-10-27T20:59:16.894989Z","steps":["trace[1054952085] 'agreement among raft nodes before linearized reading'  (duration: 186.336209ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:59:16.895136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.896551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-dlwfn\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-10-27T20:59:16.895208Z","caller":"traceutil/trace.go:171","msg":"trace[1476877958] range","detail":"{range_begin:/registry/pods/openstack/keepalived-dlwfn; range_end:; response_count:1; response_revision:5760; }","duration":"185.985092ms","start":"2026-10-27T20:59:16.709205Z","end":"2026-10-27T20:59:16.89519Z","steps":["trace[1476877958] 'agreement among raft nodes before linearized reading'  (duration: 185.824259ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:59:32.223406Z","caller":"traceutil/trace.go:171","msg":"trace[72912294] transaction","detail":"{read_only:false; response_revision:6022; number_of_response:1; }","duration":"137.596172ms","start":"2026-10-27T20:59:32.085784Z","end":"2026-10-27T20:59:32.22338Z","steps":["trace[72912294] 'process raft request'  (duration: 137.434389ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:59:32.54436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.231714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d165e574-4d69-477d-be68-d123bed90cdb\" ","response":"range_response_count:1 size:3646"}
{"level":"warn","ts":"2026-10-27T20:59:32.54441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.945941ms","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-10-27T20:59:32.544425Z","caller":"traceutil/trace.go:171","msg":"trace[2128232526] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d165e574-4d69-477d-be68-d123bed90cdb; range_end:; response_count:1; response_revision:6022; }","duration":"186.348506ms","start":"2026-10-27T20:59:32.358061Z","end":"2026-10-27T20:59:32.54441Z","steps":["trace[2128232526] 'range keys from in-memory index tree'  (duration: 186.118381ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:59:32.544459Z","caller":"traceutil/trace.go:171","msg":"trace[591961048] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6022; }","duration":"164.036633ms","start":"2026-10-27T20:59:32.380408Z","end":"2026-10-27T20:59:32.544445Z","steps":["trace[591961048] 'range keys from in-memory index tree'  (duration: 163.752137ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T20:59:32.747355Z","caller":"traceutil/trace.go:171","msg":"trace[128399302] linearizableReadLoop","detail":"{readStateIndex:6254; appliedIndex:6253; }","duration":"147.774403ms","start":"2026-10-27T20:59:32.599552Z","end":"2026-10-27T20:59:32.747327Z","steps":["trace[128399302] 'read index received'  (duration: 147.61304ms)","trace[128399302] 'applied index is now lower than readState.Index'  (duration: 159.783µs)"],"step_count":2}
{"level":"info","ts":"2026-10-27T20:59:32.747426Z","caller":"traceutil/trace.go:171","msg":"trace[246364276] transaction","detail":"{read_only:false; response_revision:6024; number_of_response:1; }","duration":"195.202706ms","start":"2026-10-27T20:59:32.5522Z","end":"2026-10-27T20:59:32.747403Z","steps":["trace[246364276] 'process raft request'  (duration: 194.962401ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:59:32.747567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.57308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-27T20:59:32.747604Z","caller":"traceutil/trace.go:171","msg":"trace[578452748] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6024; }","duration":"153.661792ms","start":"2026-10-27T20:59:32.59393Z","end":"2026-10-27T20:59:32.747592Z","steps":["trace[578452748] 'agreement among raft nodes before linearized reading'  (duration: 153.524569ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:59:32.747676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.369455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-10-27T20:59:32.747765Z","caller":"traceutil/trace.go:171","msg":"trace[1840299005] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:6024; }","duration":"182.501758ms","start":"2026-10-27T20:59:32.565244Z","end":"2026-10-27T20:59:32.747745Z","steps":["trace[1840299005] 'agreement among raft nodes before linearized reading'  (duration: 182.259873ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T20:59:32.75271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.165941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-20dda5c0-edc8-4ad1-8287-ac895c95fbfc\" ","response":"range_response_count:1 size:1450"}
{"level":"info","ts":"2026-10-27T20:59:32.752892Z","caller":"traceutil/trace.go:171","msg":"trace[1318825050] range","detail":"{range_begin:/registry/persistentvolumes/pvc-20dda5c0-edc8-4ad1-8287-ac895c95fbfc; range_end:; response_count:1; response_revision:6025; }","duration":"149.364944ms","start":"2026-10-27T20:59:32.603507Z","end":"2026-10-27T20:59:32.752872Z","steps":["trace[1318825050] 'agreement among raft nodes before linearized reading'  (duration: 149.114129ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:03:57.709612Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5453}
{"level":"info","ts":"2026-10-27T21:03:57.802897Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5453,"took":"91.809693ms","hash":982106263,"current-db-size-bytes":52297728,"current-db-size":"52 MB","current-db-size-in-use-bytes":27594752,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-27T21:03:57.803019Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":982106263,"revision":5453,"compact-revision":2972}
{"level":"info","ts":"2026-10-27T21:06:04.815225Z","caller":"traceutil/trace.go:171","msg":"trace[1926716518] linearizableReadLoop","detail":"{readStateIndex:9251; appliedIndex:9250; }","duration":"291.805177ms","start":"2026-10-27T21:06:04.523395Z","end":"2026-10-27T21:06:04.8152Z","steps":["trace[1926716518] 'read index received'  (duration: 291.604471ms)","trace[1926716518] 'applied index is now lower than readState.Index'  (duration: 200.036µs)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:06:04.815863Z","caller":"traceutil/trace.go:171","msg":"trace[326293028] transaction","detail":"{read_only:false; response_revision:8927; number_of_response:1; }","duration":"306.727261ms","start":"2026-10-27T21:06:04.509105Z","end":"2026-10-27T21:06:04.815833Z","steps":["trace[326293028] 'process raft request'  (duration: 305.96633ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:06:04.816135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:06:04.509075Z","time spent":"306.995679ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8913 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-10-27T21:06:04.815822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.368852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-27T21:06:04.816435Z","caller":"traceutil/trace.go:171","msg":"trace[1430833127] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8927; }","duration":"293.071472ms","start":"2026-10-27T21:06:04.523354Z","end":"2026-10-27T21:06:04.816425Z","steps":["trace[1430833127] 'agreement among raft nodes before linearized reading'  (duration: 292.147126ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:06:04.938629Z","caller":"traceutil/trace.go:171","msg":"trace[1996892418] transaction","detail":"{read_only:false; response_revision:8929; number_of_response:1; }","duration":"117.560916ms","start":"2026-10-27T21:06:04.82104Z","end":"2026-10-27T21:06:04.938601Z","steps":["trace[1996892418] 'process raft request'  (duration: 117.514894ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:06:04.938664Z","caller":"traceutil/trace.go:171","msg":"trace[306245442] transaction","detail":"{read_only:false; response_revision:8928; number_of_response:1; }","duration":"270.931636ms","start":"2026-10-27T21:06:04.667695Z","end":"2026-10-27T21:06:04.938626Z","steps":["trace[306245442] 'process raft request'  (duration: 237.380764ms)","trace[306245442] 'compare'  (duration: 33.356497ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:06:04.938694Z","caller":"traceutil/trace.go:171","msg":"trace[1370870694] linearizableReadLoop","detail":"{readStateIndex:9252; appliedIndex:9251; }","duration":"123.199493ms","start":"2026-10-27T21:06:04.815472Z","end":"2026-10-27T21:06:04.938671Z","steps":["trace[1370870694] 'read index received'  (duration: 89.575959ms)","trace[1370870694] 'applied index is now lower than readState.Index'  (duration: 33.620634ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:06:04.938828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.432585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-27T21:06:04.938885Z","caller":"traceutil/trace.go:171","msg":"trace[1009736488] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8929; }","duration":"341.570529ms","start":"2026-10-27T21:06:04.597305Z","end":"2026-10-27T21:06:04.938875Z","steps":["trace[1009736488] 'agreement among raft nodes before linearized reading'  (duration: 341.440716ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:06:04.938915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:06:04.597284Z","time spent":"341.62367ms","remote":"127.0.0.1:56774","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-10-27T21:06:16.429035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.423258ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734198315 > lease_revoke:<id:0828a17f1f8e751a>","response":"size:28"}
{"level":"info","ts":"2026-10-27T21:06:16.42918Z","caller":"traceutil/trace.go:171","msg":"trace[1386160265] linearizableReadLoop","detail":"{readStateIndex:9313; appliedIndex:9312; }","duration":"238.985896ms","start":"2026-10-27T21:06:16.190172Z","end":"2026-10-27T21:06:16.429158Z","steps":["trace[1386160265] 'read index received'  (duration: 49.388993ms)","trace[1386160265] 'applied index is now lower than readState.Index'  (duration: 189.595043ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:06:16.429381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.205492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-10-27T21:06:16.429421Z","caller":"traceutil/trace.go:171","msg":"trace[1017424771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8986; }","duration":"239.297284ms","start":"2026-10-27T21:06:16.190112Z","end":"2026-10-27T21:06:16.429409Z","steps":["trace[1017424771] 'agreement among raft nodes before linearized reading'  (duration: 239.14454ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:06:16.703987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.380919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-27T21:06:16.704116Z","caller":"traceutil/trace.go:171","msg":"trace[2048854981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8987; }","duration":"109.571044ms","start":"2026-10-27T21:06:16.594523Z","end":"2026-10-27T21:06:16.704094Z","steps":["trace[2048854981] 'range keys from in-memory index tree'  (duration: 109.301167ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:06:17.182631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.905142ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734198326 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8981 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-27T21:06:17.182797Z","caller":"traceutil/trace.go:171","msg":"trace[238215894] transaction","detail":"{read_only:false; response_revision:8990; number_of_response:1; }","duration":"148.618579ms","start":"2026-10-27T21:06:17.034141Z","end":"2026-10-27T21:06:17.18276Z","steps":["trace[238215894] 'process raft request'  (duration: 13.484742ms)","trace[238215894] 'compare'  (duration: 134.700835ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:06:17.183146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.615932ms","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-10-27T21:06:17.183203Z","caller":"traceutil/trace.go:171","msg":"trace[966783965] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8990; }","duration":"147.728915ms","start":"2026-10-27T21:06:17.035458Z","end":"2026-10-27T21:06:17.183187Z","steps":["trace[966783965] 'agreement among raft nodes before linearized reading'  (duration: 147.53521ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:06:17.182755Z","caller":"traceutil/trace.go:171","msg":"trace[1851099257] linearizableReadLoop","detail":"{readStateIndex:9317; appliedIndex:9316; }","duration":"147.227191ms","start":"2026-10-27T21:06:17.035507Z","end":"2026-10-27T21:06:17.182734Z","steps":["trace[1851099257] 'read index received'  (duration: 12.078263ms)","trace[1851099257] 'applied index is now lower than readState.Index'  (duration: 135.147498ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:06:17.424635Z","caller":"traceutil/trace.go:171","msg":"trace[1267595259] linearizableReadLoop","detail":"{readStateIndex:9318; appliedIndex:9317; }","duration":"241.208553ms","start":"2026-10-27T21:06:17.183391Z","end":"2026-10-27T21:06:17.4246Z","steps":["trace[1267595259] 'read index received'  (duration: 209.859828ms)","trace[1267595259] 'applied index is now lower than readState.Index'  (duration: 31.347415ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:06:17.424709Z","caller":"traceutil/trace.go:171","msg":"trace[1214991642] transaction","detail":"{read_only:false; response_revision:8991; number_of_response:1; }","duration":"328.987745ms","start":"2026-10-27T21:06:17.095646Z","end":"2026-10-27T21:06:17.424634Z","steps":["trace[1214991642] 'process raft request'  (duration: 297.6345ms)","trace[1214991642] 'compare'  (duration: 31.1773ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:06:17.424755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.224425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-27T21:06:17.424964Z","caller":"traceutil/trace.go:171","msg":"trace[217790022] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:8991; }","duration":"369.475772ms","start":"2026-10-27T21:06:17.055467Z","end":"2026-10-27T21:06:17.424943Z","steps":["trace[217790022] 'agreement among raft nodes before linearized reading'  (duration: 369.230395ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:06:17.425026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:06:17.055443Z","time spent":"369.559254ms","remote":"127.0.0.1:56086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":30,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true "}
{"level":"warn","ts":"2026-10-27T21:06:17.42535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:06:17.095625Z","time spent":"329.17365ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8983 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-27T21:06:17.428569Z","caller":"traceutil/trace.go:171","msg":"trace[1457647697] transaction","detail":"{read_only:false; response_revision:8992; number_of_response:1; }","duration":"239.935209ms","start":"2026-10-27T21:06:17.188607Z","end":"2026-10-27T21:06:17.428543Z","steps":["trace[1457647697] 'process raft request'  (duration: 239.826026ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:06:19.180702Z","caller":"traceutil/trace.go:171","msg":"trace[1919239680] transaction","detail":"{read_only:false; response_revision:9000; number_of_response:1; }","duration":"170.841758ms","start":"2026-10-27T21:06:19.009348Z","end":"2026-10-27T21:06:19.18019Z","steps":["trace[1919239680] 'process raft request'  (duration: 157.987793ms)","trace[1919239680] 'compare'  (duration: 12.265988ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:06:19.776039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.322541ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734198365 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8993 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-27T21:06:19.776179Z","caller":"traceutil/trace.go:171","msg":"trace[835367036] linearizableReadLoop","detail":"{readStateIndex:9331; appliedIndex:9330; }","duration":"252.59856ms","start":"2026-10-27T21:06:19.523556Z","end":"2026-10-27T21:06:19.776155Z","steps":["trace[835367036] 'read index received'  (duration: 44.077614ms)","trace[835367036] 'applied index is now lower than readState.Index'  (duration: 208.518836ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:06:19.776256Z","caller":"traceutil/trace.go:171","msg":"trace[1433192490] transaction","detail":"{read_only:false; response_revision:9004; number_of_response:1; }","duration":"284.732916ms","start":"2026-10-27T21:06:19.491488Z","end":"2026-10-27T21:06:19.77622Z","steps":["trace[1433192490] 'process raft request'  (duration: 76.115128ms)","trace[1433192490] 'compare'  (duration: 207.751684ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:06:19.776347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.722485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-27T21:06:19.776391Z","caller":"traceutil/trace.go:171","msg":"trace[883771629] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9004; }","duration":"182.810997ms","start":"2026-10-27T21:06:19.593566Z","end":"2026-10-27T21:06:19.776377Z","steps":["trace[883771629] 'agreement among raft nodes before linearized reading'  (duration: 182.725875ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:06:19.776476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.880438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-10-27T21:06:19.776576Z","caller":"traceutil/trace.go:171","msg":"trace[1723248755] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9004; }","duration":"253.026172ms","start":"2026-10-27T21:06:19.523522Z","end":"2026-10-27T21:06:19.776549Z","steps":["trace[1723248755] 'agreement among raft nodes before linearized reading'  (duration: 252.708773ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:06:19.776977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.626605ms","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-10-27T21:06:19.777043Z","caller":"traceutil/trace.go:171","msg":"trace[1899823442] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9004; }","duration":"148.729398ms","start":"2026-10-27T21:06:19.628294Z","end":"2026-10-27T21:06:19.777023Z","steps":["trace[1899823442] 'agreement among raft nodes before linearized reading'  (duration: 148.44665ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:06:19.918656Z","caller":"traceutil/trace.go:171","msg":"trace[880639991] transaction","detail":"{read_only:false; response_revision:9006; number_of_response:1; }","duration":"134.206348ms","start":"2026-10-27T21:06:19.784403Z","end":"2026-10-27T21:06:19.918609Z","steps":["trace[880639991] 'process raft request'  (duration: 102.812743ms)","trace[880639991] 'compare'  (duration: 31.20603ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:06:47.510113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.609061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-27T21:06:47.510206Z","caller":"traceutil/trace.go:171","msg":"trace[1310792949] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:9202; }","duration":"114.752685ms","start":"2026-10-27T21:06:47.395436Z","end":"2026-10-27T21:06:47.510188Z","steps":["trace[1310792949] 'count revisions from in-memory index tree'  (duration: 114.524719ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:06:50.012623Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002556.wal"}
{"level":"info","ts":"2026-10-27T21:06:50.789754Z","caller":"traceutil/trace.go:171","msg":"trace[810383722] linearizableReadLoop","detail":"{readStateIndex:9559; appliedIndex:9558; }","duration":"107.933616ms","start":"2026-10-27T21:06:50.681791Z","end":"2026-10-27T21:06:50.789725Z","steps":["trace[810383722] 'read index received'  (duration: 107.7178ms)","trace[810383722] 'applied index is now lower than readState.Index'  (duration: 214.166µs)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:06:50.789876Z","caller":"traceutil/trace.go:171","msg":"trace[538427775] transaction","detail":"{read_only:false; response_revision:9223; number_of_response:1; }","duration":"176.317219ms","start":"2026-10-27T21:06:50.613492Z","end":"2026-10-27T21:06:50.789809Z","steps":["trace[538427775] 'process raft request'  (duration: 175.98109ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:06:50.790036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.207873ms","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-10-27T21:06:50.790078Z","caller":"traceutil/trace.go:171","msg":"trace[1768637397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9223; }","duration":"108.314426ms","start":"2026-10-27T21:06:50.681754Z","end":"2026-10-27T21:06:50.790068Z","steps":["trace[1768637397] 'agreement among raft nodes before linearized reading'  (duration: 108.109431ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:06:50.934309Z","caller":"traceutil/trace.go:171","msg":"trace[924551661] transaction","detail":"{read_only:false; response_revision:9224; number_of_response:1; }","duration":"241.324032ms","start":"2026-10-27T21:06:50.692932Z","end":"2026-10-27T21:06:50.934256Z","steps":["trace[924551661] 'process raft request'  (duration: 236.496441ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:06:50.934872Z","caller":"traceutil/trace.go:171","msg":"trace[232686117] transaction","detail":"{read_only:false; response_revision:9225; number_of_response:1; }","duration":"140.609472ms","start":"2026-10-27T21:06:50.794199Z","end":"2026-10-27T21:06:50.934808Z","steps":["trace[232686117] 'process raft request'  (duration: 140.461578ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:06:59.846269Z","caller":"traceutil/trace.go:171","msg":"trace[730408099] transaction","detail":"{read_only:false; response_revision:9272; number_of_response:1; }","duration":"114.624123ms","start":"2026-10-27T21:06:59.731592Z","end":"2026-10-27T21:06:59.846216Z","steps":["trace[730408099] 'process raft request'  (duration: 114.391537ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:07:00.219203Z","caller":"traceutil/trace.go:171","msg":"trace[2027407832] linearizableReadLoop","detail":"{readStateIndex:9612; appliedIndex:9611; }","duration":"110.042668ms","start":"2026-10-27T21:07:00.109124Z","end":"2026-10-27T21:07:00.219167Z","steps":["trace[2027407832] 'read index received'  (duration: 36.279199ms)","trace[2027407832] 'applied index is now lower than readState.Index'  (duration: 73.762189ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:07:00.219326Z","caller":"traceutil/trace.go:171","msg":"trace[876161679] transaction","detail":"{read_only:false; response_revision:9274; number_of_response:1; }","duration":"112.071672ms","start":"2026-10-27T21:07:00.107205Z","end":"2026-10-27T21:07:00.219276Z","steps":["trace[876161679] 'process raft request'  (duration: 38.174109ms)","trace[876161679] 'compare'  (duration: 73.614515ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:07:00.219757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.611763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:229893"}
{"level":"info","ts":"2026-10-27T21:07:00.21981Z","caller":"traceutil/trace.go:171","msg":"trace[579152809] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:9274; }","duration":"110.721276ms","start":"2026-10-27T21:07:00.109077Z","end":"2026-10-27T21:07:00.219799Z","steps":["trace[579152809] 'agreement among raft nodes before linearized reading'  (duration: 110.259364ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:07:36.560638Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"86f12f2ae020828","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-27T21:07:36.569685Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-10-27T21:07:36.569888Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-10-27T21:08:33.782619Z","caller":"traceutil/trace.go:171","msg":"trace[2072722172] transaction","detail":"{read_only:false; response_revision:10155; number_of_response:1; }","duration":"145.71623ms","start":"2026-10-27T21:08:33.636857Z","end":"2026-10-27T21:08:33.782574Z","steps":["trace[2072722172] 'process raft request'  (duration: 98.738928ms)","trace[2072722172] 'compare'  (duration: 46.4984ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:08:57.718532Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7871}
{"level":"info","ts":"2026-10-27T21:08:57.805306Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7871,"took":"84.344493ms","hash":590244770,"current-db-size-bytes":52297728,"current-db-size":"52 MB","current-db-size-in-use-bytes":28434432,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-27T21:08:57.80539Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":590244770,"revision":7871,"compact-revision":5453}
{"level":"info","ts":"2026-10-27T21:13:57.728112Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10337}
{"level":"info","ts":"2026-10-27T21:13:57.815587Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10337,"took":"83.811253ms","hash":1643807553,"current-db-size-bytes":52297728,"current-db-size":"52 MB","current-db-size-in-use-bytes":25505792,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-10-27T21:13:57.815674Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1643807553,"revision":10337,"compact-revision":7871}
{"level":"warn","ts":"2026-10-27T21:14:19.291954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.014881ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734208459 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:12614 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-27T21:14:19.292229Z","caller":"traceutil/trace.go:171","msg":"trace[1095142970] linearizableReadLoop","detail":"{readStateIndex:13069; appliedIndex:13067; }","duration":"144.346349ms","start":"2026-10-27T21:14:19.147831Z","end":"2026-10-27T21:14:19.292178Z","steps":["trace[1095142970] 'read index received'  (duration: 30.98065ms)","trace[1095142970] 'applied index is now lower than readState.Index'  (duration: 113.364109ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:14:19.292331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.506734ms","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:5"}
{"level":"info","ts":"2026-10-27T21:14:19.292366Z","caller":"traceutil/trace.go:171","msg":"trace[247443696] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:12625; }","duration":"144.593835ms","start":"2026-10-27T21:14:19.147757Z","end":"2026-10-27T21:14:19.292351Z","steps":["trace[247443696] 'agreement among raft nodes before linearized reading'  (duration: 144.517264ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:14:19.292369Z","caller":"traceutil/trace.go:171","msg":"trace[1609700294] transaction","detail":"{read_only:false; response_revision:12624; number_of_response:1; }","duration":"186.107897ms","start":"2026-10-27T21:14:19.106219Z","end":"2026-10-27T21:14:19.292327Z","steps":["trace[1609700294] 'process raft request'  (duration: 72.558103ms)","trace[1609700294] 'compare'  (duration: 112.855448ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:14:19.292469Z","caller":"traceutil/trace.go:171","msg":"trace[709247271] transaction","detail":"{read_only:false; response_revision:12625; number_of_response:1; }","duration":"184.4775ms","start":"2026-10-27T21:14:19.107941Z","end":"2026-10-27T21:14:19.292419Z","steps":["trace[709247271] 'process raft request'  (duration: 184.166153ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:18:57.739954Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12507}
{"level":"info","ts":"2026-10-27T21:18:57.826208Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12507,"took":"83.788337ms","hash":1276773460,"current-db-size-bytes":52297728,"current-db-size":"52 MB","current-db-size-in-use-bytes":27312128,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-10-27T21:18:57.826303Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1276773460,"revision":12507,"compact-revision":10337}
{"level":"warn","ts":"2026-10-27T21:20:50.063055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.402543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-27T21:20:50.063156Z","caller":"traceutil/trace.go:171","msg":"trace[1845698360] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:15240; }","duration":"340.563207ms","start":"2026-10-27T21:20:49.72257Z","end":"2026-10-27T21:20:50.063133Z","steps":["trace[1845698360] 'count revisions from in-memory index tree'  (duration: 340.24587ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:20:50.063207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.374255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-h2mpk\" ","response":"range_response_count:1 size:12364"}
{"level":"warn","ts":"2026-10-27T21:20:50.063225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:20:49.722547Z","time spent":"340.667369ms","remote":"127.0.0.1:51630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "}
{"level":"info","ts":"2026-10-27T21:20:50.063252Z","caller":"traceutil/trace.go:171","msg":"trace[411621927] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-h2mpk; range_end:; response_count:1; response_revision:15240; }","duration":"260.462527ms","start":"2026-10-27T21:20:49.802777Z","end":"2026-10-27T21:20:50.06324Z","steps":["trace[411621927] 'range keys from in-memory index tree'  (duration: 260.11746ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:20:50.063444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.016447ms","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-10-27T21:20:50.063564Z","caller":"traceutil/trace.go:171","msg":"trace[1341500371] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:15240; }","duration":"334.191881ms","start":"2026-10-27T21:20:49.729342Z","end":"2026-10-27T21:20:50.063534Z","steps":["trace[1341500371] 'range keys from in-memory index tree'  (duration: 333.800302ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:20:50.063634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:20:49.729321Z","time spent":"334.303272ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-10-27T21:20:50.064408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.049252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-dlwfn\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-10-27T21:20:50.064539Z","caller":"traceutil/trace.go:171","msg":"trace[1303288572] range","detail":"{range_begin:/registry/pods/openstack/keepalived-dlwfn; range_end:; response_count:1; response_revision:15240; }","duration":"128.230506ms","start":"2026-10-27T21:20:49.936275Z","end":"2026-10-27T21:20:50.064506Z","steps":["trace[1303288572] 'range keys from in-memory index tree'  (duration: 126.922848ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:20:50.184008Z","caller":"traceutil/trace.go:171","msg":"trace[2041052257] linearizableReadLoop","detail":"{readStateIndex:15777; appliedIndex:15776; }","duration":"113.163695ms","start":"2026-10-27T21:20:50.070772Z","end":"2026-10-27T21:20:50.183936Z","steps":["trace[2041052257] 'read index received'  (duration: 112.973801ms)","trace[2041052257] 'applied index is now lower than readState.Index'  (duration: 188.614µs)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:20:50.184046Z","caller":"traceutil/trace.go:171","msg":"trace[2135815961] transaction","detail":"{read_only:false; response_revision:15241; number_of_response:1; }","duration":"114.601165ms","start":"2026-10-27T21:20:50.069402Z","end":"2026-10-27T21:20:50.184003Z","steps":["trace[2135815961] 'process raft request'  (duration: 114.281978ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:20:50.184886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.045423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:63 size:597207"}
{"level":"info","ts":"2026-10-27T21:20:50.184952Z","caller":"traceutil/trace.go:171","msg":"trace[595828591] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:63; response_revision:15241; }","duration":"114.209657ms","start":"2026-10-27T21:20:50.070726Z","end":"2026-10-27T21:20:50.184936Z","steps":["trace[595828591] 'agreement among raft nodes before linearized reading'  (duration: 113.374129ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:20:50.191967Z","caller":"traceutil/trace.go:171","msg":"trace[1107032037] transaction","detail":"{read_only:false; response_revision:15242; number_of_response:1; }","duration":"112.555371ms","start":"2026-10-27T21:20:50.079378Z","end":"2026-10-27T21:20:50.191934Z","steps":["trace[1107032037] 'process raft request'  (duration: 112.269385ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:21:01.002092Z","caller":"traceutil/trace.go:171","msg":"trace[2132720247] linearizableReadLoop","detail":"{readStateIndex:15956; appliedIndex:15955; }","duration":"250.265534ms","start":"2026-10-27T21:21:00.751787Z","end":"2026-10-27T21:21:01.002053Z","steps":["trace[2132720247] 'read index received'  (duration: 223.844441ms)","trace[2132720247] 'applied index is now lower than readState.Index'  (duration: 26.419853ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:21:01.002578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.54976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-27T21:21:01.002668Z","caller":"traceutil/trace.go:171","msg":"trace[1231886098] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:15417; }","duration":"250.879456ms","start":"2026-10-27T21:21:00.751773Z","end":"2026-10-27T21:21:01.002652Z","steps":["trace[1231886098] 'agreement among raft nodes before linearized reading'  (duration: 250.432647ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:21:01.002587Z","caller":"traceutil/trace.go:171","msg":"trace[371668657] transaction","detail":"{read_only:false; response_revision:15417; number_of_response:1; }","duration":"254.122885ms","start":"2026-10-27T21:21:00.748195Z","end":"2026-10-27T21:21:01.002318Z","steps":["trace[371668657] 'process raft request'  (duration: 227.422666ms)","trace[371668657] 'compare'  (duration: 25.829431ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:21:01.01418Z","caller":"traceutil/trace.go:171","msg":"trace[1804787169] transaction","detail":"{read_only:false; response_revision:15418; number_of_response:1; }","duration":"136.146452ms","start":"2026-10-27T21:21:00.877967Z","end":"2026-10-27T21:21:01.014113Z","steps":["trace[1804787169] 'process raft request'  (duration: 135.917777ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:22:11.994617Z","caller":"traceutil/trace.go:171","msg":"trace[446532381] linearizableReadLoop","detail":"{readStateIndex:16923; appliedIndex:16922; }","duration":"130.500138ms","start":"2026-10-27T21:22:11.864095Z","end":"2026-10-27T21:22:11.994595Z","steps":["trace[446532381] 'read index received'  (duration: 130.282244ms)","trace[446532381] 'applied index is now lower than readState.Index'  (duration: 216.854µs)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:22:11.994689Z","caller":"traceutil/trace.go:171","msg":"trace[2014636697] transaction","detail":"{read_only:false; response_revision:16356; number_of_response:1; }","duration":"139.181692ms","start":"2026-10-27T21:22:11.855475Z","end":"2026-10-27T21:22:11.994657Z","steps":["trace[2014636697] 'process raft request'  (duration: 138.980737ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:22:11.994883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.776304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-10-27T21:22:11.99494Z","caller":"traceutil/trace.go:171","msg":"trace[861385892] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16356; }","duration":"130.882436ms","start":"2026-10-27T21:22:11.864049Z","end":"2026-10-27T21:22:11.994931Z","steps":["trace[861385892] 'agreement among raft nodes before linearized reading'  (duration: 130.686472ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:22:11.995122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.440046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"info","ts":"2026-10-27T21:22:11.995182Z","caller":"traceutil/trace.go:171","msg":"trace[1834953252] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16356; }","duration":"129.528117ms","start":"2026-10-27T21:22:11.865634Z","end":"2026-10-27T21:22:11.995162Z","steps":["trace[1834953252] 'agreement among raft nodes before linearized reading'  (duration: 129.330943ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:22:11.99524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.519348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-42gpm\" ","response":"range_response_count:1 size:20799"}
{"level":"info","ts":"2026-10-27T21:22:11.995272Z","caller":"traceutil/trace.go:171","msg":"trace[1352602972] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-42gpm; range_end:; response_count:1; response_revision:16356; }","duration":"120.568878ms","start":"2026-10-27T21:22:11.874693Z","end":"2026-10-27T21:22:11.995262Z","steps":["trace[1352602972] 'agreement among raft nodes before linearized reading'  (duration: 120.459516ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:22:45.733116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.822715ms","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-10-27T21:22:45.733254Z","caller":"traceutil/trace.go:171","msg":"trace[891587582] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16530; }","duration":"113.00172ms","start":"2026-10-27T21:22:45.620231Z","end":"2026-10-27T21:22:45.733233Z","steps":["trace[891587582] 'range keys from in-memory index tree'  (duration: 112.726344ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:22:45.733288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.718618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5525"}
{"level":"warn","ts":"2026-10-27T21:22:45.733426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.536624ms","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-10-27T21:22:45.733473Z","caller":"traceutil/trace.go:171","msg":"trace[36099705] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16530; }","duration":"116.584075ms","start":"2026-10-27T21:22:45.616878Z","end":"2026-10-27T21:22:45.733462Z","steps":["trace[36099705] 'range keys from in-memory index tree'  (duration: 116.379671ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:22:45.733474Z","caller":"traceutil/trace.go:171","msg":"trace[1138393484] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16530; }","duration":"125.940952ms","start":"2026-10-27T21:22:45.607515Z","end":"2026-10-27T21:22:45.733456Z","steps":["trace[1138393484] 'range keys from in-memory index tree'  (duration: 125.437981ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:22:46.23818Z","caller":"traceutil/trace.go:171","msg":"trace[745585319] linearizableReadLoop","detail":"{readStateIndex:17108; appliedIndex:17107; }","duration":"111.798974ms","start":"2026-10-27T21:22:46.126352Z","end":"2026-10-27T21:22:46.238151Z","steps":["trace[745585319] 'read index received'  (duration: 111.348155ms)","trace[745585319] 'applied index is now lower than readState.Index'  (duration: 449.589µs)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:22:46.238282Z","caller":"traceutil/trace.go:171","msg":"trace[1912060399] transaction","detail":"{read_only:false; response_revision:16535; number_of_response:1; }","duration":"113.03336ms","start":"2026-10-27T21:22:46.125194Z","end":"2026-10-27T21:22:46.238227Z","steps":["trace[1912060399] 'process raft request'  (duration: 112.709143ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:22:46.238427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.052609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-wf8w7\" ","response":"range_response_count:1 size:22125"}
{"level":"info","ts":"2026-10-27T21:22:46.238471Z","caller":"traceutil/trace.go:171","msg":"trace[333415804] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-wf8w7; range_end:; response_count:1; response_revision:16535; }","duration":"112.147562ms","start":"2026-10-27T21:22:46.12631Z","end":"2026-10-27T21:22:46.238457Z","steps":["trace[333415804] 'agreement among raft nodes before linearized reading'  (duration: 111.945047ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:22:46.56801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.156837ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734220216 > lease_revoke:<id:0828a17f1f8ec9e8>","response":"size:29"}
{"level":"info","ts":"2026-10-27T21:22:46.568129Z","caller":"traceutil/trace.go:171","msg":"trace[1795944132] linearizableReadLoop","detail":"{readStateIndex:17109; appliedIndex:17108; }","duration":"158.652621ms","start":"2026-10-27T21:22:46.409453Z","end":"2026-10-27T21:22:46.568106Z","steps":["trace[1795944132] 'read index received'  (duration: 13.195088ms)","trace[1795944132] 'applied index is now lower than readState.Index'  (duration: 145.455663ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:22:46.568409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.908956ms","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-10-27T21:22:46.568477Z","caller":"traceutil/trace.go:171","msg":"trace[842741961] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16535; }","duration":"159.06672ms","start":"2026-10-27T21:22:46.409389Z","end":"2026-10-27T21:22:46.568455Z","steps":["trace[842741961] 'agreement among raft nodes before linearized reading'  (duration: 158.790064ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:22:46.827786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.097213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5525"}
{"level":"info","ts":"2026-10-27T21:22:46.827934Z","caller":"traceutil/trace.go:171","msg":"trace[827620622] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16536; }","duration":"105.317288ms","start":"2026-10-27T21:22:46.722584Z","end":"2026-10-27T21:22:46.827901Z","steps":["trace[827620622] 'range keys from in-memory index tree'  (duration: 104.813237ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:22:46.828246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.828848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-27T21:22:46.828286Z","caller":"traceutil/trace.go:171","msg":"trace[925916371] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16536; }","duration":"104.898379ms","start":"2026-10-27T21:22:46.723374Z","end":"2026-10-27T21:22:46.828273Z","steps":["trace[925916371] 'range keys from in-memory index tree'  (duration: 104.758796ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:22:46.828488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.687324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-27T21:22:46.828527Z","caller":"traceutil/trace.go:171","msg":"trace[1930531978] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16536; }","duration":"104.802347ms","start":"2026-10-27T21:22:46.723711Z","end":"2026-10-27T21:22:46.828513Z","steps":["trace[1930531978] 'range keys from in-memory index tree'  (duration: 104.538591ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:22:46.828729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.737595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-27T21:22:46.828814Z","caller":"traceutil/trace.go:171","msg":"trace[1983178317] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16536; }","duration":"104.790677ms","start":"2026-10-27T21:22:46.723963Z","end":"2026-10-27T21:22:46.828754Z","steps":["trace[1983178317] 'range keys from in-memory index tree'  (duration: 104.680054ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:23:57.748969Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14515}
{"level":"info","ts":"2026-10-27T21:23:57.834631Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14515,"took":"83.019276ms","hash":3563119917,"current-db-size-bytes":52297728,"current-db-size":"52 MB","current-db-size-in-use-bytes":30154752,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-27T21:23:57.834721Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3563119917,"revision":14515,"compact-revision":12507}
{"level":"info","ts":"2026-10-27T21:28:17.743624Z","caller":"traceutil/trace.go:171","msg":"trace[491035761] transaction","detail":"{read_only:false; response_revision:18897; number_of_response:1; }","duration":"183.914706ms","start":"2026-10-27T21:28:17.559696Z","end":"2026-10-27T21:28:17.743611Z","steps":["trace[491035761] 'process raft request'  (duration: 183.824674ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:28:17.743797Z","caller":"traceutil/trace.go:171","msg":"trace[1429793912] linearizableReadLoop","detail":"{readStateIndex:19552; appliedIndex:19552; }","duration":"158.433452ms","start":"2026-10-27T21:28:17.585338Z","end":"2026-10-27T21:28:17.743772Z","steps":["trace[1429793912] 'read index received'  (duration: 158.423782ms)","trace[1429793912] 'applied index is now lower than readState.Index'  (duration: 7.33µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:28:17.744032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.681148ms","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-10-27T21:28:17.744094Z","caller":"traceutil/trace.go:171","msg":"trace[1884778109] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18897; }","duration":"158.77762ms","start":"2026-10-27T21:28:17.585301Z","end":"2026-10-27T21:28:17.744079Z","steps":["trace[1884778109] 'agreement among raft nodes before linearized reading'  (duration: 158.601766ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:28:17.745615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.089484ms","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-10-27T21:28:17.745621Z","caller":"traceutil/trace.go:171","msg":"trace[583868933] transaction","detail":"{read_only:false; response_revision:18898; number_of_response:1; }","duration":"125.017087ms","start":"2026-10-27T21:28:17.620585Z","end":"2026-10-27T21:28:17.745602Z","steps":["trace[583868933] 'process raft request'  (duration: 124.812823ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:28:17.745662Z","caller":"traceutil/trace.go:171","msg":"trace[1428274802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18898; }","duration":"155.168776ms","start":"2026-10-27T21:28:17.590482Z","end":"2026-10-27T21:28:17.745651Z","steps":["trace[1428274802] 'agreement among raft nodes before linearized reading'  (duration: 155.038723ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:28:20.766517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.163124ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734229536 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:18901 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-27T21:28:20.766748Z","caller":"traceutil/trace.go:171","msg":"trace[409092457] transaction","detail":"{read_only:false; response_revision:18914; number_of_response:1; }","duration":"267.027462ms","start":"2026-10-27T21:28:20.499661Z","end":"2026-10-27T21:28:20.766688Z","steps":["trace[409092457] 'process raft request'  (duration: 55.567411ms)","trace[409092457] 'compare'  (duration: 210.897139ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:28:26.992715Z","caller":"traceutil/trace.go:171","msg":"trace[1787764043] transaction","detail":"{read_only:false; response_revision:18955; number_of_response:1; }","duration":"192.910989ms","start":"2026-10-27T21:28:26.799777Z","end":"2026-10-27T21:28:26.992688Z","steps":["trace[1787764043] 'process raft request'  (duration: 192.726285ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:28:27.143241Z","caller":"traceutil/trace.go:171","msg":"trace[897205641] linearizableReadLoop","detail":"{readStateIndex:19613; appliedIndex:19611; }","duration":"211.429239ms","start":"2026-10-27T21:28:26.931787Z","end":"2026-10-27T21:28:27.143216Z","steps":["trace[897205641] 'read index received'  (duration: 60.774267ms)","trace[897205641] 'applied index is now lower than readState.Index'  (duration: 150.654181ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:28:27.143356Z","caller":"traceutil/trace.go:171","msg":"trace[316809276] transaction","detail":"{read_only:false; response_revision:18956; number_of_response:1; }","duration":"216.37241ms","start":"2026-10-27T21:28:26.926972Z","end":"2026-10-27T21:28:27.143344Z","steps":["trace[316809276] 'process raft request'  (duration: 172.334446ms)","trace[316809276] 'compare'  (duration: 43.796579ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:28:27.143744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.935939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-27T21:28:27.143829Z","caller":"traceutil/trace.go:171","msg":"trace[799977631] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18956; }","duration":"212.056522ms","start":"2026-10-27T21:28:26.931751Z","end":"2026-10-27T21:28:27.143807Z","steps":["trace[799977631] 'agreement among raft nodes before linearized reading'  (duration: 211.852587ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:28:27.171788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.944959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-27T21:28:27.171884Z","caller":"traceutil/trace.go:171","msg":"trace[968469417] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:18957; }","duration":"232.050001ms","start":"2026-10-27T21:28:26.939813Z","end":"2026-10-27T21:28:27.171863Z","steps":["trace[968469417] 'agreement among raft nodes before linearized reading'  (duration: 231.901088ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:28:27.171909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.46693ms","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-10-27T21:28:27.171979Z","caller":"traceutil/trace.go:171","msg":"trace[1052069517] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:18957; }","duration":"154.609832ms","start":"2026-10-27T21:28:27.017355Z","end":"2026-10-27T21:28:27.171965Z","steps":["trace[1052069517] 'agreement among raft nodes before linearized reading'  (duration: 154.391708ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:28:43.346177Z","caller":"traceutil/trace.go:171","msg":"trace[1430473001] transaction","detail":"{read_only:false; response_revision:19155; number_of_response:1; }","duration":"272.1564ms","start":"2026-10-27T21:28:43.073997Z","end":"2026-10-27T21:28:43.346154Z","steps":["trace[1430473001] 'process raft request'  (duration: 272.011767ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:28:43.602184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.139679ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734230266 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:19147 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-27T21:28:43.602424Z","caller":"traceutil/trace.go:171","msg":"trace[413471948] linearizableReadLoop","detail":"{readStateIndex:19825; appliedIndex:19823; }","duration":"334.768704ms","start":"2026-10-27T21:28:43.267638Z","end":"2026-10-27T21:28:43.602407Z","steps":["trace[413471948] 'read index received'  (duration: 78.51123ms)","trace[413471948] 'applied index is now lower than readState.Index'  (duration: 256.256394ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:28:43.60241Z","caller":"traceutil/trace.go:171","msg":"trace[617804349] transaction","detail":"{read_only:false; response_revision:19156; number_of_response:1; }","duration":"388.23566ms","start":"2026-10-27T21:28:43.214154Z","end":"2026-10-27T21:28:43.60239Z","steps":["trace[617804349] 'process raft request'  (duration: 235.794754ms)","trace[617804349] 'compare'  (duration: 151.967666ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:28:43.602603Z","caller":"traceutil/trace.go:171","msg":"trace[834070019] transaction","detail":"{read_only:false; response_revision:19157; number_of_response:1; }","duration":"366.614716ms","start":"2026-10-27T21:28:43.235959Z","end":"2026-10-27T21:28:43.602573Z","steps":["trace[834070019] 'process raft request'  (duration: 366.338691ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:28:43.602704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.009847ms","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-10-27T21:28:43.602759Z","caller":"traceutil/trace.go:171","msg":"trace[1184868311] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:19157; }","duration":"311.102689ms","start":"2026-10-27T21:28:43.291642Z","end":"2026-10-27T21:28:43.602744Z","steps":["trace[1184868311] 'agreement among raft nodes before linearized reading'  (duration: 310.936105ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:28:43.602761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:28:43.235939Z","time spent":"366.74678ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:19148 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-10-27T21:28:43.602783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:28:43.291623Z","time spent":"311.15537ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-10-27T21:28:43.602637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.010528ms","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-10-27T21:28:43.602913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:28:43.21413Z","time spent":"388.73785ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:19147 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-10-27T21:28:43.602948Z","caller":"traceutil/trace.go:171","msg":"trace[1776206607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19157; }","duration":"335.343765ms","start":"2026-10-27T21:28:43.267569Z","end":"2026-10-27T21:28:43.602913Z","steps":["trace[1776206607] 'agreement among raft nodes before linearized reading'  (duration: 334.978508ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:28:43.603053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:28:43.267539Z","time spent":"335.483409ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-10-27T21:28:43.746804Z","caller":"traceutil/trace.go:171","msg":"trace[2015572917] transaction","detail":"{read_only:false; response_revision:19158; number_of_response:1; }","duration":"140.402629ms","start":"2026-10-27T21:28:43.606374Z","end":"2026-10-27T21:28:43.746777Z","steps":["trace[2015572917] 'process raft request'  (duration: 139.429189ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:28:43.74803Z","caller":"traceutil/trace.go:171","msg":"trace[159684253] linearizableReadLoop","detail":"{readStateIndex:19827; appliedIndex:19825; }","duration":"140.715555ms","start":"2026-10-27T21:28:43.60728Z","end":"2026-10-27T21:28:43.747996Z","steps":["trace[159684253] 'read index received'  (duration: 138.585251ms)","trace[159684253] 'applied index is now lower than readState.Index'  (duration: 2.128594ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:28:43.74812Z","caller":"traceutil/trace.go:171","msg":"trace[1489553363] transaction","detail":"{read_only:false; response_revision:19159; number_of_response:1; }","duration":"141.228546ms","start":"2026-10-27T21:28:43.606859Z","end":"2026-10-27T21:28:43.748087Z","steps":["trace[1489553363] 'process raft request'  (duration: 140.919799ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:28:43.748896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.180063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:934457"}
{"level":"info","ts":"2026-10-27T21:28:43.748937Z","caller":"traceutil/trace.go:171","msg":"trace[1982510] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:19159; }","duration":"138.264125ms","start":"2026-10-27T21:28:43.610664Z","end":"2026-10-27T21:28:43.748928Z","steps":["trace[1982510] 'agreement among raft nodes before linearized reading'  (duration: 137.5174ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:28:43.748936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.646134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:934457"}
{"level":"info","ts":"2026-10-27T21:28:43.748975Z","caller":"traceutil/trace.go:171","msg":"trace[276041049] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:19159; }","duration":"141.712086ms","start":"2026-10-27T21:28:43.607252Z","end":"2026-10-27T21:28:43.748964Z","steps":["trace[276041049] 'agreement among raft nodes before linearized reading'  (duration: 140.896519ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:28:55.985667Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"86f12f2ae020828","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-27T21:28:55.996494Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-10-27T21:28:55.996625Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-10-27T21:28:57.772642Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16967}
{"level":"info","ts":"2026-10-27T21:28:57.876365Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16967,"took":"100.232074ms","hash":768489490,"current-db-size-bytes":52297728,"current-db-size":"52 MB","current-db-size-in-use-bytes":32669696,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-10-27T21:28:57.876447Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":768489490,"revision":16967,"compact-revision":14515}
{"level":"warn","ts":"2026-10-27T21:29:17.993243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.697949ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-27T21:29:17.99344Z","caller":"traceutil/trace.go:171","msg":"trace[1015112056] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:19486; }","duration":"138.907313ms","start":"2026-10-27T21:29:17.854509Z","end":"2026-10-27T21:29:17.993416Z","steps":["trace[1015112056] 'range keys from in-memory index tree'  (duration: 138.680169ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:33:49.237935Z","caller":"traceutil/trace.go:171","msg":"trace[1375834880] transaction","detail":"{read_only:false; response_revision:21589; number_of_response:1; }","duration":"103.136078ms","start":"2026-10-27T21:33:49.134771Z","end":"2026-10-27T21:33:49.237907Z","steps":["trace[1375834880] 'process raft request'  (duration: 102.672987ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:33:57.782181Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19346}
{"level":"info","ts":"2026-10-27T21:33:57.899355Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19346,"took":"114.293446ms","hash":602436861,"current-db-size-bytes":52297728,"current-db-size":"52 MB","current-db-size-in-use-bytes":30429184,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-27T21:33:57.899409Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":602436861,"revision":19346,"compact-revision":16967}
{"level":"info","ts":"2026-10-27T21:34:33.869729Z","caller":"traceutil/trace.go:171","msg":"trace[1196975145] transaction","detail":"{read_only:false; response_revision:21817; number_of_response:1; }","duration":"100.335802ms","start":"2026-10-27T21:34:33.769366Z","end":"2026-10-27T21:34:33.869701Z","steps":["trace[1196975145] 'process raft request'  (duration: 99.853011ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:34:34.102573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.801566ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734238095 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:21809 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-27T21:34:34.102713Z","caller":"traceutil/trace.go:171","msg":"trace[1598087976] linearizableReadLoop","detail":"{readStateIndex:22570; appliedIndex:22569; }","duration":"222.538466ms","start":"2026-10-27T21:34:33.880158Z","end":"2026-10-27T21:34:34.102697Z","steps":["trace[1598087976] 'read index received'  (duration: 62.412036ms)","trace[1598087976] 'applied index is now lower than readState.Index'  (duration: 160.12473ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:34:34.102816Z","caller":"traceutil/trace.go:171","msg":"trace[1736383365] transaction","detail":"{read_only:false; response_revision:21818; number_of_response:1; }","duration":"226.856085ms","start":"2026-10-27T21:34:33.875913Z","end":"2026-10-27T21:34:34.102769Z","steps":["trace[1736383365] 'process raft request'  (duration: 66.744445ms)","trace[1736383365] 'compare'  (duration: 159.581847ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:34:34.10294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.780067ms","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-10-27T21:34:34.102971Z","caller":"traceutil/trace.go:171","msg":"trace[2108587615] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21818; }","duration":"222.8441ms","start":"2026-10-27T21:34:33.880117Z","end":"2026-10-27T21:34:34.102961Z","steps":["trace[2108587615] 'agreement among raft nodes before linearized reading'  (duration: 222.669382ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:34:34.10303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.706506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-27T21:34:34.103142Z","caller":"traceutil/trace.go:171","msg":"trace[900980926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21818; }","duration":"209.871423ms","start":"2026-10-27T21:34:33.893252Z","end":"2026-10-27T21:34:34.103124Z","steps":["trace[900980926] 'agreement among raft nodes before linearized reading'  (duration: 209.57883ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:34:34.103359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.830827ms","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-10-27T21:34:34.10348Z","caller":"traceutil/trace.go:171","msg":"trace[1877419412] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:21818; }","duration":"205.991063ms","start":"2026-10-27T21:34:33.897459Z","end":"2026-10-27T21:34:34.10345Z","steps":["trace[1877419412] 'agreement among raft nodes before linearized reading'  (duration: 205.548734ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:34:34.380571Z","caller":"traceutil/trace.go:171","msg":"trace[263032073] transaction","detail":"{read_only:false; response_revision:21821; number_of_response:1; }","duration":"270.847299ms","start":"2026-10-27T21:34:34.109692Z","end":"2026-10-27T21:34:34.380539Z","steps":["trace[263032073] 'process raft request'  (duration: 270.728274ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:34:34.380688Z","caller":"traceutil/trace.go:171","msg":"trace[753160039] transaction","detail":"{read_only:false; response_revision:21820; number_of_response:1; }","duration":"271.353272ms","start":"2026-10-27T21:34:34.109307Z","end":"2026-10-27T21:34:34.38066Z","steps":["trace[753160039] 'process raft request'  (duration: 217.314373ms)","trace[753160039] 'compare'  (duration: 53.274935ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:34:56.161103Z","caller":"traceutil/trace.go:171","msg":"trace[1653274070] transaction","detail":"{read_only:false; response_revision:21951; number_of_response:1; }","duration":"147.483857ms","start":"2026-10-27T21:34:56.013592Z","end":"2026-10-27T21:34:56.161076Z","steps":["trace[1653274070] 'process raft request'  (duration: 147.212745ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:34:56.597796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.519382ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734238446 > lease_revoke:<id:0828a17f1f8f11fe>","response":"size:29"}
{"level":"info","ts":"2026-10-27T21:34:56.597904Z","caller":"traceutil/trace.go:171","msg":"trace[237584257] linearizableReadLoop","detail":"{readStateIndex:22709; appliedIndex:22708; }","duration":"242.346803ms","start":"2026-10-27T21:34:56.355542Z","end":"2026-10-27T21:34:56.597889Z","steps":["trace[237584257] 'read index received'  (duration: 2.732297ms)","trace[237584257] 'applied index is now lower than readState.Index'  (duration: 239.612906ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:34:56.598086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.532451ms","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-10-27T21:34:56.598116Z","caller":"traceutil/trace.go:171","msg":"trace[176517271] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21951; }","duration":"242.595335ms","start":"2026-10-27T21:34:56.35551Z","end":"2026-10-27T21:34:56.598105Z","steps":["trace[176517271] 'agreement among raft nodes before linearized reading'  (duration: 242.463799ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:34:56.598332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.098988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-27T21:34:56.598369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.574122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-27T21:34:56.598407Z","caller":"traceutil/trace.go:171","msg":"trace[98838576] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:21951; }","duration":"121.204653ms","start":"2026-10-27T21:34:56.477184Z","end":"2026-10-27T21:34:56.598389Z","steps":["trace[98838576] 'agreement among raft nodes before linearized reading'  (duration: 121.103838ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:34:56.598438Z","caller":"traceutil/trace.go:171","msg":"trace[494492266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21951; }","duration":"238.898366ms","start":"2026-10-27T21:34:56.359525Z","end":"2026-10-27T21:34:56.598423Z","steps":["trace[494492266] 'agreement among raft nodes before linearized reading'  (duration: 238.474148ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:34:56.828588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.831188ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734238450 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:21943 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-27T21:34:56.828729Z","caller":"traceutil/trace.go:171","msg":"trace[1875747844] transaction","detail":"{read_only:false; response_revision:21953; number_of_response:1; }","duration":"225.752884ms","start":"2026-10-27T21:34:56.602959Z","end":"2026-10-27T21:34:56.828712Z","steps":["trace[1875747844] 'process raft request'  (duration: 111.720518ms)","trace[1875747844] 'compare'  (duration: 113.702142ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:34:56.828941Z","caller":"traceutil/trace.go:171","msg":"trace[115099147] transaction","detail":"{read_only:false; response_revision:21955; number_of_response:1; }","duration":"225.19476ms","start":"2026-10-27T21:34:56.603728Z","end":"2026-10-27T21:34:56.828923Z","steps":["trace[115099147] 'process raft request'  (duration: 225.079265ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:34:56.828943Z","caller":"traceutil/trace.go:171","msg":"trace[889745388] transaction","detail":"{read_only:false; response_revision:21954; number_of_response:1; }","duration":"225.851218ms","start":"2026-10-27T21:34:56.603073Z","end":"2026-10-27T21:34:56.828924Z","steps":["trace[889745388] 'process raft request'  (duration: 225.596487ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:34:57.261Z","caller":"traceutil/trace.go:171","msg":"trace[533408332] transaction","detail":"{read_only:false; response_revision:21957; number_of_response:1; }","duration":"155.42304ms","start":"2026-10-27T21:34:57.105557Z","end":"2026-10-27T21:34:57.26098Z","steps":["trace[533408332] 'process raft request'  (duration: 155.294475ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:34:57.766888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.355975ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734238458 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:21948 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-27T21:34:57.767115Z","caller":"traceutil/trace.go:171","msg":"trace[1457525524] transaction","detail":"{read_only:false; response_revision:21958; number_of_response:1; }","duration":"658.151479ms","start":"2026-10-27T21:34:57.108926Z","end":"2026-10-27T21:34:57.767078Z","steps":["trace[1457525524] 'process raft request'  (duration: 202.46668ms)","trace[1457525524] 'compare'  (duration: 454.849884ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:34:57.767171Z","caller":"traceutil/trace.go:171","msg":"trace[436512480] linearizableReadLoop","detail":"{readStateIndex:22717; appliedIndex:22715; }","duration":"242.161026ms","start":"2026-10-27T21:34:57.524987Z","end":"2026-10-27T21:34:57.767148Z","steps":["trace[436512480] 'read index received'  (duration: 54.242µs)","trace[436512480] 'applied index is now lower than readState.Index'  (duration: 242.105204ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:34:57.767333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:34:57.108907Z","time spent":"658.289665ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:21948 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-10-27T21:34:57.767437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.741959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-27T21:34:57.767522Z","caller":"traceutil/trace.go:171","msg":"trace[1833366405] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21959; }","duration":"175.856603ms","start":"2026-10-27T21:34:57.591647Z","end":"2026-10-27T21:34:57.767503Z","steps":["trace[1833366405] 'agreement among raft nodes before linearized reading'  (duration: 175.723298ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:34:57.767523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.511391ms","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-10-27T21:34:57.767602Z","caller":"traceutil/trace.go:171","msg":"trace[607324616] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21959; }","duration":"242.637427ms","start":"2026-10-27T21:34:57.524946Z","end":"2026-10-27T21:34:57.767583Z","steps":["trace[607324616] 'agreement among raft nodes before linearized reading'  (duration: 242.385206ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:34:57.767432Z","caller":"traceutil/trace.go:171","msg":"trace[1921411574] transaction","detail":"{read_only:false; response_revision:21959; number_of_response:1; }","duration":"360.778274ms","start":"2026-10-27T21:34:57.406605Z","end":"2026-10-27T21:34:57.767383Z","steps":["trace[1921411574] 'process raft request'  (duration: 360.424079ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:34:57.768048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:34:57.406586Z","time spent":"361.396771ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:21949 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-27T21:38:57.79624Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21639}
{"level":"info","ts":"2026-10-27T21:38:57.915203Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21639,"took":"116.23403ms","hash":2157607379,"current-db-size-bytes":52297728,"current-db-size":"52 MB","current-db-size-in-use-bytes":30117888,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-27T21:38:57.915261Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2157607379,"revision":21639,"compact-revision":19346}
{"level":"info","ts":"2026-10-27T21:39:19.24562Z","caller":"traceutil/trace.go:171","msg":"trace[496670821] transaction","detail":"{read_only:false; response_revision:24540; number_of_response:1; }","duration":"311.914892ms","start":"2026-10-27T21:39:18.933678Z","end":"2026-10-27T21:39:19.245593Z","steps":["trace[496670821] 'process raft request'  (duration: 307.916003ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:39:19.245894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:39:18.933653Z","time spent":"312.043996ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24494 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-10-27T21:39:19.252606Z","caller":"traceutil/trace.go:171","msg":"trace[1606200788] linearizableReadLoop","detail":"{readStateIndex:25376; appliedIndex:25374; }","duration":"197.924338ms","start":"2026-10-27T21:39:19.054651Z","end":"2026-10-27T21:39:19.252576Z","steps":["trace[1606200788] 'read index received'  (duration: 187.126133ms)","trace[1606200788] 'applied index is now lower than readState.Index'  (duration: 10.796815ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:39:19.252675Z","caller":"traceutil/trace.go:171","msg":"trace[38650051] transaction","detail":"{read_only:false; response_revision:24541; number_of_response:1; }","duration":"226.128269ms","start":"2026-10-27T21:39:19.02652Z","end":"2026-10-27T21:39:19.252648Z","steps":["trace[38650051] 'process raft request'  (duration: 225.930642ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:39:19.252773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.085524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-27T21:39:19.252815Z","caller":"traceutil/trace.go:171","msg":"trace[2028150965] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:24541; }","duration":"198.191028ms","start":"2026-10-27T21:39:19.054611Z","end":"2026-10-27T21:39:19.252802Z","steps":["trace[2028150965] 'agreement among raft nodes before linearized reading'  (duration: 198.086054ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:42:00.99137Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000697e.wal"}
{"level":"warn","ts":"2026-10-27T21:43:06.873121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.321478ms","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-10-27T21:43:06.875647Z","caller":"traceutil/trace.go:171","msg":"trace[670594714] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26737; }","duration":"162.575446ms","start":"2026-10-27T21:43:06.710744Z","end":"2026-10-27T21:43:06.873319Z","steps":["trace[670594714] 'range keys from in-memory index tree'  (duration: 162.148823ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:43:07.276098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.408883ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734251445 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26723 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-27T21:43:07.276178Z","caller":"traceutil/trace.go:171","msg":"trace[982900350] transaction","detail":"{read_only:false; response_revision:26740; number_of_response:1; }","duration":"327.350405ms","start":"2026-10-27T21:43:06.948813Z","end":"2026-10-27T21:43:07.276164Z","steps":["trace[982900350] 'process raft request'  (duration: 154.188669ms)","trace[982900350] 'compare'  (duration: 172.190916ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:43:07.276221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:43:06.948794Z","time spent":"327.406226ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26723 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-27T21:43:07.297333Z","caller":"traceutil/trace.go:171","msg":"trace[1290410404] transaction","detail":"{read_only:false; response_revision:26742; number_of_response:1; }","duration":"291.936795ms","start":"2026-10-27T21:43:07.005367Z","end":"2026-10-27T21:43:07.297303Z","steps":["trace[1290410404] 'process raft request'  (duration: 291.855102ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:43:07.297495Z","caller":"traceutil/trace.go:171","msg":"trace[264565696] transaction","detail":"{read_only:false; response_revision:26741; number_of_response:1; }","duration":"345.537049ms","start":"2026-10-27T21:43:06.95195Z","end":"2026-10-27T21:43:07.297487Z","steps":["trace[264565696] 'process raft request'  (duration: 345.128256ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:43:07.297587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:43:06.951928Z","time spent":"345.589231ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:26630 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-10-27T21:43:07.297679Z","caller":"traceutil/trace.go:171","msg":"trace[155552455] linearizableReadLoop","detail":"{readStateIndex:27634; appliedIndex:27631; }","duration":"257.183776ms","start":"2026-10-27T21:43:07.040471Z","end":"2026-10-27T21:43:07.297655Z","steps":["trace[155552455] 'read index received'  (duration: 62.554776ms)","trace[155552455] 'applied index is now lower than readState.Index'  (duration: 194.62784ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:43:07.297823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.34046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-27T21:43:07.2979Z","caller":"traceutil/trace.go:171","msg":"trace[1011318513] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:26743; }","duration":"257.452354ms","start":"2026-10-27T21:43:07.040432Z","end":"2026-10-27T21:43:07.297884Z","steps":["trace[1011318513] 'agreement among raft nodes before linearized reading'  (duration: 257.32554ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:43:07.298028Z","caller":"traceutil/trace.go:171","msg":"trace[1457228887] transaction","detail":"{read_only:false; response_revision:26743; number_of_response:1; }","duration":"215.925329ms","start":"2026-10-27T21:43:07.082093Z","end":"2026-10-27T21:43:07.298019Z","steps":["trace[1457228887] 'process raft request'  (duration: 215.164066ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:43:07.671334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.93395ms","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-10-27T21:43:07.671392Z","caller":"traceutil/trace.go:171","msg":"trace[379355373] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:26743; }","duration":"261.032403ms","start":"2026-10-27T21:43:07.410346Z","end":"2026-10-27T21:43:07.671378Z","steps":["trace[379355373] 'range keys from in-memory index tree'  (duration: 260.831677ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:43:07.671784Z","caller":"traceutil/trace.go:171","msg":"trace[1362233251] linearizableReadLoop","detail":"{readStateIndex:27636; appliedIndex:27635; }","duration":"105.974639ms","start":"2026-10-27T21:43:07.565789Z","end":"2026-10-27T21:43:07.671764Z","steps":["trace[1362233251] 'read index received'  (duration: 102.238415ms)","trace[1362233251] 'applied index is now lower than readState.Index'  (duration: 3.735064ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:43:07.671902Z","caller":"traceutil/trace.go:171","msg":"trace[1950726632] transaction","detail":"{read_only:false; response_revision:26744; number_of_response:1; }","duration":"250.070689ms","start":"2026-10-27T21:43:07.421821Z","end":"2026-10-27T21:43:07.671892Z","steps":["trace[1950726632] 'process raft request'  (duration: 246.255613ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:43:07.672181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.377011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-27T21:43:07.672212Z","caller":"traceutil/trace.go:171","msg":"trace[1985642789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26744; }","duration":"106.447423ms","start":"2026-10-27T21:43:07.565757Z","end":"2026-10-27T21:43:07.672204Z","steps":["trace[1985642789] 'agreement among raft nodes before linearized reading'  (duration: 106.309759ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:43:07.966001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.551155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:6044"}
{"level":"info","ts":"2026-10-27T21:43:07.966134Z","caller":"traceutil/trace.go:171","msg":"trace[1114707607] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:26747; }","duration":"189.684679ms","start":"2026-10-27T21:43:07.776401Z","end":"2026-10-27T21:43:07.966086Z","steps":["trace[1114707607] 'range keys from in-memory index tree'  (duration: 189.326659ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:43:07.965872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.839127ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-27T21:43:07.966223Z","caller":"traceutil/trace.go:171","msg":"trace[633850444] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:26747; }","duration":"111.559839ms","start":"2026-10-27T21:43:07.85465Z","end":"2026-10-27T21:43:07.96621Z","steps":["trace[633850444] 'range keys from in-memory index tree'  (duration: 110.818937ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:43:14.483711Z","caller":"traceutil/trace.go:171","msg":"trace[636276621] transaction","detail":"{read_only:false; response_revision:26794; number_of_response:1; }","duration":"130.826341ms","start":"2026-10-27T21:43:14.352858Z","end":"2026-10-27T21:43:14.483685Z","steps":["trace[636276621] 'process raft request'  (duration: 130.76706ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:43:14.484146Z","caller":"traceutil/trace.go:171","msg":"trace[506655012] transaction","detail":"{read_only:false; response_revision:26793; number_of_response:1; }","duration":"131.796591ms","start":"2026-10-27T21:43:14.352327Z","end":"2026-10-27T21:43:14.484123Z","steps":["trace[506655012] 'process raft request'  (duration: 131.086799ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:43:57.802672Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23809}
{"level":"info","ts":"2026-10-27T21:43:57.921564Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23809,"took":"115.663381ms","hash":4238746436,"current-db-size-bytes":55508992,"current-db-size":"56 MB","current-db-size-in-use-bytes":45318144,"current-db-size-in-use":"45 MB"}
{"level":"info","ts":"2026-10-27T21:43:57.921626Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4238746436,"revision":23809,"compact-revision":21639}
{"level":"info","ts":"2026-10-27T21:44:19.772762Z","caller":"traceutil/trace.go:171","msg":"trace[1849689723] linearizableReadLoop","detail":"{readStateIndex:28279; appliedIndex:28278; }","duration":"127.677402ms","start":"2026-10-27T21:44:19.64505Z","end":"2026-10-27T21:44:19.772727Z","steps":["trace[1849689723] 'read index received'  (duration: 127.59573ms)","trace[1849689723] 'applied index is now lower than readState.Index'  (duration: 80.352µs)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:44:19.772896Z","caller":"traceutil/trace.go:171","msg":"trace[19216523] transaction","detail":"{read_only:false; response_revision:27370; number_of_response:1; }","duration":"155.959545ms","start":"2026-10-27T21:44:19.616897Z","end":"2026-10-27T21:44:19.772857Z","steps":["trace[19216523] 'process raft request'  (duration: 155.644316ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:44:19.773103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.032753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12430"}
{"level":"info","ts":"2026-10-27T21:44:19.7732Z","caller":"traceutil/trace.go:171","msg":"trace[1443758375] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27370; }","duration":"128.202058ms","start":"2026-10-27T21:44:19.644974Z","end":"2026-10-27T21:44:19.773176Z","steps":["trace[1443758375] 'agreement among raft nodes before linearized reading'  (duration: 127.912539ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:44:19.790792Z","caller":"traceutil/trace.go:171","msg":"trace[1677103293] transaction","detail":"{read_only:false; response_revision:27371; number_of_response:1; }","duration":"111.803864ms","start":"2026-10-27T21:44:19.678966Z","end":"2026-10-27T21:44:19.79077Z","steps":["trace[1677103293] 'process raft request'  (duration: 111.32979ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:44:19.791648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.986984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-27T21:44:19.791712Z","caller":"traceutil/trace.go:171","msg":"trace[367151603] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:27372; }","duration":"104.084397ms","start":"2026-10-27T21:44:19.687609Z","end":"2026-10-27T21:44:19.791693Z","steps":["trace[367151603] 'agreement among raft nodes before linearized reading'  (duration: 103.991174ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:44:20.367578Z","caller":"traceutil/trace.go:171","msg":"trace[2072832696] linearizableReadLoop","detail":"{readStateIndex:28283; appliedIndex:28282; }","duration":"376.938261ms","start":"2026-10-27T21:44:19.990623Z","end":"2026-10-27T21:44:20.367561Z","steps":["trace[2072832696] 'read index received'  (duration: 376.777686ms)","trace[2072832696] 'applied index is now lower than readState.Index'  (duration: 159.685µs)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:44:20.367659Z","caller":"traceutil/trace.go:171","msg":"trace[1450523689] transaction","detail":"{read_only:false; response_revision:27374; number_of_response:1; }","duration":"378.230059ms","start":"2026-10-27T21:44:19.989424Z","end":"2026-10-27T21:44:20.367654Z","steps":["trace[1450523689] 'process raft request'  (duration: 378.018103ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:44:20.367732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:44:19.989397Z","time spent":"378.27743ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:27358 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-10-27T21:44:20.367884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.26549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18744"}
{"level":"warn","ts":"2026-10-27T21:44:20.368128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.605909ms","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":"warn","ts":"2026-10-27T21:44:20.368162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.899296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-10-27T21:44:20.368212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.539354ms","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-10-27T21:44:20.368237Z","caller":"traceutil/trace.go:171","msg":"trace[1482722106] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:27374; }","duration":"112.03085ms","start":"2026-10-27T21:44:20.256191Z","end":"2026-10-27T21:44:20.368221Z","steps":["trace[1482722106] 'agreement among raft nodes before linearized reading'  (duration: 111.848274ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:44:20.368249Z","caller":"traceutil/trace.go:171","msg":"trace[1019357823] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27374; }","duration":"168.575745ms","start":"2026-10-27T21:44:20.199662Z","end":"2026-10-27T21:44:20.368238Z","steps":["trace[1019357823] 'agreement among raft nodes before linearized reading'  (duration: 168.41327ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:44:20.368241Z","caller":"traceutil/trace.go:171","msg":"trace[421845405] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:27374; }","duration":"180.787305ms","start":"2026-10-27T21:44:20.187424Z","end":"2026-10-27T21:44:20.368211Z","steps":["trace[421845405] 'agreement among raft nodes before linearized reading'  (duration: 180.514957ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:44:20.36828Z","caller":"traceutil/trace.go:171","msg":"trace[1318559707] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:27374; }","duration":"377.333963ms","start":"2026-10-27T21:44:19.990571Z","end":"2026-10-27T21:44:20.367905Z","steps":["trace[1318559707] 'agreement among raft nodes before linearized reading'  (duration: 377.23055ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:44:20.368307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:44:19.990554Z","time spent":"377.746835ms","remote":"127.0.0.1:56960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18767,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-10-27T21:44:20.575653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.930707ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734253019 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:27361 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-27T21:44:20.576291Z","caller":"traceutil/trace.go:171","msg":"trace[2017415048] transaction","detail":"{read_only:false; response_revision:27375; number_of_response:1; }","duration":"204.247656ms","start":"2026-10-27T21:44:20.372012Z","end":"2026-10-27T21:44:20.57626Z","steps":["trace[2017415048] 'process raft request'  (duration: 17.633539ms)","trace[2017415048] 'compare'  (duration: 185.656899ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:44:20.576713Z","caller":"traceutil/trace.go:171","msg":"trace[1522265557] linearizableReadLoop","detail":"{readStateIndex:28287; appliedIndex:28283; }","duration":"198.28462ms","start":"2026-10-27T21:44:20.378413Z","end":"2026-10-27T21:44:20.576698Z","steps":["trace[1522265557] 'read index received'  (duration: 11.21423ms)","trace[1522265557] 'applied index is now lower than readState.Index'  (duration: 187.06972ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:44:20.577162Z","caller":"traceutil/trace.go:171","msg":"trace[1096728585] transaction","detail":"{read_only:false; response_revision:27378; number_of_response:1; }","duration":"203.339299ms","start":"2026-10-27T21:44:20.373795Z","end":"2026-10-27T21:44:20.577134Z","steps":["trace[1096728585] 'process raft request'  (duration: 202.872755ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:44:20.57721Z","caller":"traceutil/trace.go:171","msg":"trace[1322603152] transaction","detail":"{read_only:false; response_revision:27377; number_of_response:1; }","duration":"204.173963ms","start":"2026-10-27T21:44:20.373022Z","end":"2026-10-27T21:44:20.577196Z","steps":["trace[1322603152] 'process raft request'  (duration: 203.607707ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:44:20.577214Z","caller":"traceutil/trace.go:171","msg":"trace[231919077] transaction","detail":"{read_only:false; response_revision:27376; number_of_response:1; }","duration":"204.229965ms","start":"2026-10-27T21:44:20.372956Z","end":"2026-10-27T21:44:20.577186Z","steps":["trace[231919077] 'process raft request'  (duration: 203.111252ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:44:20.577922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.482265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:6044"}
{"level":"info","ts":"2026-10-27T21:44:20.578039Z","caller":"traceutil/trace.go:171","msg":"trace[292594819] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:27378; }","duration":"199.62321ms","start":"2026-10-27T21:44:20.378392Z","end":"2026-10-27T21:44:20.578015Z","steps":["trace[292594819] 'agreement among raft nodes before linearized reading'  (duration: 198.95458ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:44:21.016363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.022631ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897318734253028 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:27364 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-27T21:44:21.016488Z","caller":"traceutil/trace.go:171","msg":"trace[1000380749] transaction","detail":"{read_only:false; response_revision:27379; number_of_response:1; }","duration":"380.345552ms","start":"2026-10-27T21:44:20.63612Z","end":"2026-10-27T21:44:21.016466Z","steps":["trace[1000380749] 'process raft request'  (duration: 218.107264ms)","trace[1000380749] 'compare'  (duration: 160.852077ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:44:21.016553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:44:20.636076Z","time spent":"380.444705ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:27364 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-27T21:44:21.059608Z","caller":"traceutil/trace.go:171","msg":"trace[1024068099] transaction","detail":"{read_only:false; response_revision:27381; number_of_response:1; }","duration":"364.949938ms","start":"2026-10-27T21:44:20.694631Z","end":"2026-10-27T21:44:21.059581Z","steps":["trace[1024068099] 'process raft request'  (duration: 364.812304ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:44:21.059629Z","caller":"traceutil/trace.go:171","msg":"trace[1667614208] transaction","detail":"{read_only:false; response_revision:27380; number_of_response:1; }","duration":"407.813731ms","start":"2026-10-27T21:44:20.651776Z","end":"2026-10-27T21:44:21.05959Z","steps":["trace[1667614208] 'process raft request'  (duration: 407.515272ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:44:21.059799Z","caller":"traceutil/trace.go:171","msg":"trace[211239346] linearizableReadLoop","detail":"{readStateIndex:28290; appliedIndex:28287; }","duration":"228.880421ms","start":"2026-10-27T21:44:20.83088Z","end":"2026-10-27T21:44:21.059761Z","steps":["trace[211239346] 'read index received'  (duration: 23.42228ms)","trace[211239346] 'applied index is now lower than readState.Index'  (duration: 205.45532ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-27T21:44:21.059877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:44:20.651756Z","time spent":"407.992795ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:27365 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-10-27T21:44:21.059941Z","caller":"traceutil/trace.go:171","msg":"trace[527703768] transaction","detail":"{read_only:false; response_revision:27382; number_of_response:1; }","duration":"220.483153ms","start":"2026-10-27T21:44:20.83943Z","end":"2026-10-27T21:44:21.059913Z","steps":["trace[527703768] 'process raft request'  (duration: 220.068311ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:44:21.059979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T21:44:20.694604Z","time spent":"365.081662ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:27366 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-10-27T21:44:21.060147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.255521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-10-27T21:44:21.060209Z","caller":"traceutil/trace.go:171","msg":"trace[1032612670] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:27382; }","duration":"229.392575ms","start":"2026-10-27T21:44:20.830801Z","end":"2026-10-27T21:44:21.060194Z","steps":["trace[1032612670] 'agreement among raft nodes before linearized reading'  (duration: 229.150758ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:44:21.061641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.949531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-27T21:44:21.061766Z","caller":"traceutil/trace.go:171","msg":"trace[1240371635] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:27383; }","duration":"195.128076ms","start":"2026-10-27T21:44:20.866612Z","end":"2026-10-27T21:44:21.06174Z","steps":["trace[1240371635] 'agreement among raft nodes before linearized reading'  (duration: 194.900129ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:44:21.063218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.620648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-10-27T21:44:21.063272Z","caller":"traceutil/trace.go:171","msg":"trace[485255685] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0; range_end:; response_count:1; response_revision:27383; }","duration":"181.711661ms","start":"2026-10-27T21:44:20.881543Z","end":"2026-10-27T21:44:21.063255Z","steps":["trace[485255685] 'agreement among raft nodes before linearized reading'  (duration: 181.531806ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:44:26.507935Z","caller":"traceutil/trace.go:171","msg":"trace[1042113977] transaction","detail":"{read_only:false; response_revision:27418; number_of_response:1; }","duration":"123.173068ms","start":"2026-10-27T21:44:26.384738Z","end":"2026-10-27T21:44:26.507912Z","steps":["trace[1042113977] 'process raft request'  (duration: 122.89369ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:44:32.915496Z","caller":"traceutil/trace.go:171","msg":"trace[1069568939] transaction","detail":"{read_only:false; response_revision:27464; number_of_response:1; }","duration":"181.684613ms","start":"2026-10-27T21:44:32.733788Z","end":"2026-10-27T21:44:32.915473Z","steps":["trace[1069568939] 'process raft request'  (duration: 161.845662ms)","trace[1069568939] 'compare'  (duration: 19.648936ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:44:32.91595Z","caller":"traceutil/trace.go:171","msg":"trace[1381477290] transaction","detail":"{read_only:false; response_revision:27465; number_of_response:1; }","duration":"181.965682ms","start":"2026-10-27T21:44:32.733941Z","end":"2026-10-27T21:44:32.915906Z","steps":["trace[1381477290] 'process raft request'  (duration: 181.491888ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:47:21.225081Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"86f12f2ae020828","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-27T21:47:21.230361Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-10-27T21:47:21.230445Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-10-27T21:48:10.420388Z","caller":"traceutil/trace.go:171","msg":"trace[1908473249] transaction","detail":"{read_only:false; response_revision:29594; number_of_response:1; }","duration":"119.102572ms","start":"2026-10-27T21:48:10.301251Z","end":"2026-10-27T21:48:10.420354Z","steps":["trace[1908473249] 'process raft request'  (duration: 27.305839ms)","trace[1908473249] 'compare'  (duration: 91.414033ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:48:10.427116Z","caller":"traceutil/trace.go:171","msg":"trace[1107760059] transaction","detail":"{read_only:false; response_revision:29596; number_of_response:1; }","duration":"121.627401ms","start":"2026-10-27T21:48:10.305471Z","end":"2026-10-27T21:48:10.427098Z","steps":["trace[1107760059] 'process raft request'  (duration: 121.574259ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:48:10.427244Z","caller":"traceutil/trace.go:171","msg":"trace[216836827] linearizableReadLoop","detail":"{readStateIndex:30560; appliedIndex:30556; }","duration":"107.515239ms","start":"2026-10-27T21:48:10.319722Z","end":"2026-10-27T21:48:10.427237Z","steps":["trace[216836827] 'read index received'  (duration: 8.852989ms)","trace[216836827] 'applied index is now lower than readState.Index'  (duration: 98.66145ms)"],"step_count":2}
{"level":"info","ts":"2026-10-27T21:48:10.427194Z","caller":"traceutil/trace.go:171","msg":"trace[355822240] transaction","detail":"{read_only:false; response_revision:29595; number_of_response:1; }","duration":"121.703093ms","start":"2026-10-27T21:48:10.305448Z","end":"2026-10-27T21:48:10.427152Z","steps":["trace[355822240] 'process raft request'  (duration: 121.501908ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-27T21:48:10.42734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.608262ms","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-10-27T21:48:10.427367Z","caller":"traceutil/trace.go:171","msg":"trace[2082259402] 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:29597; }","duration":"107.677314ms","start":"2026-10-27T21:48:10.319682Z","end":"2026-10-27T21:48:10.427359Z","steps":["trace[2082259402] 'agreement among raft nodes before linearized reading'  (duration: 107.577911ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:48:10.427379Z","caller":"traceutil/trace.go:171","msg":"trace[857594546] transaction","detail":"{read_only:false; response_revision:29597; number_of_response:1; }","duration":"121.801606ms","start":"2026-10-27T21:48:10.305523Z","end":"2026-10-27T21:48:10.427325Z","steps":["trace[857594546] 'process raft request'  (duration: 121.548519ms)"],"step_count":1}
{"level":"info","ts":"2026-10-27T21:48:57.809305Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27200}
{"level":"info","ts":"2026-10-27T21:48:57.974707Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27200,"took":"161.964703ms","hash":1959483689,"current-db-size-bytes":57569280,"current-db-size":"58 MB","current-db-size-in-use-bytes":36093952,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-10-27T21:48:57.974777Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1959483689,"revision":27200,"compact-revision":23809}
{"level":"info","ts":"2026-10-27T21:53:57.819689Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30056}
{"level":"info","ts":"2026-10-27T21:53:57.978332Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30056,"took":"151.644878ms","hash":698382262,"current-db-size-bytes":57569280,"current-db-size":"58 MB","current-db-size-in-use-bytes":31719424,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-27T21:53:57.978384Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":698382262,"revision":30056,"compact-revision":27200}
{"level":"info","ts":"2026-10-27T21:58:57.826627Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32336}
{"level":"info","ts":"2026-10-27T21:58:57.984161Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32336,"took":"150.903516ms","hash":3481290133,"current-db-size-bytes":58609664,"current-db-size":"59 MB","current-db-size-in-use-bytes":30072832,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-27T21:58:57.984329Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3481290133,"revision":32336,"compact-revision":30056}
{"level":"info","ts":"2026-10-27T22:03:57.834743Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34558}
{"level":"info","ts":"2026-10-27T22:03:57.968579Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34558,"took":"128.647803ms","hash":2593397800,"current-db-size-bytes":58609664,"current-db-size":"59 MB","current-db-size-in-use-bytes":30756864,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-27T22:03:57.968639Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2593397800,"revision":34558,"compact-revision":32336}
{"level":"info","ts":"2026-10-27T22:07:58.249571Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"86f12f2ae020828","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-27T22:07:58.256253Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-10-27T22:07:58.256376Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-10-27T22:08:57.8415Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":36850}
{"level":"info","ts":"2026-10-27T22:08:58.003983Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":36850,"took":"159.150546ms","hash":2733457626,"current-db-size-bytes":58609664,"current-db-size":"59 MB","current-db-size-in-use-bytes":31346688,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-27T22:08:58.004082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2733457626,"revision":36850,"compact-revision":34558}
{"level":"info","ts":"2026-10-27T22:13:57.847237Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39217}
{"level":"info","ts":"2026-10-27T22:13:57.985628Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39217,"took":"132.355691ms","hash":41773206,"current-db-size-bytes":58609664,"current-db-size":"59 MB","current-db-size-in-use-bytes":32681984,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-10-27T22:13:57.985676Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":41773206,"revision":39217,"compact-revision":36850}
{"level":"info","ts":"2026-10-27T22:18:57.854561Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":41449}
{"level":"info","ts":"2026-10-27T22:18:57.980855Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":41449,"took":"121.534039ms","hash":442216446,"current-db-size-bytes":58609664,"current-db-size":"59 MB","current-db-size-in-use-bytes":30908416,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-27T22:18:57.980907Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":442216446,"revision":41449,"compact-revision":39217}