{"level":"warn","ts":"2026-03-13T09:51:52.420167Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-13T09:51:52.420247Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.153:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.153:2380","--initial-cluster=instance=https://199.19.213.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.153: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-03-13T09:51:52.420316Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-13T09:51:52.420329Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.153:2380"]}
{"level":"info","ts":"2026-03-13T09:51:52.420349Z","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-03-13T09:51:52.420939Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.153:2379"]}
{"level":"info","ts":"2026-03-13T09:51:52.421011Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.153:2380"],"listen-peer-urls":["https://199.19.213.153:2380"],"advertise-client-urls":["https://199.19.213.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.153: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-03-13T09:51:52.427893Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.690825ms"}
{"level":"info","ts":"2026-03-13T09:51:52.443576Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"36b63984d68b7065","cluster-id":"7c251967b436417d"}
{"level":"info","ts":"2026-03-13T09:51:52.443659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-13T09:51:52.443684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became follower at term 0"}
{"level":"info","ts":"2026-03-13T09:51:52.443694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 36b63984d68b7065 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-13T09:51:52.44371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became follower at term 1"}
{"level":"info","ts":"2026-03-13T09:51:52.443743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 switched to configuration voters=(3942401766507376741)"}
{"level":"warn","ts":"2026-03-13T09:51:52.448401Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-13T09:51:52.45026Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-13T09:51:52.45286Z","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-03-13T09:51:52.456438Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"36b63984d68b7065","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-13T09:51:52.456688Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"36b63984d68b7065","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-13T09:51:52.456761Z","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-03-13T09:51:52.458937Z","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-03-13T09:51:52.459057Z","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-03-13T09:51:52.459262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 switched to configuration voters=(3942401766507376741)"}
{"level":"info","ts":"2026-03-13T09:51:52.459842Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7c251967b436417d","local-member-id":"36b63984d68b7065","added-peer-id":"36b63984d68b7065","added-peer-peer-urls":["https://199.19.213.153:2380"]}
{"level":"info","ts":"2026-03-13T09:51:52.463768Z","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-03-13T09:51:52.46431Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"36b63984d68b7065","initial-advertise-peer-urls":["https://199.19.213.153:2380"],"listen-peer-urls":["https://199.19.213.153:2380"],"advertise-client-urls":["https://199.19.213.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-13T09:51:52.464366Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-13T09:51:52.464955Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.153:2380"}
{"level":"info","ts":"2026-03-13T09:51:52.465013Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.153:2380"}
{"level":"info","ts":"2026-03-13T09:51:52.544553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-13T09:51:52.544612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-13T09:51:52.544641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 received MsgPreVoteResp from 36b63984d68b7065 at term 1"}
{"level":"info","ts":"2026-03-13T09:51:52.544711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became candidate at term 2"}
{"level":"info","ts":"2026-03-13T09:51:52.544724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 received MsgVoteResp from 36b63984d68b7065 at term 2"}
{"level":"info","ts":"2026-03-13T09:51:52.544754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became leader at term 2"}
{"level":"info","ts":"2026-03-13T09:51:52.544769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 36b63984d68b7065 elected leader 36b63984d68b7065 at term 2"}
{"level":"info","ts":"2026-03-13T09:51:52.547479Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-13T09:51:52.548237Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"36b63984d68b7065","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.153:2379]}","request-path":"/0/members/36b63984d68b7065/attributes","cluster-id":"7c251967b436417d","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-13T09:51:52.548512Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-13T09:51:52.54859Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-13T09:51:52.548694Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7c251967b436417d","local-member-id":"36b63984d68b7065","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-13T09:51:52.548774Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-13T09:51:52.548796Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-13T09:51:52.54952Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-13T09:51:52.549668Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-13T09:51:52.554283Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.153:2379"}
{"level":"info","ts":"2026-03-13T09:51:52.554535Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-13T09:52:01.52322Z","caller":"traceutil/trace.go:171","msg":"trace[81139838] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"106.528131ms","start":"2026-03-13T09:52:01.416652Z","end":"2026-03-13T09:52:01.52318Z","steps":["trace[81139838] 'process raft request'  (duration: 43.503133ms)","trace[81139838] 'compare'  (duration: 62.801663ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T09:52:01.525295Z","caller":"traceutil/trace.go:171","msg":"trace[1343794671] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"105.993959ms","start":"2026-03-13T09:52:01.419265Z","end":"2026-03-13T09:52:01.525259Z","steps":["trace[1343794671] 'process raft request'  (duration: 105.690242ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:52:01.525479Z","caller":"traceutil/trace.go:171","msg":"trace[500662850] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"105.544311ms","start":"2026-03-13T09:52:01.4199Z","end":"2026-03-13T09:52:01.525444Z","steps":["trace[500662850] 'process raft request'  (duration: 105.236753ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:52:01.525712Z","caller":"traceutil/trace.go:171","msg":"trace[1527944472] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"105.579781ms","start":"2026-03-13T09:52:01.420122Z","end":"2026-03-13T09:52:01.525702Z","steps":["trace[1527944472] 'process raft request'  (duration: 105.238883ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:52:11.819602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.509762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-13T09:52:11.819734Z","caller":"traceutil/trace.go:171","msg":"trace[1327858960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:410; }","duration":"354.681295ms","start":"2026-03-13T09:52:11.465023Z","end":"2026-03-13T09:52:11.819704Z","steps":["trace[1327858960] 'range keys from in-memory index tree'  (duration: 354.407099ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:52:11.819785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:52:11.465002Z","time spent":"354.773537ms","remote":"127.0.0.1:48614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-13T09:52:11.979258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.909959ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8099052019170180754 > lease_revoke:<id:70659ce69c0c7ce3>","response":"size:27"}
{"level":"info","ts":"2026-03-13T09:52:11.979567Z","caller":"traceutil/trace.go:171","msg":"trace[1571098669] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"155.569565ms","start":"2026-03-13T09:52:11.823976Z","end":"2026-03-13T09:52:11.979546Z","steps":["trace[1571098669] 'process raft request'  (duration: 155.397931ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:52:32.816216Z","caller":"traceutil/trace.go:171","msg":"trace[906118960] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"256.25933ms","start":"2026-03-13T09:52:32.559932Z","end":"2026-03-13T09:52:32.816191Z","steps":["trace[906118960] 'process raft request'  (duration: 256.062076ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:52:32.816181Z","caller":"traceutil/trace.go:171","msg":"trace[1727545369] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:538; }","duration":"100.627908ms","start":"2026-03-13T09:52:32.715527Z","end":"2026-03-13T09:52:32.816155Z","steps":["trace[1727545369] 'read index received'  (duration: 100.536866ms)","trace[1727545369] 'applied index is now lower than readState.Index'  (duration: 89.932µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-13T09:52:32.816432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.890273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-13T09:52:32.816504Z","caller":"traceutil/trace.go:171","msg":"trace[1280056668] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:0; response_revision:520; }","duration":"101.011396ms","start":"2026-03-13T09:52:32.715479Z","end":"2026-03-13T09:52:32.816491Z","steps":["trace[1280056668] 'agreement among raft nodes before linearized reading'  (duration: 100.779011ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:52:33.064762Z","caller":"traceutil/trace.go:171","msg":"trace[1737898510] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"236.245183ms","start":"2026-03-13T09:52:32.828477Z","end":"2026-03-13T09:52:33.064723Z","steps":["trace[1737898510] 'process raft request'  (duration: 236.017728ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:53:40.718012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.730791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-13T09:53:40.718082Z","caller":"traceutil/trace.go:171","msg":"trace[1030673859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1537; }","duration":"246.901895ms","start":"2026-03-13T09:53:40.471165Z","end":"2026-03-13T09:53:40.718067Z","steps":["trace[1030673859] 'range keys from in-memory index tree'  (duration: 246.551528ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:53:41.157467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.514123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-13T09:53:41.157567Z","caller":"traceutil/trace.go:171","msg":"trace[403757335] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1541; }","duration":"134.84393ms","start":"2026-03-13T09:53:41.022698Z","end":"2026-03-13T09:53:41.157542Z","steps":["trace[403757335] 'count revisions from in-memory index tree'  (duration: 134.391241ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:53:56.55678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.344702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"}
{"level":"info","ts":"2026-03-13T09:53:56.556903Z","caller":"traceutil/trace.go:171","msg":"trace[623392458] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1664; }","duration":"136.521126ms","start":"2026-03-13T09:53:56.420359Z","end":"2026-03-13T09:53:56.55688Z","steps":["trace[623392458] 'range keys from in-memory index tree'  (duration: 136.149568ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:54:31.208729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.643375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-13T09:54:31.208864Z","caller":"traceutil/trace.go:171","msg":"trace[192363425] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1842; }","duration":"100.84661ms","start":"2026-03-13T09:54:31.107994Z","end":"2026-03-13T09:54:31.20884Z","steps":["trace[192363425] 'range keys from in-memory index tree'  (duration: 100.38797ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:54:31.208852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.208246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-13T09:54:31.20909Z","caller":"traceutil/trace.go:171","msg":"trace[1823135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1842; }","duration":"100.37521ms","start":"2026-03-13T09:54:31.108581Z","end":"2026-03-13T09:54:31.208956Z","steps":["trace[1823135] 'range keys from in-memory index tree'  (duration: 100.020172ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:54:31.674921Z","caller":"traceutil/trace.go:171","msg":"trace[2101050069] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"102.839761ms","start":"2026-03-13T09:54:31.572059Z","end":"2026-03-13T09:54:31.674899Z","steps":["trace[2101050069] 'process raft request'  (duration: 102.718009ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:54:31.960803Z","caller":"traceutil/trace.go:171","msg":"trace[1141229034] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"160.531247ms","start":"2026-03-13T09:54:31.800245Z","end":"2026-03-13T09:54:31.960776Z","steps":["trace[1141229034] 'process raft request'  (duration: 160.348084ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:58:36.07044Z","caller":"traceutil/trace.go:171","msg":"trace[493371897] transaction","detail":"{read_only:false; response_revision:3258; number_of_response:1; }","duration":"130.437667ms","start":"2026-03-13T09:58:35.93997Z","end":"2026-03-13T09:58:36.070408Z","steps":["trace[493371897] 'process raft request'  (duration: 130.224692ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:59:45.840338Z","caller":"traceutil/trace.go:171","msg":"trace[587497225] transaction","detail":"{read_only:false; response_revision:4052; number_of_response:1; }","duration":"113.696537ms","start":"2026-03-13T09:59:45.726624Z","end":"2026-03-13T09:59:45.840321Z","steps":["trace[587497225] 'process raft request'  (duration: 113.589845ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:59:45.843399Z","caller":"traceutil/trace.go:171","msg":"trace[1505433329] linearizableReadLoop","detail":"{readStateIndex:4219; appliedIndex:4218; }","duration":"107.577246ms","start":"2026-03-13T09:59:45.735806Z","end":"2026-03-13T09:59:45.843383Z","steps":["trace[1505433329] 'read index received'  (duration: 104.667094ms)","trace[1505433329] 'applied index is now lower than readState.Index'  (duration: 2.909432ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-13T09:59:45.843506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.686268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-13T09:59:45.843549Z","caller":"traceutil/trace.go:171","msg":"trace[940427752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4053; }","duration":"107.77152ms","start":"2026-03-13T09:59:45.735769Z","end":"2026-03-13T09:59:45.843541Z","steps":["trace[940427752] 'agreement among raft nodes before linearized reading'  (duration: 107.679378ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:59:45.843649Z","caller":"traceutil/trace.go:171","msg":"trace[1021409385] transaction","detail":"{read_only:false; response_revision:4053; number_of_response:1; }","duration":"115.327721ms","start":"2026-03-13T09:59:45.728303Z","end":"2026-03-13T09:59:45.84363Z","steps":["trace[1021409385] 'process raft request'  (duration: 115.030555ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:59:53.929483Z","caller":"traceutil/trace.go:171","msg":"trace[757691583] transaction","detail":"{read_only:false; response_revision:4339; number_of_response:1; }","duration":"117.525398ms","start":"2026-03-13T09:59:53.811932Z","end":"2026-03-13T09:59:53.929457Z","steps":["trace[757691583] 'process raft request'  (duration: 117.364815ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:59:53.951471Z","caller":"traceutil/trace.go:171","msg":"trace[1016862179] transaction","detail":"{read_only:false; response_revision:4340; number_of_response:1; }","duration":"134.911741ms","start":"2026-03-13T09:59:53.816516Z","end":"2026-03-13T09:59:53.951428Z","steps":["trace[1016862179] 'process raft request'  (duration: 134.639045ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:00:39.069931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.035476ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8099052019170191659 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" mod_revision:4612 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" value_size:881 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-13T10:00:39.070126Z","caller":"traceutil/trace.go:171","msg":"trace[2013648941] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"827.746297ms","start":"2026-03-13T10:00:38.242354Z","end":"2026-03-13T10:00:39.0701Z","steps":["trace[2013648941] 'process raft request'  (duration: 242.948894ms)","trace[2013648941] 'compare'  (duration: 583.869622ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T10:00:39.070222Z","caller":"traceutil/trace.go:171","msg":"trace[1228950539] linearizableReadLoop","detail":"{readStateIndex:5124; appliedIndex:5120; }","duration":"807.589448ms","start":"2026-03-13T10:00:38.262617Z","end":"2026-03-13T10:00:39.070206Z","steps":["trace[1228950539] 'read index received'  (duration: 222.787675ms)","trace[1228950539] 'applied index is now lower than readState.Index'  (duration: 584.800833ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T10:00:39.070248Z","caller":"traceutil/trace.go:171","msg":"trace[1388046541] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"827.775788ms","start":"2026-03-13T10:00:38.242423Z","end":"2026-03-13T10:00:39.070199Z","steps":["trace[1388046541] 'process raft request'  (duration: 827.617005ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:00:39.070395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:00:38.242322Z","time spent":"827.85974ms","remote":"127.0.0.1:48522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" mod_revision:4612 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" value_size:881 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" > >"}
{"level":"warn","ts":"2026-03-13T10:00:39.070433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.880233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mrfv9\" ","response":"range_response_count:1 size:6524"}
{"level":"warn","ts":"2026-03-13T10:00:39.070448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:00:38.242396Z","time spent":"827.950741ms","remote":"127.0.0.1:48622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-5jm2x\" mod_revision:4613 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-5jm2x\" value_size:1434 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-5jm2x\" > >"}
{"level":"info","ts":"2026-03-13T10:00:39.070524Z","caller":"traceutil/trace.go:171","msg":"trace[496128549] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"827.347199ms","start":"2026-03-13T10:00:38.243159Z","end":"2026-03-13T10:00:39.070506Z","steps":["trace[496128549] 'process raft request'  (duration: 827.009472ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:00:39.070469Z","caller":"traceutil/trace.go:171","msg":"trace[364785423] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mrfv9; range_end:; response_count:1; response_revision:4932; }","duration":"806.927613ms","start":"2026-03-13T10:00:38.263532Z","end":"2026-03-13T10:00:39.07046Z","steps":["trace[364785423] 'agreement among raft nodes before linearized reading'  (duration: 806.77514ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:00:39.07062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:00:38.243135Z","time spent":"827.436751ms","remote":"127.0.0.1:48622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-dgvzn\" mod_revision:4617 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-dgvzn\" value_size:1363 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-dgvzn\" > >"}
{"level":"warn","ts":"2026-03-13T10:00:39.070652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.943312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-13T10:00:39.070673Z","caller":"traceutil/trace.go:171","msg":"trace[1141263148] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:4932; }","duration":"327.982914ms","start":"2026-03-13T10:00:38.742683Z","end":"2026-03-13T10:00:39.070666Z","steps":["trace[1141263148] 'agreement among raft nodes before linearized reading'  (duration: 327.948293ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:00:39.070665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:00:38.263527Z","time spent":"807.121937ms","remote":"127.0.0.1:48536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6546,"request content":"key:\"/registry/pods/openstack/keepalived-mrfv9\" "}
{"level":"warn","ts":"2026-03-13T10:00:39.070693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:00:38.742675Z","time spent":"328.013804ms","remote":"127.0.0.1:56650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true "}
{"level":"warn","ts":"2026-03-13T10:00:39.070732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.349692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-13T10:00:39.07077Z","caller":"traceutil/trace.go:171","msg":"trace[648148529] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4932; }","duration":"336.425343ms","start":"2026-03-13T10:00:38.734336Z","end":"2026-03-13T10:00:39.070761Z","steps":["trace[648148529] 'agreement among raft nodes before linearized reading'  (duration: 336.372042ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:00:39.070801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:00:38.734317Z","time spent":"336.478004ms","remote":"127.0.0.1:48376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-13T10:00:39.07046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.827363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-03-13T10:00:39.070899Z","caller":"traceutil/trace.go:171","msg":"trace[440692394] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4932; }","duration":"808.297203ms","start":"2026-03-13T10:00:38.262584Z","end":"2026-03-13T10:00:39.070881Z","steps":["trace[440692394] 'agreement among raft nodes before linearized reading'  (duration: 807.714301ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:00:39.070812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.008626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-03-13T10:00:39.070933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.463554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"warn","ts":"2026-03-13T10:00:39.070947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:00:38.262571Z","time spent":"808.362314ms","remote":"127.0.0.1:48508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-03-13T10:00:39.070985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.10173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-13T10:00:39.071004Z","caller":"traceutil/trace.go:171","msg":"trace[1670418845] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:4932; }","duration":"346.167252ms","start":"2026-03-13T10:00:38.724833Z","end":"2026-03-13T10:00:39.071Z","steps":["trace[1670418845] 'agreement among raft nodes before linearized reading'  (duration: 346.135761ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:00:39.071021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:00:38.724809Z","time spent":"346.208222ms","remote":"127.0.0.1:48710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "}
{"level":"info","ts":"2026-03-13T10:00:39.070958Z","caller":"traceutil/trace.go:171","msg":"trace[946531117] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4932; }","duration":"745.534246ms","start":"2026-03-13T10:00:38.325417Z","end":"2026-03-13T10:00:39.070951Z","steps":["trace[946531117] 'agreement among raft nodes before linearized reading'  (duration: 745.466824ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:00:39.071177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:00:38.325395Z","time spent":"745.767401ms","remote":"127.0.0.1:48614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-03-13T10:00:39.07122Z","caller":"traceutil/trace.go:171","msg":"trace[717082647] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"828.760998ms","start":"2026-03-13T10:00:38.242453Z","end":"2026-03-13T10:00:39.071214Z","steps":["trace[717082647] 'process raft request'  (duration: 827.673955ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:00:39.070951Z","caller":"traceutil/trace.go:171","msg":"trace[1050644026] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4932; }","duration":"213.175899ms","start":"2026-03-13T10:00:38.857765Z","end":"2026-03-13T10:00:39.070941Z","steps":["trace[1050644026] 'agreement among raft nodes before linearized reading'  (duration: 213.005856ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:00:39.071259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:00:38.242429Z","time spent":"828.81123ms","remote":"127.0.0.1:48522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" mod_revision:4618 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" value_size:829 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" > >"}
{"level":"warn","ts":"2026-03-13T10:00:39.071136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.607526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-03-13T10:00:39.071321Z","caller":"traceutil/trace.go:171","msg":"trace[327566718] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4932; }","duration":"405.808891ms","start":"2026-03-13T10:00:38.665501Z","end":"2026-03-13T10:00:39.071309Z","steps":["trace[327566718] 'agreement among raft nodes before linearized reading'  (duration: 405.601527ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:00:39.071355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:00:38.665488Z","time spent":"405.858532ms","remote":"127.0.0.1:48614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":593,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-03-13T10:00:39.210358Z","caller":"traceutil/trace.go:171","msg":"trace[984553476] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"134.938704ms","start":"2026-03-13T10:00:39.075394Z","end":"2026-03-13T10:00:39.210333Z","steps":["trace[984553476] 'process raft request'  (duration: 134.848952ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:00:39.210402Z","caller":"traceutil/trace.go:171","msg":"trace[1356899564] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"135.019146ms","start":"2026-03-13T10:00:39.075351Z","end":"2026-03-13T10:00:39.21037Z","steps":["trace[1356899564] 'process raft request'  (duration: 97.989316ms)","trace[1356899564] 'compare'  (duration: 36.759654ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T10:00:39.210535Z","caller":"traceutil/trace.go:171","msg":"trace[318408999] linearizableReadLoop","detail":"{readStateIndex:5130; appliedIndex:5124; }","duration":"133.903892ms","start":"2026-03-13T10:00:39.076612Z","end":"2026-03-13T10:00:39.210516Z","steps":["trace[318408999] 'read index received'  (duration: 96.738629ms)","trace[318408999] 'applied index is now lower than readState.Index'  (duration: 37.164433ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T10:00:39.210619Z","caller":"traceutil/trace.go:171","msg":"trace[1479397285] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"135.140569ms","start":"2026-03-13T10:00:39.075471Z","end":"2026-03-13T10:00:39.210611Z","steps":["trace[1479397285] 'process raft request'  (duration: 134.823252ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:00:39.210633Z","caller":"traceutil/trace.go:171","msg":"trace[1247857434] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"134.917983ms","start":"2026-03-13T10:00:39.075705Z","end":"2026-03-13T10:00:39.210623Z","steps":["trace[1247857434] 'process raft request'  (duration: 134.748819ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:00:39.21075Z","caller":"traceutil/trace.go:171","msg":"trace[1576031692] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"134.608276ms","start":"2026-03-13T10:00:39.076131Z","end":"2026-03-13T10:00:39.21074Z","steps":["trace[1576031692] 'process raft request'  (duration: 134.353631ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:00:39.210582Z","caller":"traceutil/trace.go:171","msg":"trace[1785371104] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"134.984644ms","start":"2026-03-13T10:00:39.075589Z","end":"2026-03-13T10:00:39.210574Z","steps":["trace[1785371104] 'process raft request'  (duration: 134.80944ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:00:39.210904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.274729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:8 size:64997"}
{"level":"info","ts":"2026-03-13T10:00:39.210939Z","caller":"traceutil/trace.go:171","msg":"trace[1641118490] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:8; response_revision:4938; }","duration":"134.33736ms","start":"2026-03-13T10:00:39.076594Z","end":"2026-03-13T10:00:39.210931Z","steps":["trace[1641118490] 'agreement among raft nodes before linearized reading'  (duration: 134.155197ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:01:52.992388Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2578}
{"level":"info","ts":"2026-03-13T10:01:53.046543Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2578,"took":"52.834137ms","hash":839465975,"current-db-size-bytes":40394752,"current-db-size":"40 MB","current-db-size-in-use-bytes":29892608,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-03-13T10:01:53.046603Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":839465975,"revision":2578,"compact-revision":-1}
{"level":"warn","ts":"2026-03-13T10:06:21.445118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.743134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-13T10:06:21.445254Z","caller":"traceutil/trace.go:171","msg":"trace[968793999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7389; }","duration":"434.060744ms","start":"2026-03-13T10:06:21.01117Z","end":"2026-03-13T10:06:21.44523Z","steps":["trace[968793999] 'range keys from in-memory index tree'  (duration: 431.508269ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:06:21.445309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:06:21.011145Z","time spent":"434.146685ms","remote":"127.0.0.1:48614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-13T10:06:21.445686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.397429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-03-13T10:06:21.445781Z","caller":"traceutil/trace.go:171","msg":"trace[1103546554] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7389; }","duration":"426.525162ms","start":"2026-03-13T10:06:21.019223Z","end":"2026-03-13T10:06:21.445749Z","steps":["trace[1103546554] 'range keys from in-memory index tree'  (duration: 426.234226ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:06:21.445825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:06:21.019205Z","time spent":"426.611704ms","remote":"127.0.0.1:48614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-03-13T10:06:21.44606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.696794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"}
{"level":"info","ts":"2026-03-13T10:06:21.446091Z","caller":"traceutil/trace.go:171","msg":"trace[700651331] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:7389; }","duration":"409.746624ms","start":"2026-03-13T10:06:21.036333Z","end":"2026-03-13T10:06:21.44608Z","steps":["trace[700651331] 'range keys from in-memory index tree'  (duration: 409.585861ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:06:21.446116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:06:21.036306Z","time spent":"409.804576ms","remote":"127.0.0.1:48614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":592,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-03-13T10:06:21.446279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.254737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-13T10:06:21.446307Z","caller":"traceutil/trace.go:171","msg":"trace[1136196645] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7389; }","duration":"404.291868ms","start":"2026-03-13T10:06:21.042005Z","end":"2026-03-13T10:06:21.446297Z","steps":["trace[1136196645] 'range keys from in-memory index tree'  (duration: 404.179456ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:06:21.446332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:06:21.041998Z","time spent":"404.328519ms","remote":"127.0.0.1:48614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-13T10:06:21.446566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.256717ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8099052019170198578 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:7220 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-13T10:06:21.446696Z","caller":"traceutil/trace.go:171","msg":"trace[1187734679] linearizableReadLoop","detail":"{readStateIndex:7662; appliedIndex:7661; }","duration":"299.390503ms","start":"2026-03-13T10:06:21.147293Z","end":"2026-03-13T10:06:21.446683Z","steps":["trace[1187734679] 'read index received'  (duration: 129.974712ms)","trace[1187734679] 'applied index is now lower than readState.Index'  (duration: 169.414431ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T10:06:21.446733Z","caller":"traceutil/trace.go:171","msg":"trace[1637456003] transaction","detail":"{read_only:false; response_revision:7390; number_of_response:1; }","duration":"309.102119ms","start":"2026-03-13T10:06:21.13759Z","end":"2026-03-13T10:06:21.446693Z","steps":["trace[1637456003] 'process raft request'  (duration: 139.665118ms)","trace[1637456003] 'compare'  (duration: 168.203265ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T10:06:21.446818Z","caller":"traceutil/trace.go:171","msg":"trace[763294057] transaction","detail":"{read_only:false; response_revision:7391; number_of_response:1; }","duration":"195.364014ms","start":"2026-03-13T10:06:21.251433Z","end":"2026-03-13T10:06:21.446797Z","steps":["trace[763294057] 'process raft request'  (duration: 195.201551ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:06:21.446879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.584637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mrfv9\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-03-13T10:06:21.446905Z","caller":"traceutil/trace.go:171","msg":"trace[817646548] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mrfv9; range_end:; response_count:1; response_revision:7391; }","duration":"299.637047ms","start":"2026-03-13T10:06:21.147257Z","end":"2026-03-13T10:06:21.446894Z","steps":["trace[817646548] 'agreement among raft nodes before linearized reading'  (duration: 299.508635ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:06:21.446904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:06:21.137567Z","time spent":"309.245272ms","remote":"127.0.0.1:48614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:7220 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-03-13T10:06:21.446978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.46663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-13T10:06:21.447016Z","caller":"traceutil/trace.go:171","msg":"trace[916379629] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7391; }","duration":"236.532482ms","start":"2026-03-13T10:06:21.210473Z","end":"2026-03-13T10:06:21.447005Z","steps":["trace[916379629] 'agreement among raft nodes before linearized reading'  (duration: 236.4354ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:06:21.447028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.290964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-03-13T10:06:21.44709Z","caller":"traceutil/trace.go:171","msg":"trace[534583441] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7391; }","duration":"294.377935ms","start":"2026-03-13T10:06:21.152695Z","end":"2026-03-13T10:06:21.447073Z","steps":["trace[534583441] 'agreement among raft nodes before linearized reading'  (duration: 294.163891ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:06:33.602153Z","caller":"traceutil/trace.go:171","msg":"trace[10511139] transaction","detail":"{read_only:false; response_revision:7447; number_of_response:1; }","duration":"110.250729ms","start":"2026-03-13T10:06:33.49188Z","end":"2026-03-13T10:06:33.602131Z","steps":["trace[10511139] 'process raft request'  (duration: 110.016375ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:06:33.717748Z","caller":"traceutil/trace.go:171","msg":"trace[874169329] transaction","detail":"{read_only:false; response_revision:7449; number_of_response:1; }","duration":"111.135419ms","start":"2026-03-13T10:06:33.606578Z","end":"2026-03-13T10:06:33.717713Z","steps":["trace[874169329] 'process raft request'  (duration: 110.849472ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:06:33.717998Z","caller":"traceutil/trace.go:171","msg":"trace[2100517513] transaction","detail":"{read_only:false; response_revision:7451; number_of_response:1; }","duration":"111.239402ms","start":"2026-03-13T10:06:33.606744Z","end":"2026-03-13T10:06:33.717983Z","steps":["trace[2100517513] 'process raft request'  (duration: 111.104359ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:06:33.717999Z","caller":"traceutil/trace.go:171","msg":"trace[1405230674] linearizableReadLoop","detail":"{readStateIndex:7728; appliedIndex:7723; }","duration":"110.153768ms","start":"2026-03-13T10:06:33.60782Z","end":"2026-03-13T10:06:33.717974Z","steps":["trace[1405230674] 'read index received'  (duration: 46.291611ms)","trace[1405230674] 'applied index is now lower than readState.Index'  (duration: 63.860527ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T10:06:33.718169Z","caller":"traceutil/trace.go:171","msg":"trace[1000863909] transaction","detail":"{read_only:false; response_revision:7452; number_of_response:1; }","duration":"110.765442ms","start":"2026-03-13T10:06:33.607311Z","end":"2026-03-13T10:06:33.718076Z","steps":["trace[1000863909] 'process raft request'  (duration: 110.612798ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:06:33.718235Z","caller":"traceutil/trace.go:171","msg":"trace[1162072984] transaction","detail":"{read_only:false; response_revision:7450; number_of_response:1; }","duration":"111.61586ms","start":"2026-03-13T10:06:33.606599Z","end":"2026-03-13T10:06:33.718215Z","steps":["trace[1162072984] 'process raft request'  (duration: 111.042398ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:06:33.718886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.043067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:24 size:207037"}
{"level":"info","ts":"2026-03-13T10:06:33.718962Z","caller":"traceutil/trace.go:171","msg":"trace[210791212] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:24; response_revision:7452; }","duration":"111.17383ms","start":"2026-03-13T10:06:33.60777Z","end":"2026-03-13T10:06:33.718944Z","steps":["trace[210791212] 'agreement among raft nodes before linearized reading'  (duration: 110.288611ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:06:52.998995Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5523}
{"level":"info","ts":"2026-03-13T10:06:53.090211Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5523,"took":"89.164059ms","hash":3898586785,"current-db-size-bytes":43319296,"current-db-size":"43 MB","current-db-size-in-use-bytes":22601728,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-03-13T10:06:53.090273Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3898586785,"revision":5523,"compact-revision":2578}
{"level":"warn","ts":"2026-03-13T10:07:01.803103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.394227ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8099052019170199416 > lease_revoke:<id:70659ce69c0cc5eb>","response":"size:27"}
{"level":"info","ts":"2026-03-13T10:07:15.389182Z","caller":"traceutil/trace.go:171","msg":"trace[453761863] linearizableReadLoop","detail":"{readStateIndex:8030; appliedIndex:8029; }","duration":"186.530383ms","start":"2026-03-13T10:07:15.202627Z","end":"2026-03-13T10:07:15.389158Z","steps":["trace[453761863] 'read index received'  (duration: 186.4015ms)","trace[453761863] 'applied index is now lower than readState.Index'  (duration: 127.843µs)"],"step_count":2}
{"level":"info","ts":"2026-03-13T10:07:15.389281Z","caller":"traceutil/trace.go:171","msg":"trace[2107604794] transaction","detail":"{read_only:false; response_revision:7742; number_of_response:1; }","duration":"187.071194ms","start":"2026-03-13T10:07:15.202154Z","end":"2026-03-13T10:07:15.389225Z","steps":["trace[2107604794] 'process raft request'  (duration: 186.791798ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:07:15.389448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.790818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-t2hds\" ","response":"range_response_count:1 size:4648"}
{"level":"info","ts":"2026-03-13T10:07:15.389545Z","caller":"traceutil/trace.go:171","msg":"trace[1752953054] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-t2hds; range_end:; response_count:1; response_revision:7742; }","duration":"186.919961ms","start":"2026-03-13T10:07:15.202601Z","end":"2026-03-13T10:07:15.389521Z","steps":["trace[1752953054] 'agreement among raft nodes before linearized reading'  (duration: 186.647785ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:07:15.532666Z","caller":"traceutil/trace.go:171","msg":"trace[370635725] linearizableReadLoop","detail":"{readStateIndex:8031; appliedIndex:8030; }","duration":"143.389859ms","start":"2026-03-13T10:07:15.389255Z","end":"2026-03-13T10:07:15.532645Z","steps":["trace[370635725] 'read index received'  (duration: 103.190899ms)","trace[370635725] 'applied index is now lower than readState.Index'  (duration: 40.198139ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-13T10:07:15.532863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.638682ms","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-03-13T10:07:15.532885Z","caller":"traceutil/trace.go:171","msg":"trace[597540981] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7743; }","duration":"212.679592ms","start":"2026-03-13T10:07:15.320199Z","end":"2026-03-13T10:07:15.532878Z","steps":["trace[597540981] 'agreement among raft nodes before linearized reading'  (duration: 212.519949ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:07:15.532872Z","caller":"traceutil/trace.go:171","msg":"trace[329526374] transaction","detail":"{read_only:false; response_revision:7743; number_of_response:1; }","duration":"330.166146ms","start":"2026-03-13T10:07:15.202666Z","end":"2026-03-13T10:07:15.532832Z","steps":["trace[329526374] 'process raft request'  (duration: 289.761642ms)","trace[329526374] 'compare'  (duration: 40.089668ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-13T10:07:15.533003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T10:07:15.202655Z","time spent":"330.29048ms","remote":"127.0.0.1:48436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-detect-version-t2hds.189c5ea97613d58e\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-detect-version-t2hds.189c5ea97613d58e\" value_size:654 lease:8099052019170198717 >> failure:<>"}
{"level":"info","ts":"2026-03-13T10:07:15.594481Z","caller":"traceutil/trace.go:171","msg":"trace[1733627915] transaction","detail":"{read_only:false; response_revision:7744; number_of_response:1; }","duration":"197.210361ms","start":"2026-03-13T10:07:15.397241Z","end":"2026-03-13T10:07:15.594452Z","steps":["trace[1733627915] 'process raft request'  (duration: 197.059587ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:07:15.660578Z","caller":"traceutil/trace.go:171","msg":"trace[1039051172] transaction","detail":"{read_only:false; response_revision:7745; number_of_response:1; }","duration":"166.809611ms","start":"2026-03-13T10:07:15.493737Z","end":"2026-03-13T10:07:15.660546Z","steps":["trace[1039051172] 'process raft request'  (duration: 160.338102ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:07:15.660559Z","caller":"traceutil/trace.go:171","msg":"trace[430826782] transaction","detail":"{read_only:false; response_revision:7746; number_of_response:1; }","duration":"124.210639ms","start":"2026-03-13T10:07:15.536321Z","end":"2026-03-13T10:07:15.660532Z","steps":["trace[430826782] 'process raft request'  (duration: 124.156228ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:07:16.450474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.047514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5146"}
{"level":"info","ts":"2026-03-13T10:07:16.450551Z","caller":"traceutil/trace.go:171","msg":"trace[249628560] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:7753; }","duration":"159.163027ms","start":"2026-03-13T10:07:16.29137Z","end":"2026-03-13T10:07:16.450533Z","steps":["trace[249628560] 'range keys from in-memory index tree'  (duration: 158.918052ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:08:22.19059Z","caller":"traceutil/trace.go:171","msg":"trace[1428424702] transaction","detail":"{read_only:false; response_revision:8347; number_of_response:1; }","duration":"103.606687ms","start":"2026-03-13T10:08:22.086814Z","end":"2026-03-13T10:08:22.19042Z","steps":["trace[1428424702] 'process raft request'  (duration: 48.484927ms)","trace[1428424702] 'compare'  (duration: 55.002427ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T10:08:22.449984Z","caller":"traceutil/trace.go:171","msg":"trace[1445113149] linearizableReadLoop","detail":"{readStateIndex:8654; appliedIndex:8653; }","duration":"176.826805ms","start":"2026-03-13T10:08:22.273132Z","end":"2026-03-13T10:08:22.449959Z","steps":["trace[1445113149] 'read index received'  (duration: 157.351949ms)","trace[1445113149] 'applied index is now lower than readState.Index'  (duration: 19.473316ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T10:08:22.450126Z","caller":"traceutil/trace.go:171","msg":"trace[1534318048] transaction","detail":"{read_only:false; response_revision:8348; number_of_response:1; }","duration":"184.688503ms","start":"2026-03-13T10:08:22.265422Z","end":"2026-03-13T10:08:22.450111Z","steps":["trace[1534318048] 'process raft request'  (duration: 165.092303ms)","trace[1534318048] 'compare'  (duration: 18.032626ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-13T10:08:22.450411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.434258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-03-13T10:08:22.450512Z","caller":"traceutil/trace.go:171","msg":"trace[616214093] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8348; }","duration":"163.575911ms","start":"2026-03-13T10:08:22.286911Z","end":"2026-03-13T10:08:22.450487Z","steps":["trace[616214093] 'agreement among raft nodes before linearized reading'  (duration: 163.318926ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:08:22.450627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.177185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mrfv9\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-03-13T10:08:22.450675Z","caller":"traceutil/trace.go:171","msg":"trace[74759349] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mrfv9; range_end:; response_count:1; response_revision:8348; }","duration":"101.271797ms","start":"2026-03-13T10:08:22.349392Z","end":"2026-03-13T10:08:22.450664Z","steps":["trace[74759349] 'agreement among raft nodes before linearized reading'  (duration: 101.106984ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:08:22.450833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.78161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-03-13T10:08:22.450886Z","caller":"traceutil/trace.go:171","msg":"trace[1194012905] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8348; }","duration":"159.834641ms","start":"2026-03-13T10:08:22.291038Z","end":"2026-03-13T10:08:22.450872Z","steps":["trace[1194012905] 'agreement among raft nodes before linearized reading'  (duration: 159.696818ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:08:22.451029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.891878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"}
{"level":"info","ts":"2026-03-13T10:08:22.451083Z","caller":"traceutil/trace.go:171","msg":"trace[784816941] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8348; }","duration":"177.97226ms","start":"2026-03-13T10:08:22.273097Z","end":"2026-03-13T10:08:22.451069Z","steps":["trace[784816941] 'agreement among raft nodes before linearized reading'  (duration: 177.774956ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T10:08:22.45113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.644038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-13T10:08:22.451329Z","caller":"traceutil/trace.go:171","msg":"trace[26981485] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8348; }","duration":"160.856313ms","start":"2026-03-13T10:08:22.290456Z","end":"2026-03-13T10:08:22.451313Z","steps":["trace[26981485] 'agreement among raft nodes before linearized reading'  (duration: 160.589087ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:08:22.576716Z","caller":"traceutil/trace.go:171","msg":"trace[721310963] linearizableReadLoop","detail":"{readStateIndex:8655; appliedIndex:8654; }","duration":"120.07957ms","start":"2026-03-13T10:08:22.456613Z","end":"2026-03-13T10:08:22.576693Z","steps":["trace[721310963] 'read index received'  (duration: 95.195137ms)","trace[721310963] 'applied index is now lower than readState.Index'  (duration: 24.883213ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-13T10:08:22.577084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.457028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:28 size:244637"}
{"level":"info","ts":"2026-03-13T10:08:22.577113Z","caller":"traceutil/trace.go:171","msg":"trace[120420400] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:28; response_revision:8349; }","duration":"120.501458ms","start":"2026-03-13T10:08:22.456604Z","end":"2026-03-13T10:08:22.577105Z","steps":["trace[120420400] 'agreement among raft nodes before linearized reading'  (duration: 120.168831ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:08:22.577238Z","caller":"traceutil/trace.go:171","msg":"trace[1317472128] transaction","detail":"{read_only:false; response_revision:8349; number_of_response:1; }","duration":"121.593172ms","start":"2026-03-13T10:08:22.455613Z","end":"2026-03-13T10:08:22.577207Z","steps":["trace[1317472128] 'process raft request'  (duration: 96.248309ms)","trace[1317472128] 'compare'  (duration: 24.73963ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T10:08:22.606075Z","caller":"traceutil/trace.go:171","msg":"trace[1120307068] transaction","detail":"{read_only:false; response_revision:8350; number_of_response:1; }","duration":"149.419948ms","start":"2026-03-13T10:08:22.456628Z","end":"2026-03-13T10:08:22.606047Z","steps":["trace[1120307068] 'process raft request'  (duration: 149.223543ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:08:22.606105Z","caller":"traceutil/trace.go:171","msg":"trace[18103487] transaction","detail":"{read_only:false; response_revision:8352; number_of_response:1; }","duration":"148.831205ms","start":"2026-03-13T10:08:22.457251Z","end":"2026-03-13T10:08:22.606082Z","steps":["trace[18103487] 'process raft request'  (duration: 148.777174ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:08:22.606202Z","caller":"traceutil/trace.go:171","msg":"trace[124433499] transaction","detail":"{read_only:false; response_revision:8351; number_of_response:1; }","duration":"149.415127ms","start":"2026-03-13T10:08:22.456752Z","end":"2026-03-13T10:08:22.606167Z","steps":["trace[124433499] 'process raft request'  (duration: 149.229743ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:10:44.243859Z","caller":"traceutil/trace.go:171","msg":"trace[1030864861] transaction","detail":"{read_only:false; response_revision:9442; number_of_response:1; }","duration":"113.739316ms","start":"2026-03-13T10:10:44.129981Z","end":"2026-03-13T10:10:44.24372Z","steps":["trace[1030864861] 'process raft request'  (duration: 113.560533ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T10:11:17.483415Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"36b63984d68b7065","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-13T10:11:17.491151Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-13T10:11:17.491242Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-13T10:11:53.004353Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7545}
{"level":"info","ts":"2026-03-13T10:11:53.06177Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7545,"took":"53.728442ms","hash":3692493089,"current-db-size-bytes":43319296,"current-db-size":"43 MB","current-db-size-in-use-bytes":25079808,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-03-13T10:11:53.061858Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3692493089,"revision":7545,"compact-revision":5523}
{"level":"info","ts":"2026-03-13T10:16:53.010126Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9827}
{"level":"info","ts":"2026-03-13T10:16:53.087428Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9827,"took":"75.532257ms","hash":652790605,"current-db-size-bytes":43319296,"current-db-size":"43 MB","current-db-size-in-use-bytes":16445440,"current-db-size-in-use":"16 MB"}
{"level":"info","ts":"2026-03-13T10:16:53.087508Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":652790605,"revision":9827,"compact-revision":7545}