{"level":"warn","ts":"2026-04-09T22:30:08.623211Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-09T22:30:08.623311Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-04-09T22:30:08.623621Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-09T22:30:08.623643Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]}
{"level":"info","ts":"2026-04-09T22:30:08.623668Z","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-04-09T22:30:08.624339Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]}
{"level":"info","ts":"2026-04-09T22:30:08.624421Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-04-09T22:30:08.628005Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.362895ms"}
{"level":"info","ts":"2026-04-09T22:30:08.633904Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"}
{"level":"info","ts":"2026-04-09T22:30:08.634021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-09T22:30:08.634054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"}
{"level":"info","ts":"2026-04-09T22:30:08.634083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-09T22:30:08.634098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"}
{"level":"info","ts":"2026-04-09T22:30:08.634158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"}
{"level":"warn","ts":"2026-04-09T22:30:08.643502Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-09T22:30:08.64463Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-09T22:30:08.645891Z","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-04-09T22:30:08.649158Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-09T22:30:08.649398Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-09T22:30:08.649462Z","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-04-09T22:30:08.650075Z","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-04-09T22:30:08.65015Z","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-04-09T22:30:08.651289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"}
{"level":"info","ts":"2026-04-09T22:30:08.651484Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]}
{"level":"info","ts":"2026-04-09T22:30:08.653907Z","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-04-09T22:30:08.654237Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-09T22:30:08.65427Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-09T22:30:08.654364Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"}
{"level":"info","ts":"2026-04-09T22:30:08.654395Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"}
{"level":"info","ts":"2026-04-09T22:30:09.63446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-09T22:30:09.634541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-09T22:30:09.634583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"}
{"level":"info","ts":"2026-04-09T22:30:09.634603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"}
{"level":"info","ts":"2026-04-09T22:30:09.634614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"}
{"level":"info","ts":"2026-04-09T22:30:09.634637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"}
{"level":"info","ts":"2026-04-09T22:30:09.634651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"}
{"level":"info","ts":"2026-04-09T22:30:09.635703Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-09T22:30:09.636437Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-09T22:30:09.63646Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-09T22:30:09.636484Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-09T22:30:09.636839Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-09T22:30:09.636841Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-09T22:30:09.636946Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-09T22:30:09.63696Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-09T22:30:09.63701Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-09T22:30:09.641695Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-09T22:30:09.643838Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"}
{"level":"info","ts":"2026-04-09T22:30:44.504852Z","caller":"traceutil/trace.go:171","msg":"trace[544786600] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"288.013839ms","start":"2026-04-09T22:30:44.216809Z","end":"2026-04-09T22:30:44.504823Z","steps":["trace[544786600] 'process raft request'  (duration: 275.648579ms)","trace[544786600] 'compare'  (duration: 12.245287ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:30:44.558668Z","caller":"traceutil/trace.go:171","msg":"trace[1520554522] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:636; }","duration":"142.857243ms","start":"2026-04-09T22:30:44.415783Z","end":"2026-04-09T22:30:44.55864Z","steps":["trace[1520554522] 'read index received'  (duration: 76.697915ms)","trace[1520554522] 'applied index is now lower than readState.Index'  (duration: 66.158308ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:30:44.558787Z","caller":"traceutil/trace.go:171","msg":"trace[1031307839] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"300.776296ms","start":"2026-04-09T22:30:44.257961Z","end":"2026-04-09T22:30:44.558737Z","steps":["trace[1031307839] 'process raft request'  (duration: 300.563172ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:30:44.558971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.413444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mgdtm\" ","response":"range_response_count:1 size:16965"}
{"level":"warn","ts":"2026-04-09T22:30:44.558977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.135608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:30:44.55911Z","caller":"traceutil/trace.go:171","msg":"trace[554318001] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mgdtm; range_end:; response_count:1; response_revision:616; }","duration":"142.587488ms","start":"2026-04-09T22:30:44.416504Z","end":"2026-04-09T22:30:44.559091Z","steps":["trace[554318001] 'agreement among raft nodes before linearized reading'  (duration: 142.284762ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:30:44.55913Z","caller":"traceutil/trace.go:171","msg":"trace[1683416126] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"143.377022ms","start":"2026-04-09T22:30:44.41573Z","end":"2026-04-09T22:30:44.559107Z","steps":["trace[1683416126] 'agreement among raft nodes before linearized reading'  (duration: 143.053206ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:30:44.559295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:30:44.257929Z","time spent":"300.935939ms","remote":"127.0.0.1:47702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"warn","ts":"2026-04-09T22:30:45.020695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.582649ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415871965502111488 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-mgdtm\" mod_revision:499 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-mgdtm\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-mgdtm\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-09T22:30:45.020851Z","caller":"traceutil/trace.go:171","msg":"trace[68904772] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"331.468426ms","start":"2026-04-09T22:30:44.689336Z","end":"2026-04-09T22:30:45.020805Z","steps":["trace[68904772] 'read index received'  (duration: 157.596078ms)","trace[68904772] 'applied index is now lower than readState.Index'  (duration: 173.870078ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:30:45.020927Z","caller":"traceutil/trace.go:171","msg":"trace[107623024] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"446.318228ms","start":"2026-04-09T22:30:44.574546Z","end":"2026-04-09T22:30:45.020864Z","steps":["trace[107623024] 'process raft request'  (duration: 272.45428ms)","trace[107623024] 'compare'  (duration: 169.447366ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:30:45.021006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.672649ms","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-04-09T22:30:45.021064Z","caller":"traceutil/trace.go:171","msg":"trace[554346314] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:617; }","duration":"331.76271ms","start":"2026-04-09T22:30:44.689283Z","end":"2026-04-09T22:30:45.021046Z","steps":["trace[554346314] 'agreement among raft nodes before linearized reading'  (duration: 331.604347ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:30:45.021101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:30:44.689263Z","time spent":"331.830082ms","remote":"127.0.0.1:47504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-09T22:30:45.021204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:30:44.574534Z","time spent":"446.523211ms","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-mgdtm\" mod_revision:499 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-mgdtm\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-mgdtm\" > >"}
{"level":"warn","ts":"2026-04-09T22:32:11.585651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.039918ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415871965502113806 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" mod_revision:1738 > success:<request_put:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" value_size:562 >> failure:<request_range:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-09T22:32:11.585784Z","caller":"traceutil/trace.go:171","msg":"trace[1814721948] linearizableReadLoop","detail":"{readStateIndex:1865; appliedIndex:1864; }","duration":"169.911727ms","start":"2026-04-09T22:32:11.415835Z","end":"2026-04-09T22:32:11.585747Z","steps":["trace[1814721948] 'read index received'  (duration: 32.961µs)","trace[1814721948] 'applied index is now lower than readState.Index'  (duration: 169.877176ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:32:11.585887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.059539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:32:11.585924Z","caller":"traceutil/trace.go:171","msg":"trace[1101908945] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1812; }","duration":"170.129231ms","start":"2026-04-09T22:32:11.415785Z","end":"2026-04-09T22:32:11.585915Z","steps":["trace[1101908945] 'agreement among raft nodes before linearized reading'  (duration: 170.06684ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:32:11.585929Z","caller":"traceutil/trace.go:171","msg":"trace[1448102372] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"356.519899ms","start":"2026-04-09T22:32:11.229332Z","end":"2026-04-09T22:32:11.585852Z","steps":["trace[1448102372] 'process raft request'  (duration: 87.154875ms)","trace[1448102372] 'compare'  (duration: 268.690381ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:32:11.586206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:32:11.229313Z","time spent":"356.728793ms","remote":"127.0.0.1:47330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":644,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" mod_revision:1738 > success:<request_put:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" value_size:562 >> failure:<request_range:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-09T22:32:17.165247Z","caller":"traceutil/trace.go:171","msg":"trace[324089930] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"120.961613ms","start":"2026-04-09T22:32:17.044262Z","end":"2026-04-09T22:32:17.165224Z","steps":["trace[324089930] 'process raft request'  (duration: 120.751449ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:32:53.436172Z","caller":"traceutil/trace.go:171","msg":"trace[1920365047] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"100.252263ms","start":"2026-04-09T22:32:53.335892Z","end":"2026-04-09T22:32:53.436144Z","steps":["trace[1920365047] 'process raft request'  (duration: 73.211101ms)","trace[1920365047] 'compare'  (duration: 26.885998ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:33:30.424095Z","caller":"traceutil/trace.go:171","msg":"trace[1346712269] transaction","detail":"{read_only:false; response_revision:2451; number_of_response:1; }","duration":"123.798291ms","start":"2026-04-09T22:33:30.300267Z","end":"2026-04-09T22:33:30.424065Z","steps":["trace[1346712269] 'process raft request'  (duration: 123.630367ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:34:00.856298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.900342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"}
{"level":"info","ts":"2026-04-09T22:34:00.856399Z","caller":"traceutil/trace.go:171","msg":"trace[1994831073] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2661; }","duration":"110.061696ms","start":"2026-04-09T22:34:00.746314Z","end":"2026-04-09T22:34:00.856376Z","steps":["trace[1994831073] 'range keys from in-memory index tree'  (duration: 109.621368ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:34:06.442596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.242663ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415871965502116128 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:2632 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-09T22:34:06.442771Z","caller":"traceutil/trace.go:171","msg":"trace[1241828731] transaction","detail":"{read_only:false; response_revision:2699; number_of_response:1; }","duration":"185.021968ms","start":"2026-04-09T22:34:06.257716Z","end":"2026-04-09T22:34:06.442738Z","steps":["trace[1241828731] 'process raft request'  (duration: 77.53213ms)","trace[1241828731] 'compare'  (duration: 107.102241ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:36:29.549017Z","caller":"traceutil/trace.go:171","msg":"trace[372925583] linearizableReadLoop","detail":"{readStateIndex:4873; appliedIndex:4872; }","duration":"207.663962ms","start":"2026-04-09T22:36:29.341334Z","end":"2026-04-09T22:36:29.548998Z","steps":["trace[372925583] 'read index received'  (duration: 207.487149ms)","trace[372925583] 'applied index is now lower than readState.Index'  (duration: 176.043µs)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:36:29.549276Z","caller":"traceutil/trace.go:171","msg":"trace[25004108] transaction","detail":"{read_only:false; response_revision:4677; number_of_response:1; }","duration":"353.351494ms","start":"2026-04-09T22:36:29.195916Z","end":"2026-04-09T22:36:29.549267Z","steps":["trace[25004108] 'process raft request'  (duration: 352.925486ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:36:29.549355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:36:29.195895Z","time spent":"353.400904ms","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8036,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/memcached-memcached-c47d949f5-zt9h6\" mod_revision:4648 > success:<request_put:<key:\"/registry/pods/openstack/memcached-memcached-c47d949f5-zt9h6\" value_size:7968 >> failure:<request_range:<key:\"/registry/pods/openstack/memcached-memcached-c47d949f5-zt9h6\" > >"}
{"level":"warn","ts":"2026-04-09T22:36:29.549514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.181432ms","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-04-09T22:36:29.549534Z","caller":"traceutil/trace.go:171","msg":"trace[1941450678] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4677; }","duration":"208.235424ms","start":"2026-04-09T22:36:29.341292Z","end":"2026-04-09T22:36:29.549528Z","steps":["trace[1941450678] 'agreement among raft nodes before linearized reading'  (duration: 208.150421ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:36:29.54965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.919703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:36:29.549668Z","caller":"traceutil/trace.go:171","msg":"trace[932246176] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:4677; }","duration":"150.938213ms","start":"2026-04-09T22:36:29.398723Z","end":"2026-04-09T22:36:29.549662Z","steps":["trace[932246176] 'agreement among raft nodes before linearized reading'  (duration: 150.909213ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:36:29.549905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.603439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:36:29.549974Z","caller":"traceutil/trace.go:171","msg":"trace[296902965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4677; }","duration":"133.727901ms","start":"2026-04-09T22:36:29.416228Z","end":"2026-04-09T22:36:29.549955Z","steps":["trace[296902965] 'agreement among raft nodes before linearized reading'  (duration: 133.581348ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:36:29.706945Z","caller":"traceutil/trace.go:171","msg":"trace[595244217] transaction","detail":"{read_only:false; response_revision:4678; number_of_response:1; }","duration":"153.633576ms","start":"2026-04-09T22:36:29.553288Z","end":"2026-04-09T22:36:29.706921Z","steps":["trace[595244217] 'process raft request'  (duration: 153.506544ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:36:29.71746Z","caller":"traceutil/trace.go:171","msg":"trace[912630805] transaction","detail":"{read_only:false; response_revision:4682; number_of_response:1; }","duration":"161.037469ms","start":"2026-04-09T22:36:29.556407Z","end":"2026-04-09T22:36:29.717445Z","steps":["trace[912630805] 'process raft request'  (duration: 160.975408ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:36:29.717513Z","caller":"traceutil/trace.go:171","msg":"trace[1239673247] transaction","detail":"{read_only:false; response_revision:4679; number_of_response:1; }","duration":"161.940295ms","start":"2026-04-09T22:36:29.555524Z","end":"2026-04-09T22:36:29.717464Z","steps":["trace[1239673247] 'process raft request'  (duration: 161.723751ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:36:29.71765Z","caller":"traceutil/trace.go:171","msg":"trace[1901494789] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"162.122241ms","start":"2026-04-09T22:36:29.55552Z","end":"2026-04-09T22:36:29.717642Z","steps":["trace[1901494789] 'process raft request'  (duration: 161.805364ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:36:29.71777Z","caller":"traceutil/trace.go:171","msg":"trace[119230936] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"159.766254ms","start":"2026-04-09T22:36:29.557982Z","end":"2026-04-09T22:36:29.717748Z","steps":["trace[119230936] 'process raft request'  (duration: 159.430137ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:36:29.717807Z","caller":"traceutil/trace.go:171","msg":"trace[486451306] linearizableReadLoop","detail":"{readStateIndex:4877; appliedIndex:4873; }","duration":"162.10147ms","start":"2026-04-09T22:36:29.555697Z","end":"2026-04-09T22:36:29.717799Z","steps":["trace[486451306] 'read index received'  (duration: 151.164398ms)","trace[486451306] 'applied index is now lower than readState.Index'  (duration: 10.936532ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:36:29.717906Z","caller":"traceutil/trace.go:171","msg":"trace[1269447] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"103.066267ms","start":"2026-04-09T22:36:29.614831Z","end":"2026-04-09T22:36:29.717897Z","steps":["trace[1269447] 'process raft request'  (duration: 102.844112ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:36:29.717912Z","caller":"traceutil/trace.go:171","msg":"trace[806545416] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"162.309073ms","start":"2026-04-09T22:36:29.555581Z","end":"2026-04-09T22:36:29.71789Z","steps":["trace[806545416] 'process raft request'  (duration: 161.776803ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:36:29.718071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.359834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-2f9hs\" ","response":"range_response_count:1 size:9901"}
{"level":"info","ts":"2026-04-09T22:36:29.718098Z","caller":"traceutil/trace.go:171","msg":"trace[1260329405] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-2f9hs; range_end:; response_count:1; response_revision:4684; }","duration":"162.423626ms","start":"2026-04-09T22:36:29.555666Z","end":"2026-04-09T22:36:29.718089Z","steps":["trace[1260329405] 'agreement among raft nodes before linearized reading'  (duration: 162.310964ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:36:29.718201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.471157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:50401"}
{"level":"info","ts":"2026-04-09T22:36:29.718245Z","caller":"traceutil/trace.go:171","msg":"trace[1061511951] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:4684; }","duration":"162.567089ms","start":"2026-04-09T22:36:29.555666Z","end":"2026-04-09T22:36:29.718233Z","steps":["trace[1061511951] 'agreement among raft nodes before linearized reading'  (duration: 162.361945ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:36:29.718279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.531719ms","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-04-09T22:36:29.718307Z","caller":"traceutil/trace.go:171","msg":"trace[245459831] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4684; }","duration":"127.586991ms","start":"2026-04-09T22:36:29.590712Z","end":"2026-04-09T22:36:29.718299Z","steps":["trace[245459831] 'agreement among raft nodes before linearized reading'  (duration: 127.53921ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:36:35.932523Z","caller":"traceutil/trace.go:171","msg":"trace[18284078] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"161.64938ms","start":"2026-04-09T22:36:35.77082Z","end":"2026-04-09T22:36:35.932469Z","steps":["trace[18284078] 'process raft request'  (duration: 90.41014ms)","trace[18284078] 'compare'  (duration: 71.116948ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:40:09.662767Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3301}
{"level":"info","ts":"2026-04-09T22:40:09.751248Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3301,"took":"86.845207ms","hash":3315531330,"current-db-size-bytes":60915712,"current-db-size":"61 MB","current-db-size-in-use-bytes":34271232,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-04-09T22:40:09.751327Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3315531330,"revision":3301,"compact-revision":-1}
{"level":"info","ts":"2026-04-09T22:42:21.910932Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000020af.wal"}
{"level":"info","ts":"2026-04-09T22:42:25.499966Z","caller":"traceutil/trace.go:171","msg":"trace[842586734] transaction","detail":"{read_only:false; response_revision:8037; number_of_response:1; }","duration":"217.865627ms","start":"2026-04-09T22:42:25.282072Z","end":"2026-04-09T22:42:25.499938Z","steps":["trace[842586734] 'process raft request'  (duration: 217.591162ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:42:25.606082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.938913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:42:25.606172Z","caller":"traceutil/trace.go:171","msg":"trace[1729474592] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8037; }","duration":"105.066386ms","start":"2026-04-09T22:42:25.501087Z","end":"2026-04-09T22:42:25.606154Z","steps":["trace[1729474592] 'range keys from in-memory index tree'  (duration: 104.864162ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:42:25.606456Z","caller":"traceutil/trace.go:171","msg":"trace[1606957079] transaction","detail":"{read_only:false; response_revision:8038; number_of_response:1; }","duration":"102.05345ms","start":"2026-04-09T22:42:25.504379Z","end":"2026-04-09T22:42:25.606433Z","steps":["trace[1606957079] 'process raft request'  (duration: 64.312487ms)","trace[1606957079] 'compare'  (duration: 37.487349ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:42:37.717807Z","caller":"traceutil/trace.go:171","msg":"trace[1380183027] transaction","detail":"{read_only:false; response_revision:8113; number_of_response:1; }","duration":"182.223602ms","start":"2026-04-09T22:42:37.535549Z","end":"2026-04-09T22:42:37.717772Z","steps":["trace[1380183027] 'process raft request'  (duration: 181.963987ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:42:37.85309Z","caller":"traceutil/trace.go:171","msg":"trace[1911028675] transaction","detail":"{read_only:false; response_revision:8115; number_of_response:1; }","duration":"130.892134ms","start":"2026-04-09T22:42:37.722171Z","end":"2026-04-09T22:42:37.853063Z","steps":["trace[1911028675] 'process raft request'  (duration: 130.794522ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:42:37.853107Z","caller":"traceutil/trace.go:171","msg":"trace[1457652678] transaction","detail":"{read_only:false; response_revision:8114; number_of_response:1; }","duration":"131.15973ms","start":"2026-04-09T22:42:37.721912Z","end":"2026-04-09T22:42:37.853071Z","steps":["trace[1457652678] 'process raft request'  (duration: 99.989837ms)","trace[1457652678] 'compare'  (duration: 30.935437ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:42:37.853137Z","caller":"traceutil/trace.go:171","msg":"trace[553343317] linearizableReadLoop","detail":"{readStateIndex:8478; appliedIndex:8475; }","duration":"105.405149ms","start":"2026-04-09T22:42:37.747703Z","end":"2026-04-09T22:42:37.853108Z","steps":["trace[553343317] 'read index received'  (duration: 74.222846ms)","trace[553343317] 'applied index is now lower than readState.Index'  (duration: 31.180893ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:42:37.853368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.655824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-h4ghd\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-04-09T22:42:37.85344Z","caller":"traceutil/trace.go:171","msg":"trace[651871183] range","detail":"{range_begin:/registry/pods/openstack/keepalived-h4ghd; range_end:; response_count:1; response_revision:8116; }","duration":"105.761665ms","start":"2026-04-09T22:42:37.747668Z","end":"2026-04-09T22:42:37.85343Z","steps":["trace[651871183] 'agreement among raft nodes before linearized reading'  (duration: 105.50631ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:42:37.853727Z","caller":"traceutil/trace.go:171","msg":"trace[75382137] transaction","detail":"{read_only:false; response_revision:8116; number_of_response:1; }","duration":"118.628526ms","start":"2026-04-09T22:42:37.7345Z","end":"2026-04-09T22:42:37.853129Z","steps":["trace[75382137] 'process raft request'  (duration: 118.528943ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:42:38.415518Z","caller":"traceutil/trace.go:171","msg":"trace[116809482] transaction","detail":"{read_only:false; response_revision:8120; number_of_response:1; }","duration":"121.542469ms","start":"2026-04-09T22:42:38.293948Z","end":"2026-04-09T22:42:38.41549Z","steps":["trace[116809482] 'process raft request'  (duration: 121.099421ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:42:38.599396Z","caller":"traceutil/trace.go:171","msg":"trace[513879816] transaction","detail":"{read_only:false; response_revision:8121; number_of_response:1; }","duration":"179.254087ms","start":"2026-04-09T22:42:38.420115Z","end":"2026-04-09T22:42:38.599369Z","steps":["trace[513879816] 'process raft request'  (duration: 86.612237ms)","trace[513879816] 'compare'  (duration: 92.449136ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:42:38.599554Z","caller":"traceutil/trace.go:171","msg":"trace[573894225] linearizableReadLoop","detail":"{readStateIndex:8485; appliedIndex:8483; }","duration":"177.979423ms","start":"2026-04-09T22:42:38.421535Z","end":"2026-04-09T22:42:38.599514Z","steps":["trace[573894225] 'read index received'  (duration: 85.20561ms)","trace[573894225] 'applied index is now lower than readState.Index'  (duration: 92.771443ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:42:38.599665Z","caller":"traceutil/trace.go:171","msg":"trace[1634500110] transaction","detail":"{read_only:false; response_revision:8122; number_of_response:1; }","duration":"179.063824ms","start":"2026-04-09T22:42:38.420549Z","end":"2026-04-09T22:42:38.599612Z","steps":["trace[1634500110] 'process raft request'  (duration: 178.777198ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:42:38.599823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.282653ms","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-04-09T22:42:38.599898Z","caller":"traceutil/trace.go:171","msg":"trace[1236634247] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8122; }","duration":"175.374344ms","start":"2026-04-09T22:42:38.424505Z","end":"2026-04-09T22:42:38.599879Z","steps":["trace[1236634247] 'agreement among raft nodes before linearized reading'  (duration: 175.214321ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:42:38.599824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.267479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:552"}
{"level":"info","ts":"2026-04-09T22:42:38.599978Z","caller":"traceutil/trace.go:171","msg":"trace[54964405] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8122; }","duration":"178.467493ms","start":"2026-04-09T22:42:38.421483Z","end":"2026-04-09T22:42:38.59995Z","steps":["trace[54964405] 'agreement among raft nodes before linearized reading'  (duration: 178.167747ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:42:38.60029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.129902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18239"}
{"level":"info","ts":"2026-04-09T22:42:38.600376Z","caller":"traceutil/trace.go:171","msg":"trace[1624763152] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8122; }","duration":"143.266365ms","start":"2026-04-09T22:42:38.457091Z","end":"2026-04-09T22:42:38.600357Z","steps":["trace[1624763152] 'agreement among raft nodes before linearized reading'  (duration: 142.98464ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:43:04.869039Z","caller":"traceutil/trace.go:171","msg":"trace[354021348] transaction","detail":"{read_only:false; response_revision:8350; number_of_response:1; }","duration":"140.707208ms","start":"2026-04-09T22:43:04.728301Z","end":"2026-04-09T22:43:04.869008Z","steps":["trace[354021348] 'process raft request'  (duration: 140.509454ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:43:04.870017Z","caller":"traceutil/trace.go:171","msg":"trace[674100913] linearizableReadLoop","detail":"{readStateIndex:8726; appliedIndex:8724; }","duration":"122.590968ms","start":"2026-04-09T22:43:04.747398Z","end":"2026-04-09T22:43:04.869989Z","steps":["trace[674100913] 'read index received'  (duration: 121.458928ms)","trace[674100913] 'applied index is now lower than readState.Index'  (duration: 1.1305ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:43:04.870228Z","caller":"traceutil/trace.go:171","msg":"trace[929045567] transaction","detail":"{read_only:false; response_revision:8351; number_of_response:1; }","duration":"141.795258ms","start":"2026-04-09T22:43:04.728375Z","end":"2026-04-09T22:43:04.87017Z","steps":["trace[929045567] 'process raft request'  (duration: 141.446571ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:43:04.870371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.949335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11500"}
{"level":"info","ts":"2026-04-09T22:43:04.870423Z","caller":"traceutil/trace.go:171","msg":"trace[235273875] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8351; }","duration":"123.084348ms","start":"2026-04-09T22:43:04.747324Z","end":"2026-04-09T22:43:04.870409Z","steps":["trace[235273875] 'agreement among raft nodes before linearized reading'  (duration: 122.814543ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:43:04.870447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.898058ms","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-04-09T22:43:04.87051Z","caller":"traceutil/trace.go:171","msg":"trace[1289028307] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8351; }","duration":"106.03406ms","start":"2026-04-09T22:43:04.764464Z","end":"2026-04-09T22:43:04.870498Z","steps":["trace[1289028307] 'agreement among raft nodes before linearized reading'  (duration: 105.815806ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:43:18.608774Z","caller":"traceutil/trace.go:171","msg":"trace[1878361012] linearizableReadLoop","detail":"{readStateIndex:8868; appliedIndex:8867; }","duration":"220.64005ms","start":"2026-04-09T22:43:18.38811Z","end":"2026-04-09T22:43:18.60875Z","steps":["trace[1878361012] 'read index received'  (duration: 220.554118ms)","trace[1878361012] 'applied index is now lower than readState.Index'  (duration: 84.792µs)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:43:18.608874Z","caller":"traceutil/trace.go:171","msg":"trace[2089690956] transaction","detail":"{read_only:false; response_revision:8482; number_of_response:1; }","duration":"228.642329ms","start":"2026-04-09T22:43:18.380224Z","end":"2026-04-09T22:43:18.608867Z","steps":["trace[2089690956] 'process raft request'  (duration: 228.338984ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:43:18.609077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.956595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-jqhgm\" ","response":"range_response_count:1 size:4615"}
{"level":"info","ts":"2026-04-09T22:43:18.609113Z","caller":"traceutil/trace.go:171","msg":"trace[535173677] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-jqhgm; range_end:; response_count:1; response_revision:8482; }","duration":"221.037007ms","start":"2026-04-09T22:43:18.388067Z","end":"2026-04-09T22:43:18.609104Z","steps":["trace[535173677] 'agreement among raft nodes before linearized reading'  (duration: 220.909395ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:43:18.661793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.198998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:43:18.66187Z","caller":"traceutil/trace.go:171","msg":"trace[864276044] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8484; }","duration":"245.319771ms","start":"2026-04-09T22:43:18.416535Z","end":"2026-04-09T22:43:18.661855Z","steps":["trace[864276044] 'agreement among raft nodes before linearized reading'  (duration: 245.189168ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:43:18.661877Z","caller":"traceutil/trace.go:171","msg":"trace[1600712561] transaction","detail":"{read_only:false; response_revision:8483; number_of_response:1; }","duration":"273.188741ms","start":"2026-04-09T22:43:18.388647Z","end":"2026-04-09T22:43:18.661836Z","steps":["trace[1600712561] 'process raft request'  (duration: 253.352021ms)","trace[1600712561] 'compare'  (duration: 19.544435ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:43:18.661884Z","caller":"traceutil/trace.go:171","msg":"trace[1744613019] transaction","detail":"{read_only:false; response_revision:8484; number_of_response:1; }","duration":"267.28965ms","start":"2026-04-09T22:43:18.394561Z","end":"2026-04-09T22:43:18.66185Z","steps":["trace[1744613019] 'process raft request'  (duration: 267.102217ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:43:18.662142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.076413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"}
{"level":"info","ts":"2026-04-09T22:43:18.662205Z","caller":"traceutil/trace.go:171","msg":"trace[1891178686] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8484; }","duration":"164.157245ms","start":"2026-04-09T22:43:18.498031Z","end":"2026-04-09T22:43:18.662189Z","steps":["trace[1891178686] 'agreement among raft nodes before linearized reading'  (duration: 163.935341ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:43:20.207033Z","caller":"traceutil/trace.go:171","msg":"trace[1878223583] linearizableReadLoop","detail":"{readStateIndex:8882; appliedIndex:8880; }","duration":"106.134381ms","start":"2026-04-09T22:43:20.100855Z","end":"2026-04-09T22:43:20.206989Z","steps":["trace[1878223583] 'read index received'  (duration: 18.081958ms)","trace[1878223583] 'applied index is now lower than readState.Index'  (duration: 88.050973ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:43:20.207227Z","caller":"traceutil/trace.go:171","msg":"trace[1475090125] transaction","detail":"{read_only:false; response_revision:8496; number_of_response:1; }","duration":"108.966665ms","start":"2026-04-09T22:43:20.098236Z","end":"2026-04-09T22:43:20.207203Z","steps":["trace[1475090125] 'process raft request'  (duration: 94.774839ms)","trace[1475090125] 'compare'  (duration: 13.855089ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:43:20.207456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.57781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:208113"}
{"level":"info","ts":"2026-04-09T22:43:20.207507Z","caller":"traceutil/trace.go:171","msg":"trace[2099437131] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8496; }","duration":"106.662211ms","start":"2026-04-09T22:43:20.100832Z","end":"2026-04-09T22:43:20.207494Z","steps":["trace[2099437131] 'agreement among raft nodes before linearized reading'  (duration: 106.271984ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:44:26.536098Z","caller":"traceutil/trace.go:171","msg":"trace[1845637505] transaction","detail":"{read_only:false; response_revision:9218; number_of_response:1; }","duration":"107.151228ms","start":"2026-04-09T22:44:26.428718Z","end":"2026-04-09T22:44:26.535869Z","steps":["trace[1845637505] 'process raft request'  (duration: 106.993155ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:45:05.876793Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-09T22:45:05.882388Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-09T22:45:05.882491Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-04-09T22:45:09.668323Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6724}
{"level":"info","ts":"2026-04-09T22:45:09.773117Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6724,"took":"97.458449ms","hash":3051712139,"current-db-size-bytes":60915712,"current-db-size":"61 MB","current-db-size-in-use-bytes":27267072,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-04-09T22:45:09.773232Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3051712139,"revision":6724,"compact-revision":3301}
{"level":"info","ts":"2026-04-09T22:50:09.675705Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9592}
{"level":"info","ts":"2026-04-09T22:50:09.76526Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9592,"took":"87.05117ms","hash":3485787289,"current-db-size-bytes":60915712,"current-db-size":"61 MB","current-db-size-in-use-bytes":25149440,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-04-09T22:50:09.765318Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3485787289,"revision":9592,"compact-revision":6724}