{"level":"warn","ts":"2026-05-05T07:00:14.094361Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-05T07:00:14.094443Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3: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.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3: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-05-05T07:00:14.094507Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-05T07:00:14.094514Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]}
{"level":"info","ts":"2026-05-05T07:00:14.094532Z","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-05-05T07:00:14.095104Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]}
{"level":"info","ts":"2026-05-05T07:00:14.095211Z","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.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3: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-05-05T07:00:14.101973Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.550417ms"}
{"level":"info","ts":"2026-05-05T07:00:14.110124Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"}
{"level":"info","ts":"2026-05-05T07:00:14.110254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"}
{"level":"info","ts":"2026-05-05T07:00:14.110293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"}
{"level":"info","ts":"2026-05-05T07:00:14.110333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-05T07:00:14.110361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"}
{"level":"info","ts":"2026-05-05T07:00:14.110425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"}
{"level":"warn","ts":"2026-05-05T07:00:14.117328Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-05T07:00:14.118682Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-05T07:00:14.121285Z","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-05-05T07:00:14.12407Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-05T07:00:14.124299Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-05T07:00:14.124497Z","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-05-05T07:00:14.124693Z","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-05-05T07:00:14.124728Z","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-05-05T07:00:14.125964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"}
{"level":"info","ts":"2026-05-05T07:00:14.12631Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]}
{"level":"info","ts":"2026-05-05T07:00:14.128065Z","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-05-05T07:00:14.128178Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"}
{"level":"info","ts":"2026-05-05T07:00:14.128248Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"}
{"level":"info","ts":"2026-05-05T07:00:14.128261Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-05T07:00:14.1283Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-05T07:00:14.911564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"}
{"level":"info","ts":"2026-05-05T07:00:14.911649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-05T07:00:14.911683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"}
{"level":"info","ts":"2026-05-05T07:00:14.911705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"}
{"level":"info","ts":"2026-05-05T07:00:14.911717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"}
{"level":"info","ts":"2026-05-05T07:00:14.911734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"}
{"level":"info","ts":"2026-05-05T07:00:14.911748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"}
{"level":"info","ts":"2026-05-05T07:00:14.912803Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T07:00:14.913642Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-05T07:00:14.913695Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-05T07:00:14.913746Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-05T07:00:14.914Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-05T07:00:14.914043Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-05T07:00:14.914177Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T07:00:14.914322Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T07:00:14.914372Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T07:00:14.916886Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"}
{"level":"info","ts":"2026-05-05T07:00:14.917611Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-05T07:00:45.405139Z","caller":"traceutil/trace.go:171","msg":"trace[1637076846] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"257.559242ms","start":"2026-05-05T07:00:45.147547Z","end":"2026-05-05T07:00:45.405106Z","steps":["trace[1637076846] 'process raft request'  (duration: 246.492988ms)","trace[1637076846] 'compare'  (duration: 10.952371ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T07:00:45.406271Z","caller":"traceutil/trace.go:171","msg":"trace[365580979] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"244.288781ms","start":"2026-05-05T07:00:45.161949Z","end":"2026-05-05T07:00:45.406238Z","steps":["trace[365580979] 'process raft request'  (duration: 243.976945ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:00:49.750527Z","caller":"traceutil/trace.go:171","msg":"trace[680960949] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"100.338679ms","start":"2026-05-05T07:00:49.650166Z","end":"2026-05-05T07:00:49.750504Z","steps":["trace[680960949] 'process raft request'  (duration: 95.16878ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:00:50.225895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.583867ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265623343735566 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-05T07:00:50.226101Z","caller":"traceutil/trace.go:171","msg":"trace[972536134] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"289.755862ms","start":"2026-05-05T07:00:49.936312Z","end":"2026-05-05T07:00:50.226068Z","steps":["trace[972536134] 'read index received'  (duration: 115.360587ms)","trace[972536134] 'applied index is now lower than readState.Index'  (duration: 174.393855ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T07:00:50.226236Z","caller":"traceutil/trace.go:171","msg":"trace[1692205736] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"422.439125ms","start":"2026-05-05T07:00:49.803758Z","end":"2026-05-05T07:00:50.226198Z","steps":["trace[1692205736] 'process raft request'  (duration: 247.908287ms)","trace[1692205736] 'compare'  (duration: 173.435874ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T07:00:50.226289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.973607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zbtsw\" ","response":"range_response_count:1 size:16957"}
{"level":"info","ts":"2026-05-05T07:00:50.226326Z","caller":"traceutil/trace.go:171","msg":"trace[1491034204] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zbtsw; range_end:; response_count:1; response_revision:615; }","duration":"290.061928ms","start":"2026-05-05T07:00:49.936255Z","end":"2026-05-05T07:00:50.226317Z","steps":["trace[1491034204] 'agreement among raft nodes before linearized reading'  (duration: 289.949266ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:00:50.226437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:00:49.803734Z","time spent":"422.591758ms","remote":"127.0.0.1:43686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>"}
{"level":"info","ts":"2026-05-05T07:01:10.512867Z","caller":"traceutil/trace.go:171","msg":"trace[283310147] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"101.972917ms","start":"2026-05-05T07:01:10.410872Z","end":"2026-05-05T07:01:10.512845Z","steps":["trace[283310147] 'process raft request'  (duration: 101.856175ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:01:37.347062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.229975ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265623343736693 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1177 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T07:01:37.347316Z","caller":"traceutil/trace.go:171","msg":"trace[1505370433] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"202.892683ms","start":"2026-05-05T07:01:37.144377Z","end":"2026-05-05T07:01:37.34727Z","steps":["trace[1505370433] 'process raft request'  (duration: 53.136477ms)","trace[1505370433] 'compare'  (duration: 149.103563ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T07:02:18.881311Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265623343737908,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-05T07:02:18.893341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.787676ms","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-05-05T07:02:18.893397Z","caller":"traceutil/trace.go:171","msg":"trace[1095303774] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1820; }","duration":"553.896338ms","start":"2026-05-05T07:02:18.339482Z","end":"2026-05-05T07:02:18.893378Z","steps":["trace[1095303774] 'range keys from in-memory index tree'  (duration: 553.591052ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:02:18.89343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:02:18.339457Z","time spent":"553.966079ms","remote":"127.0.0.1:43436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":682,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-05-05T07:02:18.897636Z","caller":"traceutil/trace.go:171","msg":"trace[90535258] linearizableReadLoop","detail":"{readStateIndex:1877; appliedIndex:1876; }","duration":"516.842913ms","start":"2026-05-05T07:02:18.380769Z","end":"2026-05-05T07:02:18.897612Z","steps":["trace[90535258] 'read index received'  (duration: 516.622559ms)","trace[90535258] 'applied index is now lower than readState.Index'  (duration: 219.234µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T07:02:18.897748Z","caller":"traceutil/trace.go:171","msg":"trace[1772707227] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"555.259036ms","start":"2026-05-05T07:02:18.342464Z","end":"2026-05-05T07:02:18.897723Z","steps":["trace[1772707227] 'process raft request'  (duration: 555.004831ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:02:18.897843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.060507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d750240c-bc63-46e1-824a-c4d587d16966\" ","response":"range_response_count:1 size:3625"}
{"level":"info","ts":"2026-05-05T07:02:18.897877Z","caller":"traceutil/trace.go:171","msg":"trace[1742338034] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d750240c-bc63-46e1-824a-c4d587d16966; range_end:; response_count:1; response_revision:1821; }","duration":"517.111188ms","start":"2026-05-05T07:02:18.380755Z","end":"2026-05-05T07:02:18.897866Z","steps":["trace[1742338034] 'agreement among raft nodes before linearized reading'  (duration: 516.976815ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:02:18.897907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:02:18.380736Z","time spent":"517.163339ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d750240c-bc63-46e1-824a-c4d587d16966\" "}
{"level":"warn","ts":"2026-05-05T07:02:18.897904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:02:18.342439Z","time spent":"555.372698ms","remote":"127.0.0.1:43606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1750 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-05T07:02:18.897941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.80676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"}
{"level":"warn","ts":"2026-05-05T07:02:18.89796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.691962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"info","ts":"2026-05-05T07:02:18.898005Z","caller":"traceutil/trace.go:171","msg":"trace[2146823965] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1821; }","duration":"463.879981ms","start":"2026-05-05T07:02:18.434108Z","end":"2026-05-05T07:02:18.897988Z","steps":["trace[2146823965] 'agreement among raft nodes before linearized reading'  (duration: 463.676097ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:02:18.897899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.781452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T07:02:18.898037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:02:18.434022Z","time spent":"464.008593ms","remote":"127.0.0.1:38310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":4614,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-05-05T07:02:18.898054Z","caller":"traceutil/trace.go:171","msg":"trace[868309141] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1821; }","duration":"162.984246ms","start":"2026-05-05T07:02:18.735053Z","end":"2026-05-05T07:02:18.898037Z","steps":["trace[868309141] 'agreement among raft nodes before linearized reading'  (duration: 162.779002ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:02:18.898095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.942611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d750240c-bc63-46e1-824a-c4d587d16966\" ","response":"range_response_count:1 size:3625"}
{"level":"info","ts":"2026-05-05T07:02:18.898124Z","caller":"traceutil/trace.go:171","msg":"trace[1463789351] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d750240c-bc63-46e1-824a-c4d587d16966; range_end:; response_count:1; response_revision:1821; }","duration":"190.017723ms","start":"2026-05-05T07:02:18.708098Z","end":"2026-05-05T07:02:18.898115Z","steps":["trace[1463789351] 'agreement among raft nodes before linearized reading'  (duration: 189.934721ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:02:18.898011Z","caller":"traceutil/trace.go:171","msg":"trace[2135760115] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1821; }","duration":"287.780484ms","start":"2026-05-05T07:02:18.610215Z","end":"2026-05-05T07:02:18.897996Z","steps":["trace[2135760115] 'agreement among raft nodes before linearized reading'  (duration: 287.646182ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:02:18.898218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.789009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T07:02:18.898241Z","caller":"traceutil/trace.go:171","msg":"trace[1378902345] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1821; }","duration":"396.86669ms","start":"2026-05-05T07:02:18.501367Z","end":"2026-05-05T07:02:18.898234Z","steps":["trace[1378902345] 'agreement among raft nodes before linearized reading'  (duration: 396.820369ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:02:18.89826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:02:18.501334Z","time spent":"396.921232ms","remote":"127.0.0.1:43492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "}
{"level":"info","ts":"2026-05-05T07:02:19.098336Z","caller":"traceutil/trace.go:171","msg":"trace[336444059] linearizableReadLoop","detail":"{readStateIndex:1881; appliedIndex:1880; }","duration":"113.018544ms","start":"2026-05-05T07:02:18.985284Z","end":"2026-05-05T07:02:19.098303Z","steps":["trace[336444059] 'read index received'  (duration: 112.756819ms)","trace[336444059] 'applied index is now lower than readState.Index'  (duration: 256.485µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T07:02:19.098631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.357081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:567"}
{"level":"info","ts":"2026-05-05T07:02:19.098616Z","caller":"traceutil/trace.go:171","msg":"trace[873041249] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"167.030956ms","start":"2026-05-05T07:02:18.931555Z","end":"2026-05-05T07:02:19.098586Z","steps":["trace[873041249] 'process raft request'  (duration: 166.525876ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:02:19.098901Z","caller":"traceutil/trace.go:171","msg":"trace[39049325] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1825; }","duration":"113.518764ms","start":"2026-05-05T07:02:18.985143Z","end":"2026-05-05T07:02:19.098662Z","steps":["trace[39049325] 'agreement among raft nodes before linearized reading'  (duration: 113.29114ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:06:33.247642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.914395ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265623343744579 > lease_revoke:<id:4f3d9df6eff4c13c>","response":"size:28"}
{"level":"info","ts":"2026-05-05T07:06:44.882127Z","caller":"traceutil/trace.go:171","msg":"trace[712852781] transaction","detail":"{read_only:false; response_revision:4746; number_of_response:1; }","duration":"138.345125ms","start":"2026-05-05T07:06:44.743756Z","end":"2026-05-05T07:06:44.882101Z","steps":["trace[712852781] 'process raft request'  (duration: 138.178441ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:06:44.966431Z","caller":"traceutil/trace.go:171","msg":"trace[1826922590] linearizableReadLoop","detail":"{readStateIndex:4946; appliedIndex:4944; }","duration":"114.616079ms","start":"2026-05-05T07:06:44.851791Z","end":"2026-05-05T07:06:44.966407Z","steps":["trace[1826922590] 'read index received'  (duration: 30.130525ms)","trace[1826922590] 'applied index is now lower than readState.Index'  (duration: 84.484344ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T07:06:44.966483Z","caller":"traceutil/trace.go:171","msg":"trace[1027341165] transaction","detail":"{read_only:false; response_revision:4747; number_of_response:1; }","duration":"148.583008ms","start":"2026-05-05T07:06:44.817866Z","end":"2026-05-05T07:06:44.966449Z","steps":["trace[1027341165] 'process raft request'  (duration: 93.886941ms)","trace[1027341165] 'compare'  (duration: 54.544754ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T07:06:44.966674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.869233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-wb5cc.18ac998e1c416e40\" ","response":"range_response_count:1 size:906"}
{"level":"info","ts":"2026-05-05T07:06:44.966739Z","caller":"traceutil/trace.go:171","msg":"trace[1377006406] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-wb5cc.18ac998e1c416e40; range_end:; response_count:1; response_revision:4747; }","duration":"114.984666ms","start":"2026-05-05T07:06:44.851741Z","end":"2026-05-05T07:06:44.966726Z","steps":["trace[1377006406] 'agreement among raft nodes before linearized reading'  (duration: 114.776712ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:06:44.991191Z","caller":"traceutil/trace.go:171","msg":"trace[2070330167] transaction","detail":"{read_only:false; response_revision:4748; number_of_response:1; }","duration":"103.357362ms","start":"2026-05-05T07:06:44.887816Z","end":"2026-05-05T07:06:44.991174Z","steps":["trace[2070330167] 'process raft request'  (duration: 103.2196ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:06:44.99155Z","caller":"traceutil/trace.go:171","msg":"trace[1611973834] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"103.634038ms","start":"2026-05-05T07:06:44.887887Z","end":"2026-05-05T07:06:44.991521Z","steps":["trace[1611973834] 'process raft request'  (duration: 103.24442ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:06:44.991586Z","caller":"traceutil/trace.go:171","msg":"trace[1079356286] transaction","detail":"{read_only:false; response_revision:4750; number_of_response:1; }","duration":"103.516096ms","start":"2026-05-05T07:06:44.888043Z","end":"2026-05-05T07:06:44.991559Z","steps":["trace[1079356286] 'process raft request'  (duration: 103.336532ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:06:44.991753Z","caller":"traceutil/trace.go:171","msg":"trace[819043339] transaction","detail":"{read_only:false; response_revision:4751; number_of_response:1; }","duration":"103.134008ms","start":"2026-05-05T07:06:44.888604Z","end":"2026-05-05T07:06:44.991738Z","steps":["trace[819043339] 'process raft request'  (duration: 102.881093ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:06:45.284068Z","caller":"traceutil/trace.go:171","msg":"trace[727827802] linearizableReadLoop","detail":"{readStateIndex:4954; appliedIndex:4953; }","duration":"170.070859ms","start":"2026-05-05T07:06:45.113971Z","end":"2026-05-05T07:06:45.284042Z","steps":["trace[727827802] 'read index received'  (duration: 169.923076ms)","trace[727827802] 'applied index is now lower than readState.Index'  (duration: 146.213µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T07:06:45.284319Z","caller":"traceutil/trace.go:171","msg":"trace[1197976770] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"188.07013ms","start":"2026-05-05T07:06:45.096226Z","end":"2026-05-05T07:06:45.284296Z","steps":["trace[1197976770] 'process raft request'  (duration: 187.637892ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:06:45.284359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.366135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T07:06:45.284428Z","caller":"traceutil/trace.go:171","msg":"trace[1324591029] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:4755; }","duration":"170.454047ms","start":"2026-05-05T07:06:45.113958Z","end":"2026-05-05T07:06:45.284412Z","steps":["trace[1324591029] 'agreement among raft nodes before linearized reading'  (duration: 170.314954ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:06:45.556653Z","caller":"traceutil/trace.go:171","msg":"trace[1878453688] linearizableReadLoop","detail":"{readStateIndex:4955; appliedIndex:4954; }","duration":"272.366941ms","start":"2026-05-05T07:06:45.284257Z","end":"2026-05-05T07:06:45.556624Z","steps":["trace[1878453688] 'read index received'  (duration: 272.181157ms)","trace[1878453688] 'applied index is now lower than readState.Index'  (duration: 184.694µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T07:06:45.556712Z","caller":"traceutil/trace.go:171","msg":"trace[1588415763] transaction","detail":"{read_only:false; response_revision:4756; number_of_response:1; }","duration":"414.208664ms","start":"2026-05-05T07:06:45.142472Z","end":"2026-05-05T07:06:45.556681Z","steps":["trace[1588415763] 'process raft request'  (duration: 413.975139ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:06:45.556872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.440024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T07:06:45.556955Z","caller":"traceutil/trace.go:171","msg":"trace[1862900208] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:4756; }","duration":"313.584217ms","start":"2026-05-05T07:06:45.243352Z","end":"2026-05-05T07:06:45.556936Z","steps":["trace[1862900208] 'agreement among raft nodes before linearized reading'  (duration: 313.429184ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:06:45.557018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:06:45.24333Z","time spent":"313.670039ms","remote":"127.0.0.1:50376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T07:06:45.557097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:06:45.142452Z","time spent":"414.425649ms","remote":"127.0.0.1:43606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:4557 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-05-05T07:06:45.569959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.841455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-05-05T07:06:45.570011Z","caller":"traceutil/trace.go:171","msg":"trace[1148451476] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4756; }","duration":"176.939718ms","start":"2026-05-05T07:06:45.393059Z","end":"2026-05-05T07:06:45.569999Z","steps":["trace[1148451476] 'agreement among raft nodes before linearized reading'  (duration: 176.786265ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:06:45.570026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.509068ms","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":"warn","ts":"2026-05-05T07:06:45.570196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.869014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wch65\" ","response":"range_response_count:1 size:6523"}
{"level":"info","ts":"2026-05-05T07:06:45.570215Z","caller":"traceutil/trace.go:171","msg":"trace[971895201] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wch65; range_end:; response_count:1; response_revision:4756; }","duration":"164.926596ms","start":"2026-05-05T07:06:45.405284Z","end":"2026-05-05T07:06:45.570211Z","steps":["trace[971895201] 'agreement among raft nodes before linearized reading'  (duration: 164.873375ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:06:45.570243Z","caller":"traceutil/trace.go:171","msg":"trace[307851164] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4756; }","duration":"164.675671ms","start":"2026-05-05T07:06:45.405424Z","end":"2026-05-05T07:06:45.570099Z","steps":["trace[307851164] 'agreement among raft nodes before linearized reading'  (duration: 164.439496ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:06:45.570415Z","caller":"traceutil/trace.go:171","msg":"trace[1104594230] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4756; }","duration":"278.064585ms","start":"2026-05-05T07:06:45.292345Z","end":"2026-05-05T07:06:45.57041Z","steps":["trace[1104594230] 'process raft request'  (duration: 277.424972ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:06:51.714452Z","caller":"traceutil/trace.go:171","msg":"trace[894708237] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"108.571007ms","start":"2026-05-05T07:06:51.605846Z","end":"2026-05-05T07:06:51.714417Z","steps":["trace[894708237] 'process raft request'  (duration: 79.180187ms)","trace[894708237] 'compare'  (duration: 29.280497ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T07:10:14.958533Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3301}
{"level":"info","ts":"2026-05-05T07:10:15.043786Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3301,"took":"83.552758ms","hash":611601875,"current-db-size-bytes":61599744,"current-db-size":"62 MB","current-db-size-in-use-bytes":34107392,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-05T07:10:15.043873Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":611601875,"revision":3301,"compact-revision":-1}
{"level":"info","ts":"2026-05-05T07:12:35.290166Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000020e2.wal"}
{"level":"warn","ts":"2026-05-05T07:12:38.768296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.323518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T07:12:38.768429Z","caller":"traceutil/trace.go:171","msg":"trace[289804045] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8089; }","duration":"196.495811ms","start":"2026-05-05T07:12:38.571916Z","end":"2026-05-05T07:12:38.768411Z","steps":["trace[289804045] 'range keys from in-memory index tree'  (duration: 196.207775ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:12:38.904058Z","caller":"traceutil/trace.go:171","msg":"trace[347496682] transaction","detail":"{read_only:false; response_revision:8090; number_of_response:1; }","duration":"130.378205ms","start":"2026-05-05T07:12:38.773642Z","end":"2026-05-05T07:12:38.90402Z","steps":["trace[347496682] 'process raft request'  (duration: 130.136999ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:12:50.206719Z","caller":"traceutil/trace.go:171","msg":"trace[817906270] transaction","detail":"{read_only:false; response_revision:8166; number_of_response:1; }","duration":"119.681436ms","start":"2026-05-05T07:12:50.087015Z","end":"2026-05-05T07:12:50.206696Z","steps":["trace[817906270] 'process raft request'  (duration: 119.553684ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:12:50.693636Z","caller":"traceutil/trace.go:171","msg":"trace[602363037] transaction","detail":"{read_only:false; response_revision:8167; number_of_response:1; }","duration":"191.791704ms","start":"2026-05-05T07:12:50.501741Z","end":"2026-05-05T07:12:50.693533Z","steps":["trace[602363037] 'process raft request'  (duration: 191.63224ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:12:50.923398Z","caller":"traceutil/trace.go:171","msg":"trace[1697287922] linearizableReadLoop","detail":"{readStateIndex:8527; appliedIndex:8526; }","duration":"214.276843ms","start":"2026-05-05T07:12:50.709096Z","end":"2026-05-05T07:12:50.923373Z","steps":["trace[1697287922] 'read index received'  (duration: 168.808196ms)","trace[1697287922] 'applied index is now lower than readState.Index'  (duration: 45.467617ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T07:12:50.923487Z","caller":"traceutil/trace.go:171","msg":"trace[575461667] transaction","detail":"{read_only:false; response_revision:8168; number_of_response:1; }","duration":"420.922993ms","start":"2026-05-05T07:12:50.502538Z","end":"2026-05-05T07:12:50.923461Z","steps":["trace[575461667] 'process raft request'  (duration: 375.468157ms)","trace[575461667] 'compare'  (duration: 45.243292ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T07:12:50.923598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:12:50.502505Z","time spent":"421.035955ms","remote":"127.0.0.1:43606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8155 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-05T07:12:50.923819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.723531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-67d6f4bd74-hhc4x.18ac99e26ef3d11e\" ","response":"range_response_count:1 size:1133"}
{"level":"info","ts":"2026-05-05T07:12:50.923854Z","caller":"traceutil/trace.go:171","msg":"trace[52700901] range","detail":"{range_begin:/registry/events/openstack/barbican-api-67d6f4bd74-hhc4x.18ac99e26ef3d11e; range_end:; response_count:1; response_revision:8168; }","duration":"214.784752ms","start":"2026-05-05T07:12:50.70906Z","end":"2026-05-05T07:12:50.923844Z","steps":["trace[52700901] 'agreement among raft nodes before linearized reading'  (duration: 214.414975ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:12:51.561571Z","caller":"traceutil/trace.go:171","msg":"trace[1811373856] linearizableReadLoop","detail":"{readStateIndex:8532; appliedIndex:8531; }","duration":"100.875832ms","start":"2026-05-05T07:12:51.460675Z","end":"2026-05-05T07:12:51.561551Z","steps":["trace[1811373856] 'read index received'  (duration: 100.603597ms)","trace[1811373856] 'applied index is now lower than readState.Index'  (duration: 271.695µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T07:12:51.561639Z","caller":"traceutil/trace.go:171","msg":"trace[497520450] transaction","detail":"{read_only:false; response_revision:8172; number_of_response:1; }","duration":"103.716988ms","start":"2026-05-05T07:12:51.457895Z","end":"2026-05-05T07:12:51.561612Z","steps":["trace[497520450] 'process raft request'  (duration: 103.537955ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:12:51.561717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.032225ms","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-05-05T07:12:51.561741Z","caller":"traceutil/trace.go:171","msg":"trace[1722345723] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8172; }","duration":"101.090126ms","start":"2026-05-05T07:12:51.460645Z","end":"2026-05-05T07:12:51.561735Z","steps":["trace[1722345723] 'agreement among raft nodes before linearized reading'  (duration: 100.990974ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:12:51.820305Z","caller":"traceutil/trace.go:171","msg":"trace[1173521961] linearizableReadLoop","detail":"{readStateIndex:8533; appliedIndex:8532; }","duration":"248.153098ms","start":"2026-05-05T07:12:51.572121Z","end":"2026-05-05T07:12:51.820274Z","steps":["trace[1173521961] 'read index received'  (duration: 238.319232ms)","trace[1173521961] 'applied index is now lower than readState.Index'  (duration: 9.832625ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T07:12:51.820455Z","caller":"traceutil/trace.go:171","msg":"trace[637583652] transaction","detail":"{read_only:false; response_revision:8173; number_of_response:1; }","duration":"252.368222ms","start":"2026-05-05T07:12:51.568071Z","end":"2026-05-05T07:12:51.820439Z","steps":["trace[637583652] 'process raft request'  (duration: 242.399783ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:12:51.820601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.463803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T07:12:51.820635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.14003ms","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-05-05T07:12:51.820669Z","caller":"traceutil/trace.go:171","msg":"trace[1751172398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8173; }","duration":"248.573626ms","start":"2026-05-05T07:12:51.572078Z","end":"2026-05-05T07:12:51.820652Z","steps":["trace[1751172398] 'agreement among raft nodes before linearized reading'  (duration: 248.453874ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:12:51.820704Z","caller":"traceutil/trace.go:171","msg":"trace[805570466] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8173; }","duration":"198.245483ms","start":"2026-05-05T07:12:51.622443Z","end":"2026-05-05T07:12:51.820689Z","steps":["trace[805570466] 'agreement among raft nodes before linearized reading'  (duration: 198.072869ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:12:51.820723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.347725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"}
{"level":"info","ts":"2026-05-05T07:12:51.820796Z","caller":"traceutil/trace.go:171","msg":"trace[1637180671] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8173; }","duration":"196.440227ms","start":"2026-05-05T07:12:51.624334Z","end":"2026-05-05T07:12:51.820774Z","steps":["trace[1637180671] 'agreement among raft nodes before linearized reading'  (duration: 196.225803ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:12:51.820989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.476129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-05T07:12:51.821041Z","caller":"traceutil/trace.go:171","msg":"trace[372421661] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:8173; }","duration":"176.55868ms","start":"2026-05-05T07:12:51.644469Z","end":"2026-05-05T07:12:51.821028Z","steps":["trace[372421661] 'agreement among raft nodes before linearized reading'  (duration: 176.045349ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:13:18.282595Z","caller":"traceutil/trace.go:171","msg":"trace[678286972] transaction","detail":"{read_only:false; response_revision:8406; number_of_response:1; }","duration":"136.586873ms","start":"2026-05-05T07:13:18.145987Z","end":"2026-05-05T07:13:18.282574Z","steps":["trace[678286972] 'process raft request'  (duration: 136.4408ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:13:18.342959Z","caller":"traceutil/trace.go:171","msg":"trace[881289260] transaction","detail":"{read_only:false; response_revision:8407; number_of_response:1; }","duration":"194.862906ms","start":"2026-05-05T07:13:18.148056Z","end":"2026-05-05T07:13:18.342919Z","steps":["trace[881289260] 'process raft request'  (duration: 194.673933ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:13:18.452824Z","caller":"traceutil/trace.go:171","msg":"trace[288757277] transaction","detail":"{read_only:false; response_revision:8408; number_of_response:1; }","duration":"103.514574ms","start":"2026-05-05T07:13:18.349288Z","end":"2026-05-05T07:13:18.452803Z","steps":["trace[288757277] 'process raft request'  (duration: 103.332281ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:13:18.45716Z","caller":"traceutil/trace.go:171","msg":"trace[1338678293] transaction","detail":"{read_only:false; response_revision:8409; number_of_response:1; }","duration":"106.100896ms","start":"2026-05-05T07:13:18.351041Z","end":"2026-05-05T07:13:18.457142Z","steps":["trace[1338678293] 'process raft request'  (duration: 105.961783ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:13:18.457306Z","caller":"traceutil/trace.go:171","msg":"trace[1237841499] linearizableReadLoop","detail":"{readStateIndex:8781; appliedIndex:8779; }","duration":"102.148297ms","start":"2026-05-05T07:13:18.354956Z","end":"2026-05-05T07:13:18.457104Z","steps":["trace[1237841499] 'read index received'  (duration: 97.723269ms)","trace[1237841499] 'applied index is now lower than readState.Index'  (duration: 4.424358ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T07:13:18.457462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.480084ms","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-05-05T07:13:18.457568Z","caller":"traceutil/trace.go:171","msg":"trace[1347792423] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8409; }","duration":"102.630147ms","start":"2026-05-05T07:13:18.354915Z","end":"2026-05-05T07:13:18.457546Z","steps":["trace[1347792423] 'agreement among raft nodes before linearized reading'  (duration: 102.373352ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:13:31.169023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.104126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T07:13:31.16909Z","caller":"traceutil/trace.go:171","msg":"trace[535911414] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:8536; }","duration":"103.188577ms","start":"2026-05-05T07:13:31.065885Z","end":"2026-05-05T07:13:31.169074Z","steps":["trace[535911414] 'count revisions from in-memory index tree'  (duration: 102.940263ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:13:31.305422Z","caller":"traceutil/trace.go:171","msg":"trace[589449886] linearizableReadLoop","detail":"{readStateIndex:8917; appliedIndex:8916; }","duration":"112.516743ms","start":"2026-05-05T07:13:31.192881Z","end":"2026-05-05T07:13:31.305398Z","steps":["trace[589449886] 'read index received'  (duration: 112.36381ms)","trace[589449886] 'applied index is now lower than readState.Index'  (duration: 151.533µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T07:13:31.305474Z","caller":"traceutil/trace.go:171","msg":"trace[1001728876] transaction","detail":"{read_only:false; response_revision:8537; number_of_response:1; }","duration":"132.143385ms","start":"2026-05-05T07:13:31.173305Z","end":"2026-05-05T07:13:31.305449Z","steps":["trace[1001728876] 'process raft request'  (duration: 131.908591ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T07:13:31.305725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.83191ms","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-05-05T07:13:31.305805Z","caller":"traceutil/trace.go:171","msg":"trace[673047874] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8537; }","duration":"112.961012ms","start":"2026-05-05T07:13:31.192826Z","end":"2026-05-05T07:13:31.305787Z","steps":["trace[673047874] 'agreement among raft nodes before linearized reading'  (duration: 112.703107ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:13:31.426769Z","caller":"traceutil/trace.go:171","msg":"trace[1302735312] transaction","detail":"{read_only:false; response_revision:8538; number_of_response:1; }","duration":"116.668606ms","start":"2026-05-05T07:13:31.310064Z","end":"2026-05-05T07:13:31.426733Z","steps":["trace[1302735312] 'process raft request'  (duration: 76.059476ms)","trace[1302735312] 'compare'  (duration: 40.399035ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T07:13:31.426847Z","caller":"traceutil/trace.go:171","msg":"trace[289992744] transaction","detail":"{read_only:false; response_revision:8540; number_of_response:1; }","duration":"112.890222ms","start":"2026-05-05T07:13:31.313933Z","end":"2026-05-05T07:13:31.426823Z","steps":["trace[289992744] 'process raft request'  (duration: 112.7725ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:13:31.426911Z","caller":"traceutil/trace.go:171","msg":"trace[467502005] transaction","detail":"{read_only:false; response_revision:8539; number_of_response:1; }","duration":"116.579685ms","start":"2026-05-05T07:13:31.310295Z","end":"2026-05-05T07:13:31.426875Z","steps":["trace[467502005] 'process raft request'  (duration: 116.358901ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:15:13.835442Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"597401b06ce1cf3d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-05T07:15:13.840518Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-05T07:15:13.840637Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-05T07:15:14.970734Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6662}
{"level":"info","ts":"2026-05-05T07:15:15.075739Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6662,"took":"102.265164ms","hash":1783526042,"current-db-size-bytes":61599744,"current-db-size":"62 MB","current-db-size-in-use-bytes":27361280,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-05-05T07:15:15.075817Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1783526042,"revision":6662,"compact-revision":3301}
{"level":"info","ts":"2026-05-05T07:20:14.976434Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9588}
{"level":"info","ts":"2026-05-05T07:20:15.063298Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9588,"took":"84.580591ms","hash":1067345820,"current-db-size-bytes":61599744,"current-db-size":"62 MB","current-db-size-in-use-bytes":28979200,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-05-05T07:20:15.063495Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1067345820,"revision":9588,"compact-revision":6662}
{"level":"info","ts":"2026-05-05T07:24:18.395203Z","caller":"traceutil/trace.go:171","msg":"trace[762419478] transaction","detail":"{read_only:false; response_revision:14404; number_of_response:1; }","duration":"145.153077ms","start":"2026-05-05T07:24:18.250011Z","end":"2026-05-05T07:24:18.395164Z","steps":["trace[762419478] 'process raft request'  (duration: 144.993773ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T07:25:14.98204Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12425}
{"level":"info","ts":"2026-05-05T07:25:15.07667Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12425,"took":"91.686326ms","hash":484679165,"current-db-size-bytes":61599744,"current-db-size":"62 MB","current-db-size-in-use-bytes":24879104,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-05-05T07:25:15.076761Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":484679165,"revision":12425,"compact-revision":9588}
{"level":"info","ts":"2026-05-05T07:30:14.98779Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14766}
{"level":"info","ts":"2026-05-05T07:30:15.077398Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14766,"took":"86.964739ms","hash":3161118743,"current-db-size-bytes":61599744,"current-db-size":"62 MB","current-db-size-in-use-bytes":22536192,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-05-05T07:30:15.077746Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3161118743,"revision":14766,"compact-revision":12425}
{"level":"info","ts":"2026-05-05T07:35:14.994147Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16702}
{"level":"info","ts":"2026-05-05T07:35:15.062275Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16702,"took":"65.362394ms","hash":3696255253,"current-db-size-bytes":61599744,"current-db-size":"62 MB","current-db-size-in-use-bytes":24178688,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-05-05T07:35:15.062333Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3696255253,"revision":16702,"compact-revision":14766}
{"level":"info","ts":"2026-05-05T07:36:17.045579Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"597401b06ce1cf3d","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-05T07:36:17.051098Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-05T07:36:17.05121Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-05T07:40:15.000871Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18645}
{"level":"info","ts":"2026-05-05T07:40:15.069955Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18645,"took":"66.662371ms","hash":1434324569,"current-db-size-bytes":61599744,"current-db-size":"62 MB","current-db-size-in-use-bytes":24129536,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-05-05T07:40:15.070026Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1434324569,"revision":18645,"compact-revision":16702}
{"level":"info","ts":"2026-05-05T07:45:15.006726Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20581}
{"level":"info","ts":"2026-05-05T07:45:15.071445Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20581,"took":"62.205761ms","hash":2326518205,"current-db-size-bytes":61599744,"current-db-size":"62 MB","current-db-size-in-use-bytes":24137728,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-05-05T07:45:15.071498Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2326518205,"revision":20581,"compact-revision":18645}