{"level":"warn","ts":"2026-10-16T11:10:16.98576Z","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-16T11:10:16.985869Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.57: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.57:2380","--initial-cluster=instance=https://162.253.55.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.57: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-16T11:10:16.985966Z","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-16T11:10:16.985983Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.57:2380"]}
{"level":"info","ts":"2026-10-16T11:10:16.986003Z","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-16T11:10:16.986856Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"]}
{"level":"info","ts":"2026-10-16T11:10:16.986993Z","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.57:2380"],"listen-peer-urls":["https://162.253.55.57:2380"],"advertise-client-urls":["https://162.253.55.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.57: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-16T11:10:16.991096Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.869291ms"}
{"level":"info","ts":"2026-10-16T11:10:16.9961Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"db28a37eabf8270","cluster-id":"33328f64ab44b15e"}
{"level":"info","ts":"2026-10-16T11:10:16.996179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=()"}
{"level":"info","ts":"2026-10-16T11:10:16.996205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became follower at term 0"}
{"level":"info","ts":"2026-10-16T11:10:16.996219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft db28a37eabf8270 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-16T11:10:16.99623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became follower at term 1"}
{"level":"info","ts":"2026-10-16T11:10:16.996267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=(987003241113813616)"}
{"level":"warn","ts":"2026-10-16T11:10:17.009773Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-16T11:10:17.025649Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-16T11:10:17.037419Z","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-16T11:10:17.050584Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"db28a37eabf8270","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-16T11:10:17.05105Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"db28a37eabf8270","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-16T11:10:17.051318Z","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-16T11:10:17.051391Z","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-16T11:10:17.051407Z","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-16T11:10:17.055504Z","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-16T11:10:17.055919Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.57:2380"}
{"level":"info","ts":"2026-10-16T11:10:17.05597Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.57:2380"}
{"level":"info","ts":"2026-10-16T11:10:17.056283Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"db28a37eabf8270","initial-advertise-peer-urls":["https://162.253.55.57:2380"],"listen-peer-urls":["https://162.253.55.57:2380"],"advertise-client-urls":["https://162.253.55.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-16T11:10:17.05634Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-16T11:10:17.057614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=(987003241113813616)"}
{"level":"info","ts":"2026-10-16T11:10:17.057799Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"33328f64ab44b15e","local-member-id":"db28a37eabf8270","added-peer-id":"db28a37eabf8270","added-peer-peer-urls":["https://162.253.55.57:2380"]}
{"level":"info","ts":"2026-10-16T11:10:17.896961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 is starting a new election at term 1"}
{"level":"info","ts":"2026-10-16T11:10:17.89703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-16T11:10:17.897078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 received MsgPreVoteResp from db28a37eabf8270 at term 1"}
{"level":"info","ts":"2026-10-16T11:10:17.897104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became candidate at term 2"}
{"level":"info","ts":"2026-10-16T11:10:17.897117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 received MsgVoteResp from db28a37eabf8270 at term 2"}
{"level":"info","ts":"2026-10-16T11:10:17.897138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became leader at term 2"}
{"level":"info","ts":"2026-10-16T11:10:17.897154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: db28a37eabf8270 elected leader db28a37eabf8270 at term 2"}
{"level":"info","ts":"2026-10-16T11:10:17.898336Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-16T11:10:17.899649Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-16T11:10:17.89965Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"db28a37eabf8270","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.57:2379]}","request-path":"/0/members/db28a37eabf8270/attributes","cluster-id":"33328f64ab44b15e","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-16T11:10:17.899684Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-16T11:10:17.900089Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-16T11:10:17.900177Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-16T11:10:17.9005Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"33328f64ab44b15e","local-member-id":"db28a37eabf8270","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-16T11:10:17.900674Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-16T11:10:17.900741Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-16T11:10:17.903211Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.57:2379"}
{"level":"info","ts":"2026-10-16T11:10:17.903261Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-16T11:10:35.680016Z","caller":"traceutil/trace.go:171","msg":"trace[316097081] linearizableReadLoop","detail":"{readStateIndex:391; appliedIndex:390; }","duration":"102.450083ms","start":"2026-10-16T11:10:35.577539Z","end":"2026-10-16T11:10:35.679989Z","steps":["trace[316097081] 'read index received'  (duration: 102.213736ms)","trace[316097081] 'applied index is now lower than readState.Index'  (duration: 235.387µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T11:10:35.680213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.631918ms","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-16T11:10:35.680251Z","caller":"traceutil/trace.go:171","msg":"trace[1831253285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:377; }","duration":"102.734541ms","start":"2026-10-16T11:10:35.577507Z","end":"2026-10-16T11:10:35.680241Z","steps":["trace[1831253285] 'agreement among raft nodes before linearized reading'  (duration: 102.605888ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:10:35.680592Z","caller":"traceutil/trace.go:171","msg":"trace[2056999145] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"145.684197ms","start":"2026-10-16T11:10:35.534895Z","end":"2026-10-16T11:10:35.680579Z","steps":["trace[2056999145] 'process raft request'  (duration: 144.935836ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:10:36.029895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.671044ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9399189737493866346 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:372 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-16T11:10:36.030433Z","caller":"traceutil/trace.go:171","msg":"trace[1067678658] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"345.354875ms","start":"2026-10-16T11:10:35.685058Z","end":"2026-10-16T11:10:36.030412Z","steps":["trace[1067678658] 'process raft request'  (duration: 237.390454ms)","trace[1067678658] 'compare'  (duration: 106.504589ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T11:10:36.030518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:10:35.685037Z","time spent":"345.441107ms","remote":"127.0.0.1:44360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:372 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-10-16T11:11:09.423493Z","caller":"traceutil/trace.go:171","msg":"trace[55909335] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"289.282082ms","start":"2026-10-16T11:11:09.134175Z","end":"2026-10-16T11:11:09.423457Z","steps":["trace[55909335] 'process raft request'  (duration: 289.018055ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:11:09.462179Z","caller":"traceutil/trace.go:171","msg":"trace[1147742981] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"276.257143ms","start":"2026-10-16T11:11:09.185878Z","end":"2026-10-16T11:11:09.462135Z","steps":["trace[1147742981] 'process raft request'  (duration: 275.583034ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:11:09.82689Z","caller":"traceutil/trace.go:171","msg":"trace[846613267] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"271.843031ms","start":"2026-10-16T11:11:09.555011Z","end":"2026-10-16T11:11:09.826854Z","steps":["trace[846613267] 'process raft request'  (duration: 257.985729ms)","trace[846613267] 'compare'  (duration: 13.716938ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:11:24.958943Z","caller":"traceutil/trace.go:171","msg":"trace[958063650] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"173.57893ms","start":"2026-10-16T11:11:24.785316Z","end":"2026-10-16T11:11:24.958894Z","steps":["trace[958063650] 'process raft request'  (duration: 173.440716ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:11:53.413361Z","caller":"traceutil/trace.go:171","msg":"trace[813637076] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"117.80708ms","start":"2026-10-16T11:11:53.295527Z","end":"2026-10-16T11:11:53.413335Z","steps":["trace[813637076] 'process raft request'  (duration: 117.668287ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:12:17.692107Z","caller":"traceutil/trace.go:171","msg":"trace[905085362] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"118.619758ms","start":"2026-10-16T11:12:17.573455Z","end":"2026-10-16T11:12:17.692075Z","steps":["trace[905085362] 'process raft request'  (duration: 118.403542ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:12:44.849906Z","caller":"traceutil/trace.go:171","msg":"trace[1492334504] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1943; }","duration":"175.700039ms","start":"2026-10-16T11:12:44.674182Z","end":"2026-10-16T11:12:44.849882Z","steps":["trace[1492334504] 'read index received'  (duration: 150.943364ms)","trace[1492334504] 'applied index is now lower than readState.Index'  (duration: 24.755574ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:12:44.85009Z","caller":"traceutil/trace.go:171","msg":"trace[2049140719] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"200.71885ms","start":"2026-10-16T11:12:44.649358Z","end":"2026-10-16T11:12:44.850077Z","steps":["trace[2049140719] 'process raft request'  (duration: 175.811691ms)","trace[2049140719] 'compare'  (duration: 24.606551ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T11:12:44.850329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.12336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-16T11:12:44.850411Z","caller":"traceutil/trace.go:171","msg":"trace[1823473086] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1868; }","duration":"176.250994ms","start":"2026-10-16T11:12:44.674138Z","end":"2026-10-16T11:12:44.850389Z","steps":["trace[1823473086] 'agreement among raft nodes before linearized reading'  (duration: 176.11123ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:12:44.857569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.433789ms","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-16T11:12:44.857698Z","caller":"traceutil/trace.go:171","msg":"trace[1084006723] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1869; }","duration":"135.659235ms","start":"2026-10-16T11:12:44.722015Z","end":"2026-10-16T11:12:44.857674Z","steps":["trace[1084006723] 'agreement among raft nodes before linearized reading'  (duration: 135.401438ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:12:57.203244Z","caller":"traceutil/trace.go:171","msg":"trace[168749607] transaction","detail":"{read_only:false; response_revision:1970; number_of_response:1; }","duration":"117.908787ms","start":"2026-10-16T11:12:57.085305Z","end":"2026-10-16T11:12:57.203214Z","steps":["trace[168749607] 'process raft request'  (duration: 117.66458ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:12:57.61925Z","caller":"traceutil/trace.go:171","msg":"trace[1139453382] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"159.984107ms","start":"2026-10-16T11:12:57.459232Z","end":"2026-10-16T11:12:57.619216Z","steps":["trace[1139453382] 'process raft request'  (duration: 159.786211ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:13:29.757611Z","caller":"traceutil/trace.go:171","msg":"trace[2072798519] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"117.500352ms","start":"2026-10-16T11:13:29.640086Z","end":"2026-10-16T11:13:29.757587Z","steps":["trace[2072798519] 'process raft request'  (duration: 116.683669ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:13:36.074512Z","caller":"traceutil/trace.go:171","msg":"trace[42984174] linearizableReadLoop","detail":"{readStateIndex:2283; appliedIndex:2282; }","duration":"255.626359ms","start":"2026-10-16T11:13:35.818856Z","end":"2026-10-16T11:13:36.074482Z","steps":["trace[42984174] 'read index received'  (duration: 217.927116ms)","trace[42984174] 'applied index is now lower than readState.Index'  (duration: 37.698213ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:13:36.074683Z","caller":"traceutil/trace.go:171","msg":"trace[900221642] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"274.868946ms","start":"2026-10-16T11:13:35.799765Z","end":"2026-10-16T11:13:36.074634Z","steps":["trace[900221642] 'process raft request'  (duration: 236.945847ms)","trace[900221642] 'compare'  (duration: 37.645971ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T11:13:36.074799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.928698ms","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-16T11:13:36.074847Z","caller":"traceutil/trace.go:171","msg":"trace[2050070069] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2195; }","duration":"256.03651ms","start":"2026-10-16T11:13:35.818794Z","end":"2026-10-16T11:13:36.07483Z","steps":["trace[2050070069] 'agreement among raft nodes before linearized reading'  (duration: 255.833445ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:13:36.075254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.571169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"}
{"level":"info","ts":"2026-10-16T11:13:36.075328Z","caller":"traceutil/trace.go:171","msg":"trace[1024061935] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2195; }","duration":"177.707813ms","start":"2026-10-16T11:13:35.897602Z","end":"2026-10-16T11:13:36.07531Z","steps":["trace[1024061935] 'agreement among raft nodes before linearized reading'  (duration: 177.452406ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:15:12.884777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.113301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-16T11:15:12.884888Z","caller":"traceutil/trace.go:171","msg":"trace[1942459491] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2906; }","duration":"128.288876ms","start":"2026-10-16T11:15:12.756572Z","end":"2026-10-16T11:15:12.88486Z","steps":["trace[1942459491] 'count revisions from in-memory index tree'  (duration: 127.992797ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:15:13.135541Z","caller":"traceutil/trace.go:171","msg":"trace[1287068994] transaction","detail":"{read_only:false; response_revision:2908; number_of_response:1; }","duration":"126.886137ms","start":"2026-10-16T11:15:13.008623Z","end":"2026-10-16T11:15:13.13551Z","steps":["trace[1287068994] 'process raft request'  (duration: 126.757534ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:15:18.579674Z","caller":"traceutil/trace.go:171","msg":"trace[2108846418] transaction","detail":"{read_only:false; response_revision:2939; number_of_response:1; }","duration":"106.187602ms","start":"2026-10-16T11:15:18.473463Z","end":"2026-10-16T11:15:18.57965Z","steps":["trace[2108846418] 'process raft request'  (duration: 106.045538ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:19:47.717962Z","caller":"traceutil/trace.go:171","msg":"trace[1986937637] transaction","detail":"{read_only:false; response_revision:5092; number_of_response:1; }","duration":"133.988431ms","start":"2026-10-16T11:19:47.583938Z","end":"2026-10-16T11:19:47.717926Z","steps":["trace[1986937637] 'process raft request'  (duration: 125.728392ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:19:54.152044Z","caller":"traceutil/trace.go:171","msg":"trace[742277832] linearizableReadLoop","detail":"{readStateIndex:5509; appliedIndex:5508; }","duration":"118.945685ms","start":"2026-10-16T11:19:54.033078Z","end":"2026-10-16T11:19:54.152024Z","steps":["trace[742277832] 'read index received'  (duration: 98.620752ms)","trace[742277832] 'applied index is now lower than readState.Index'  (duration: 20.324123ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:19:54.15214Z","caller":"traceutil/trace.go:171","msg":"trace[551532626] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"177.531397ms","start":"2026-10-16T11:19:53.974545Z","end":"2026-10-16T11:19:54.152076Z","steps":["trace[551532626] 'process raft request'  (duration: 157.191544ms)","trace[551532626] 'compare'  (duration: 20.180899ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T11:19:54.152224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.13078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-16T11:19:54.152249Z","caller":"traceutil/trace.go:171","msg":"trace[1277384385] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5304; }","duration":"119.222132ms","start":"2026-10-16T11:19:54.03302Z","end":"2026-10-16T11:19:54.152242Z","steps":["trace[1277384385] 'agreement among raft nodes before linearized reading'  (duration: 119.112229ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:19:54.432565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.902567ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9399189737493877507 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/monitoring/vector-headless-5skt4\" mod_revision:0 > success:<request_put:<key:\"/registry/endpointslices/monitoring/vector-headless-5skt4\" value_size:1336 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-10-16T11:19:54.433005Z","caller":"traceutil/trace.go:171","msg":"trace[650680469] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"195.489975ms","start":"2026-10-16T11:19:54.237497Z","end":"2026-10-16T11:19:54.432986Z","steps":["trace[650680469] 'process raft request'  (duration: 195.156145ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:19:54.433001Z","caller":"traceutil/trace.go:171","msg":"trace[196517300] transaction","detail":"{read_only:false; response_revision:5313; number_of_response:1; }","duration":"196.933174ms","start":"2026-10-16T11:19:54.236036Z","end":"2026-10-16T11:19:54.432969Z","steps":["trace[196517300] 'process raft request'  (duration: 35.553894ms)","trace[196517300] 'compare'  (duration: 160.797134ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:19:54.548342Z","caller":"traceutil/trace.go:171","msg":"trace[1989938054] transaction","detail":"{read_only:false; response_revision:5315; number_of_response:1; }","duration":"109.324698ms","start":"2026-10-16T11:19:54.438987Z","end":"2026-10-16T11:19:54.548312Z","steps":["trace[1989938054] 'process raft request'  (duration: 103.142087ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:19:54.560789Z","caller":"traceutil/trace.go:171","msg":"trace[445025666] transaction","detail":"{read_only:false; response_revision:5316; number_of_response:1; }","duration":"120.706624ms","start":"2026-10-16T11:19:54.440054Z","end":"2026-10-16T11:19:54.560761Z","steps":["trace[445025666] 'process raft request'  (duration: 120.506878ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:19:54.560905Z","caller":"traceutil/trace.go:171","msg":"trace[999140845] transaction","detail":"{read_only:false; response_revision:5318; number_of_response:1; }","duration":"103.413444ms","start":"2026-10-16T11:19:54.457469Z","end":"2026-10-16T11:19:54.560882Z","steps":["trace[999140845] 'process raft request'  (duration: 103.317411ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:19:54.561111Z","caller":"traceutil/trace.go:171","msg":"trace[807615357] transaction","detail":"{read_only:false; response_revision:5317; number_of_response:1; }","duration":"105.142182ms","start":"2026-10-16T11:19:54.455934Z","end":"2026-10-16T11:19:54.561076Z","steps":["trace[807615357] 'process raft request'  (duration: 104.733801ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:20:16.309628Z","caller":"traceutil/trace.go:171","msg":"trace[885923015] transaction","detail":"{read_only:false; response_revision:5765; number_of_response:1; }","duration":"124.774787ms","start":"2026-10-16T11:20:16.18482Z","end":"2026-10-16T11:20:16.309595Z","steps":["trace[885923015] 'process raft request'  (duration: 124.586251ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:20:16.324841Z","caller":"traceutil/trace.go:171","msg":"trace[1618011400] transaction","detail":"{read_only:false; response_revision:5766; number_of_response:1; }","duration":"138.736293ms","start":"2026-10-16T11:20:16.186076Z","end":"2026-10-16T11:20:16.324812Z","steps":["trace[1618011400] 'process raft request'  (duration: 138.449475ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:20:16.553422Z","caller":"traceutil/trace.go:171","msg":"trace[1635815882] transaction","detail":"{read_only:false; response_revision:5767; number_of_response:1; }","duration":"224.650532ms","start":"2026-10-16T11:20:16.328747Z","end":"2026-10-16T11:20:16.553397Z","steps":["trace[1635815882] 'process raft request'  (duration: 224.475467ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:20:16.740431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.127213ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9399189737493878507 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5668 > 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:16"}
{"level":"info","ts":"2026-10-16T11:20:16.740678Z","caller":"traceutil/trace.go:171","msg":"trace[478743614] transaction","detail":"{read_only:false; response_revision:5768; number_of_response:1; }","duration":"411.644942ms","start":"2026-10-16T11:20:16.328993Z","end":"2026-10-16T11:20:16.740638Z","steps":["trace[478743614] 'process raft request'  (duration: 259.242431ms)","trace[478743614] 'compare'  (duration: 152.034491ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T11:20:16.74084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:20:16.32897Z","time spent":"411.784886ms","remote":"127.0.0.1:44360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5668 > 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-16T11:20:17.92629Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2937}
{"level":"info","ts":"2026-10-16T11:20:18.004151Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2937,"took":"76.479438ms","hash":2874852278,"current-db-size-bytes":57094144,"current-db-size":"57 MB","current-db-size-in-use-bytes":32329728,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-16T11:20:18.00424Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2874852278,"revision":2937,"compact-revision":-1}
{"level":"info","ts":"2026-10-16T11:25:17.934278Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5794}
{"level":"info","ts":"2026-10-16T11:25:18.026649Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5794,"took":"90.835038ms","hash":346917056,"current-db-size-bytes":57094144,"current-db-size":"57 MB","current-db-size-in-use-bytes":26685440,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-10-16T11:25:18.02673Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":346917056,"revision":5794,"compact-revision":2937}
{"level":"info","ts":"2026-10-16T11:26:50.603597Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002341.wal"}
{"level":"warn","ts":"2026-10-16T11:26:52.460608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.609973ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9399189737493886173 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8712 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-16T11:26:52.460724Z","caller":"traceutil/trace.go:171","msg":"trace[814941399] linearizableReadLoop","detail":"{readStateIndex:9035; appliedIndex:9034; }","duration":"132.355303ms","start":"2026-10-16T11:26:52.328347Z","end":"2026-10-16T11:26:52.460702Z","steps":["trace[814941399] 'read index received'  (duration: 29.498754ms)","trace[814941399] 'applied index is now lower than readState.Index'  (duration: 102.855089ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T11:26:52.46093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.60306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sh4ms\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-10-16T11:26:52.460905Z","caller":"traceutil/trace.go:171","msg":"trace[1717661018] transaction","detail":"{read_only:false; response_revision:8723; number_of_response:1; }","duration":"194.347585ms","start":"2026-10-16T11:26:52.266519Z","end":"2026-10-16T11:26:52.460866Z","steps":["trace[1717661018] 'process raft request'  (duration: 91.380252ms)","trace[1717661018] 'compare'  (duration: 102.50748ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:26:52.460986Z","caller":"traceutil/trace.go:171","msg":"trace[883767678] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sh4ms; range_end:; response_count:1; response_revision:8723; }","duration":"132.692693ms","start":"2026-10-16T11:26:52.328279Z","end":"2026-10-16T11:26:52.460971Z","steps":["trace[883767678] 'agreement among raft nodes before linearized reading'  (duration: 132.540388ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:26:52.97662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.607892ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9399189737493886186 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8717 > 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-16T11:26:52.976864Z","caller":"traceutil/trace.go:171","msg":"trace[532213200] transaction","detail":"{read_only:false; response_revision:8728; number_of_response:1; }","duration":"140.697434ms","start":"2026-10-16T11:26:52.836077Z","end":"2026-10-16T11:26:52.976774Z","steps":["trace[532213200] 'process raft request'  (duration: 16.826174ms)","trace[532213200] 'compare'  (duration: 123.487619ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:27:21.395008Z","caller":"traceutil/trace.go:171","msg":"trace[612291784] linearizableReadLoop","detail":"{readStateIndex:9255; appliedIndex:9254; }","duration":"117.840307ms","start":"2026-10-16T11:27:21.277142Z","end":"2026-10-16T11:27:21.394982Z","steps":["trace[612291784] 'read index received'  (duration: 117.631761ms)","trace[612291784] 'applied index is now lower than readState.Index'  (duration: 207.706µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T11:27:21.395207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.056613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.57\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-10-16T11:27:21.395245Z","caller":"traceutil/trace.go:171","msg":"trace[1973941502] range","detail":"{range_begin:/registry/masterleases/162.253.55.57; range_end:; response_count:1; response_revision:8935; }","duration":"118.150706ms","start":"2026-10-16T11:27:21.277085Z","end":"2026-10-16T11:27:21.395236Z","steps":["trace[1973941502] 'agreement among raft nodes before linearized reading'  (duration: 117.998082ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:27:21.395555Z","caller":"traceutil/trace.go:171","msg":"trace[1465730222] transaction","detail":"{read_only:false; response_revision:8935; number_of_response:1; }","duration":"254.242367ms","start":"2026-10-16T11:27:21.141302Z","end":"2026-10-16T11:27:21.395544Z","steps":["trace[1465730222] 'process raft request'  (duration: 253.534608ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:27:21.589762Z","caller":"traceutil/trace.go:171","msg":"trace[1372680911] transaction","detail":"{read_only:false; response_revision:8936; number_of_response:1; }","duration":"183.031649ms","start":"2026-10-16T11:27:21.406702Z","end":"2026-10-16T11:27:21.589734Z","steps":["trace[1372680911] 'process raft request'  (duration: 182.796563ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:27:21.589817Z","caller":"traceutil/trace.go:171","msg":"trace[1876447628] transaction","detail":"{read_only:false; response_revision:8937; number_of_response:1; }","duration":"152.592718ms","start":"2026-10-16T11:27:21.437191Z","end":"2026-10-16T11:27:21.589784Z","steps":["trace[1876447628] 'process raft request'  (duration: 152.401073ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:27:24.627998Z","caller":"traceutil/trace.go:171","msg":"trace[1092513630] transaction","detail":"{read_only:false; response_revision:8950; number_of_response:1; }","duration":"169.373762ms","start":"2026-10-16T11:27:24.458593Z","end":"2026-10-16T11:27:24.627967Z","steps":["trace[1092513630] 'process raft request'  (duration: 169.151986ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:27:24.864987Z","caller":"traceutil/trace.go:171","msg":"trace[1574686844] linearizableReadLoop","detail":"{readStateIndex:9272; appliedIndex:9271; }","duration":"217.42887ms","start":"2026-10-16T11:27:24.647534Z","end":"2026-10-16T11:27:24.864962Z","steps":["trace[1574686844] 'read index received'  (duration: 217.265146ms)","trace[1574686844] 'applied index is now lower than readState.Index'  (duration: 162.694µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T11:27:24.865156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.612046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sh4ms\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-10-16T11:27:24.865131Z","caller":"traceutil/trace.go:171","msg":"trace[1781285724] transaction","detail":"{read_only:false; response_revision:8951; number_of_response:1; }","duration":"285.459311ms","start":"2026-10-16T11:27:24.579642Z","end":"2026-10-16T11:27:24.865101Z","steps":["trace[1781285724] 'process raft request'  (duration: 285.180593ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:27:24.865191Z","caller":"traceutil/trace.go:171","msg":"trace[488317059] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sh4ms; range_end:; response_count:1; response_revision:8951; }","duration":"217.703698ms","start":"2026-10-16T11:27:24.647477Z","end":"2026-10-16T11:27:24.86518Z","steps":["trace[488317059] 'agreement among raft nodes before linearized reading'  (duration: 217.622166ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:27:33.020595Z","caller":"traceutil/trace.go:171","msg":"trace[1600557492] linearizableReadLoop","detail":"{readStateIndex:9319; appliedIndex:9318; }","duration":"102.757871ms","start":"2026-10-16T11:27:32.917811Z","end":"2026-10-16T11:27:33.020569Z","steps":["trace[1600557492] 'read index received'  (duration: 102.570316ms)","trace[1600557492] 'applied index is now lower than readState.Index'  (duration: 186.315µs)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:27:33.020637Z","caller":"traceutil/trace.go:171","msg":"trace[2089694147] transaction","detail":"{read_only:false; response_revision:8996; number_of_response:1; }","duration":"124.863391ms","start":"2026-10-16T11:27:32.895744Z","end":"2026-10-16T11:27:33.020607Z","steps":["trace[2089694147] 'process raft request'  (duration: 124.662385ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:27:33.02081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.984897ms","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-16T11:27:33.02085Z","caller":"traceutil/trace.go:171","msg":"trace[917021041] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8996; }","duration":"103.043238ms","start":"2026-10-16T11:27:32.917797Z","end":"2026-10-16T11:27:33.02084Z","steps":["trace[917021041] 'agreement among raft nodes before linearized reading'  (duration: 102.889844ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:27:33.049805Z","caller":"traceutil/trace.go:171","msg":"trace[250520514] transaction","detail":"{read_only:false; response_revision:8997; number_of_response:1; }","duration":"113.298842ms","start":"2026-10-16T11:27:32.936461Z","end":"2026-10-16T11:27:33.04976Z","steps":["trace[250520514] 'process raft request'  (duration: 92.837406ms)","trace[250520514] 'compare'  (duration: 20.335522ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T11:27:33.050023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.647403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sh4ms\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-10-16T11:27:33.050083Z","caller":"traceutil/trace.go:171","msg":"trace[29007449] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sh4ms; range_end:; response_count:1; response_revision:8998; }","duration":"129.762246ms","start":"2026-10-16T11:27:32.92031Z","end":"2026-10-16T11:27:33.050072Z","steps":["trace[29007449] 'agreement among raft nodes before linearized reading'  (duration: 129.647723ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:27:33.767111Z","caller":"traceutil/trace.go:171","msg":"trace[1255824064] linearizableReadLoop","detail":"{readStateIndex:9325; appliedIndex:9324; }","duration":"118.878406ms","start":"2026-10-16T11:27:33.648205Z","end":"2026-10-16T11:27:33.767084Z","steps":["trace[1255824064] 'read index received'  (duration: 86.597334ms)","trace[1255824064] 'applied index is now lower than readState.Index'  (duration: 32.279822ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:27:33.767253Z","caller":"traceutil/trace.go:171","msg":"trace[1762610103] transaction","detail":"{read_only:false; response_revision:9002; number_of_response:1; }","duration":"136.332519ms","start":"2026-10-16T11:27:33.630885Z","end":"2026-10-16T11:27:33.767218Z","steps":["trace[1762610103] 'process raft request'  (duration: 103.962594ms)","trace[1762610103] 'compare'  (duration: 31.919432ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T11:27:33.767291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.078471ms","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-16T11:27:33.767326Z","caller":"traceutil/trace.go:171","msg":"trace[1158802394] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9002; }","duration":"119.161814ms","start":"2026-10-16T11:27:33.648155Z","end":"2026-10-16T11:27:33.767316Z","steps":["trace[1158802394] 'agreement among raft nodes before linearized reading'  (duration: 119.02098ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:28:36.476205Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"db28a37eabf8270","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-16T11:28:36.486135Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-10-16T11:28:36.486236Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-10-16T11:30:17.941317Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7997}
{"level":"info","ts":"2026-10-16T11:30:18.017645Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7997,"took":"74.231664ms","hash":4090873226,"current-db-size-bytes":57094144,"current-db-size":"57 MB","current-db-size-in-use-bytes":28180480,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-16T11:30:18.017794Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4090873226,"revision":7997,"compact-revision":5794}
{"level":"info","ts":"2026-10-16T11:34:41.313033Z","caller":"traceutil/trace.go:171","msg":"trace[1939050961] transaction","detail":"{read_only:false; response_revision:12283; number_of_response:1; }","duration":"100.795791ms","start":"2026-10-16T11:34:41.212212Z","end":"2026-10-16T11:34:41.313008Z","steps":["trace[1939050961] 'process raft request'  (duration: 100.609056ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:34:42.175807Z","caller":"traceutil/trace.go:171","msg":"trace[590079237] linearizableReadLoop","detail":"{readStateIndex:12715; appliedIndex:12714; }","duration":"131.58157ms","start":"2026-10-16T11:34:42.044203Z","end":"2026-10-16T11:34:42.175785Z","steps":["trace[590079237] 'read index received'  (duration: 131.354654ms)","trace[590079237] 'applied index is now lower than readState.Index'  (duration: 225.986µs)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:34:42.175916Z","caller":"traceutil/trace.go:171","msg":"trace[42766253] transaction","detail":"{read_only:false; response_revision:12289; number_of_response:1; }","duration":"156.018104ms","start":"2026-10-16T11:34:42.019866Z","end":"2026-10-16T11:34:42.175884Z","steps":["trace[42766253] 'process raft request'  (duration: 155.745926ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:34:42.176041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.817126ms","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-16T11:34:42.176092Z","caller":"traceutil/trace.go:171","msg":"trace[1487322760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12289; }","duration":"131.915339ms","start":"2026-10-16T11:34:42.044163Z","end":"2026-10-16T11:34:42.176079Z","steps":["trace[1487322760] 'agreement among raft nodes before linearized reading'  (duration: 131.734604ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:34:42.176155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.762309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sh4ms\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-10-16T11:34:42.176318Z","caller":"traceutil/trace.go:171","msg":"trace[1784121872] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sh4ms; range_end:; response_count:1; response_revision:12289; }","duration":"121.886073ms","start":"2026-10-16T11:34:42.054359Z","end":"2026-10-16T11:34:42.176245Z","steps":["trace[1784121872] 'agreement among raft nodes before linearized reading'  (duration: 121.698248ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:35:17.95174Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10364}
{"level":"info","ts":"2026-10-16T11:35:18.037562Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10364,"took":"83.33334ms","hash":1395332635,"current-db-size-bytes":57094144,"current-db-size":"57 MB","current-db-size-in-use-bytes":25931776,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-10-16T11:35:18.037658Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1395332635,"revision":10364,"compact-revision":7997}
{"level":"info","ts":"2026-10-16T11:40:17.959883Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12548}
{"level":"info","ts":"2026-10-16T11:40:18.038907Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12548,"took":"76.584721ms","hash":1204071736,"current-db-size-bytes":57094144,"current-db-size":"57 MB","current-db-size-in-use-bytes":27611136,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-16T11:40:18.038989Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1204071736,"revision":12548,"compact-revision":10364}
{"level":"info","ts":"2026-10-16T11:40:54.205019Z","caller":"traceutil/trace.go:171","msg":"trace[1596415950] transaction","detail":"{read_only:false; response_revision:14800; number_of_response:1; }","duration":"115.765132ms","start":"2026-10-16T11:40:54.089215Z","end":"2026-10-16T11:40:54.20498Z","steps":["trace[1596415950] 'process raft request'  (duration: 115.615728ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:40:54.212819Z","caller":"traceutil/trace.go:171","msg":"trace[115331563] transaction","detail":"{read_only:false; response_revision:14801; number_of_response:1; }","duration":"115.511085ms","start":"2026-10-16T11:40:54.097253Z","end":"2026-10-16T11:40:54.212764Z","steps":["trace[115331563] 'process raft request'  (duration: 115.377491ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:41:14.408642Z","caller":"traceutil/trace.go:171","msg":"trace[1837656863] transaction","detail":"{read_only:false; response_revision:14901; number_of_response:1; }","duration":"159.402135ms","start":"2026-10-16T11:41:14.249209Z","end":"2026-10-16T11:41:14.408611Z","steps":["trace[1837656863] 'process raft request'  (duration: 159.205109ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:41:14.485096Z","caller":"traceutil/trace.go:171","msg":"trace[478133415] linearizableReadLoop","detail":"{readStateIndex:15420; appliedIndex:15417; }","duration":"182.567364ms","start":"2026-10-16T11:41:14.302499Z","end":"2026-10-16T11:41:14.485066Z","steps":["trace[478133415] 'read index received'  (duration: 105.871639ms)","trace[478133415] 'applied index is now lower than readState.Index'  (duration: 76.693865ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T11:41:14.485356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.839021ms","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-16T11:41:14.485396Z","caller":"traceutil/trace.go:171","msg":"trace[1465839099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14903; }","duration":"182.924913ms","start":"2026-10-16T11:41:14.302458Z","end":"2026-10-16T11:41:14.485383Z","steps":["trace[1465839099] 'agreement among raft nodes before linearized reading'  (duration: 182.754809ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:41:14.48524Z","caller":"traceutil/trace.go:171","msg":"trace[1376330703] transaction","detail":"{read_only:false; response_revision:14902; number_of_response:1; }","duration":"216.848029ms","start":"2026-10-16T11:41:14.26834Z","end":"2026-10-16T11:41:14.485188Z","steps":["trace[1376330703] 'process raft request'  (duration: 216.493039ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:41:14.485588Z","caller":"traceutil/trace.go:171","msg":"trace[306715257] transaction","detail":"{read_only:false; response_revision:14903; number_of_response:1; }","duration":"210.029051ms","start":"2026-10-16T11:41:14.275516Z","end":"2026-10-16T11:41:14.485545Z","steps":["trace[306715257] 'process raft request'  (duration: 209.489646ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:41:32.033566Z","caller":"traceutil/trace.go:171","msg":"trace[1498296025] transaction","detail":"{read_only:false; response_revision:15012; number_of_response:1; }","duration":"133.329756ms","start":"2026-10-16T11:41:31.9002Z","end":"2026-10-16T11:41:32.03353Z","steps":["trace[1498296025] 'process raft request'  (duration: 122.692073ms)","trace[1498296025] 'compare'  (duration: 10.320024ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:42:49.046101Z","caller":"traceutil/trace.go:171","msg":"trace[95619926] transaction","detail":"{read_only:false; response_revision:16094; number_of_response:1; }","duration":"164.135993ms","start":"2026-10-16T11:42:48.881939Z","end":"2026-10-16T11:42:49.046075Z","steps":["trace[95619926] 'process raft request'  (duration: 163.989079ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:42:49.048234Z","caller":"traceutil/trace.go:171","msg":"trace[1642890813] transaction","detail":"{read_only:false; response_revision:16095; number_of_response:1; }","duration":"158.430355ms","start":"2026-10-16T11:42:48.889772Z","end":"2026-10-16T11:42:49.048202Z","steps":["trace[1642890813] 'process raft request'  (duration: 158.276971ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:43:22.886641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.75952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:681"}
{"level":"info","ts":"2026-10-16T11:43:22.886746Z","caller":"traceutil/trace.go:171","msg":"trace[2047101074] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:16273; }","duration":"151.904664ms","start":"2026-10-16T11:43:22.734817Z","end":"2026-10-16T11:43:22.886722Z","steps":["trace[2047101074] 'range keys from in-memory index tree'  (duration: 151.527044ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:43:22.88674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.74297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-16T11:43:22.886675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.742879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"warn","ts":"2026-10-16T11:43:22.886975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.834161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-16T11:43:22.88705Z","caller":"traceutil/trace.go:171","msg":"trace[1973279046] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:16273; }","duration":"151.920004ms","start":"2026-10-16T11:43:22.735113Z","end":"2026-10-16T11:43:22.887033Z","steps":["trace[1973279046] 'range keys from in-memory index tree'  (duration: 151.796381ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:43:22.887044Z","caller":"traceutil/trace.go:171","msg":"trace[840275115] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16273; }","duration":"152.11366ms","start":"2026-10-16T11:43:22.734905Z","end":"2026-10-16T11:43:22.887019Z","steps":["trace[840275115] 'range keys from in-memory index tree'  (duration: 151.648596ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:43:22.88738Z","caller":"traceutil/trace.go:171","msg":"trace[2146798954] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16273; }","duration":"151.883113ms","start":"2026-10-16T11:43:22.734917Z","end":"2026-10-16T11:43:22.8868Z","steps":["trace[2146798954] 'range keys from in-memory index tree'  (duration: 151.667117ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:43:22.886414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.460471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-10-16T11:43:22.888098Z","caller":"traceutil/trace.go:171","msg":"trace[1037313946] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16273; }","duration":"149.191209ms","start":"2026-10-16T11:43:22.738886Z","end":"2026-10-16T11:43:22.888077Z","steps":["trace[1037313946] 'range keys from in-memory index tree'  (duration: 147.281646ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:43:23.303251Z","caller":"traceutil/trace.go:171","msg":"trace[282153362] transaction","detail":"{read_only:false; response_revision:16274; number_of_response:1; }","duration":"108.019413ms","start":"2026-10-16T11:43:23.195201Z","end":"2026-10-16T11:43:23.30322Z","steps":["trace[282153362] 'process raft request'  (duration: 107.871269ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:43:23.373849Z","caller":"traceutil/trace.go:171","msg":"trace[1111038431] linearizableReadLoop","detail":"{readStateIndex:16835; appliedIndex:16833; }","duration":"129.524767ms","start":"2026-10-16T11:43:23.244296Z","end":"2026-10-16T11:43:23.373821Z","steps":["trace[1111038431] 'read index received'  (duration: 58.763783ms)","trace[1111038431] 'applied index is now lower than readState.Index'  (duration: 70.759664ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:43:23.373913Z","caller":"traceutil/trace.go:171","msg":"trace[2123468394] transaction","detail":"{read_only:false; response_revision:16275; number_of_response:1; }","duration":"175.603319ms","start":"2026-10-16T11:43:23.198286Z","end":"2026-10-16T11:43:23.373889Z","steps":["trace[2123468394] 'process raft request'  (duration: 175.339372ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:43:23.374303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.844155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-10-16T11:43:23.374984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.354938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12431"}
{"level":"info","ts":"2026-10-16T11:43:23.375256Z","caller":"traceutil/trace.go:171","msg":"trace[1998048466] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:16275; }","duration":"114.662817ms","start":"2026-10-16T11:43:23.260567Z","end":"2026-10-16T11:43:23.37523Z","steps":["trace[1998048466] 'agreement among raft nodes before linearized reading'  (duration: 113.422923ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:43:23.374402Z","caller":"traceutil/trace.go:171","msg":"trace[52005466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16275; }","duration":"130.126273ms","start":"2026-10-16T11:43:23.244251Z","end":"2026-10-16T11:43:23.374377Z","steps":["trace[52005466] 'agreement among raft nodes before linearized reading'  (duration: 129.672771ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:43:23.559929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.474757ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9399189737493907553 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:16265 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-16T11:43:23.560055Z","caller":"traceutil/trace.go:171","msg":"trace[1562050372] transaction","detail":"{read_only:false; response_revision:16277; number_of_response:1; }","duration":"149.972971ms","start":"2026-10-16T11:43:23.410068Z","end":"2026-10-16T11:43:23.560041Z","steps":["trace[1562050372] 'process raft request'  (duration: 149.93409ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:43:23.56024Z","caller":"traceutil/trace.go:171","msg":"trace[861459461] transaction","detail":"{read_only:false; response_revision:16276; number_of_response:1; }","duration":"180.060393ms","start":"2026-10-16T11:43:23.380147Z","end":"2026-10-16T11:43:23.560208Z","steps":["trace[861459461] 'process raft request'  (duration: 13.238986ms)","trace[861459461] 'compare'  (duration: 166.393825ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:43:23.5603Z","caller":"traceutil/trace.go:171","msg":"trace[790644392] linearizableReadLoop","detail":"{readStateIndex:16836; appliedIndex:16835; }","duration":"180.062302ms","start":"2026-10-16T11:43:23.380208Z","end":"2026-10-16T11:43:23.56027Z","steps":["trace[790644392] 'read index received'  (duration: 13.097032ms)","trace[790644392] 'applied index is now lower than readState.Index'  (duration: 166.96376ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T11:43:23.569871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.235819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-10-16T11:43:23.569959Z","caller":"traceutil/trace.go:171","msg":"trace[1755740339] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16277; }","duration":"112.326932ms","start":"2026-10-16T11:43:23.457605Z","end":"2026-10-16T11:43:23.569932Z","steps":["trace[1755740339] 'agreement among raft nodes before linearized reading'  (duration: 103.036266ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:43:23.570147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.668181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-16T11:43:23.570243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.356752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"warn","ts":"2026-10-16T11:43:23.561768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.534853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19057"}
{"level":"warn","ts":"2026-10-16T11:43:23.570268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.297966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-16T11:43:23.570321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.37865ms","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-16T11:43:23.570343Z","caller":"traceutil/trace.go:171","msg":"trace[1943888507] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16277; }","duration":"125.462185ms","start":"2026-10-16T11:43:23.44484Z","end":"2026-10-16T11:43:23.570302Z","steps":["trace[1943888507] 'agreement among raft nodes before linearized reading'  (duration: 125.229888ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:43:23.570379Z","caller":"traceutil/trace.go:171","msg":"trace[255406096] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16277; }","duration":"127.433339ms","start":"2026-10-16T11:43:23.442904Z","end":"2026-10-16T11:43:23.570338Z","steps":["trace[255406096] 'agreement among raft nodes before linearized reading'  (duration: 127.242523ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:43:23.570394Z","caller":"traceutil/trace.go:171","msg":"trace[1911192135] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:16277; }","duration":"190.144751ms","start":"2026-10-16T11:43:23.38018Z","end":"2026-10-16T11:43:23.570324Z","steps":["trace[1911192135] 'agreement among raft nodes before linearized reading'  (duration: 180.420923ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:43:23.570405Z","caller":"traceutil/trace.go:171","msg":"trace[614911743] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:16277; }","duration":"105.463082ms","start":"2026-10-16T11:43:23.464902Z","end":"2026-10-16T11:43:23.570365Z","steps":["trace[614911743] 'agreement among raft nodes before linearized reading'  (duration: 105.36276ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:43:23.570399Z","caller":"traceutil/trace.go:171","msg":"trace[763789566] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16277; }","duration":"125.860125ms","start":"2026-10-16T11:43:23.444399Z","end":"2026-10-16T11:43:23.570259Z","steps":["trace[763789566] 'agreement among raft nodes before linearized reading'  (duration: 125.6598ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:43:23.569782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.186671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"warn","ts":"2026-10-16T11:43:23.571264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.934415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-10-16T11:43:23.57131Z","caller":"traceutil/trace.go:171","msg":"trace[1927679670] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16277; }","duration":"101.988897ms","start":"2026-10-16T11:43:23.469299Z","end":"2026-10-16T11:43:23.571287Z","steps":["trace[1927679670] 'agreement among raft nodes before linearized reading'  (duration: 91.460256ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:43:23.571659Z","caller":"traceutil/trace.go:171","msg":"trace[617246517] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16277; }","duration":"125.536107ms","start":"2026-10-16T11:43:23.445596Z","end":"2026-10-16T11:43:23.571132Z","steps":["trace[617246517] 'agreement among raft nodes before linearized reading'  (duration: 115.124909ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:43:23.572818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.40879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:772515"}
{"level":"info","ts":"2026-10-16T11:43:23.572964Z","caller":"traceutil/trace.go:171","msg":"trace[1545807818] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:16277; }","duration":"189.564295ms","start":"2026-10-16T11:43:23.383359Z","end":"2026-10-16T11:43:23.572924Z","steps":["trace[1545807818] 'agreement among raft nodes before linearized reading'  (duration: 177.278126ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:43:23.577806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.438991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:772515"}
{"level":"info","ts":"2026-10-16T11:43:23.577976Z","caller":"traceutil/trace.go:171","msg":"trace[757141527] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:16277; }","duration":"193.655198ms","start":"2026-10-16T11:43:23.384215Z","end":"2026-10-16T11:43:23.577871Z","steps":["trace[757141527] 'agreement among raft nodes before linearized reading'  (duration: 185.982506ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:45:17.967904Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14538}
{"level":"info","ts":"2026-10-16T11:45:18.075558Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14538,"took":"104.493906ms","hash":2881719858,"current-db-size-bytes":57094144,"current-db-size":"57 MB","current-db-size-in-use-bytes":31408128,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-16T11:45:18.075677Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2881719858,"revision":14538,"compact-revision":12548}
{"level":"info","ts":"2026-10-16T11:46:52.587264Z","caller":"traceutil/trace.go:171","msg":"trace[689652309] transaction","detail":"{read_only:false; response_revision:17869; number_of_response:1; }","duration":"118.858639ms","start":"2026-10-16T11:46:52.468371Z","end":"2026-10-16T11:46:52.587229Z","steps":["trace[689652309] 'process raft request'  (duration: 118.593502ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:46:52.588733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.520727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:91 size:901327"}
{"level":"info","ts":"2026-10-16T11:46:52.588843Z","caller":"traceutil/trace.go:171","msg":"trace[360604318] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:91; response_revision:17869; }","duration":"119.661901ms","start":"2026-10-16T11:46:52.469157Z","end":"2026-10-16T11:46:52.588819Z","steps":["trace[360604318] 'agreement among raft nodes before linearized reading'  (duration: 118.023487ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:49:05.751947Z","caller":"traceutil/trace.go:171","msg":"trace[483000887] transaction","detail":"{read_only:false; response_revision:18718; number_of_response:1; }","duration":"103.663ms","start":"2026-10-16T11:49:05.648256Z","end":"2026-10-16T11:49:05.751919Z","steps":["trace[483000887] 'process raft request'  (duration: 103.464385ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:49:06.207254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.118664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-16T11:49:06.207363Z","caller":"traceutil/trace.go:171","msg":"trace[1980801728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18720; }","duration":"233.275508ms","start":"2026-10-16T11:49:05.974052Z","end":"2026-10-16T11:49:06.207327Z","steps":["trace[1980801728] 'range keys from in-memory index tree'  (duration: 233.044791ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:49:12.897942Z","caller":"traceutil/trace.go:171","msg":"trace[1510965985] transaction","detail":"{read_only:false; response_revision:18780; number_of_response:1; }","duration":"113.903514ms","start":"2026-10-16T11:49:12.784006Z","end":"2026-10-16T11:49:12.897909Z","steps":["trace[1510965985] 'process raft request'  (duration: 90.247351ms)","trace[1510965985] 'compare'  (duration: 23.347034ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:50:06.865995Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"db28a37eabf8270","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-16T11:50:06.87122Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-10-16T11:50:06.871294Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-10-16T11:50:17.978562Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16990}
{"level":"info","ts":"2026-10-16T11:50:18.086467Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16990,"took":"104.205597ms","hash":2592570974,"current-db-size-bytes":57094144,"current-db-size":"57 MB","current-db-size-in-use-bytes":34140160,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-10-16T11:50:18.086725Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2592570974,"revision":16990,"compact-revision":14538}
{"level":"info","ts":"2026-10-16T11:55:17.988764Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19565}
{"level":"info","ts":"2026-10-16T11:55:18.140018Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19565,"took":"147.661842ms","hash":3944751495,"current-db-size-bytes":57094144,"current-db-size":"57 MB","current-db-size-in-use-bytes":30351360,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-16T11:55:18.140091Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3944751495,"revision":19565,"compact-revision":16990}
{"level":"info","ts":"2026-10-16T11:55:26.577376Z","caller":"traceutil/trace.go:171","msg":"trace[1000049439] transaction","detail":"{read_only:false; response_revision:21673; number_of_response:1; }","duration":"196.115045ms","start":"2026-10-16T11:55:26.381236Z","end":"2026-10-16T11:55:26.577351Z","steps":["trace[1000049439] 'process raft request'  (duration: 195.972472ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:55:26.739893Z","caller":"traceutil/trace.go:171","msg":"trace[510591885] transaction","detail":"{read_only:false; response_revision:21674; number_of_response:1; }","duration":"191.886891ms","start":"2026-10-16T11:55:26.547965Z","end":"2026-10-16T11:55:26.739852Z","steps":["trace[510591885] 'process raft request'  (duration: 184.447529ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:55:26.739897Z","caller":"traceutil/trace.go:171","msg":"trace[1444539229] linearizableReadLoop","detail":"{readStateIndex:22414; appliedIndex:22413; }","duration":"133.479048ms","start":"2026-10-16T11:55:26.606388Z","end":"2026-10-16T11:55:26.739868Z","steps":["trace[1444539229] 'read index received'  (duration: 126.173369ms)","trace[1444539229] 'applied index is now lower than readState.Index'  (duration: 7.304368ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:55:26.740048Z","caller":"traceutil/trace.go:171","msg":"trace[1228280833] transaction","detail":"{read_only:false; response_revision:21675; number_of_response:1; }","duration":"113.204069ms","start":"2026-10-16T11:55:26.626812Z","end":"2026-10-16T11:55:26.740016Z","steps":["trace[1228280833] 'process raft request'  (duration: 113.000213ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:55:26.740206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.873221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-16T11:55:26.740262Z","caller":"traceutil/trace.go:171","msg":"trace[755336472] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:21675; }","duration":"122.964633ms","start":"2026-10-16T11:55:26.617282Z","end":"2026-10-16T11:55:26.740247Z","steps":["trace[755336472] 'agreement among raft nodes before linearized reading'  (duration: 122.85093ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:55:26.740628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.174967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-16T11:55:26.740763Z","caller":"traceutil/trace.go:171","msg":"trace[2111253646] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:21675; }","duration":"134.403053ms","start":"2026-10-16T11:55:26.606335Z","end":"2026-10-16T11:55:26.740738Z","steps":["trace[2111253646] 'agreement among raft nodes before linearized reading'  (duration: 133.625702ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T11:55:26.95048Z","caller":"traceutil/trace.go:171","msg":"trace[1426828981] transaction","detail":"{read_only:false; response_revision:21676; number_of_response:1; }","duration":"142.350889ms","start":"2026-10-16T11:55:26.808078Z","end":"2026-10-16T11:55:26.950429Z","steps":["trace[1426828981] 'process raft request'  (duration: 142.190864ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:55:37.430589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.277411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-16T11:55:37.430665Z","caller":"traceutil/trace.go:171","msg":"trace[143763018] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:21728; }","duration":"213.399814ms","start":"2026-10-16T11:55:37.217249Z","end":"2026-10-16T11:55:37.430648Z","steps":["trace[143763018] 'count revisions from in-memory index tree'  (duration: 213.204029ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:55:43.04366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.95742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-16T11:55:43.043751Z","caller":"traceutil/trace.go:171","msg":"trace[402818642] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:21755; }","duration":"262.096224ms","start":"2026-10-16T11:55:42.78163Z","end":"2026-10-16T11:55:43.043726Z","steps":["trace[402818642] 'count revisions from in-memory index tree'  (duration: 261.791326ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:55:43.04442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.522694ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9399189737493925629 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:21746 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-16T11:55:43.044608Z","caller":"traceutil/trace.go:171","msg":"trace[802512116] linearizableReadLoop","detail":"{readStateIndex:22501; appliedIndex:22499; }","duration":"240.428997ms","start":"2026-10-16T11:55:42.804165Z","end":"2026-10-16T11:55:43.044594Z","steps":["trace[802512116] 'read index received'  (duration: 63.638635ms)","trace[802512116] 'applied index is now lower than readState.Index'  (duration: 176.788942ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:55:43.04468Z","caller":"traceutil/trace.go:171","msg":"trace[1045562139] transaction","detail":"{read_only:false; response_revision:21756; number_of_response:1; }","duration":"250.12783ms","start":"2026-10-16T11:55:42.79454Z","end":"2026-10-16T11:55:43.044668Z","steps":["trace[1045562139] 'process raft request'  (duration: 73.229955ms)","trace[1045562139] 'compare'  (duration: 176.288868ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:55:43.045188Z","caller":"traceutil/trace.go:171","msg":"trace[1299893402] transaction","detail":"{read_only:false; response_revision:21757; number_of_response:1; }","duration":"249.093382ms","start":"2026-10-16T11:55:42.79607Z","end":"2026-10-16T11:55:43.045163Z","steps":["trace[1299893402] 'process raft request'  (duration: 248.457495ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:55:43.045386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.223639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-10-16T11:55:43.045437Z","caller":"traceutil/trace.go:171","msg":"trace[1492012596] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:21757; }","duration":"241.343462ms","start":"2026-10-16T11:55:42.804081Z","end":"2026-10-16T11:55:43.045425Z","steps":["trace[1492012596] 'agreement among raft nodes before linearized reading'  (duration: 240.843629ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:55:43.296422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.183012ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9399189737493925631 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:21748 > 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-16T11:55:43.296574Z","caller":"traceutil/trace.go:171","msg":"trace[1389261659] linearizableReadLoop","detail":"{readStateIndex:22502; appliedIndex:22501; }","duration":"251.913338ms","start":"2026-10-16T11:55:43.044637Z","end":"2026-10-16T11:55:43.29655Z","steps":["trace[1389261659] 'read index received'  (duration: 129.529081ms)","trace[1389261659] 'applied index is now lower than readState.Index'  (duration: 122.382527ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:55:43.296756Z","caller":"traceutil/trace.go:171","msg":"trace[712134231] transaction","detail":"{read_only:false; response_revision:21758; number_of_response:1; }","duration":"253.114681ms","start":"2026-10-16T11:55:43.043605Z","end":"2026-10-16T11:55:43.296719Z","steps":["trace[712134231] 'process raft request'  (duration: 130.520678ms)","trace[712134231] 'compare'  (duration: 122.049668ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T11:55:43.296894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.120788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-16T11:55:43.296952Z","caller":"traceutil/trace.go:171","msg":"trace[2037715759] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21758; }","duration":"323.246221ms","start":"2026-10-16T11:55:42.973689Z","end":"2026-10-16T11:55:43.296935Z","steps":["trace[2037715759] 'agreement among raft nodes before linearized reading'  (duration: 323.137709ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:55:43.29701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:55:42.973666Z","time spent":"323.330294ms","remote":"127.0.0.1:44056","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-16T11:55:43.297484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.706931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-10-16T11:55:43.297674Z","caller":"traceutil/trace.go:171","msg":"trace[1530664601] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21758; }","duration":"141.937407ms","start":"2026-10-16T11:55:43.15572Z","end":"2026-10-16T11:55:43.297658Z","steps":["trace[1530664601] 'agreement among raft nodes before linearized reading'  (duration: 141.578667ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:55:43.567273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.548544ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9399189737493925636 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:21749 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-16T11:55:43.567555Z","caller":"traceutil/trace.go:171","msg":"trace[974486973] transaction","detail":"{read_only:false; response_revision:21759; number_of_response:1; }","duration":"264.723666ms","start":"2026-10-16T11:55:43.302792Z","end":"2026-10-16T11:55:43.567515Z","steps":["trace[974486973] 'process raft request'  (duration: 159.788571ms)","trace[974486973] 'compare'  (duration: 104.273767ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T11:55:43.567606Z","caller":"traceutil/trace.go:171","msg":"trace[1649265322] transaction","detail":"{read_only:false; response_revision:21760; number_of_response:1; }","duration":"116.996832ms","start":"2026-10-16T11:55:43.450561Z","end":"2026-10-16T11:55:43.567558Z","steps":["trace[1649265322] 'process raft request'  (duration: 116.842918ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:59:51.653227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.111768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.57\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-10-16T11:59:51.653408Z","caller":"traceutil/trace.go:171","msg":"trace[874354438] range","detail":"{range_begin:/registry/masterleases/162.253.55.57; range_end:; response_count:1; response_revision:24259; }","duration":"271.334364ms","start":"2026-10-16T11:59:51.382056Z","end":"2026-10-16T11:59:51.65339Z","steps":["trace[874354438] 'range keys from in-memory index tree'  (duration: 270.948495ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:59:51.653498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.788405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-16T11:59:51.65357Z","caller":"traceutil/trace.go:171","msg":"trace[2089039314] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24259; }","duration":"213.884517ms","start":"2026-10-16T11:59:51.439656Z","end":"2026-10-16T11:59:51.653541Z","steps":["trace[2089039314] 'range keys from in-memory index tree'  (duration: 213.693383ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:59:51.653638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.946122ms","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-16T11:59:51.653743Z","caller":"traceutil/trace.go:171","msg":"trace[1179528887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24259; }","duration":"244.068895ms","start":"2026-10-16T11:59:51.409621Z","end":"2026-10-16T11:59:51.65369Z","steps":["trace[1179528887] 'range keys from in-memory index tree'  (duration: 243.651604ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T11:59:51.654051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.823572ms","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-16T11:59:51.65416Z","caller":"traceutil/trace.go:171","msg":"trace[1257769887] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24259; }","duration":"235.984026ms","start":"2026-10-16T11:59:51.418151Z","end":"2026-10-16T11:59:51.654135Z","steps":["trace[1257769887] 'range keys from in-memory index tree'  (duration: 235.555035ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T12:00:17.99899Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21629}
{"level":"info","ts":"2026-10-16T12:00:18.128686Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21629,"took":"123.179288ms","hash":2616920781,"current-db-size-bytes":57094144,"current-db-size":"57 MB","current-db-size-in-use-bytes":42844160,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-10-16T12:00:18.128745Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2616920781,"revision":21629,"compact-revision":19565}
{"level":"info","ts":"2026-10-16T12:01:55.368062Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006797.wal"}
{"level":"info","ts":"2026-10-16T12:03:14.655921Z","caller":"traceutil/trace.go:171","msg":"trace[1586204179] linearizableReadLoop","detail":"{readStateIndex:27235; appliedIndex:27234; }","duration":"185.543106ms","start":"2026-10-16T12:03:14.470346Z","end":"2026-10-16T12:03:14.655889Z","steps":["trace[1586204179] 'read index received'  (duration: 185.168866ms)","trace[1586204179] 'applied index is now lower than readState.Index'  (duration: 373.41µs)"],"step_count":2}
{"level":"info","ts":"2026-10-16T12:03:14.656027Z","caller":"traceutil/trace.go:171","msg":"trace[255196077] transaction","detail":"{read_only:false; response_revision:26363; number_of_response:1; }","duration":"204.927752ms","start":"2026-10-16T12:03:14.451044Z","end":"2026-10-16T12:03:14.655972Z","steps":["trace[255196077] 'process raft request'  (duration: 204.570982ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T12:03:14.656098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.721572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-16T12:03:14.65635Z","caller":"traceutil/trace.go:171","msg":"trace[1696360821] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:26363; }","duration":"185.946508ms","start":"2026-10-16T12:03:14.470318Z","end":"2026-10-16T12:03:14.656265Z","steps":["trace[1696360821] 'agreement among raft nodes before linearized reading'  (duration: 185.705741ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T12:03:20.517424Z","caller":"traceutil/trace.go:171","msg":"trace[1289772721] transaction","detail":"{read_only:false; response_revision:26409; number_of_response:1; }","duration":"165.603697ms","start":"2026-10-16T12:03:20.351767Z","end":"2026-10-16T12:03:20.517371Z","steps":["trace[1289772721] 'process raft request'  (duration: 165.171716ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T12:04:21.362871Z","caller":"traceutil/trace.go:171","msg":"trace[1556517827] transaction","detail":"{read_only:false; response_revision:26959; number_of_response:1; }","duration":"180.059396ms","start":"2026-10-16T12:04:21.182783Z","end":"2026-10-16T12:04:21.362843Z","steps":["trace[1556517827] 'process raft request'  (duration: 179.918142ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T12:04:21.592195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.355529ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9399189737493939306 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26947 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-16T12:04:21.592637Z","caller":"traceutil/trace.go:171","msg":"trace[55743547] transaction","detail":"{read_only:false; response_revision:26960; number_of_response:1; }","duration":"351.594386ms","start":"2026-10-16T12:04:21.240981Z","end":"2026-10-16T12:04:21.592575Z","steps":["trace[55743547] 'process raft request'  (duration: 206.750274ms)","trace[55743547] 'compare'  (duration: 144.231466ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T12:04:21.592881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T12:04:21.240959Z","time spent":"351.76289ms","remote":"127.0.0.1:44360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26947 > 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-16T12:04:21.592904Z","caller":"traceutil/trace.go:171","msg":"trace[343192645] transaction","detail":"{read_only:false; response_revision:26961; number_of_response:1; }","duration":"343.180263ms","start":"2026-10-16T12:04:21.249692Z","end":"2026-10-16T12:04:21.592872Z","steps":["trace[343192645] 'process raft request'  (duration: 342.610438ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T12:04:21.593022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T12:04:21.249672Z","time spent":"343.293386ms","remote":"127.0.0.1:44360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26948 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-10-16T12:04:21.593306Z","caller":"traceutil/trace.go:171","msg":"trace[418910202] linearizableReadLoop","detail":"{readStateIndex:27848; appliedIndex:27845; }","duration":"270.794683ms","start":"2026-10-16T12:04:21.322495Z","end":"2026-10-16T12:04:21.59329Z","steps":["trace[418910202] 'read index received'  (duration: 40.543316ms)","trace[418910202] 'applied index is now lower than readState.Index'  (duration: 230.249597ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T12:04:21.593338Z","caller":"traceutil/trace.go:171","msg":"trace[224154963] transaction","detail":"{read_only:false; response_revision:26962; number_of_response:1; }","duration":"342.201706ms","start":"2026-10-16T12:04:21.251126Z","end":"2026-10-16T12:04:21.593328Z","steps":["trace[224154963] 'process raft request'  (duration: 341.657922ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T12:04:21.593545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T12:04:21.251103Z","time spent":"342.394182ms","remote":"127.0.0.1:44360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:26949 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-10-16T12:04:21.593567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.07191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-10-16T12:04:21.593599Z","caller":"traceutil/trace.go:171","msg":"trace[401171441] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26962; }","duration":"271.130341ms","start":"2026-10-16T12:04:21.322461Z","end":"2026-10-16T12:04:21.593591Z","steps":["trace[401171441] 'agreement among raft nodes before linearized reading'  (duration: 270.951106ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T12:04:21.655405Z","caller":"traceutil/trace.go:171","msg":"trace[624373460] transaction","detail":"{read_only:false; response_revision:26964; number_of_response:1; }","duration":"262.598635ms","start":"2026-10-16T12:04:21.39279Z","end":"2026-10-16T12:04:21.655388Z","steps":["trace[624373460] 'process raft request'  (duration: 262.535844ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T12:04:21.655578Z","caller":"traceutil/trace.go:171","msg":"trace[1701608512] transaction","detail":"{read_only:false; response_revision:26963; number_of_response:1; }","duration":"292.456878ms","start":"2026-10-16T12:04:21.363096Z","end":"2026-10-16T12:04:21.655553Z","steps":["trace[1701608512] 'process raft request'  (duration: 292.132749ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T12:04:21.655784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.101952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.57\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-10-16T12:04:21.655814Z","caller":"traceutil/trace.go:171","msg":"trace[718431536] range","detail":"{range_begin:/registry/masterleases/162.253.55.57; range_end:; response_count:1; response_revision:26964; }","duration":"259.171814ms","start":"2026-10-16T12:04:21.396634Z","end":"2026-10-16T12:04:21.655806Z","steps":["trace[718431536] 'agreement among raft nodes before linearized reading'  (duration: 259.071162ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T12:04:21.881746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.891368ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9399189737493939312 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26950 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-16T12:04:21.881976Z","caller":"traceutil/trace.go:171","msg":"trace[1163737509] linearizableReadLoop","detail":"{readStateIndex:27852; appliedIndex:27850; }","duration":"226.460357ms","start":"2026-10-16T12:04:21.655494Z","end":"2026-10-16T12:04:21.881954Z","steps":["trace[1163737509] 'read index received'  (duration: 88.381904ms)","trace[1163737509] 'applied index is now lower than readState.Index'  (duration: 138.077353ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T12:04:21.88202Z","caller":"traceutil/trace.go:171","msg":"trace[1566093945] transaction","detail":"{read_only:false; response_revision:26965; number_of_response:1; }","duration":"284.132126ms","start":"2026-10-16T12:04:21.597847Z","end":"2026-10-16T12:04:21.881979Z","steps":["trace[1566093945] 'process raft request'  (duration: 145.89293ms)","trace[1566093945] 'compare'  (duration: 137.678021ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T12:04:21.882034Z","caller":"traceutil/trace.go:171","msg":"trace[1948524396] transaction","detail":"{read_only:false; response_revision:26966; number_of_response:1; }","duration":"232.234849ms","start":"2026-10-16T12:04:21.649778Z","end":"2026-10-16T12:04:21.882013Z","steps":["trace[1948524396] 'process raft request'  (duration: 232.060555ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T12:04:21.882378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.232487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-10-16T12:04:21.882409Z","caller":"traceutil/trace.go:171","msg":"trace[478007436] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26966; }","duration":"227.322709ms","start":"2026-10-16T12:04:21.655075Z","end":"2026-10-16T12:04:21.882398Z","steps":["trace[478007436] 'agreement among raft nodes before linearized reading'  (duration: 226.942899ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T12:04:22.091729Z","caller":"traceutil/trace.go:171","msg":"trace[1511434380] transaction","detail":"{read_only:false; response_revision:26967; number_of_response:1; }","duration":"207.824342ms","start":"2026-10-16T12:04:21.883877Z","end":"2026-10-16T12:04:22.091701Z","steps":["trace[1511434380] 'process raft request'  (duration: 144.963955ms)","trace[1511434380] 'compare'  (duration: 62.533008ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T12:04:22.173241Z","caller":"traceutil/trace.go:171","msg":"trace[405891184] linearizableReadLoop","detail":"{readStateIndex:27855; appliedIndex:27853; }","duration":"200.276162ms","start":"2026-10-16T12:04:21.972937Z","end":"2026-10-16T12:04:22.173213Z","steps":["trace[405891184] 'read index received'  (duration: 55.883402ms)","trace[405891184] 'applied index is now lower than readState.Index'  (duration: 144.39171ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T12:04:22.173291Z","caller":"traceutil/trace.go:171","msg":"trace[1413642385] transaction","detail":"{read_only:false; response_revision:26968; number_of_response:1; }","duration":"287.020343ms","start":"2026-10-16T12:04:21.886239Z","end":"2026-10-16T12:04:22.173259Z","steps":["trace[1413642385] 'process raft request'  (duration: 286.781327ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T12:04:22.173422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.464037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-16T12:04:22.17364Z","caller":"traceutil/trace.go:171","msg":"trace[188557936] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26969; }","duration":"200.725464ms","start":"2026-10-16T12:04:21.972894Z","end":"2026-10-16T12:04:22.173619Z","steps":["trace[188557936] 'agreement among raft nodes before linearized reading'  (duration: 200.440716ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T12:04:22.173968Z","caller":"traceutil/trace.go:171","msg":"trace[1046949106] transaction","detail":"{read_only:false; response_revision:26969; number_of_response:1; }","duration":"166.843735ms","start":"2026-10-16T12:04:22.006558Z","end":"2026-10-16T12:04:22.173401Z","steps":["trace[1046949106] 'process raft request'  (duration: 166.608539ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T12:04:22.174039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.189435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"}
{"level":"info","ts":"2026-10-16T12:04:22.174077Z","caller":"traceutil/trace.go:171","msg":"trace[1440729559] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:26969; }","duration":"115.256917ms","start":"2026-10-16T12:04:22.058805Z","end":"2026-10-16T12:04:22.174062Z","steps":["trace[1440729559] 'agreement among raft nodes before linearized reading'  (duration: 114.755933ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T12:05:08.211799Z","caller":"traceutil/trace.go:171","msg":"trace[1064049275] transaction","detail":"{read_only:false; response_revision:27517; number_of_response:1; }","duration":"123.620009ms","start":"2026-10-16T12:05:08.088158Z","end":"2026-10-16T12:05:08.211778Z","steps":["trace[1064049275] 'process raft request'  (duration: 76.246732ms)","trace[1064049275] 'compare'  (duration: 47.243633ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T12:05:18.005936Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24624}
{"level":"info","ts":"2026-10-16T12:05:18.161555Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24624,"took":"148.129339ms","hash":3006088612,"current-db-size-bytes":59203584,"current-db-size":"59 MB","current-db-size-in-use-bytes":37179392,"current-db-size-in-use":"37 MB"}
{"level":"info","ts":"2026-10-16T12:05:18.161639Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3006088612,"revision":24624,"compact-revision":21629}
{"level":"info","ts":"2026-10-16T12:07:55.021544Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"db28a37eabf8270","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-16T12:07:55.027394Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-10-16T12:07:55.027636Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-10-16T12:10:18.012835Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27617}
{"level":"info","ts":"2026-10-16T12:10:18.191959Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27617,"took":"174.479353ms","hash":3779276230,"current-db-size-bytes":59203584,"current-db-size":"59 MB","current-db-size-in-use-bytes":35241984,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-10-16T12:10:18.192027Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3779276230,"revision":27617,"compact-revision":24624}
{"level":"info","ts":"2026-10-16T12:15:18.021098Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30313}
{"level":"info","ts":"2026-10-16T12:15:18.182316Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30313,"took":"156.466245ms","hash":382032611,"current-db-size-bytes":59203584,"current-db-size":"59 MB","current-db-size-in-use-bytes":31031296,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-16T12:15:18.18239Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":382032611,"revision":30313,"compact-revision":27617}
{"level":"info","ts":"2026-10-16T12:20:18.027658Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32565}
{"level":"info","ts":"2026-10-16T12:20:18.185899Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32565,"took":"153.288573ms","hash":2182061212,"current-db-size-bytes":60243968,"current-db-size":"60 MB","current-db-size-in-use-bytes":30625792,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-16T12:20:18.185968Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2182061212,"revision":32565,"compact-revision":30313}
{"level":"info","ts":"2026-10-16T12:25:18.041411Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34790}
{"level":"info","ts":"2026-10-16T12:25:18.178967Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34790,"took":"131.674871ms","hash":1406494432,"current-db-size-bytes":60243968,"current-db-size":"60 MB","current-db-size-in-use-bytes":31621120,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-16T12:25:18.179041Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1406494432,"revision":34790,"compact-revision":32565}
{"level":"info","ts":"2026-10-16T12:29:05.957661Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"db28a37eabf8270","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-16T12:29:05.962062Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-10-16T12:29:05.962142Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-10-16T12:30:18.051132Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37089}
{"level":"info","ts":"2026-10-16T12:30:18.191231Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37089,"took":"135.955455ms","hash":1246228807,"current-db-size-bytes":61091840,"current-db-size":"61 MB","current-db-size-in-use-bytes":32534528,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-16T12:30:18.191307Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1246228807,"revision":37089,"compact-revision":34790}
{"level":"info","ts":"2026-10-16T12:35:18.058814Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39360}
{"level":"info","ts":"2026-10-16T12:35:18.196642Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39360,"took":"133.701035ms","hash":2490876890,"current-db-size-bytes":63647744,"current-db-size":"64 MB","current-db-size-in-use-bytes":31899648,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-16T12:35:18.196694Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2490876890,"revision":39360,"compact-revision":37089}
{"level":"info","ts":"2026-10-16T12:40:18.06542Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":41590}
{"level":"info","ts":"2026-10-16T12:40:18.218843Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":41590,"took":"149.592132ms","hash":1001243773,"current-db-size-bytes":63647744,"current-db-size":"64 MB","current-db-size-in-use-bytes":30277632,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-16T12:40:18.218934Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1001243773,"revision":41590,"compact-revision":39360}