{"level":"warn","ts":"2026-07-31T21:29:05.405312Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-31T21:29:05.405461Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-07-31T21:29:05.405531Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-31T21:29:05.405548Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]}
{"level":"info","ts":"2026-07-31T21:29:05.405572Z","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-07-31T21:29:05.406217Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]}
{"level":"info","ts":"2026-07-31T21:29:05.406315Z","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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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-07-31T21:29:05.409875Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.943715ms"}
{"level":"info","ts":"2026-07-31T21:29:05.415951Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"}
{"level":"info","ts":"2026-07-31T21:29:05.416077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"}
{"level":"info","ts":"2026-07-31T21:29:05.416118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"}
{"level":"info","ts":"2026-07-31T21:29:05.416144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-07-31T21:29:05.416158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"}
{"level":"info","ts":"2026-07-31T21:29:05.416216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"}
{"level":"warn","ts":"2026-07-31T21:29:05.426619Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-07-31T21:29:05.428482Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-07-31T21:29:05.430661Z","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-07-31T21:29:05.435071Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-07-31T21:29:05.442416Z","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-07-31T21:29:05.442652Z","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-07-31T21:29:05.442665Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-07-31T21:29:05.442766Z","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-07-31T21:29:05.44366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"}
{"level":"info","ts":"2026-07-31T21:29:05.443793Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]}
{"level":"info","ts":"2026-07-31T21:29:05.444014Z","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-07-31T21:29:05.444121Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"}
{"level":"info","ts":"2026-07-31T21:29:05.44417Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"}
{"level":"info","ts":"2026-07-31T21:29:05.444293Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-07-31T21:29:05.444338Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-07-31T21:29:06.216803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"}
{"level":"info","ts":"2026-07-31T21:29:06.21689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"}
{"level":"info","ts":"2026-07-31T21:29:06.21695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"}
{"level":"info","ts":"2026-07-31T21:29:06.217001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"}
{"level":"info","ts":"2026-07-31T21:29:06.217071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"}
{"level":"info","ts":"2026-07-31T21:29:06.217088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"}
{"level":"info","ts":"2026-07-31T21:29:06.217105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"}
{"level":"info","ts":"2026-07-31T21:29:06.218151Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-31T21:29:06.218887Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-31T21:29:06.218886Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"}
{"level":"info","ts":"2026-07-31T21:29:06.218934Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-31T21:29:06.219225Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-07-31T21:29:06.219304Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-07-31T21:29:06.221219Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-31T21:29:06.221333Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-31T21:29:06.221369Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-31T21:29:06.222237Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-07-31T21:29:06.224868Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"}
{"level":"info","ts":"2026-07-31T21:29:49.43086Z","caller":"traceutil/trace.go:171","msg":"trace[752866027] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"126.47904ms","start":"2026-07-31T21:29:49.304327Z","end":"2026-07-31T21:29:49.430806Z","steps":["trace[752866027] 'process raft request'  (duration: 125.757329ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:29:49.771211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.565958ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927270272 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.72\" mod_revision:481 > success:<request_put:<key:\"/registry/masterleases/199.204.45.72\" value_size:66 lease:5456849520072494462 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.72\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-31T21:29:49.771449Z","caller":"traceutil/trace.go:171","msg":"trace[1145888561] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"282.047845ms","start":"2026-07-31T21:29:49.489381Z","end":"2026-07-31T21:29:49.771429Z","steps":["trace[1145888561] 'process raft request'  (duration: 281.980533ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:29:49.771407Z","caller":"traceutil/trace.go:171","msg":"trace[841612425] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"331.456859ms","start":"2026-07-31T21:29:49.439912Z","end":"2026-07-31T21:29:49.771369Z","steps":["trace[841612425] 'compare'  (duration: 325.338791ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:29:49.771538Z","caller":"traceutil/trace.go:171","msg":"trace[2082764461] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"318.230675ms","start":"2026-07-31T21:29:49.453265Z","end":"2026-07-31T21:29:49.771496Z","steps":["trace[2082764461] 'read index received'  (duration: 44.151µs)","trace[2082764461] 'applied index is now lower than readState.Index'  (duration: 318.182904ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T21:29:49.771767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:29:49.439887Z","time spent":"331.670556ms","remote":"127.0.0.1:34116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.72\" mod_revision:481 > success:<request_put:<key:\"/registry/masterleases/199.204.45.72\" value_size:66 lease:5456849520072494462 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.72\" > >"}
{"level":"warn","ts":"2026-07-31T21:29:49.77185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.538906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-07-31T21:29:49.7719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.88225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-07-31T21:29:49.77195Z","caller":"traceutil/trace.go:171","msg":"trace[905595758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"281.982933ms","start":"2026-07-31T21:29:49.489954Z","end":"2026-07-31T21:29:49.771937Z","steps":["trace[905595758] 'agreement among raft nodes before linearized reading'  (duration: 281.732746ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:29:49.771927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.632397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5s7b9\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-07-31T21:29:49.772039Z","caller":"traceutil/trace.go:171","msg":"trace[1648168] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5s7b9; range_end:; response_count:1; response_revision:632; }","duration":"318.805962ms","start":"2026-07-31T21:29:49.453207Z","end":"2026-07-31T21:29:49.772013Z","steps":["trace[1648168] 'agreement among raft nodes before linearized reading'  (duration: 318.4155ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:29:49.772093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:29:49.453182Z","time spent":"318.902755ms","remote":"127.0.0.1:34308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-5s7b9\" "}
{"level":"info","ts":"2026-07-31T21:29:49.771959Z","caller":"traceutil/trace.go:171","msg":"trace[1486542932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"204.71509ms","start":"2026-07-31T21:29:49.567218Z","end":"2026-07-31T21:29:49.771934Z","steps":["trace[1486542932] 'agreement among raft nodes before linearized reading'  (duration: 204.484294ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:29:49.933545Z","caller":"traceutil/trace.go:171","msg":"trace[806154811] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"154.995248ms","start":"2026-07-31T21:29:49.778516Z","end":"2026-07-31T21:29:49.933512Z","steps":["trace[806154811] 'read index received'  (duration: 139.20465ms)","trace[806154811] 'applied index is now lower than readState.Index'  (duration: 15.788858ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T21:29:49.933639Z","caller":"traceutil/trace.go:171","msg":"trace[1434584537] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"156.414459ms","start":"2026-07-31T21:29:49.777185Z","end":"2026-07-31T21:29:49.933599Z","steps":["trace[1434584537] 'process raft request'  (duration: 140.434875ms)","trace[1434584537] 'compare'  (duration: 15.739286ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T21:29:49.933749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.197874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-07-31T21:29:49.933798Z","caller":"traceutil/trace.go:171","msg":"trace[830165113] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:633; }","duration":"155.286906ms","start":"2026-07-31T21:29:49.778497Z","end":"2026-07-31T21:29:49.933784Z","steps":["trace[830165113] 'agreement among raft nodes before linearized reading'  (duration: 155.163553ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:29:49.93579Z","caller":"traceutil/trace.go:171","msg":"trace[138492323] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"149.500998ms","start":"2026-07-31T21:29:49.786273Z","end":"2026-07-31T21:29:49.935774Z","steps":["trace[138492323] 'process raft request'  (duration: 149.246791ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:29:49.935762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.154874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-31T21:29:49.93586Z","caller":"traceutil/trace.go:171","msg":"trace[796142437] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:634; }","duration":"153.294298ms","start":"2026-07-31T21:29:49.782542Z","end":"2026-07-31T21:29:49.935836Z","steps":["trace[796142437] 'agreement among raft nodes before linearized reading'  (duration: 153.133553ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:30:03.754315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.825897ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927270568 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/kube-system/kube-dns-sh2m2\" mod_revision:778 > success:<request_put:<key:\"/registry/endpointslices/kube-system/kube-dns-sh2m2\" value_size:1231 >> failure:<request_range:<key:\"/registry/endpointslices/kube-system/kube-dns-sh2m2\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-31T21:30:03.754542Z","caller":"traceutil/trace.go:171","msg":"trace[1488078248] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"147.460875ms","start":"2026-07-31T21:30:03.607064Z","end":"2026-07-31T21:30:03.754525Z","steps":["trace[1488078248] 'process raft request'  (duration: 147.390763ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:30:03.754778Z","caller":"traceutil/trace.go:171","msg":"trace[1725907946] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"149.057501ms","start":"2026-07-31T21:30:03.60562Z","end":"2026-07-31T21:30:03.754677Z","steps":["trace[1725907946] 'process raft request'  (duration: 46.780631ms)","trace[1725907946] 'compare'  (duration: 101.606331ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T21:30:33.934469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.082313ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927271320 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1184 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-31T21:30:33.934598Z","caller":"traceutil/trace.go:171","msg":"trace[1201050133] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"205.699162ms","start":"2026-07-31T21:30:33.72888Z","end":"2026-07-31T21:30:33.934579Z","steps":["trace[1201050133] 'process raft request'  (duration: 77.422943ms)","trace[1201050133] 'compare'  (duration: 127.96093ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T21:31:21.929047Z","caller":"traceutil/trace.go:171","msg":"trace[1449294700] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"304.789685ms","start":"2026-07-31T21:31:21.624227Z","end":"2026-07-31T21:31:21.929017Z","steps":["trace[1449294700] 'process raft request'  (duration: 304.580059ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:31:21.929311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:31:21.624206Z","time spent":"305.013962ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1791 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-07-31T21:31:30.19087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.665021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-07-31T21:31:30.191045Z","caller":"traceutil/trace.go:171","msg":"trace[548136020] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1946; }","duration":"113.923428ms","start":"2026-07-31T21:31:30.077101Z","end":"2026-07-31T21:31:30.191024Z","steps":["trace[548136020] 'range keys from in-memory index tree'  (duration: 113.515017ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:32:06.501933Z","caller":"traceutil/trace.go:171","msg":"trace[1792700452] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"114.986848ms","start":"2026-07-31T21:32:06.38688Z","end":"2026-07-31T21:32:06.501867Z","steps":["trace[1792700452] 'process raft request'  (duration: 93.953566ms)","trace[1792700452] 'compare'  (duration: 20.726353ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T21:33:29.252303Z","caller":"traceutil/trace.go:171","msg":"trace[1461366406] transaction","detail":"{read_only:false; response_revision:2661; number_of_response:1; }","duration":"108.188279ms","start":"2026-07-31T21:33:29.144082Z","end":"2026-07-31T21:33:29.25227Z","steps":["trace[1461366406] 'process raft request'  (duration: 107.964552ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:33:29.569194Z","caller":"traceutil/trace.go:171","msg":"trace[44707978] linearizableReadLoop","detail":"{readStateIndex:2764; appliedIndex:2763; }","duration":"102.703824ms","start":"2026-07-31T21:33:29.466467Z","end":"2026-07-31T21:33:29.569171Z","steps":["trace[44707978] 'read index received'  (duration: 27.405221ms)","trace[44707978] 'applied index is now lower than readState.Index'  (duration: 75.297013ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T21:33:29.569507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.011742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-07-31T21:33:29.569647Z","caller":"traceutil/trace.go:171","msg":"trace[2119373270] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2664; }","duration":"103.197967ms","start":"2026-07-31T21:33:29.466417Z","end":"2026-07-31T21:33:29.569615Z","steps":["trace[2119373270] 'agreement among raft nodes before linearized reading'  (duration: 102.879048ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:33:34.88998Z","caller":"traceutil/trace.go:171","msg":"trace[1486373889] linearizableReadLoop","detail":"{readStateIndex:2789; appliedIndex:2788; }","duration":"104.104112ms","start":"2026-07-31T21:33:34.785846Z","end":"2026-07-31T21:33:34.88995Z","steps":["trace[1486373889] 'read index received'  (duration: 76.972521ms)","trace[1486373889] 'applied index is now lower than readState.Index'  (duration: 27.130221ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T21:33:34.890827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.954117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18c77d56f99e9fcb\" ","response":"range_response_count:1 size:781"}
{"level":"info","ts":"2026-07-31T21:33:34.890925Z","caller":"traceutil/trace.go:171","msg":"trace[1120906681] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18c77d56f99e9fcb; range_end:; response_count:1; response_revision:2688; }","duration":"105.090451ms","start":"2026-07-31T21:33:34.785813Z","end":"2026-07-31T21:33:34.890904Z","steps":["trace[1120906681] 'agreement among raft nodes before linearized reading'  (duration: 104.292428ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:36:10.36662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.587927ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927277602 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:3646 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-31T21:36:10.366921Z","caller":"traceutil/trace.go:171","msg":"trace[1286454713] transaction","detail":"{read_only:false; response_revision:3699; number_of_response:1; }","duration":"164.613706ms","start":"2026-07-31T21:36:10.202253Z","end":"2026-07-31T21:36:10.366866Z","steps":["trace[1286454713] 'process raft request'  (duration: 42.682199ms)","trace[1286454713] 'compare'  (duration: 121.467934ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T21:37:26.148731Z","caller":"traceutil/trace.go:171","msg":"trace[1832956581] transaction","detail":"{read_only:false; response_revision:4723; number_of_response:1; }","duration":"103.493585ms","start":"2026-07-31T21:37:26.045175Z","end":"2026-07-31T21:37:26.148668Z","steps":["trace[1832956581] 'process raft request'  (duration: 103.277659ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:31.42877Z","caller":"traceutil/trace.go:171","msg":"trace[1438844526] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"126.148557ms","start":"2026-07-31T21:37:31.302596Z","end":"2026-07-31T21:37:31.428745Z","steps":["trace[1438844526] 'process raft request'  (duration: 126.011543ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:31.935995Z","caller":"traceutil/trace.go:171","msg":"trace[1447067811] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"102.804007ms","start":"2026-07-31T21:37:31.83317Z","end":"2026-07-31T21:37:31.935974Z","steps":["trace[1447067811] 'process raft request'  (duration: 102.739735ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:31.936127Z","caller":"traceutil/trace.go:171","msg":"trace[1188975719] transaction","detail":"{read_only:false; response_revision:4903; number_of_response:1; }","duration":"106.648917ms","start":"2026-07-31T21:37:31.829413Z","end":"2026-07-31T21:37:31.936062Z","steps":["trace[1188975719] 'process raft request'  (duration: 106.354968ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:44.020011Z","caller":"traceutil/trace.go:171","msg":"trace[1285397657] linearizableReadLoop","detail":"{readStateIndex:5326; appliedIndex:5324; }","duration":"147.557785ms","start":"2026-07-31T21:37:43.872429Z","end":"2026-07-31T21:37:44.019987Z","steps":["trace[1285397657] 'read index received'  (duration: 52.228043ms)","trace[1285397657] 'applied index is now lower than readState.Index'  (duration: 95.328732ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T21:37:44.020054Z","caller":"traceutil/trace.go:171","msg":"trace[729357674] transaction","detail":"{read_only:false; response_revision:5138; number_of_response:1; }","duration":"164.512053ms","start":"2026-07-31T21:37:43.855509Z","end":"2026-07-31T21:37:44.020021Z","steps":["trace[729357674] 'process raft request'  (duration: 164.42926ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:44.020053Z","caller":"traceutil/trace.go:171","msg":"trace[324850202] transaction","detail":"{read_only:false; response_revision:5137; number_of_response:1; }","duration":"166.010455ms","start":"2026-07-31T21:37:43.854012Z","end":"2026-07-31T21:37:44.020022Z","steps":["trace[324850202] 'process raft request'  (duration: 70.641342ms)","trace[324850202] 'compare'  (duration: 95.104935ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T21:37:44.020267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.823602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/goldpinger-4vw7d\" ","response":"range_response_count:1 size:4991"}
{"level":"info","ts":"2026-07-31T21:37:44.020322Z","caller":"traceutil/trace.go:171","msg":"trace[1919967801] range","detail":"{range_begin:/registry/pods/monitoring/goldpinger-4vw7d; range_end:; response_count:1; response_revision:5138; }","duration":"147.917655ms","start":"2026-07-31T21:37:43.87239Z","end":"2026-07-31T21:37:44.020308Z","steps":["trace[1919967801] 'agreement among raft nodes before linearized reading'  (duration: 147.712109ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:44.215339Z","caller":"traceutil/trace.go:171","msg":"trace[499381273] linearizableReadLoop","detail":"{readStateIndex:5328; appliedIndex:5327; }","duration":"133.999225ms","start":"2026-07-31T21:37:44.081313Z","end":"2026-07-31T21:37:44.215312Z","steps":["trace[499381273] 'read index received'  (duration: 91.515223ms)","trace[499381273] 'applied index is now lower than readState.Index'  (duration: 42.483022ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T21:37:44.21543Z","caller":"traceutil/trace.go:171","msg":"trace[1750247619] transaction","detail":"{read_only:false; response_revision:5140; number_of_response:1; }","duration":"139.269816ms","start":"2026-07-31T21:37:44.076117Z","end":"2026-07-31T21:37:44.215386Z","steps":["trace[1750247619] 'process raft request'  (duration: 96.777544ms)","trace[1750247619] 'compare'  (duration: 42.243905ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T21:37:44.215511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.17224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-31T21:37:44.21555Z","caller":"traceutil/trace.go:171","msg":"trace[1953213006] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5140; }","duration":"134.262892ms","start":"2026-07-31T21:37:44.081277Z","end":"2026-07-31T21:37:44.215539Z","steps":["trace[1953213006] 'agreement among raft nodes before linearized reading'  (duration: 134.17108ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:44.887266Z","caller":"traceutil/trace.go:171","msg":"trace[981674843] transaction","detail":"{read_only:false; response_revision:5148; number_of_response:1; }","duration":"268.328228ms","start":"2026-07-31T21:37:44.618922Z","end":"2026-07-31T21:37:44.88725Z","steps":["trace[981674843] 'process raft request'  (duration: 268.218245ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:44.90252Z","caller":"traceutil/trace.go:171","msg":"trace[381342813] transaction","detail":"{read_only:false; response_revision:5149; number_of_response:1; }","duration":"282.976319ms","start":"2026-07-31T21:37:44.619519Z","end":"2026-07-31T21:37:44.902495Z","steps":["trace[381342813] 'process raft request'  (duration: 282.779103ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:44.902711Z","caller":"traceutil/trace.go:171","msg":"trace[716213326] transaction","detail":"{read_only:false; response_revision:5150; number_of_response:1; }","duration":"282.911177ms","start":"2026-07-31T21:37:44.619747Z","end":"2026-07-31T21:37:44.902659Z","steps":["trace[716213326] 'process raft request'  (duration: 282.699601ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:37:51.038365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.950384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-07-31T21:37:51.03847Z","caller":"traceutil/trace.go:171","msg":"trace[983550132] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5305; }","duration":"108.122329ms","start":"2026-07-31T21:37:50.93033Z","end":"2026-07-31T21:37:51.038453Z","steps":["trace[983550132] 'range keys from in-memory index tree'  (duration: 107.78543ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:37:51.038664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.47342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-07-31T21:37:51.038689Z","caller":"traceutil/trace.go:171","msg":"trace[571991552] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5305; }","duration":"108.534802ms","start":"2026-07-31T21:37:50.930146Z","end":"2026-07-31T21:37:51.03868Z","steps":["trace[571991552] 'range keys from in-memory index tree'  (duration: 108.325796ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:37:51.03885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.527232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-07-31T21:37:51.038927Z","caller":"traceutil/trace.go:171","msg":"trace[2112403215] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5305; }","duration":"108.690696ms","start":"2026-07-31T21:37:50.930214Z","end":"2026-07-31T21:37:51.038904Z","steps":["trace[2112403215] 'range keys from in-memory index tree'  (duration: 108.353806ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:51.21906Z","caller":"traceutil/trace.go:171","msg":"trace[1894682031] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"175.294332ms","start":"2026-07-31T21:37:51.043739Z","end":"2026-07-31T21:37:51.219033Z","steps":["trace[1894682031] 'process raft request'  (duration: 175.21276ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:51.219214Z","caller":"traceutil/trace.go:171","msg":"trace[344223453] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"175.905299ms","start":"2026-07-31T21:37:51.043266Z","end":"2026-07-31T21:37:51.219171Z","steps":["trace[344223453] 'process raft request'  (duration: 175.534849ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:51.219376Z","caller":"traceutil/trace.go:171","msg":"trace[450503652] transaction","detail":"{read_only:false; response_revision:5309; number_of_response:1; }","duration":"175.302222ms","start":"2026-07-31T21:37:51.044065Z","end":"2026-07-31T21:37:51.219368Z","steps":["trace[450503652] 'process raft request'  (duration: 174.930531ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:51.219791Z","caller":"traceutil/trace.go:171","msg":"trace[394786475] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"174.357064ms","start":"2026-07-31T21:37:51.045052Z","end":"2026-07-31T21:37:51.219409Z","steps":["trace[394786475] 'process raft request'  (duration: 174.186639ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:37:51.474435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.322224ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927281313 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/monitoring/loki-chunks-cache\" mod_revision:4785 > success:<request_put:<key:\"/registry/services/endpoints/monitoring/loki-chunks-cache\" value_size:1065 >> failure:<request_range:<key:\"/registry/services/endpoints/monitoring/loki-chunks-cache\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-31T21:37:51.47477Z","caller":"traceutil/trace.go:171","msg":"trace[328655229] transaction","detail":"{read_only:false; response_revision:5312; number_of_response:1; }","duration":"248.772965ms","start":"2026-07-31T21:37:51.225963Z","end":"2026-07-31T21:37:51.474736Z","steps":["trace[328655229] 'process raft request'  (duration: 147.0735ms)","trace[328655229] 'compare'  (duration: 101.148019ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T21:37:51.474817Z","caller":"traceutil/trace.go:171","msg":"trace[1791917582] transaction","detail":"{read_only:false; response_revision:5317; number_of_response:1; }","duration":"246.054487ms","start":"2026-07-31T21:37:51.228745Z","end":"2026-07-31T21:37:51.474799Z","steps":["trace[1791917582] 'process raft request'  (duration: 246.006096ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:51.47489Z","caller":"traceutil/trace.go:171","msg":"trace[1236896252] transaction","detail":"{read_only:false; response_revision:5313; number_of_response:1; }","duration":"248.708563ms","start":"2026-07-31T21:37:51.22615Z","end":"2026-07-31T21:37:51.474859Z","steps":["trace[1236896252] 'process raft request'  (duration: 248.413705ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:51.474956Z","caller":"traceutil/trace.go:171","msg":"trace[452527763] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"248.712092ms","start":"2026-07-31T21:37:51.22623Z","end":"2026-07-31T21:37:51.474942Z","steps":["trace[452527763] 'process raft request'  (duration: 248.388033ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:51.475021Z","caller":"traceutil/trace.go:171","msg":"trace[410529160] transaction","detail":"{read_only:false; response_revision:5316; number_of_response:1; }","duration":"246.85497ms","start":"2026-07-31T21:37:51.228127Z","end":"2026-07-31T21:37:51.474982Z","steps":["trace[410529160] 'process raft request'  (duration: 246.581532ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:37:51.475108Z","caller":"traceutil/trace.go:171","msg":"trace[224946598] transaction","detail":"{read_only:false; response_revision:5315; number_of_response:1; }","duration":"248.362282ms","start":"2026-07-31T21:37:51.226676Z","end":"2026-07-31T21:37:51.475039Z","steps":["trace[224946598] 'process raft request'  (duration: 247.983581ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:38:38.75558Z","caller":"traceutil/trace.go:171","msg":"trace[1754546685] transaction","detail":"{read_only:false; response_revision:5779; number_of_response:1; }","duration":"117.290159ms","start":"2026-07-31T21:38:38.638238Z","end":"2026-07-31T21:38:38.755529Z","steps":["trace[1754546685] 'process raft request'  (duration: 88.154089ms)","trace[1754546685] 'compare'  (duration: 28.521512ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T21:39:06.253174Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2856}
{"level":"info","ts":"2026-07-31T21:39:06.320165Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2856,"took":"65.565828ms","hash":506699051,"current-db-size-bytes":57171968,"current-db-size":"57 MB","current-db-size-in-use-bytes":33579008,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-07-31T21:39:06.320232Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":506699051,"revision":2856,"compact-revision":-1}
{"level":"info","ts":"2026-07-31T21:43:42.348412Z","caller":"traceutil/trace.go:171","msg":"trace[1063046641] linearizableReadLoop","detail":"{readStateIndex:8329; appliedIndex:8328; }","duration":"267.711556ms","start":"2026-07-31T21:43:42.080678Z","end":"2026-07-31T21:43:42.348389Z","steps":["trace[1063046641] 'read index received'  (duration: 267.50385ms)","trace[1063046641] 'applied index is now lower than readState.Index'  (duration: 206.626µs)"],"step_count":2}
{"level":"info","ts":"2026-07-31T21:43:42.348555Z","caller":"traceutil/trace.go:171","msg":"trace[1927364592] transaction","detail":"{read_only:false; response_revision:8051; number_of_response:1; }","duration":"270.526126ms","start":"2026-07-31T21:43:42.07798Z","end":"2026-07-31T21:43:42.348506Z","steps":["trace[1927364592] 'process raft request'  (duration: 270.260799ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:43:42.34867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.971453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-07-31T21:43:42.348741Z","caller":"traceutil/trace.go:171","msg":"trace[1223268425] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8051; }","duration":"268.081997ms","start":"2026-07-31T21:43:42.080643Z","end":"2026-07-31T21:43:42.348725Z","steps":["trace[1223268425] 'agreement among raft nodes before linearized reading'  (duration: 267.873811ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:43:42.498624Z","caller":"traceutil/trace.go:171","msg":"trace[1640904550] transaction","detail":"{read_only:false; response_revision:8052; number_of_response:1; }","duration":"146.029182ms","start":"2026-07-31T21:43:42.35257Z","end":"2026-07-31T21:43:42.498599Z","steps":["trace[1640904550] 'process raft request'  (duration: 145.3045ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:43:42.508237Z","caller":"traceutil/trace.go:171","msg":"trace[1867993893] transaction","detail":"{read_only:false; response_revision:8054; number_of_response:1; }","duration":"155.175927ms","start":"2026-07-31T21:43:42.353043Z","end":"2026-07-31T21:43:42.508219Z","steps":["trace[1867993893] 'process raft request'  (duration: 155.140366ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:43:42.508348Z","caller":"traceutil/trace.go:171","msg":"trace[1073491979] transaction","detail":"{read_only:false; response_revision:8053; number_of_response:1; }","duration":"155.348772ms","start":"2026-07-31T21:43:42.352976Z","end":"2026-07-31T21:43:42.508324Z","steps":["trace[1073491979] 'process raft request'  (duration: 155.079855ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:43:54.893438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.455715ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927288963 > lease_revoke:<id:4bba9fba14aed573>","response":"size:27"}
{"level":"info","ts":"2026-07-31T21:43:54.893532Z","caller":"traceutil/trace.go:171","msg":"trace[1307449587] linearizableReadLoop","detail":"{readStateIndex:8395; appliedIndex:8394; }","duration":"325.26513ms","start":"2026-07-31T21:43:54.568253Z","end":"2026-07-31T21:43:54.893518Z","steps":["trace[1307449587] 'read index received'  (duration: 53.661µs)","trace[1307449587] 'applied index is now lower than readState.Index'  (duration: 325.210239ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T21:43:54.89374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.476427ms","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-07-31T21:43:54.893773Z","caller":"traceutil/trace.go:171","msg":"trace[1257614382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8114; }","duration":"325.548929ms","start":"2026-07-31T21:43:54.568213Z","end":"2026-07-31T21:43:54.893762Z","steps":["trace[1257614382] 'agreement among raft nodes before linearized reading'  (duration: 325.393975ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:43:54.893805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:43:54.568193Z","time spent":"325.60379ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-07-31T21:43:54.899169Z","caller":"traceutil/trace.go:171","msg":"trace[1381179577] transaction","detail":"{read_only:false; response_revision:8115; number_of_response:1; }","duration":"131.351175ms","start":"2026-07-31T21:43:54.767795Z","end":"2026-07-31T21:43:54.899147Z","steps":["trace[1381179577] 'process raft request'  (duration: 131.088797ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:43:54.94908Z","caller":"traceutil/trace.go:171","msg":"trace[1792388884] transaction","detail":"{read_only:false; response_revision:8116; number_of_response:1; }","duration":"105.164911ms","start":"2026-07-31T21:43:54.843895Z","end":"2026-07-31T21:43:54.94906Z","steps":["trace[1792388884] 'process raft request'  (duration: 104.941605ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:43:54.94912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.753036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-07-31T21:43:54.949255Z","caller":"traceutil/trace.go:171","msg":"trace[751919852] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8116; }","duration":"379.931521ms","start":"2026-07-31T21:43:54.569303Z","end":"2026-07-31T21:43:54.949235Z","steps":["trace[751919852] 'agreement among raft nodes before linearized reading'  (duration: 379.681914ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:43:54.949301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:43:54.569287Z","time spent":"380.005505ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-07-31T21:44:06.260134Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6014}
{"level":"info","ts":"2026-07-31T21:44:06.358142Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6014,"took":"96.097019ms","hash":3572107025,"current-db-size-bytes":57171968,"current-db-size":"57 MB","current-db-size-in-use-bytes":22802432,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-07-31T21:44:06.358219Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3572107025,"revision":6014,"compact-revision":2856}
{"level":"warn","ts":"2026-07-31T21:44:21.425329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.508757ms","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-07-31T21:44:21.425447Z","caller":"traceutil/trace.go:171","msg":"trace[297059509] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8314; }","duration":"167.672402ms","start":"2026-07-31T21:44:21.257752Z","end":"2026-07-31T21:44:21.425424Z","steps":["trace[297059509] 'range keys from in-memory index tree'  (duration: 167.302222ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:44:21.425549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.651498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-07-31T21:44:21.425681Z","caller":"traceutil/trace.go:171","msg":"trace[2025352334] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8314; }","duration":"251.845344ms","start":"2026-07-31T21:44:21.173801Z","end":"2026-07-31T21:44:21.425647Z","steps":["trace[2025352334] 'range keys from in-memory index tree'  (duration: 251.478062ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:44:21.425697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.54233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"warn","ts":"2026-07-31T21:44:21.425334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.317817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-07-31T21:44:21.425752Z","caller":"traceutil/trace.go:171","msg":"trace[1401024366] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8314; }","duration":"165.650253ms","start":"2026-07-31T21:44:21.260087Z","end":"2026-07-31T21:44:21.425737Z","steps":["trace[1401024366] 'range keys from in-memory index tree'  (duration: 165.379785ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:44:21.425808Z","caller":"traceutil/trace.go:171","msg":"trace[1503843052] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8314; }","duration":"252.822451ms","start":"2026-07-31T21:44:21.172941Z","end":"2026-07-31T21:44:21.425764Z","steps":["trace[1503843052] 'range keys from in-memory index tree'  (duration: 252.161902ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:44:21.425898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.383816ms","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-07-31T21:44:21.425959Z","caller":"traceutil/trace.go:171","msg":"trace[1510861481] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8314; }","duration":"220.50766ms","start":"2026-07-31T21:44:21.205434Z","end":"2026-07-31T21:44:21.425942Z","steps":["trace[1510861481] 'range keys from in-memory index tree'  (duration: 219.615004ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:44:21.558353Z","caller":"traceutil/trace.go:171","msg":"trace[159710838] transaction","detail":"{read_only:false; response_revision:8315; number_of_response:1; }","duration":"127.996097ms","start":"2026-07-31T21:44:21.43033Z","end":"2026-07-31T21:44:21.558326Z","steps":["trace[159710838] 'process raft request'  (duration: 127.817392ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:44:21.570062Z","caller":"traceutil/trace.go:171","msg":"trace[1333719564] transaction","detail":"{read_only:false; response_revision:8316; number_of_response:1; }","duration":"139.646996ms","start":"2026-07-31T21:44:21.430388Z","end":"2026-07-31T21:44:21.570035Z","steps":["trace[1333719564] 'process raft request'  (duration: 139.211494ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:44:21.570131Z","caller":"traceutil/trace.go:171","msg":"trace[1920572378] transaction","detail":"{read_only:false; response_revision:8317; number_of_response:1; }","duration":"139.551083ms","start":"2026-07-31T21:44:21.430558Z","end":"2026-07-31T21:44:21.570109Z","steps":["trace[1920572378] 'process raft request'  (duration: 139.357698ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:44:21.570353Z","caller":"traceutil/trace.go:171","msg":"trace[1384807871] transaction","detail":"{read_only:false; response_revision:8318; number_of_response:1; }","duration":"139.000458ms","start":"2026-07-31T21:44:21.431342Z","end":"2026-07-31T21:44:21.570342Z","steps":["trace[1384807871] 'process raft request'  (duration: 138.653828ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:44:21.570444Z","caller":"traceutil/trace.go:171","msg":"trace[648685771] transaction","detail":"{read_only:false; response_revision:8319; number_of_response:1; }","duration":"137.170524ms","start":"2026-07-31T21:44:21.433249Z","end":"2026-07-31T21:44:21.570419Z","steps":["trace[648685771] 'process raft request'  (duration: 136.805134ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:44:34.718766Z","caller":"traceutil/trace.go:171","msg":"trace[1052654446] transaction","detail":"{read_only:false; response_revision:8425; number_of_response:1; }","duration":"103.572316ms","start":"2026-07-31T21:44:34.615168Z","end":"2026-07-31T21:44:34.71874Z","steps":["trace[1052654446] 'process raft request'  (duration: 103.214315ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:44:34.881989Z","caller":"traceutil/trace.go:171","msg":"trace[1064732944] transaction","detail":"{read_only:false; response_revision:8426; number_of_response:1; }","duration":"264.557123ms","start":"2026-07-31T21:44:34.617391Z","end":"2026-07-31T21:44:34.881948Z","steps":["trace[1064732944] 'process raft request'  (duration: 264.237994ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:44:35.742265Z","caller":"traceutil/trace.go:171","msg":"trace[810036964] transaction","detail":"{read_only:false; response_revision:8432; number_of_response:1; }","duration":"103.390001ms","start":"2026-07-31T21:44:35.638847Z","end":"2026-07-31T21:44:35.742237Z","steps":["trace[810036964] 'process raft request'  (duration: 68.635338ms)","trace[810036964] 'compare'  (duration: 34.169226ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T21:44:36.070661Z","caller":"traceutil/trace.go:171","msg":"trace[2019283087] linearizableReadLoop","detail":"{readStateIndex:8731; appliedIndex:8729; }","duration":"193.133614ms","start":"2026-07-31T21:44:35.877502Z","end":"2026-07-31T21:44:36.070635Z","steps":["trace[2019283087] 'read index received'  (duration: 163.368867ms)","trace[2019283087] 'applied index is now lower than readState.Index'  (duration: 29.763377ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T21:44:36.070703Z","caller":"traceutil/trace.go:171","msg":"trace[1860575410] transaction","detail":"{read_only:false; response_revision:8436; number_of_response:1; }","duration":"323.018965ms","start":"2026-07-31T21:44:35.747629Z","end":"2026-07-31T21:44:36.070648Z","steps":["trace[1860575410] 'process raft request'  (duration: 322.921262ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:44:36.070751Z","caller":"traceutil/trace.go:171","msg":"trace[214494061] transaction","detail":"{read_only:false; response_revision:8435; number_of_response:1; }","duration":"323.155039ms","start":"2026-07-31T21:44:35.747507Z","end":"2026-07-31T21:44:36.070662Z","steps":["trace[214494061] 'process raft request'  (duration: 293.359621ms)","trace[214494061] 'compare'  (duration: 29.469318ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T21:44:36.070877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.35764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-31T21:44:36.070922Z","caller":"traceutil/trace.go:171","msg":"trace[185088489] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:8436; }","duration":"193.466584ms","start":"2026-07-31T21:44:35.877442Z","end":"2026-07-31T21:44:36.070909Z","steps":["trace[185088489] 'agreement among raft nodes before linearized reading'  (duration: 193.371521ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:44:36.070915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:44:35.747617Z","time spent":"323.21802ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8411 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-07-31T21:44:36.071038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:44:35.747478Z","time spent":"323.402126ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8409 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-31T21:44:36.071039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.680589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-4lrj6\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-07-31T21:44:36.071302Z","caller":"traceutil/trace.go:171","msg":"trace[1185955133] range","detail":"{range_begin:/registry/pods/openstack/keepalived-4lrj6; range_end:; response_count:1; response_revision:8436; }","duration":"158.942428ms","start":"2026-07-31T21:44:35.912285Z","end":"2026-07-31T21:44:36.071227Z","steps":["trace[1185955133] 'agreement among raft nodes before linearized reading'  (duration: 158.602878ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:45:21.148245Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002404.wal"}
{"level":"info","ts":"2026-07-31T21:45:43.601406Z","caller":"traceutil/trace.go:171","msg":"trace[703400925] transaction","detail":"{read_only:false; response_revision:9074; number_of_response:1; }","duration":"194.503677ms","start":"2026-07-31T21:45:43.40685Z","end":"2026-07-31T21:45:43.601353Z","steps":["trace[703400925] 'process raft request'  (duration: 156.876253ms)","trace[703400925] 'compare'  (duration: 37.034827ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T21:46:56.616492Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"50e03cebfd94cbba","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-31T21:46:56.623395Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-07-31T21:46:56.623545Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-07-31T21:49:06.266933Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8184}
{"level":"info","ts":"2026-07-31T21:49:06.340941Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8184,"took":"71.83607ms","hash":1192167316,"current-db-size-bytes":57171968,"current-db-size":"57 MB","current-db-size-in-use-bytes":26697728,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-07-31T21:49:06.341032Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1192167316,"revision":8184,"compact-revision":6014}
{"level":"info","ts":"2026-07-31T21:54:06.275429Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10901}
{"level":"info","ts":"2026-07-31T21:54:06.357233Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10901,"took":"78.470157ms","hash":1429188446,"current-db-size-bytes":57171968,"current-db-size":"57 MB","current-db-size-in-use-bytes":27860992,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-07-31T21:54:06.357303Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1429188446,"revision":10901,"compact-revision":8184}
{"level":"info","ts":"2026-07-31T21:55:26.729821Z","caller":"traceutil/trace.go:171","msg":"trace[1616476873] linearizableReadLoop","detail":"{readStateIndex:13912; appliedIndex:13911; }","duration":"183.322765ms","start":"2026-07-31T21:55:26.546472Z","end":"2026-07-31T21:55:26.729795Z","steps":["trace[1616476873] 'read index received'  (duration: 183.229192ms)","trace[1616476873] 'applied index is now lower than readState.Index'  (duration: 92.683µs)"],"step_count":2}
{"level":"info","ts":"2026-07-31T21:55:26.729857Z","caller":"traceutil/trace.go:171","msg":"trace[546353775] transaction","detail":"{read_only:false; response_revision:13459; number_of_response:1; }","duration":"236.914244ms","start":"2026-07-31T21:55:26.49291Z","end":"2026-07-31T21:55:26.729824Z","steps":["trace[546353775] 'process raft request'  (duration: 236.744939ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:55:26.730042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.550961ms","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-07-31T21:55:26.730074Z","caller":"traceutil/trace.go:171","msg":"trace[585665150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13459; }","duration":"183.634334ms","start":"2026-07-31T21:55:26.54643Z","end":"2026-07-31T21:55:26.730064Z","steps":["trace[585665150] 'agreement among raft nodes before linearized reading'  (duration: 183.473509ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:55:40.667534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.880802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-31T21:55:40.667639Z","caller":"traceutil/trace.go:171","msg":"trace[636604699] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13547; }","duration":"102.046638ms","start":"2026-07-31T21:55:40.565571Z","end":"2026-07-31T21:55:40.667617Z","steps":["trace[636604699] 'range keys from in-memory index tree'  (duration: 101.7834ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:55:40.667688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.75322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-kzkpl\" ","response":"range_response_count:1 size:12360"}
{"level":"info","ts":"2026-07-31T21:55:40.667805Z","caller":"traceutil/trace.go:171","msg":"trace[1900691830] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-kzkpl; range_end:; response_count:1; response_revision:13547; }","duration":"100.938485ms","start":"2026-07-31T21:55:40.566841Z","end":"2026-07-31T21:55:40.667779Z","steps":["trace[1900691830] 'range keys from in-memory index tree'  (duration: 100.434441ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:55:41.453022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.143186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-07-31T21:55:41.453049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.890933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-07-31T21:55:41.453093Z","caller":"traceutil/trace.go:171","msg":"trace[1313353895] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:13551; }","duration":"232.247118ms","start":"2026-07-31T21:55:41.220829Z","end":"2026-07-31T21:55:41.453076Z","steps":["trace[1313353895] 'count revisions from in-memory index tree'  (duration: 232.011622ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:55:41.453099Z","caller":"traceutil/trace.go:171","msg":"trace[1308549705] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:13551; }","duration":"245.980816ms","start":"2026-07-31T21:55:41.207103Z","end":"2026-07-31T21:55:41.453084Z","steps":["trace[1308549705] 'range keys from in-memory index tree'  (duration: 245.718909ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:55:41.644047Z","caller":"traceutil/trace.go:171","msg":"trace[1947766809] transaction","detail":"{read_only:false; response_revision:13552; number_of_response:1; }","duration":"185.782007ms","start":"2026-07-31T21:55:41.458236Z","end":"2026-07-31T21:55:41.644018Z","steps":["trace[1947766809] 'process raft request'  (duration: 185.569071ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:55:41.656793Z","caller":"traceutil/trace.go:171","msg":"trace[1770297306] linearizableReadLoop","detail":"{readStateIndex:14010; appliedIndex:14008; }","duration":"194.24707ms","start":"2026-07-31T21:55:41.462525Z","end":"2026-07-31T21:55:41.656772Z","steps":["trace[1770297306] 'read index received'  (duration: 181.282267ms)","trace[1770297306] 'applied index is now lower than readState.Index'  (duration: 12.963863ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T21:55:41.656896Z","caller":"traceutil/trace.go:171","msg":"trace[195495892] transaction","detail":"{read_only:false; response_revision:13553; number_of_response:1; }","duration":"196.677771ms","start":"2026-07-31T21:55:41.460157Z","end":"2026-07-31T21:55:41.656835Z","steps":["trace[195495892] 'process raft request'  (duration: 193.955133ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:55:41.657013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.472767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-07-31T21:55:41.65705Z","caller":"traceutil/trace.go:171","msg":"trace[1372957583] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:13554; }","duration":"194.54452ms","start":"2026-07-31T21:55:41.462494Z","end":"2026-07-31T21:55:41.657038Z","steps":["trace[1372957583] 'agreement among raft nodes before linearized reading'  (duration: 194.405165ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:55:41.657034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.759123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-31T21:55:41.657118Z","caller":"traceutil/trace.go:171","msg":"trace[1065349695] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:13554; }","duration":"142.854227ms","start":"2026-07-31T21:55:41.514239Z","end":"2026-07-31T21:55:41.657093Z","steps":["trace[1065349695] 'agreement among raft nodes before linearized reading'  (duration: 142.715022ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:57:23.46646Z","caller":"traceutil/trace.go:171","msg":"trace[1726668644] transaction","detail":"{read_only:false; response_revision:14758; number_of_response:1; }","duration":"146.27609ms","start":"2026-07-31T21:57:23.320157Z","end":"2026-07-31T21:57:23.466434Z","steps":["trace[1726668644] 'process raft request'  (duration: 146.075564ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:57:23.827233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.326043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-07-31T21:57:23.827239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.64183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-31T21:57:23.827312Z","caller":"traceutil/trace.go:171","msg":"trace[805462690] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14758; }","duration":"182.464537ms","start":"2026-07-31T21:57:23.644828Z","end":"2026-07-31T21:57:23.827293Z","steps":["trace[805462690] 'range keys from in-memory index tree'  (duration: 182.149898ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:57:23.827337Z","caller":"traceutil/trace.go:171","msg":"trace[415563080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14758; }","duration":"258.792344ms","start":"2026-07-31T21:57:23.568516Z","end":"2026-07-31T21:57:23.827308Z","steps":["trace[415563080] 'range keys from in-memory index tree'  (duration: 258.542057ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T21:57:23.827682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.960158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-07-31T21:57:23.827774Z","caller":"traceutil/trace.go:171","msg":"trace[1800374826] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14758; }","duration":"186.096692ms","start":"2026-07-31T21:57:23.641654Z","end":"2026-07-31T21:57:23.827751Z","steps":["trace[1800374826] 'range keys from in-memory index tree'  (duration: 185.68246ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T21:59:06.281783Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12941}
{"level":"info","ts":"2026-07-31T21:59:06.358207Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12941,"took":"73.470274ms","hash":3763938322,"current-db-size-bytes":57171968,"current-db-size":"57 MB","current-db-size-in-use-bytes":30920704,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-31T21:59:06.358259Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3763938322,"revision":12941,"compact-revision":10901}
{"level":"info","ts":"2026-07-31T22:00:54.880875Z","caller":"traceutil/trace.go:171","msg":"trace[1316873233] linearizableReadLoop","detail":"{readStateIndex:16929; appliedIndex:16928; }","duration":"141.053796ms","start":"2026-07-31T22:00:54.739794Z","end":"2026-07-31T22:00:54.880848Z","steps":["trace[1316873233] 'read index received'  (duration: 140.985844ms)","trace[1316873233] 'applied index is now lower than readState.Index'  (duration: 66.902µs)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:00:54.880984Z","caller":"traceutil/trace.go:171","msg":"trace[1812524894] transaction","detail":"{read_only:false; response_revision:16384; number_of_response:1; }","duration":"162.399072ms","start":"2026-07-31T22:00:54.718551Z","end":"2026-07-31T22:00:54.88095Z","steps":["trace[1812524894] 'process raft request'  (duration: 162.154175ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:00:54.881166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.346365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-l5l2g\" ","response":"range_response_count:1 size:20650"}
{"level":"info","ts":"2026-07-31T22:00:54.881231Z","caller":"traceutil/trace.go:171","msg":"trace[725459810] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-l5l2g; range_end:; response_count:1; response_revision:16384; }","duration":"141.49882ms","start":"2026-07-31T22:00:54.739717Z","end":"2026-07-31T22:00:54.881216Z","steps":["trace[725459810] 'agreement among raft nodes before linearized reading'  (duration: 141.262433ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:03:07.288146Z","caller":"traceutil/trace.go:171","msg":"trace[919075980] transaction","detail":"{read_only:false; response_revision:17370; number_of_response:1; }","duration":"168.714106ms","start":"2026-07-31T22:03:07.119394Z","end":"2026-07-31T22:03:07.288108Z","steps":["trace[919075980] 'process raft request'  (duration: 136.677657ms)","trace[919075980] 'compare'  (duration: 31.70203ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:03:13.321635Z","caller":"traceutil/trace.go:171","msg":"trace[1459160178] linearizableReadLoop","detail":"{readStateIndex:17985; appliedIndex:17984; }","duration":"173.698802ms","start":"2026-07-31T22:03:13.147909Z","end":"2026-07-31T22:03:13.321608Z","steps":["trace[1459160178] 'read index received'  (duration: 173.527877ms)","trace[1459160178] 'applied index is now lower than readState.Index'  (duration: 169.685µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:03:13.321891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.969091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-7ss2s\" ","response":"range_response_count:1 size:9799"}
{"level":"info","ts":"2026-07-31T22:03:13.32193Z","caller":"traceutil/trace.go:171","msg":"trace[1797991679] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-7ss2s; range_end:; response_count:1; response_revision:17407; }","duration":"174.067003ms","start":"2026-07-31T22:03:13.147852Z","end":"2026-07-31T22:03:13.321919Z","steps":["trace[1797991679] 'agreement among raft nodes before linearized reading'  (duration: 173.861487ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:03:13.322053Z","caller":"traceutil/trace.go:171","msg":"trace[1905307581] transaction","detail":"{read_only:false; response_revision:17407; number_of_response:1; }","duration":"178.343468ms","start":"2026-07-31T22:03:13.1437Z","end":"2026-07-31T22:03:13.322044Z","steps":["trace[1905307581] 'process raft request'  (duration: 177.741121ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:04:06.287541Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15418}
{"level":"info","ts":"2026-07-31T22:04:06.382104Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15418,"took":"90.029213ms","hash":442566117,"current-db-size-bytes":57171968,"current-db-size":"57 MB","current-db-size-in-use-bytes":33148928,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-07-31T22:04:06.382166Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":442566117,"revision":15418,"compact-revision":12941}
{"level":"info","ts":"2026-07-31T22:06:32.134532Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"50e03cebfd94cbba","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-31T22:06:32.140583Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-07-31T22:06:32.140727Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-07-31T22:09:06.294678Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18016}
{"level":"info","ts":"2026-07-31T22:09:06.407282Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18016,"took":"109.449655ms","hash":3518817874,"current-db-size-bytes":57171968,"current-db-size":"57 MB","current-db-size-in-use-bytes":32231424,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-07-31T22:09:06.407355Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3518817874,"revision":18016,"compact-revision":15418}
{"level":"info","ts":"2026-07-31T22:10:18.054436Z","caller":"traceutil/trace.go:171","msg":"trace[1213005002] transaction","detail":"{read_only:false; response_revision:20998; number_of_response:1; }","duration":"120.52466ms","start":"2026-07-31T22:10:17.933884Z","end":"2026-07-31T22:10:18.054408Z","steps":["trace[1213005002] 'process raft request'  (duration: 120.344214ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:10:23.707672Z","caller":"traceutil/trace.go:171","msg":"trace[140903002] linearizableReadLoop","detail":"{readStateIndex:21714; appliedIndex:21713; }","duration":"140.392502ms","start":"2026-07-31T22:10:23.56726Z","end":"2026-07-31T22:10:23.707652Z","steps":["trace[140903002] 'read index received'  (duration: 140.220577ms)","trace[140903002] 'applied index is now lower than readState.Index'  (duration: 171.105µs)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:10:23.707724Z","caller":"traceutil/trace.go:171","msg":"trace[335647869] transaction","detail":"{read_only:false; response_revision:21025; number_of_response:1; }","duration":"244.477761ms","start":"2026-07-31T22:10:23.463212Z","end":"2026-07-31T22:10:23.70769Z","steps":["trace[335647869] 'process raft request'  (duration: 244.317036ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:10:23.7078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.531766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:10:23.707829Z","caller":"traceutil/trace.go:171","msg":"trace[397826795] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21025; }","duration":"140.614528ms","start":"2026-07-31T22:10:23.567207Z","end":"2026-07-31T22:10:23.707822Z","steps":["trace[397826795] 'agreement among raft nodes before linearized reading'  (duration: 140.544626ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:10:23.908648Z","caller":"traceutil/trace.go:171","msg":"trace[430588591] transaction","detail":"{read_only:false; response_revision:21026; number_of_response:1; }","duration":"196.205207ms","start":"2026-07-31T22:10:23.712415Z","end":"2026-07-31T22:10:23.90862Z","steps":["trace[430588591] 'process raft request'  (duration: 110.861177ms)","trace[430588591] 'compare'  (duration: 85.133084ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:10:23.908861Z","caller":"traceutil/trace.go:171","msg":"trace[407138874] transaction","detail":"{read_only:false; response_revision:21027; number_of_response:1; }","duration":"196.31629ms","start":"2026-07-31T22:10:23.712504Z","end":"2026-07-31T22:10:23.90882Z","steps":["trace[407138874] 'process raft request'  (duration: 196.072353ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:10:24.232945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.082255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-07-31T22:10:24.233066Z","caller":"traceutil/trace.go:171","msg":"trace[1755672107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21027; }","duration":"153.250248ms","start":"2026-07-31T22:10:24.079795Z","end":"2026-07-31T22:10:24.233045Z","steps":["trace[1755672107] 'range keys from in-memory index tree'  (duration: 152.897489ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:10:24.434331Z","caller":"traceutil/trace.go:171","msg":"trace[2061846143] transaction","detail":"{read_only:false; response_revision:21028; number_of_response:1; }","duration":"195.760914ms","start":"2026-07-31T22:10:24.238529Z","end":"2026-07-31T22:10:24.43429Z","steps":["trace[2061846143] 'process raft request'  (duration: 195.501406ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:10:24.551138Z","caller":"traceutil/trace.go:171","msg":"trace[211716966] linearizableReadLoop","detail":"{readStateIndex:21718; appliedIndex:21716; }","duration":"141.535475ms","start":"2026-07-31T22:10:24.409558Z","end":"2026-07-31T22:10:24.551093Z","steps":["trace[211716966] 'read index received'  (duration: 24.486016ms)","trace[211716966] 'applied index is now lower than readState.Index'  (duration: 117.044658ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:10:24.551176Z","caller":"traceutil/trace.go:171","msg":"trace[1663972287] transaction","detail":"{read_only:false; response_revision:21029; number_of_response:1; }","duration":"311.255407ms","start":"2026-07-31T22:10:24.239838Z","end":"2026-07-31T22:10:24.551093Z","steps":["trace[1663972287] 'process raft request'  (duration: 310.088133ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:10:24.55145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:10:24.23981Z","time spent":"311.491934ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:21019 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-31T22:10:24.553873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.264664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-07-31T22:10:24.553937Z","caller":"traceutil/trace.go:171","msg":"trace[1217618424] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:21029; }","duration":"144.402238ms","start":"2026-07-31T22:10:24.409517Z","end":"2026-07-31T22:10:24.553919Z","steps":["trace[1217618424] 'agreement among raft nodes before linearized reading'  (duration: 141.749531ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:10:24.750631Z","caller":"traceutil/trace.go:171","msg":"trace[127990095] transaction","detail":"{read_only:false; response_revision:21031; number_of_response:1; }","duration":"191.280892ms","start":"2026-07-31T22:10:24.559316Z","end":"2026-07-31T22:10:24.750596Z","steps":["trace[127990095] 'process raft request'  (duration: 150.745715ms)","trace[127990095] 'compare'  (duration: 40.356362ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:13:57.05536Z","caller":"traceutil/trace.go:171","msg":"trace[233848042] linearizableReadLoop","detail":"{readStateIndex:24057; appliedIndex:24056; }","duration":"204.830166ms","start":"2026-07-31T22:13:56.850503Z","end":"2026-07-31T22:13:57.055333Z","steps":["trace[233848042] 'read index received'  (duration: 204.631631ms)","trace[233848042] 'applied index is now lower than readState.Index'  (duration: 197.535µs)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:13:57.055488Z","caller":"traceutil/trace.go:171","msg":"trace[709216160] transaction","detail":"{read_only:false; response_revision:23295; number_of_response:1; }","duration":"238.667684ms","start":"2026-07-31T22:13:56.81681Z","end":"2026-07-31T22:13:57.055478Z","steps":["trace[709216160] 'process raft request'  (duration: 238.357575ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:13:57.055771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.274619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-07-31T22:13:57.055857Z","caller":"traceutil/trace.go:171","msg":"trace[49572293] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23295; }","duration":"205.419384ms","start":"2026-07-31T22:13:56.850417Z","end":"2026-07-31T22:13:57.055836Z","steps":["trace[49572293] 'agreement among raft nodes before linearized reading'  (duration: 205.141956ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:13:57.100993Z","caller":"traceutil/trace.go:171","msg":"trace[255724207] transaction","detail":"{read_only:false; response_revision:23296; number_of_response:1; }","duration":"141.328357ms","start":"2026-07-31T22:13:56.959638Z","end":"2026-07-31T22:13:57.100967Z","steps":["trace[255724207] 'process raft request'  (duration: 141.108451ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:13:57.101034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.921547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"warn","ts":"2026-07-31T22:13:57.101053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.319375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-07-31T22:13:57.101102Z","caller":"traceutil/trace.go:171","msg":"trace[869129762] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:23296; }","duration":"164.0386ms","start":"2026-07-31T22:13:56.937045Z","end":"2026-07-31T22:13:57.101084Z","steps":["trace[869129762] 'agreement among raft nodes before linearized reading'  (duration: 163.848854ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:13:57.101116Z","caller":"traceutil/trace.go:171","msg":"trace[1499341876] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23296; }","duration":"119.424078ms","start":"2026-07-31T22:13:56.981677Z","end":"2026-07-31T22:13:57.101101Z","steps":["trace[1499341876] 'agreement among raft nodes before linearized reading'  (duration: 119.240143ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:13:57.10118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.486041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-07-31T22:13:57.101249Z","caller":"traceutil/trace.go:171","msg":"trace[133616548] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23296; }","duration":"123.593064ms","start":"2026-07-31T22:13:56.977639Z","end":"2026-07-31T22:13:57.101232Z","steps":["trace[133616548] 'agreement among raft nodes before linearized reading'  (duration: 123.339807ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:14:06.301152Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20533}
{"level":"info","ts":"2026-07-31T22:14:06.412284Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20533,"took":"107.633005ms","hash":824955864,"current-db-size-bytes":57171968,"current-db-size":"57 MB","current-db-size-in-use-bytes":44003328,"current-db-size-in-use":"44 MB"}
{"level":"info","ts":"2026-07-31T22:14:06.412353Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":824955864,"revision":20533,"compact-revision":18016}
{"level":"warn","ts":"2026-07-31T22:17:00.805286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.940218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedrainrules/\" range_end:\"/registry/cluster.x-k8s.io/machinedrainrules0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-31T22:17:00.805366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.891886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"}
{"level":"info","ts":"2026-07-31T22:17:00.805402Z","caller":"traceutil/trace.go:171","msg":"trace[879957391] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedrainrules/; range_end:/registry/cluster.x-k8s.io/machinedrainrules0; response_count:0; response_revision:25295; }","duration":"178.110623ms","start":"2026-07-31T22:17:00.62727Z","end":"2026-07-31T22:17:00.805381Z","steps":["trace[879957391] 'count revisions from in-memory index tree'  (duration: 177.864616ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:00.80545Z","caller":"traceutil/trace.go:171","msg":"trace[572477105] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25295; }","duration":"178.02348ms","start":"2026-07-31T22:17:00.627403Z","end":"2026-07-31T22:17:00.805427Z","steps":["trace[572477105] 'range keys from in-memory index tree'  (duration: 177.715772ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:01.099232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.56388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-31T22:17:01.099307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.56469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"}
{"level":"info","ts":"2026-07-31T22:17:01.099351Z","caller":"traceutil/trace.go:171","msg":"trace[2022810667] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25297; }","duration":"114.709904ms","start":"2026-07-31T22:17:00.984612Z","end":"2026-07-31T22:17:01.099322Z","steps":["trace[2022810667] 'range keys from in-memory index tree'  (duration: 114.474077ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:01.099374Z","caller":"traceutil/trace.go:171","msg":"trace[2077893197] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25297; }","duration":"114.681853ms","start":"2026-07-31T22:17:00.984677Z","end":"2026-07-31T22:17:01.099359Z","steps":["trace[2077893197] 'range keys from in-memory index tree'  (duration: 114.125498ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:01.427583Z","caller":"traceutil/trace.go:171","msg":"trace[1578626362] linearizableReadLoop","detail":"{readStateIndex:26112; appliedIndex:26111; }","duration":"297.118623ms","start":"2026-07-31T22:17:01.130436Z","end":"2026-07-31T22:17:01.427555Z","steps":["trace[1578626362] 'read index received'  (duration: 296.895836ms)","trace[1578626362] 'applied index is now lower than readState.Index'  (duration: 221.317µs)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:01.427658Z","caller":"traceutil/trace.go:171","msg":"trace[1710284094] transaction","detail":"{read_only:false; response_revision:25298; number_of_response:1; }","duration":"310.695658ms","start":"2026-07-31T22:17:01.116917Z","end":"2026-07-31T22:17:01.427612Z","steps":["trace[1710284094] 'process raft request'  (duration: 310.45096ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:01.427781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.087524ms","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:6"}
{"level":"info","ts":"2026-07-31T22:17:01.427821Z","caller":"traceutil/trace.go:171","msg":"trace[1438535072] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:25298; }","duration":"247.186736ms","start":"2026-07-31T22:17:01.180622Z","end":"2026-07-31T22:17:01.427809Z","steps":["trace[1438535072] 'agreement among raft nodes before linearized reading'  (duration: 247.084673ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:01.427832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.37367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5684"}
{"level":"info","ts":"2026-07-31T22:17:01.427897Z","caller":"traceutil/trace.go:171","msg":"trace[574858871] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:25298; }","duration":"297.492894ms","start":"2026-07-31T22:17:01.13039Z","end":"2026-07-31T22:17:01.427883Z","steps":["trace[574858871] 'agreement among raft nodes before linearized reading'  (duration: 297.280427ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:01.427927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:01.116895Z","time spent":"310.850282ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25282 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-07-31T22:17:05.167669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.219804ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927341187 > lease_revoke:<id:4bba9fba14afa0c6>","response":"size:28"}
{"level":"warn","ts":"2026-07-31T22:17:05.737161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.680186ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927341193 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25295 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:519 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-31T22:17:05.737269Z","caller":"traceutil/trace.go:171","msg":"trace[521990634] linearizableReadLoop","detail":"{readStateIndex:26142; appliedIndex:26141; }","duration":"171.832341ms","start":"2026-07-31T22:17:05.56542Z","end":"2026-07-31T22:17:05.737252Z","steps":["trace[521990634] 'read index received'  (duration: 35.818045ms)","trace[521990634] 'applied index is now lower than readState.Index'  (duration: 136.012766ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:17:05.737385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.963905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:17:05.737378Z","caller":"traceutil/trace.go:171","msg":"trace[173243025] transaction","detail":"{read_only:false; response_revision:25327; number_of_response:1; }","duration":"207.650114ms","start":"2026-07-31T22:17:05.529691Z","end":"2026-07-31T22:17:05.737341Z","steps":["trace[173243025] 'process raft request'  (duration: 71.618327ms)","trace[173243025] 'compare'  (duration: 135.523842ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:05.73741Z","caller":"traceutil/trace.go:171","msg":"trace[17232394] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25327; }","duration":"172.027766ms","start":"2026-07-31T22:17:05.565374Z","end":"2026-07-31T22:17:05.737402Z","steps":["trace[17232394] 'agreement among raft nodes before linearized reading'  (duration: 171.969135ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:05.737463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.81046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-31T22:17:05.737517Z","caller":"traceutil/trace.go:171","msg":"trace[775435722] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:25327; }","duration":"111.916103ms","start":"2026-07-31T22:17:05.625586Z","end":"2026-07-31T22:17:05.737502Z","steps":["trace[775435722] 'agreement among raft nodes before linearized reading'  (duration: 111.79524ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:06.553552Z","caller":"traceutil/trace.go:171","msg":"trace[1051526906] transaction","detail":"{read_only:false; response_revision:25330; number_of_response:1; }","duration":"402.111103ms","start":"2026-07-31T22:17:06.151421Z","end":"2026-07-31T22:17:06.553532Z","steps":["trace[1051526906] 'process raft request'  (duration: 402.060952ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:06.5536Z","caller":"traceutil/trace.go:171","msg":"trace[1885509182] transaction","detail":"{read_only:false; response_revision:25329; number_of_response:1; }","duration":"402.66665ms","start":"2026-07-31T22:17:06.150899Z","end":"2026-07-31T22:17:06.553565Z","steps":["trace[1885509182] 'process raft request'  (duration: 373.261344ms)","trace[1885509182] 'compare'  (duration: 28.990114ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:17:06.553768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:06.150884Z","time spent":"402.783504ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25314 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-07-31T22:17:06.553825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:06.151407Z","time spent":"402.206197ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25315 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-07-31T22:17:06.776467Z","caller":"traceutil/trace.go:171","msg":"trace[787771473] transaction","detail":"{read_only:false; response_revision:25331; number_of_response:1; }","duration":"544.142285ms","start":"2026-07-31T22:17:06.232298Z","end":"2026-07-31T22:17:06.77644Z","steps":["trace[787771473] 'process raft request'  (duration: 479.586623ms)","trace[787771473] 'compare'  (duration: 64.344786ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:06.776771Z","caller":"traceutil/trace.go:171","msg":"trace[1169356023] transaction","detail":"{read_only:false; response_revision:25332; number_of_response:1; }","duration":"512.431741ms","start":"2026-07-31T22:17:06.264306Z","end":"2026-07-31T22:17:06.776738Z","steps":["trace[1169356023] 'process raft request'  (duration: 512.089131ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:06.776803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:06.232269Z","time spent":"544.272119ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25317 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-07-31T22:17:06.776958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:06.264287Z","time spent":"512.573165ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25318 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-07-31T22:17:06.776981Z","caller":"traceutil/trace.go:171","msg":"trace[510201779] transaction","detail":"{read_only:false; response_revision:25333; number_of_response:1; }","duration":"391.6621ms","start":"2026-07-31T22:17:06.385299Z","end":"2026-07-31T22:17:06.776961Z","steps":["trace[510201779] 'process raft request'  (duration: 391.30382ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:06.777093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:06.385279Z","time spent":"391.745282ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25319 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-07-31T22:17:06.777262Z","caller":"traceutil/trace.go:171","msg":"trace[762153109] transaction","detail":"{read_only:false; response_revision:25334; number_of_response:1; }","duration":"380.887795ms","start":"2026-07-31T22:17:06.396335Z","end":"2026-07-31T22:17:06.777223Z","steps":["trace[762153109] 'process raft request'  (duration: 380.553176ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:06.77745Z","caller":"traceutil/trace.go:171","msg":"trace[106778160] linearizableReadLoop","detail":"{readStateIndex:26147; appliedIndex:26143; }","duration":"405.296917ms","start":"2026-07-31T22:17:06.372127Z","end":"2026-07-31T22:17:06.777424Z","steps":["trace[106778160] 'read index received'  (duration: 152.048054ms)","trace[106778160] 'applied index is now lower than readState.Index'  (duration: 253.247883ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:17:06.777549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:06.396318Z","time spent":"381.05241ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25320 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-07-31T22:17:06.777766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.1792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:17:06.777861Z","caller":"traceutil/trace.go:171","msg":"trace[1792730517] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25336; }","duration":"397.308734ms","start":"2026-07-31T22:17:06.380532Z","end":"2026-07-31T22:17:06.777841Z","steps":["trace[1792730517] 'agreement among raft nodes before linearized reading'  (duration: 397.15289ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:06.777879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.332267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-07-31T22:17:06.777925Z","caller":"traceutil/trace.go:171","msg":"trace[200623545] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25336; }","duration":"288.392968ms","start":"2026-07-31T22:17:06.489522Z","end":"2026-07-31T22:17:06.777915Z","steps":["trace[200623545] 'agreement among raft nodes before linearized reading'  (duration: 288.237424ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:06.777941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:06.380524Z","time spent":"397.379036ms","remote":"127.0.0.1:47684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":28,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"info","ts":"2026-07-31T22:17:06.778133Z","caller":"traceutil/trace.go:171","msg":"trace[780409740] transaction","detail":"{read_only:false; response_revision:25335; number_of_response:1; }","duration":"379.375851ms","start":"2026-07-31T22:17:06.398718Z","end":"2026-07-31T22:17:06.778094Z","steps":["trace[780409740] 'process raft request'  (duration: 378.464804ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:06.778193Z","caller":"traceutil/trace.go:171","msg":"trace[184721732] transaction","detail":"{read_only:false; response_revision:25336; number_of_response:1; }","duration":"293.436885ms","start":"2026-07-31T22:17:06.48474Z","end":"2026-07-31T22:17:06.778176Z","steps":["trace[184721732] 'process raft request'  (duration: 292.636902ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:06.778236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.658183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs/\" range_end:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-31T22:17:06.778284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.095104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"warn","ts":"2026-07-31T22:17:06.778323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:06.398696Z","time spent":"379.532035ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25321 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-07-31T22:17:06.77835Z","caller":"traceutil/trace.go:171","msg":"trace[217690396] range","detail":"{range_begin:/registry/runtime.cluster.x-k8s.io/extensionconfigs/; range_end:/registry/runtime.cluster.x-k8s.io/extensionconfigs0; response_count:0; response_revision:25336; }","duration":"279.796777ms","start":"2026-07-31T22:17:06.498511Z","end":"2026-07-31T22:17:06.778308Z","steps":["trace[217690396] 'agreement among raft nodes before linearized reading'  (duration: 279.632502ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:06.77838Z","caller":"traceutil/trace.go:171","msg":"trace[1049797607] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25336; }","duration":"342.212627ms","start":"2026-07-31T22:17:06.436139Z","end":"2026-07-31T22:17:06.778352Z","steps":["trace[1049797607] 'agreement among raft nodes before linearized reading'  (duration: 341.986191ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:06.778453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:06.436121Z","time spent":"342.323721ms","remote":"127.0.0.1:34308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-07-31T22:17:06.778827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.692938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"}
{"level":"info","ts":"2026-07-31T22:17:06.778893Z","caller":"traceutil/trace.go:171","msg":"trace[935333526] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:25336; }","duration":"406.7603ms","start":"2026-07-31T22:17:06.372117Z","end":"2026-07-31T22:17:06.778877Z","steps":["trace[935333526] 'agreement among raft nodes before linearized reading'  (duration: 405.477712ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:06.778936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:06.372104Z","time spent":"406.823693ms","remote":"127.0.0.1:34274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "}
{"level":"info","ts":"2026-07-31T22:17:06.953506Z","caller":"traceutil/trace.go:171","msg":"trace[599759868] transaction","detail":"{read_only:false; response_revision:25337; number_of_response:1; }","duration":"171.718786ms","start":"2026-07-31T22:17:06.781772Z","end":"2026-07-31T22:17:06.953491Z","steps":["trace[599759868] 'process raft request'  (duration: 139.60047ms)","trace[599759868] 'compare'  (duration: 31.693994ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:06.953349Z","caller":"traceutil/trace.go:171","msg":"trace[1241359676] linearizableReadLoop","detail":"{readStateIndex:26152; appliedIndex:26151; }","duration":"171.15392ms","start":"2026-07-31T22:17:06.782173Z","end":"2026-07-31T22:17:06.953327Z","steps":["trace[1241359676] 'read index received'  (duration: 139.127816ms)","trace[1241359676] 'applied index is now lower than readState.Index'  (duration: 32.025334ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:17:06.953948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.739437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-07-31T22:17:06.954018Z","caller":"traceutil/trace.go:171","msg":"trace[118887491] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25337; }","duration":"171.859191ms","start":"2026-07-31T22:17:06.782141Z","end":"2026-07-31T22:17:06.954Z","steps":["trace[118887491] 'agreement among raft nodes before linearized reading'  (duration: 171.600303ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:06.954209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.198202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-31T22:17:06.954252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.772438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-4ef1471c-138b-4c20-97a6-57d22328a2c1\" ","response":"range_response_count:1 size:1451"}
{"level":"info","ts":"2026-07-31T22:17:06.95429Z","caller":"traceutil/trace.go:171","msg":"trace[736264548] range","detail":"{range_begin:/registry/persistentvolumes/pvc-4ef1471c-138b-4c20-97a6-57d22328a2c1; range_end:; response_count:1; response_revision:25337; }","duration":"171.865171ms","start":"2026-07-31T22:17:06.782415Z","end":"2026-07-31T22:17:06.95428Z","steps":["trace[736264548] 'agreement among raft nodes before linearized reading'  (duration: 171.468359ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:06.954298Z","caller":"traceutil/trace.go:171","msg":"trace[1505776749] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25337; }","duration":"170.310346ms","start":"2026-07-31T22:17:06.783968Z","end":"2026-07-31T22:17:06.954278Z","steps":["trace[1505776749] 'agreement among raft nodes before linearized reading'  (duration: 170.1283ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:07.079095Z","caller":"traceutil/trace.go:171","msg":"trace[834111466] transaction","detail":"{read_only:false; response_revision:25338; number_of_response:1; }","duration":"121.164452ms","start":"2026-07-31T22:17:06.957895Z","end":"2026-07-31T22:17:07.07906Z","steps":["trace[834111466] 'process raft request'  (duration: 119.325358ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:07.079078Z","caller":"traceutil/trace.go:171","msg":"trace[1706368909] linearizableReadLoop","detail":"{readStateIndex:26153; appliedIndex:26152; }","duration":"120.172374ms","start":"2026-07-31T22:17:06.958874Z","end":"2026-07-31T22:17:07.079046Z","steps":["trace[1706368909] 'read index received'  (duration: 118.291768ms)","trace[1706368909] 'applied index is now lower than readState.Index'  (duration: 1.879326ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:17:07.079319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.421201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:17:07.079358Z","caller":"traceutil/trace.go:171","msg":"trace[1598125892] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25339; }","duration":"120.492273ms","start":"2026-07-31T22:17:06.958854Z","end":"2026-07-31T22:17:07.079346Z","steps":["trace[1598125892] 'agreement among raft nodes before linearized reading'  (duration: 120.284467ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:07.079209Z","caller":"traceutil/trace.go:171","msg":"trace[1254413198] transaction","detail":"{read_only:false; response_revision:25339; number_of_response:1; }","duration":"120.261856ms","start":"2026-07-31T22:17:06.958934Z","end":"2026-07-31T22:17:07.079196Z","steps":["trace[1254413198] 'process raft request'  (duration: 120.077111ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:07.854055Z","caller":"traceutil/trace.go:171","msg":"trace[800456540] linearizableReadLoop","detail":"{readStateIndex:26156; appliedIndex:26155; }","duration":"127.154817ms","start":"2026-07-31T22:17:07.726875Z","end":"2026-07-31T22:17:07.854029Z","steps":["trace[800456540] 'read index received'  (duration: 125.496719ms)","trace[800456540] 'applied index is now lower than readState.Index'  (duration: 1.657038ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:07.854405Z","caller":"traceutil/trace.go:171","msg":"trace[893875645] transaction","detail":"{read_only:false; response_revision:25341; number_of_response:1; }","duration":"222.631811ms","start":"2026-07-31T22:17:07.631761Z","end":"2026-07-31T22:17:07.854392Z","steps":["trace[893875645] 'process raft request'  (duration: 222.070934ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:07.854595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.013856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130470"}
{"level":"info","ts":"2026-07-31T22:17:07.854653Z","caller":"traceutil/trace.go:171","msg":"trace[1962335298] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:25341; }","duration":"125.168019ms","start":"2026-07-31T22:17:07.729472Z","end":"2026-07-31T22:17:07.85464Z","steps":["trace[1962335298] 'agreement among raft nodes before linearized reading'  (duration: 124.917822ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:07.855775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.889168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:119"}
{"level":"info","ts":"2026-07-31T22:17:07.855856Z","caller":"traceutil/trace.go:171","msg":"trace[1564093532] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:25341; }","duration":"129.024472ms","start":"2026-07-31T22:17:07.726814Z","end":"2026-07-31T22:17:07.855839Z","steps":["trace[1564093532] 'agreement among raft nodes before linearized reading'  (duration: 127.59067ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:09.070725Z","caller":"traceutil/trace.go:171","msg":"trace[189556808] transaction","detail":"{read_only:false; response_revision:25346; number_of_response:1; }","duration":"286.987838ms","start":"2026-07-31T22:17:08.783709Z","end":"2026-07-31T22:17:09.070697Z","steps":["trace[189556808] 'process raft request'  (duration: 210.183568ms)","trace[189556808] 'compare'  (duration: 76.630525ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:09.071074Z","caller":"traceutil/trace.go:171","msg":"trace[120785750] transaction","detail":"{read_only:false; response_revision:25348; number_of_response:1; }","duration":"287.262726ms","start":"2026-07-31T22:17:08.783796Z","end":"2026-07-31T22:17:09.071058Z","steps":["trace[120785750] 'process raft request'  (duration: 287.073511ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:09.071066Z","caller":"traceutil/trace.go:171","msg":"trace[1981869957] linearizableReadLoop","detail":"{readStateIndex:26165; appliedIndex:26160; }","duration":"170.172762ms","start":"2026-07-31T22:17:08.900868Z","end":"2026-07-31T22:17:09.071041Z","steps":["trace[1981869957] 'read index received'  (duration: 93.070763ms)","trace[1981869957] 'applied index is now lower than readState.Index'  (duration: 77.100789ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:09.071115Z","caller":"traceutil/trace.go:171","msg":"trace[1922643712] transaction","detail":"{read_only:false; response_revision:25349; number_of_response:1; }","duration":"286.643277ms","start":"2026-07-31T22:17:08.784453Z","end":"2026-07-31T22:17:09.071096Z","steps":["trace[1922643712] 'process raft request'  (duration: 286.501993ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:09.071157Z","caller":"traceutil/trace.go:171","msg":"trace[1641865987] transaction","detail":"{read_only:false; response_revision:25347; number_of_response:1; }","duration":"287.366898ms","start":"2026-07-31T22:17:08.783771Z","end":"2026-07-31T22:17:09.071138Z","steps":["trace[1641865987] 'process raft request'  (duration: 286.886375ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:09.071175Z","caller":"traceutil/trace.go:171","msg":"trace[723824574] transaction","detail":"{read_only:false; response_revision:25350; number_of_response:1; }","duration":"286.369549ms","start":"2026-07-31T22:17:08.784776Z","end":"2026-07-31T22:17:09.071146Z","steps":["trace[723824574] 'process raft request'  (duration: 286.220004ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:09.071296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.414968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:17:09.071333Z","caller":"traceutil/trace.go:171","msg":"trace[181362266] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25350; }","duration":"170.497141ms","start":"2026-07-31T22:17:08.900825Z","end":"2026-07-31T22:17:09.071322Z","steps":["trace[181362266] 'agreement among raft nodes before linearized reading'  (duration: 170.344486ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:09.071399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.454847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-07-31T22:17:09.07146Z","caller":"traceutil/trace.go:171","msg":"trace[702372755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25350; }","duration":"114.55402ms","start":"2026-07-31T22:17:08.956889Z","end":"2026-07-31T22:17:09.071443Z","steps":["trace[702372755] 'agreement among raft nodes before linearized reading'  (duration: 114.366665ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:09.180129Z","caller":"traceutil/trace.go:171","msg":"trace[810729128] transaction","detail":"{read_only:false; response_revision:25351; number_of_response:1; }","duration":"103.655032ms","start":"2026-07-31T22:17:09.076452Z","end":"2026-07-31T22:17:09.180107Z","steps":["trace[810729128] 'process raft request'  (duration: 102.981882ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:09.453317Z","caller":"traceutil/trace.go:171","msg":"trace[455857563] transaction","detail":"{read_only:false; response_revision:25352; number_of_response:1; }","duration":"272.67773ms","start":"2026-07-31T22:17:09.180613Z","end":"2026-07-31T22:17:09.453291Z","steps":["trace[455857563] 'process raft request'  (duration: 272.496845ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:09.772178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.064729ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927341266 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25339 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-31T22:17:09.772395Z","caller":"traceutil/trace.go:171","msg":"trace[1556506727] linearizableReadLoop","detail":"{readStateIndex:26170; appliedIndex:26167; }","duration":"332.404781ms","start":"2026-07-31T22:17:09.439974Z","end":"2026-07-31T22:17:09.772378Z","steps":["trace[1556506727] 'read index received'  (duration: 13.05884ms)","trace[1556506727] 'applied index is now lower than readState.Index'  (duration: 319.345011ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:09.772376Z","caller":"traceutil/trace.go:171","msg":"trace[637876488] transaction","detail":"{read_only:false; response_revision:25353; number_of_response:1; }","duration":"587.556962ms","start":"2026-07-31T22:17:09.184782Z","end":"2026-07-31T22:17:09.772339Z","steps":["trace[637876488] 'process raft request'  (duration: 311.238326ms)","trace[637876488] 'compare'  (duration: 275.733329ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:17:09.7725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.520424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/networks/\" range_end:\"/registry/openstack.k-orc.cloud/networks0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:17:09.772536Z","caller":"traceutil/trace.go:171","msg":"trace[1265524784] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/networks/; range_end:/registry/openstack.k-orc.cloud/networks0; response_count:0; response_revision:25354; }","duration":"332.597287ms","start":"2026-07-31T22:17:09.439929Z","end":"2026-07-31T22:17:09.772527Z","steps":["trace[1265524784] 'agreement among raft nodes before linearized reading'  (duration: 332.533385ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:09.772547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:09.184753Z","time spent":"587.702055ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25339 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-31T22:17:09.772571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:09.439906Z","time spent":"332.656018ms","remote":"127.0.0.1:34206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/openstack.k-orc.cloud/networks/\" range_end:\"/registry/openstack.k-orc.cloud/networks0\" count_only:true "}
{"level":"warn","ts":"2026-07-31T22:17:09.772645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.783529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-07-31T22:17:09.772711Z","caller":"traceutil/trace.go:171","msg":"trace[1593481082] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:25354; }","duration":"253.891062ms","start":"2026-07-31T22:17:09.518806Z","end":"2026-07-31T22:17:09.772697Z","steps":["trace[1593481082] 'agreement among raft nodes before linearized reading'  (duration: 253.727587ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:09.772908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.879211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:17:09.77295Z","caller":"traceutil/trace.go:171","msg":"trace[1788758557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25354; }","duration":"207.933223ms","start":"2026-07-31T22:17:09.565007Z","end":"2026-07-31T22:17:09.77294Z","steps":["trace[1788758557] 'agreement among raft nodes before linearized reading'  (duration: 207.871941ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:09.772952Z","caller":"traceutil/trace.go:171","msg":"trace[1829442015] transaction","detail":"{read_only:false; response_revision:25354; number_of_response:1; }","duration":"587.766476ms","start":"2026-07-31T22:17:09.185172Z","end":"2026-07-31T22:17:09.772938Z","steps":["trace[1829442015] 'process raft request'  (duration: 587.100387ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:09.772945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.708145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-07-31T22:17:09.772999Z","caller":"traceutil/trace.go:171","msg":"trace[1605117139] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25354; }","duration":"232.774596ms","start":"2026-07-31T22:17:09.540212Z","end":"2026-07-31T22:17:09.772986Z","steps":["trace[1605117139] 'agreement among raft nodes before linearized reading'  (duration: 232.623382ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:09.773318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:09.185115Z","time spent":"587.868659ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25338 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-31T22:17:09.985484Z","caller":"traceutil/trace.go:171","msg":"trace[1250835999] transaction","detail":"{read_only:false; response_revision:25355; number_of_response:1; }","duration":"206.010946ms","start":"2026-07-31T22:17:09.779448Z","end":"2026-07-31T22:17:09.985459Z","steps":["trace[1250835999] 'process raft request'  (duration: 205.713207ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:10.261878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.965657ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927341273 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.72\" mod_revision:25283 > success:<request_put:<key:\"/registry/masterleases/199.204.45.72\" value_size:67 lease:5456849520072565462 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.72\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-31T22:17:10.262034Z","caller":"traceutil/trace.go:171","msg":"trace[501159462] linearizableReadLoop","detail":"{readStateIndex:26173; appliedIndex:26172; }","duration":"186.207519ms","start":"2026-07-31T22:17:10.075802Z","end":"2026-07-31T22:17:10.26201Z","steps":["trace[501159462] 'read index received'  (duration: 53.921142ms)","trace[501159462] 'applied index is now lower than readState.Index'  (duration: 132.283237ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:10.262163Z","caller":"traceutil/trace.go:171","msg":"trace[1726018955] transaction","detail":"{read_only:false; response_revision:25356; number_of_response:1; }","duration":"275.921065ms","start":"2026-07-31T22:17:09.986227Z","end":"2026-07-31T22:17:10.262148Z","steps":["trace[1726018955] 'process raft request'  (duration: 143.565636ms)","trace[1726018955] 'compare'  (duration: 131.613797ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:17:10.262644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.842817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:673"}
{"level":"info","ts":"2026-07-31T22:17:10.262691Z","caller":"traceutil/trace.go:171","msg":"trace[1687890997] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25356; }","duration":"186.921349ms","start":"2026-07-31T22:17:10.075758Z","end":"2026-07-31T22:17:10.262679Z","steps":["trace[1687890997] 'agreement among raft nodes before linearized reading'  (duration: 186.662941ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:10.262885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.809538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:673"}
{"level":"info","ts":"2026-07-31T22:17:10.262998Z","caller":"traceutil/trace.go:171","msg":"trace[1786240926] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25356; }","duration":"184.974173ms","start":"2026-07-31T22:17:10.078Z","end":"2026-07-31T22:17:10.262974Z","steps":["trace[1786240926] 'agreement among raft nodes before linearized reading'  (duration: 184.52299ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:10.264559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.254199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:673"}
{"level":"info","ts":"2026-07-31T22:17:10.264649Z","caller":"traceutil/trace.go:171","msg":"trace[1838630435] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25356; }","duration":"165.420743ms","start":"2026-07-31T22:17:10.09921Z","end":"2026-07-31T22:17:10.264631Z","steps":["trace[1838630435] 'agreement among raft nodes before linearized reading'  (duration: 163.370743ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:10.611163Z","caller":"traceutil/trace.go:171","msg":"trace[1674036047] linearizableReadLoop","detail":"{readStateIndex:26174; appliedIndex:26173; }","duration":"244.494819ms","start":"2026-07-31T22:17:10.366648Z","end":"2026-07-31T22:17:10.611143Z","steps":["trace[1674036047] 'read index received'  (duration: 244.293674ms)","trace[1674036047] 'applied index is now lower than readState.Index'  (duration: 200.425µs)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:10.611363Z","caller":"traceutil/trace.go:171","msg":"trace[69667183] transaction","detail":"{read_only:false; response_revision:25357; number_of_response:1; }","duration":"320.588347ms","start":"2026-07-31T22:17:10.290766Z","end":"2026-07-31T22:17:10.611355Z","steps":["trace[69667183] 'process raft request'  (duration: 320.235097ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:10.611459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:10.290736Z","time spent":"320.646979ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25342 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-07-31T22:17:10.61151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.310103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/floatingips/\" range_end:\"/registry/openstack.k-orc.cloud/floatingips0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:17:10.611556Z","caller":"traceutil/trace.go:171","msg":"trace[432002009] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/floatingips/; range_end:/registry/openstack.k-orc.cloud/floatingips0; response_count:0; response_revision:25357; }","duration":"125.400566ms","start":"2026-07-31T22:17:10.486141Z","end":"2026-07-31T22:17:10.611542Z","steps":["trace[432002009] 'agreement among raft nodes before linearized reading'  (duration: 125.322614ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:10.611694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.055905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:17:10.611721Z","caller":"traceutil/trace.go:171","msg":"trace[356212969] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:25357; }","duration":"245.109157ms","start":"2026-07-31T22:17:10.366605Z","end":"2026-07-31T22:17:10.611714Z","steps":["trace[356212969] 'agreement among raft nodes before linearized reading'  (duration: 245.068066ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:10.774299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.339445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-07-31T22:17:10.774431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.961702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-07-31T22:17:10.774432Z","caller":"traceutil/trace.go:171","msg":"trace[2067912073] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25357; }","duration":"136.561822ms","start":"2026-07-31T22:17:10.63783Z","end":"2026-07-31T22:17:10.774391Z","steps":["trace[2067912073] 'range keys from in-memory index tree'  (duration: 136.174381ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:10.7745Z","caller":"traceutil/trace.go:171","msg":"trace[2127385741] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25357; }","duration":"138.081496ms","start":"2026-07-31T22:17:10.6364Z","end":"2026-07-31T22:17:10.774481Z","steps":["trace[2127385741] 'range keys from in-memory index tree'  (duration: 137.781187ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:19.06837Z","caller":"traceutil/trace.go:171","msg":"trace[205229141] linearizableReadLoop","detail":"{readStateIndex:26235; appliedIndex:26234; }","duration":"240.470912ms","start":"2026-07-31T22:17:18.827873Z","end":"2026-07-31T22:17:19.068344Z","steps":["trace[205229141] 'read index received'  (duration: 186.698583ms)","trace[205229141] 'applied index is now lower than readState.Index'  (duration: 53.771329ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:19.068503Z","caller":"traceutil/trace.go:171","msg":"trace[520717545] transaction","detail":"{read_only:false; response_revision:25418; number_of_response:1; }","duration":"207.945883ms","start":"2026-07-31T22:17:18.860522Z","end":"2026-07-31T22:17:19.068468Z","steps":["trace[520717545] 'process raft request'  (duration: 207.406327ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:19.068591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.796758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-31T22:17:19.068543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.116951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:17:19.068629Z","caller":"traceutil/trace.go:171","msg":"trace[1227551068] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:25418; }","duration":"161.87073ms","start":"2026-07-31T22:17:18.906746Z","end":"2026-07-31T22:17:19.068616Z","steps":["trace[1227551068] 'agreement among raft nodes before linearized reading'  (duration: 161.814788ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:19.068652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.76587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-07-31T22:17:19.068675Z","caller":"traceutil/trace.go:171","msg":"trace[389365669] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25418; }","duration":"170.279985ms","start":"2026-07-31T22:17:18.898359Z","end":"2026-07-31T22:17:19.068639Z","steps":["trace[389365669] 'agreement among raft nodes before linearized reading'  (duration: 170.130481ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:19.068789Z","caller":"traceutil/trace.go:171","msg":"trace[2092124699] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25418; }","duration":"240.933235ms","start":"2026-07-31T22:17:18.827792Z","end":"2026-07-31T22:17:19.068726Z","steps":["trace[2092124699] 'agreement among raft nodes before linearized reading'  (duration: 240.638116ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:19.0687Z","caller":"traceutil/trace.go:171","msg":"trace[916083147] transaction","detail":"{read_only:false; response_revision:25417; number_of_response:1; }","duration":"241.844181ms","start":"2026-07-31T22:17:18.826556Z","end":"2026-07-31T22:17:19.0684Z","steps":["trace[916083147] 'process raft request'  (duration: 188.053152ms)","trace[916083147] 'compare'  (duration: 52.966985ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:17:19.714084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.418384ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927341443 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25407 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-31T22:17:19.714388Z","caller":"traceutil/trace.go:171","msg":"trace[41402181] linearizableReadLoop","detail":"{readStateIndex:26242; appliedIndex:26237; }","duration":"491.446348ms","start":"2026-07-31T22:17:19.222929Z","end":"2026-07-31T22:17:19.714375Z","steps":["trace[41402181] 'read index received'  (duration: 172.770066ms)","trace[41402181] 'applied index is now lower than readState.Index'  (duration: 318.675412ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:19.714533Z","caller":"traceutil/trace.go:171","msg":"trace[632417992] transaction","detail":"{read_only:false; response_revision:25423; number_of_response:1; }","duration":"567.157376ms","start":"2026-07-31T22:17:19.147352Z","end":"2026-07-31T22:17:19.714509Z","steps":["trace[632417992] 'process raft request'  (duration: 566.97209ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:19.714663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:19.147315Z","time spent":"567.279529ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25410 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-07-31T22:17:19.714751Z","caller":"traceutil/trace.go:171","msg":"trace[665586108] transaction","detail":"{read_only:false; response_revision:25420; number_of_response:1; }","duration":"594.295578ms","start":"2026-07-31T22:17:19.120449Z","end":"2026-07-31T22:17:19.714745Z","steps":["trace[665586108] 'process raft request'  (duration: 275.136452ms)","trace[665586108] 'compare'  (duration: 318.262ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:17:19.714783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:19.120422Z","time spent":"594.344859ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25407 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-07-31T22:17:19.714828Z","caller":"traceutil/trace.go:171","msg":"trace[850811147] transaction","detail":"{read_only:false; response_revision:25421; number_of_response:1; }","duration":"589.57371ms","start":"2026-07-31T22:17:19.125244Z","end":"2026-07-31T22:17:19.714818Z","steps":["trace[850811147] 'process raft request'  (duration: 588.951292ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:19.714855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:19.125214Z","time spent":"589.62884ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25408 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-07-31T22:17:19.714899Z","caller":"traceutil/trace.go:171","msg":"trace[1696941579] transaction","detail":"{read_only:false; response_revision:25422; number_of_response:1; }","duration":"569.287308ms","start":"2026-07-31T22:17:19.145606Z","end":"2026-07-31T22:17:19.714893Z","steps":["trace[1696941579] 'process raft request'  (duration: 568.67169ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:19.71493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:19.145592Z","time spent":"569.321859ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25409 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-07-31T22:17:19.71505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.132258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-07-31T22:17:19.715071Z","caller":"traceutil/trace.go:171","msg":"trace[1092541343] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25424; }","duration":"492.153819ms","start":"2026-07-31T22:17:19.222913Z","end":"2026-07-31T22:17:19.715066Z","steps":["trace[1092541343] 'agreement among raft nodes before linearized reading'  (duration: 492.054036ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:19.715089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:19.222863Z","time spent":"492.21811ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-07-31T22:17:19.715176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.337356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:17:19.715271Z","caller":"traceutil/trace.go:171","msg":"trace[1841227070] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25424; }","duration":"147.466809ms","start":"2026-07-31T22:17:19.567779Z","end":"2026-07-31T22:17:19.715246Z","steps":["trace[1841227070] 'agreement among raft nodes before linearized reading'  (duration: 147.336505ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:19.715258Z","caller":"traceutil/trace.go:171","msg":"trace[1510425353] transaction","detail":"{read_only:false; response_revision:25424; number_of_response:1; }","duration":"565.726674ms","start":"2026-07-31T22:17:19.149359Z","end":"2026-07-31T22:17:19.715085Z","steps":["trace[1510425353] 'process raft request'  (duration: 564.990763ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:19.716001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:19.149348Z","time spent":"566.23003ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25411 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-07-31T22:17:19.714746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.357845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-07-31T22:17:19.716522Z","caller":"traceutil/trace.go:171","msg":"trace[704095786] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:25424; }","duration":"197.185058ms","start":"2026-07-31T22:17:19.519321Z","end":"2026-07-31T22:17:19.716506Z","steps":["trace[704095786] 'agreement among raft nodes before linearized reading'  (duration: 195.255282ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:20.274183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.096584ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927341453 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.72\" mod_revision:25356 > success:<request_put:<key:\"/registry/masterleases/199.204.45.72\" value_size:67 lease:5456849520072565642 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.72\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-31T22:17:20.274287Z","caller":"traceutil/trace.go:171","msg":"trace[664157218] linearizableReadLoop","detail":"{readStateIndex:26245; appliedIndex:26243; }","duration":"529.823858ms","start":"2026-07-31T22:17:19.744447Z","end":"2026-07-31T22:17:20.274271Z","steps":["trace[664157218] 'read index received'  (duration: 22.595379ms)","trace[664157218] 'applied index is now lower than readState.Index'  (duration: 507.226078ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:20.274373Z","caller":"traceutil/trace.go:171","msg":"trace[2028172255] transaction","detail":"{read_only:false; response_revision:25426; number_of_response:1; }","duration":"545.604438ms","start":"2026-07-31T22:17:19.728751Z","end":"2026-07-31T22:17:20.274356Z","steps":["trace[2028172255] 'process raft request'  (duration: 273.256748ms)","trace[2028172255] 'compare'  (duration: 271.882267ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:17:20.274431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:19.728735Z","time spent":"545.668439ms","remote":"127.0.0.1:34116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":119,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.72\" mod_revision:25356 > success:<request_put:<key:\"/registry/masterleases/199.204.45.72\" value_size:67 lease:5456849520072565642 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.72\" > >"}
{"level":"warn","ts":"2026-07-31T22:17:20.274667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.221179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:17:20.274703Z","caller":"traceutil/trace.go:171","msg":"trace[468978530] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:25426; }","duration":"530.288231ms","start":"2026-07-31T22:17:19.744407Z","end":"2026-07-31T22:17:20.274695Z","steps":["trace[468978530] 'agreement among raft nodes before linearized reading'  (duration: 530.186918ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:20.274724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:19.744389Z","time spent":"530.329912ms","remote":"127.0.0.1:50728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "}
{"level":"warn","ts":"2026-07-31T22:17:20.275142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.790235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-07-31T22:17:20.275152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.546834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-07-31T22:17:20.275159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.908244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"}
{"level":"info","ts":"2026-07-31T22:17:20.275202Z","caller":"traceutil/trace.go:171","msg":"trace[1909134450] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25426; }","duration":"246.889158ms","start":"2026-07-31T22:17:20.0283Z","end":"2026-07-31T22:17:20.275189Z","steps":["trace[1909134450] 'agreement among raft nodes before linearized reading'  (duration: 246.716413ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:20.275221Z","caller":"traceutil/trace.go:171","msg":"trace[1535307729] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25426; }","duration":"453.995256ms","start":"2026-07-31T22:17:19.821209Z","end":"2026-07-31T22:17:20.275204Z","steps":["trace[1535307729] 'agreement among raft nodes before linearized reading'  (duration: 453.795881ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:20.275234Z","caller":"traceutil/trace.go:171","msg":"trace[1337057243] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:25426; }","duration":"499.652357ms","start":"2026-07-31T22:17:19.775544Z","end":"2026-07-31T22:17:20.275197Z","steps":["trace[1337057243] 'agreement among raft nodes before linearized reading'  (duration: 499.442051ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:20.275257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:19.821201Z","time spent":"454.049619ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":596,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-07-31T22:17:20.275269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:19.775527Z","time spent":"499.73309ms","remote":"127.0.0.1:34316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":90,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"warn","ts":"2026-07-31T22:17:20.275183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.284275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-07-31T22:17:20.275467Z","caller":"traceutil/trace.go:171","msg":"trace[2001341782] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25426; }","duration":"454.576654ms","start":"2026-07-31T22:17:19.820845Z","end":"2026-07-31T22:17:20.275421Z","steps":["trace[2001341782] 'agreement among raft nodes before linearized reading'  (duration: 454.165062ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:20.275575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:19.820826Z","time spent":"454.712237ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-07-31T22:17:20.876495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.243217ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927341459 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25414 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-31T22:17:20.876702Z","caller":"traceutil/trace.go:171","msg":"trace[124652458] linearizableReadLoop","detail":"{readStateIndex:26248; appliedIndex:26245; }","duration":"587.944782ms","start":"2026-07-31T22:17:20.288741Z","end":"2026-07-31T22:17:20.876686Z","steps":["trace[124652458] 'read index received'  (duration: 266.454908ms)","trace[124652458] 'applied index is now lower than readState.Index'  (duration: 321.488824ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:20.876769Z","caller":"traceutil/trace.go:171","msg":"trace[847185086] transaction","detail":"{read_only:false; response_revision:25428; number_of_response:1; }","duration":"595.844793ms","start":"2026-07-31T22:17:20.280915Z","end":"2026-07-31T22:17:20.87676Z","steps":["trace[847185086] 'process raft request'  (duration: 595.685418ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:20.876821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:20.280904Z","time spent":"595.888505ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25413 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-31T22:17:20.876846Z","caller":"traceutil/trace.go:171","msg":"trace[1070517478] transaction","detail":"{read_only:false; response_revision:25427; number_of_response:1; }","duration":"597.519002ms","start":"2026-07-31T22:17:20.279296Z","end":"2026-07-31T22:17:20.876815Z","steps":["trace[1070517478] 'process raft request'  (duration: 275.881503ms)","trace[1070517478] 'compare'  (duration: 321.133284ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:20.876945Z","caller":"traceutil/trace.go:171","msg":"trace[591173024] transaction","detail":"{read_only:false; response_revision:25429; number_of_response:1; }","duration":"595.453611ms","start":"2026-07-31T22:17:20.281459Z","end":"2026-07-31T22:17:20.876912Z","steps":["trace[591173024] 'process raft request'  (duration: 595.192134ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:20.876991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:20.279284Z","time spent":"597.624404ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25414 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-31T22:17:20.877038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.286653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:673"}
{"level":"info","ts":"2026-07-31T22:17:20.877085Z","caller":"traceutil/trace.go:171","msg":"trace[519698125] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25429; }","duration":"588.349084ms","start":"2026-07-31T22:17:20.288722Z","end":"2026-07-31T22:17:20.877071Z","steps":["trace[519698125] 'agreement among raft nodes before linearized reading'  (duration: 588.180319ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:20.877124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:20.288713Z","time spent":"588.403975ms","remote":"127.0.0.1:34290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":695,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "}
{"level":"warn","ts":"2026-07-31T22:17:20.877114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:20.281455Z","time spent":"595.559804ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25415 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-07-31T22:17:20.889109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.75906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:17:20.889182Z","caller":"traceutil/trace.go:171","msg":"trace[1451002005] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25430; }","duration":"321.880455ms","start":"2026-07-31T22:17:20.567288Z","end":"2026-07-31T22:17:20.889169Z","steps":["trace[1451002005] 'agreement among raft nodes before linearized reading'  (duration: 321.73638ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:20.889212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:20.567268Z","time spent":"321.938276ms","remote":"127.0.0.1:34076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-07-31T22:17:20.8892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.402736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:673"}
{"level":"info","ts":"2026-07-31T22:17:20.889275Z","caller":"traceutil/trace.go:171","msg":"trace[963167374] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25430; }","duration":"600.53532ms","start":"2026-07-31T22:17:20.288721Z","end":"2026-07-31T22:17:20.889257Z","steps":["trace[963167374] 'agreement among raft nodes before linearized reading'  (duration: 600.278661ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:20.889323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:20.288694Z","time spent":"600.619912ms","remote":"127.0.0.1:34290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":695,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "}
{"level":"warn","ts":"2026-07-31T22:17:20.889311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.470447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:673"}
{"level":"info","ts":"2026-07-31T22:17:20.889386Z","caller":"traceutil/trace.go:171","msg":"trace[2052863703] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25430; }","duration":"600.577191ms","start":"2026-07-31T22:17:20.288787Z","end":"2026-07-31T22:17:20.889364Z","steps":["trace[2052863703] 'agreement among raft nodes before linearized reading'  (duration: 600.380075ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:20.889396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.589106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"warn","ts":"2026-07-31T22:17:20.889433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:20.28877Z","time spent":"600.654583ms","remote":"127.0.0.1:34290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":695,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "}
{"level":"info","ts":"2026-07-31T22:17:20.889457Z","caller":"traceutil/trace.go:171","msg":"trace[1460575050] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25430; }","duration":"131.663418ms","start":"2026-07-31T22:17:20.75776Z","end":"2026-07-31T22:17:20.889424Z","steps":["trace[1460575050] 'agreement among raft nodes before linearized reading'  (duration: 131.538575ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:20.889295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.413993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-07-31T22:17:20.889685Z","caller":"traceutil/trace.go:171","msg":"trace[1885818695] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25430; }","duration":"520.829446ms","start":"2026-07-31T22:17:20.368818Z","end":"2026-07-31T22:17:20.889647Z","steps":["trace[1885818695] 'agreement among raft nodes before linearized reading'  (duration: 520.255118ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:20.889727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:20.368793Z","time spent":"520.920148ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":379,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "}
{"level":"info","ts":"2026-07-31T22:17:21.01651Z","caller":"traceutil/trace.go:171","msg":"trace[315582071] transaction","detail":"{read_only:false; response_revision:25431; number_of_response:1; }","duration":"123.620304ms","start":"2026-07-31T22:17:20.892858Z","end":"2026-07-31T22:17:21.016479Z","steps":["trace[315582071] 'process raft request'  (duration: 109.019309ms)","trace[315582071] 'compare'  (duration: 14.42425ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:21.325875Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006696.wal"}
{"level":"info","ts":"2026-07-31T22:17:27.856513Z","caller":"traceutil/trace.go:171","msg":"trace[1740719966] transaction","detail":"{read_only:false; response_revision:25558; number_of_response:1; }","duration":"217.206283ms","start":"2026-07-31T22:17:27.639274Z","end":"2026-07-31T22:17:27.856481Z","steps":["trace[1740719966] 'process raft request'  (duration: 217.030338ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:28.049262Z","caller":"traceutil/trace.go:171","msg":"trace[1880266173] transaction","detail":"{read_only:false; response_revision:25560; number_of_response:1; }","duration":"309.643612ms","start":"2026-07-31T22:17:27.739589Z","end":"2026-07-31T22:17:28.049232Z","steps":["trace[1880266173] 'process raft request'  (duration: 309.513998ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:28.049284Z","caller":"traceutil/trace.go:171","msg":"trace[314120256] transaction","detail":"{read_only:false; response_revision:25559; number_of_response:1; }","duration":"310.93203ms","start":"2026-07-31T22:17:27.738309Z","end":"2026-07-31T22:17:28.049241Z","steps":["trace[314120256] 'process raft request'  (duration: 310.542859ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:28.049443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:27.739583Z","time spent":"309.765985ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25537 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-07-31T22:17:28.049527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:27.738279Z","time spent":"311.081474ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25535 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-07-31T22:17:28.049577Z","caller":"traceutil/trace.go:171","msg":"trace[382427009] transaction","detail":"{read_only:false; response_revision:25561; number_of_response:1; }","duration":"309.763746ms","start":"2026-07-31T22:17:27.739755Z","end":"2026-07-31T22:17:28.049518Z","steps":["trace[382427009] 'process raft request'  (duration: 309.435606ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:28.049639Z","caller":"traceutil/trace.go:171","msg":"trace[170906509] transaction","detail":"{read_only:false; response_revision:25562; number_of_response:1; }","duration":"303.105592ms","start":"2026-07-31T22:17:27.746515Z","end":"2026-07-31T22:17:28.049621Z","steps":["trace[170906509] 'process raft request'  (duration: 302.939647ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:28.049735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:27.746491Z","time spent":"303.201485ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25538 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-07-31T22:17:28.049745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:27.739728Z","time spent":"309.925731ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25536 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-07-31T22:17:28.049783Z","caller":"traceutil/trace.go:171","msg":"trace[1553654434] transaction","detail":"{read_only:false; response_revision:25563; number_of_response:1; }","duration":"302.672469ms","start":"2026-07-31T22:17:27.747091Z","end":"2026-07-31T22:17:28.049763Z","steps":["trace[1553654434] 'process raft request'  (duration: 302.492954ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:28.049744Z","caller":"traceutil/trace.go:171","msg":"trace[509935635] linearizableReadLoop","detail":"{readStateIndex:26384; appliedIndex:26378; }","duration":"249.804371ms","start":"2026-07-31T22:17:27.799914Z","end":"2026-07-31T22:17:28.049718Z","steps":["trace[509935635] 'read index received'  (duration: 56.443453ms)","trace[509935635] 'applied index is now lower than readState.Index'  (duration: 193.359838ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:17:28.049862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:17:27.747076Z","time spent":"302.753601ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25539 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-07-31T22:17:28.049914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.001827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-07-31T22:17:28.049955Z","caller":"traceutil/trace.go:171","msg":"trace[562373337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25563; }","duration":"250.077969ms","start":"2026-07-31T22:17:27.799866Z","end":"2026-07-31T22:17:28.049944Z","steps":["trace[562373337] 'agreement among raft nodes before linearized reading'  (duration: 249.911705ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:28.162138Z","caller":"traceutil/trace.go:171","msg":"trace[1693117248] transaction","detail":"{read_only:false; response_revision:25564; number_of_response:1; }","duration":"107.654594ms","start":"2026-07-31T22:17:28.054453Z","end":"2026-07-31T22:17:28.162108Z","steps":["trace[1693117248] 'process raft request'  (duration: 98.333762ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:59.102003Z","caller":"traceutil/trace.go:171","msg":"trace[1266787587] linearizableReadLoop","detail":"{readStateIndex:26636; appliedIndex:26635; }","duration":"119.140307ms","start":"2026-07-31T22:17:58.982849Z","end":"2026-07-31T22:17:59.101989Z","steps":["trace[1266787587] 'read index received'  (duration: 118.967922ms)","trace[1266787587] 'applied index is now lower than readState.Index'  (duration: 171.795µs)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:59.10208Z","caller":"traceutil/trace.go:171","msg":"trace[1839728128] transaction","detail":"{read_only:false; response_revision:25809; number_of_response:1; }","duration":"133.711972ms","start":"2026-07-31T22:17:58.968328Z","end":"2026-07-31T22:17:59.10204Z","steps":["trace[1839728128] 'process raft request'  (duration: 133.546867ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:59.102167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.309222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:673"}
{"level":"info","ts":"2026-07-31T22:17:59.102193Z","caller":"traceutil/trace.go:171","msg":"trace[829276901] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25809; }","duration":"119.375494ms","start":"2026-07-31T22:17:58.98281Z","end":"2026-07-31T22:17:59.102185Z","steps":["trace[829276901] 'agreement among raft nodes before linearized reading'  (duration: 119.269921ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:59.102413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.370233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:673"}
{"level":"info","ts":"2026-07-31T22:17:59.10244Z","caller":"traceutil/trace.go:171","msg":"trace[645930392] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25809; }","duration":"119.456656ms","start":"2026-07-31T22:17:58.982976Z","end":"2026-07-31T22:17:59.102432Z","steps":["trace[645930392] 'agreement among raft nodes before linearized reading'  (duration: 119.306112ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:59.261314Z","caller":"traceutil/trace.go:171","msg":"trace[1482142691] transaction","detail":"{read_only:false; response_revision:25810; number_of_response:1; }","duration":"154.413584ms","start":"2026-07-31T22:17:59.10687Z","end":"2026-07-31T22:17:59.261283Z","steps":["trace[1482142691] 'process raft request'  (duration: 134.640389ms)","trace[1482142691] 'compare'  (duration: 19.613171ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:17:59.406993Z","caller":"traceutil/trace.go:171","msg":"trace[1752229533] transaction","detail":"{read_only:false; response_revision:25812; number_of_response:1; }","duration":"299.062884ms","start":"2026-07-31T22:17:59.107911Z","end":"2026-07-31T22:17:59.406974Z","steps":["trace[1752229533] 'process raft request'  (duration: 299.004612ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:59.407132Z","caller":"traceutil/trace.go:171","msg":"trace[583527668] transaction","detail":"{read_only:false; response_revision:25811; number_of_response:1; }","duration":"299.346382ms","start":"2026-07-31T22:17:59.10778Z","end":"2026-07-31T22:17:59.407127Z","steps":["trace[583527668] 'process raft request'  (duration: 296.929572ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:59.407184Z","caller":"traceutil/trace.go:171","msg":"trace[529212004] linearizableReadLoop","detail":"{readStateIndex:26639; appliedIndex:26636; }","duration":"216.509521ms","start":"2026-07-31T22:17:59.190668Z","end":"2026-07-31T22:17:59.407178Z","steps":["trace[529212004] 'read index received'  (duration: 50.86621ms)","trace[529212004] 'applied index is now lower than readState.Index'  (duration: 165.642111ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:17:59.407377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.691306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-07-31T22:17:59.407429Z","caller":"traceutil/trace.go:171","msg":"trace[834417221] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25813; }","duration":"216.80697ms","start":"2026-07-31T22:17:59.19061Z","end":"2026-07-31T22:17:59.407417Z","steps":["trace[834417221] 'agreement among raft nodes before linearized reading'  (duration: 216.670376ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:17:59.407439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.843492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-07-31T22:17:59.40746Z","caller":"traceutil/trace.go:171","msg":"trace[169949945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25813; }","duration":"137.923414ms","start":"2026-07-31T22:17:59.269531Z","end":"2026-07-31T22:17:59.407454Z","steps":["trace[169949945] 'agreement among raft nodes before linearized reading'  (duration: 137.832681ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:17:59.407537Z","caller":"traceutil/trace.go:171","msg":"trace[1609548309] transaction","detail":"{read_only:false; response_revision:25813; number_of_response:1; }","duration":"199.157096ms","start":"2026-07-31T22:17:59.208373Z","end":"2026-07-31T22:17:59.40753Z","steps":["trace[1609548309] 'process raft request'  (duration: 198.569839ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:01.54509Z","caller":"traceutil/trace.go:171","msg":"trace[837759467] transaction","detail":"{read_only:false; response_revision:25827; number_of_response:1; }","duration":"131.405654ms","start":"2026-07-31T22:18:01.413665Z","end":"2026-07-31T22:18:01.54507Z","steps":["trace[837759467] 'process raft request'  (duration: 131.27054ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:01.545546Z","caller":"traceutil/trace.go:171","msg":"trace[1544558168] linearizableReadLoop","detail":"{readStateIndex:26655; appliedIndex:26655; }","duration":"130.90906ms","start":"2026-07-31T22:18:01.4146Z","end":"2026-07-31T22:18:01.545509Z","steps":["trace[1544558168] 'read index received'  (duration: 130.893379ms)","trace[1544558168] 'applied index is now lower than readState.Index'  (duration: 12.931µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:18:01.545897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.646263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"warn","ts":"2026-07-31T22:18:01.545926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.226152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-07-31T22:18:01.546063Z","caller":"traceutil/trace.go:171","msg":"trace[232255077] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25827; }","duration":"129.404377ms","start":"2026-07-31T22:18:01.41663Z","end":"2026-07-31T22:18:01.546034Z","steps":["trace[232255077] 'agreement among raft nodes before linearized reading'  (duration: 129.077947ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:01.546137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.480718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-07-31T22:18:01.546179Z","caller":"traceutil/trace.go:171","msg":"trace[1026995764] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25827; }","duration":"130.54607ms","start":"2026-07-31T22:18:01.415623Z","end":"2026-07-31T22:18:01.546169Z","steps":["trace[1026995764] 'agreement among raft nodes before linearized reading'  (duration: 130.383975ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:01.545971Z","caller":"traceutil/trace.go:171","msg":"trace[386679407] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25827; }","duration":"130.779576ms","start":"2026-07-31T22:18:01.415169Z","end":"2026-07-31T22:18:01.545948Z","steps":["trace[386679407] 'agreement among raft nodes before linearized reading'  (duration: 130.514999ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:01.546289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.664782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:573"}
{"level":"info","ts":"2026-07-31T22:18:01.546342Z","caller":"traceutil/trace.go:171","msg":"trace[323798742] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25827; }","duration":"131.769265ms","start":"2026-07-31T22:18:01.414556Z","end":"2026-07-31T22:18:01.546325Z","steps":["trace[323798742] 'agreement among raft nodes before linearized reading'  (duration: 131.58172ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:01.546519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.21723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-07-31T22:18:01.546568Z","caller":"traceutil/trace.go:171","msg":"trace[1945114789] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25827; }","duration":"131.284651ms","start":"2026-07-31T22:18:01.415271Z","end":"2026-07-31T22:18:01.546556Z","steps":["trace[1945114789] 'agreement among raft nodes before linearized reading'  (duration: 131.143157ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:01.711138Z","caller":"traceutil/trace.go:171","msg":"trace[994182323] transaction","detail":"{read_only:false; response_revision:25828; number_of_response:1; }","duration":"161.84117ms","start":"2026-07-31T22:18:01.549251Z","end":"2026-07-31T22:18:01.711092Z","steps":["trace[994182323] 'process raft request'  (duration: 137.336297ms)","trace[994182323] 'compare'  (duration: 24.09386ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:18:01.925231Z","caller":"traceutil/trace.go:171","msg":"trace[53903226] transaction","detail":"{read_only:false; response_revision:25829; number_of_response:1; }","duration":"374.990885ms","start":"2026-07-31T22:18:01.550216Z","end":"2026-07-31T22:18:01.925207Z","steps":["trace[53903226] 'process raft request'  (duration: 351.016716ms)","trace[53903226] 'compare'  (duration: 23.776403ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:18:01.925366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:01.550186Z","time spent":"375.109827ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25814 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-07-31T22:18:01.925705Z","caller":"traceutil/trace.go:171","msg":"trace[301683726] transaction","detail":"{read_only:false; response_revision:25830; number_of_response:1; }","duration":"374.784789ms","start":"2026-07-31T22:18:01.55091Z","end":"2026-07-31T22:18:01.925695Z","steps":["trace[301683726] 'process raft request'  (duration: 374.259373ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:01.925679Z","caller":"traceutil/trace.go:171","msg":"trace[498671039] transaction","detail":"{read_only:false; response_revision:25831; number_of_response:1; }","duration":"374.382267ms","start":"2026-07-31T22:18:01.551248Z","end":"2026-07-31T22:18:01.925631Z","steps":["trace[498671039] 'process raft request'  (duration: 374.167701ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:01.925746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:01.550895Z","time spent":"374.828979ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25815 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-07-31T22:18:01.926013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:01.551234Z","time spent":"374.644904ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25812 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-31T22:18:01.925715Z","caller":"traceutil/trace.go:171","msg":"trace[171421069] transaction","detail":"{read_only:false; response_revision:25832; number_of_response:1; }","duration":"374.267613ms","start":"2026-07-31T22:18:01.551399Z","end":"2026-07-31T22:18:01.925667Z","steps":["trace[171421069] 'process raft request'  (duration: 374.113248ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:01.926313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:01.551379Z","time spent":"374.814298ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25816 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-07-31T22:18:03.464441Z","caller":"traceutil/trace.go:171","msg":"trace[711218854] transaction","detail":"{read_only:false; response_revision:25839; number_of_response:1; }","duration":"175.932529ms","start":"2026-07-31T22:18:03.288467Z","end":"2026-07-31T22:18:03.4644Z","steps":["trace[711218854] 'process raft request'  (duration: 175.692183ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:03.859614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.349128ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927342588 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25827 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-31T22:18:03.859738Z","caller":"traceutil/trace.go:171","msg":"trace[1179005195] linearizableReadLoop","detail":"{readStateIndex:26668; appliedIndex:26667; }","duration":"293.729899ms","start":"2026-07-31T22:18:03.565971Z","end":"2026-07-31T22:18:03.859701Z","steps":["trace[1179005195] 'read index received'  (duration: 102.218725ms)","trace[1179005195] 'applied index is now lower than readState.Index'  (duration: 191.510024ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:18:03.859815Z","caller":"traceutil/trace.go:171","msg":"trace[1743922503] transaction","detail":"{read_only:false; response_revision:25840; number_of_response:1; }","duration":"309.291472ms","start":"2026-07-31T22:18:03.550513Z","end":"2026-07-31T22:18:03.859805Z","steps":["trace[1743922503] 'process raft request'  (duration: 117.673925ms)","trace[1743922503] 'compare'  (duration: 191.252426ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:18:03.859882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:03.550483Z","time spent":"309.363225ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25827 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-07-31T22:18:03.859918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.925885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:18:03.860022Z","caller":"traceutil/trace.go:171","msg":"trace[625567522] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25840; }","duration":"294.062469ms","start":"2026-07-31T22:18:03.565935Z","end":"2026-07-31T22:18:03.859998Z","steps":["trace[625567522] 'agreement among raft nodes before linearized reading'  (duration: 293.906404ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:03.862518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.596457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-07-31T22:18:03.862519Z","caller":"traceutil/trace.go:171","msg":"trace[287629765] transaction","detail":"{read_only:false; response_revision:25841; number_of_response:1; }","duration":"151.229921ms","start":"2026-07-31T22:18:03.711276Z","end":"2026-07-31T22:18:03.862506Z","steps":["trace[287629765] 'process raft request'  (duration: 150.983433ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:03.862557Z","caller":"traceutil/trace.go:171","msg":"trace[573025053] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25841; }","duration":"145.67823ms","start":"2026-07-31T22:18:03.716868Z","end":"2026-07-31T22:18:03.862547Z","steps":["trace[573025053] 'agreement among raft nodes before linearized reading'  (duration: 145.557907ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:04.184268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.552406ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927342593 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25828 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-31T22:18:04.18439Z","caller":"traceutil/trace.go:171","msg":"trace[617530069] linearizableReadLoop","detail":"{readStateIndex:26670; appliedIndex:26669; }","duration":"254.553068ms","start":"2026-07-31T22:18:03.929823Z","end":"2026-07-31T22:18:04.184376Z","steps":["trace[617530069] 'read index received'  (duration: 74.428376ms)","trace[617530069] 'applied index is now lower than readState.Index'  (duration: 180.123622ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:18:04.184386Z","caller":"traceutil/trace.go:171","msg":"trace[921203549] transaction","detail":"{read_only:false; response_revision:25842; number_of_response:1; }","duration":"317.670066ms","start":"2026-07-31T22:18:03.866687Z","end":"2026-07-31T22:18:04.184357Z","steps":["trace[921203549] 'process raft request'  (duration: 137.662066ms)","trace[921203549] 'compare'  (duration: 179.030701ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:18:04.18469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:03.866671Z","time spent":"317.911093ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25828 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-31T22:18:04.185119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.29282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-07-31T22:18:04.185202Z","caller":"traceutil/trace.go:171","msg":"trace[1174225612] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25842; }","duration":"255.415454ms","start":"2026-07-31T22:18:03.929774Z","end":"2026-07-31T22:18:04.18519Z","steps":["trace[1174225612] 'agreement among raft nodes before linearized reading'  (duration: 255.251119ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:04.577584Z","caller":"traceutil/trace.go:171","msg":"trace[1958002266] transaction","detail":"{read_only:false; response_revision:25846; number_of_response:1; }","duration":"389.497546ms","start":"2026-07-31T22:18:04.188051Z","end":"2026-07-31T22:18:04.577549Z","steps":["trace[1958002266] 'process raft request'  (duration: 389.415243ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:04.577628Z","caller":"traceutil/trace.go:171","msg":"trace[1338620993] transaction","detail":"{read_only:false; response_revision:25844; number_of_response:1; }","duration":"393.875474ms","start":"2026-07-31T22:18:04.183713Z","end":"2026-07-31T22:18:04.577588Z","steps":["trace[1338620993] 'process raft request'  (duration: 393.467922ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:04.57769Z","caller":"traceutil/trace.go:171","msg":"trace[2030411328] transaction","detail":"{read_only:false; response_revision:25845; number_of_response:1; }","duration":"392.079881ms","start":"2026-07-31T22:18:04.185561Z","end":"2026-07-31T22:18:04.577641Z","steps":["trace[2030411328] 'process raft request'  (duration: 391.851445ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:04.577799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:04.188016Z","time spent":"389.668971ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25836 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-07-31T22:18:04.577827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:04.183686Z","time spent":"394.030118ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25834 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-07-31T22:18:04.577871Z","caller":"traceutil/trace.go:171","msg":"trace[1766472024] transaction","detail":"{read_only:false; response_revision:25847; number_of_response:1; }","duration":"389.156016ms","start":"2026-07-31T22:18:04.188688Z","end":"2026-07-31T22:18:04.577844Z","steps":["trace[1766472024] 'process raft request'  (duration: 388.815556ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:04.577908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:04.185539Z","time spent":"392.262496ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25835 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-07-31T22:18:04.57792Z","caller":"traceutil/trace.go:171","msg":"trace[586527573] linearizableReadLoop","detail":"{readStateIndex:26672; appliedIndex:26670; }","duration":"393.412991ms","start":"2026-07-31T22:18:04.184481Z","end":"2026-07-31T22:18:04.577894Z","steps":["trace[586527573] 'read index received'  (duration: 10.824255ms)","trace[586527573] 'applied index is now lower than readState.Index'  (duration: 382.587746ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:18:04.578004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:04.188675Z","time spent":"389.258029ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25837 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-07-31T22:18:04.578035Z","caller":"traceutil/trace.go:171","msg":"trace[1305855315] transaction","detail":"{read_only:false; response_revision:25848; number_of_response:1; }","duration":"388.848327ms","start":"2026-07-31T22:18:04.189175Z","end":"2026-07-31T22:18:04.578024Z","steps":["trace[1305855315] 'process raft request'  (duration: 388.58732ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:04.57809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:04.189162Z","time spent":"388.898388ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25829 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-07-31T22:18:04.578103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.249088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"}
{"level":"warn","ts":"2026-07-31T22:18:04.578173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.818225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-07-31T22:18:04.578187Z","caller":"traceutil/trace.go:171","msg":"trace[1524534818] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25848; }","duration":"647.379311ms","start":"2026-07-31T22:18:03.930782Z","end":"2026-07-31T22:18:04.578162Z","steps":["trace[1524534818] 'agreement among raft nodes before linearized reading'  (duration: 647.174025ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:04.578204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.971788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-07-31T22:18:04.578219Z","caller":"traceutil/trace.go:171","msg":"trace[1374905255] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25848; }","duration":"647.908477ms","start":"2026-07-31T22:18:03.930298Z","end":"2026-07-31T22:18:04.578206Z","steps":["trace[1374905255] 'agreement among raft nodes before linearized reading'  (duration: 647.729161ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:04.578232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:03.930765Z","time spent":"647.456534ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":596,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-07-31T22:18:04.578243Z","caller":"traceutil/trace.go:171","msg":"trace[1634301785] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25848; }","duration":"648.049681ms","start":"2026-07-31T22:18:03.930181Z","end":"2026-07-31T22:18:04.57823Z","steps":["trace[1634301785] 'agreement among raft nodes before linearized reading'  (duration: 647.884186ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:04.578445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:03.930289Z","time spent":"648.144933ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-07-31T22:18:04.578457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:03.930156Z","time spent":"648.294138ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-07-31T22:18:04.669932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.24929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-07-31T22:18:04.67Z","caller":"traceutil/trace.go:171","msg":"trace[388819638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25848; }","duration":"344.402594ms","start":"2026-07-31T22:18:04.325583Z","end":"2026-07-31T22:18:04.669985Z","steps":["trace[388819638] 'agreement among raft nodes before linearized reading'  (duration: 344.199448ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:04.670038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:04.325548Z","time spent":"344.482346ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-07-31T22:18:04.670139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.688738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:18:04.670223Z","caller":"traceutil/trace.go:171","msg":"trace[1215026853] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25848; }","duration":"103.842062ms","start":"2026-07-31T22:18:04.566362Z","end":"2026-07-31T22:18:04.670204Z","steps":["trace[1215026853] 'agreement among raft nodes before linearized reading'  (duration: 103.464292ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:04.939058Z","caller":"traceutil/trace.go:171","msg":"trace[438266053] transaction","detail":"{read_only:false; response_revision:25852; number_of_response:1; }","duration":"264.612262ms","start":"2026-07-31T22:18:04.674422Z","end":"2026-07-31T22:18:04.939034Z","steps":["trace[438266053] 'process raft request'  (duration: 264.424336ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:06.201906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.462976ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927342624 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25825 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:519 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-31T22:18:06.202099Z","caller":"traceutil/trace.go:171","msg":"trace[1900182456] transaction","detail":"{read_only:false; response_revision:25856; number_of_response:1; }","duration":"249.072809ms","start":"2026-07-31T22:18:05.952997Z","end":"2026-07-31T22:18:06.20207Z","steps":["trace[1900182456] 'process raft request'  (duration: 128.379446ms)","trace[1900182456] 'compare'  (duration: 120.356963ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:18:06.583854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.132627ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927342625 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25843 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-31T22:18:06.583977Z","caller":"traceutil/trace.go:171","msg":"trace[1997880180] linearizableReadLoop","detail":"{readStateIndex:26687; appliedIndex:26685; }","duration":"281.236304ms","start":"2026-07-31T22:18:06.30273Z","end":"2026-07-31T22:18:06.583966Z","steps":["trace[1997880180] 'read index received'  (duration: 60.940962ms)","trace[1997880180] 'applied index is now lower than readState.Index'  (duration: 220.294342ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:18:06.584021Z","caller":"traceutil/trace.go:171","msg":"trace[1219966492] transaction","detail":"{read_only:false; response_revision:25858; number_of_response:1; }","duration":"377.783956ms","start":"2026-07-31T22:18:06.206232Z","end":"2026-07-31T22:18:06.584016Z","steps":["trace[1219966492] 'process raft request'  (duration: 377.697983ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:06.584062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:06.206215Z","time spent":"377.824057ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25842 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-31T22:18:06.584212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.488172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:18:06.584232Z","caller":"traceutil/trace.go:171","msg":"trace[1558503896] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:25858; }","duration":"281.535923ms","start":"2026-07-31T22:18:06.302691Z","end":"2026-07-31T22:18:06.584227Z","steps":["trace[1558503896] 'agreement among raft nodes before linearized reading'  (duration: 281.478221ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:06.584379Z","caller":"traceutil/trace.go:171","msg":"trace[42336351] transaction","detail":"{read_only:false; response_revision:25857; number_of_response:1; }","duration":"385.660945ms","start":"2026-07-31T22:18:06.19871Z","end":"2026-07-31T22:18:06.584371Z","steps":["trace[42336351] 'process raft request'  (duration: 164.946091ms)","trace[42336351] 'compare'  (duration: 220.045525ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:18:06.584412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:06.198692Z","time spent":"385.704146ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25843 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-07-31T22:18:07.001108Z","caller":"traceutil/trace.go:171","msg":"trace[1069228964] linearizableReadLoop","detail":"{readStateIndex:26691; appliedIndex:26688; }","duration":"338.703358ms","start":"2026-07-31T22:18:06.662379Z","end":"2026-07-31T22:18:07.001082Z","steps":["trace[1069228964] 'read index received'  (duration: 338.573554ms)","trace[1069228964] 'applied index is now lower than readState.Index'  (duration: 128.644µs)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:18:07.001448Z","caller":"traceutil/trace.go:171","msg":"trace[1413281704] transaction","detail":"{read_only:false; response_revision:25860; number_of_response:1; }","duration":"416.670248ms","start":"2026-07-31T22:18:06.584763Z","end":"2026-07-31T22:18:07.001434Z","steps":["trace[1413281704] 'process raft request'  (duration: 416.06011ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:07.001567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:06.584732Z","time spent":"416.75312ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25847 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-07-31T22:18:07.001753Z","caller":"traceutil/trace.go:171","msg":"trace[498842468] transaction","detail":"{read_only:false; response_revision:25861; number_of_response:1; }","duration":"415.343219ms","start":"2026-07-31T22:18:06.586399Z","end":"2026-07-31T22:18:07.001742Z","steps":["trace[498842468] 'process raft request'  (duration: 414.601307ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:07.001814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:06.586381Z","time spent":"415.40106ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25845 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-07-31T22:18:07.001981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.749822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:18:07.002049Z","caller":"traceutil/trace.go:171","msg":"trace[192820364] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines0; response_count:0; response_revision:25862; }","duration":"390.878076ms","start":"2026-07-31T22:18:06.611154Z","end":"2026-07-31T22:18:07.002032Z","steps":["trace[192820364] 'agreement among raft nodes before linearized reading'  (duration: 390.742222ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:07.00208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:06.611131Z","time spent":"390.941898ms","remote":"127.0.0.1:34694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":28,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true "}
{"level":"info","ts":"2026-07-31T22:18:07.002205Z","caller":"traceutil/trace.go:171","msg":"trace[109074950] transaction","detail":"{read_only:false; response_revision:25862; number_of_response:1; }","duration":"415.197844ms","start":"2026-07-31T22:18:06.586999Z","end":"2026-07-31T22:18:07.002197Z","steps":["trace[109074950] 'process raft request'  (duration: 414.044041ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:07.002315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:06.586939Z","time spent":"415.311207ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25846 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-07-31T22:18:07.010992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.451862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:18:07.011033Z","caller":"traceutil/trace.go:171","msg":"trace[206665616] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25863; }","duration":"347.520194ms","start":"2026-07-31T22:18:06.663498Z","end":"2026-07-31T22:18:07.011018Z","steps":["trace[206665616] 'agreement among raft nodes before linearized reading'  (duration: 347.448332ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:07.011053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:06.66348Z","time spent":"347.568296ms","remote":"127.0.0.1:34074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-07-31T22:18:07.011125Z","caller":"traceutil/trace.go:171","msg":"trace[1461296868] transaction","detail":"{read_only:false; response_revision:25863; number_of_response:1; }","duration":"344.59831ms","start":"2026-07-31T22:18:06.666517Z","end":"2026-07-31T22:18:07.011115Z","steps":["trace[1461296868] 'process raft request'  (duration: 344.315142ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:07.011186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:06.666497Z","time spent":"344.659701ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25848 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-07-31T22:18:07.011185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.008988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"}
{"level":"warn","ts":"2026-07-31T22:18:07.011244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.132622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-07-31T22:18:07.011271Z","caller":"traceutil/trace.go:171","msg":"trace[16892703] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25863; }","duration":"337.193074ms","start":"2026-07-31T22:18:06.67407Z","end":"2026-07-31T22:18:07.011263Z","steps":["trace[16892703] 'agreement among raft nodes before linearized reading'  (duration: 337.09387ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:07.011272Z","caller":"traceutil/trace.go:171","msg":"trace[920663646] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25863; }","duration":"337.126123ms","start":"2026-07-31T22:18:06.674125Z","end":"2026-07-31T22:18:07.011251Z","steps":["trace[920663646] 'agreement among raft nodes before linearized reading'  (duration: 336.865274ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:07.011264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.819634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-07-31T22:18:07.011317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:06.674121Z","time spent":"337.188314ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":596,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-07-31T22:18:07.011356Z","caller":"traceutil/trace.go:171","msg":"trace[568010963] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25863; }","duration":"336.957417ms","start":"2026-07-31T22:18:06.674379Z","end":"2026-07-31T22:18:07.011337Z","steps":["trace[568010963] 'agreement among raft nodes before linearized reading'  (duration: 336.666888ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:07.011412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:06.674367Z","time spent":"337.03553ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-07-31T22:18:07.0113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T22:18:06.674052Z","time spent":"337.243626ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-07-31T22:18:07.140822Z","caller":"traceutil/trace.go:171","msg":"trace[433471557] transaction","detail":"{read_only:false; response_revision:25864; number_of_response:1; }","duration":"117.15093ms","start":"2026-07-31T22:18:07.023648Z","end":"2026-07-31T22:18:07.140799Z","steps":["trace[433471557] 'process raft request'  (duration: 61.268734ms)","trace[433471557] 'compare'  (duration: 55.705471ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:18:07.141227Z","caller":"traceutil/trace.go:171","msg":"trace[80212481] transaction","detail":"{read_only:false; response_revision:25865; number_of_response:1; }","duration":"117.489149ms","start":"2026-07-31T22:18:07.023704Z","end":"2026-07-31T22:18:07.141194Z","steps":["trace[80212481] 'process raft request'  (duration: 117.065347ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:07.141261Z","caller":"traceutil/trace.go:171","msg":"trace[1937782241] transaction","detail":"{read_only:false; response_revision:25866; number_of_response:1; }","duration":"117.52174ms","start":"2026-07-31T22:18:07.023713Z","end":"2026-07-31T22:18:07.141234Z","steps":["trace[1937782241] 'process raft request'  (duration: 117.348795ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:07.141304Z","caller":"traceutil/trace.go:171","msg":"trace[2054358547] transaction","detail":"{read_only:false; response_revision:25867; number_of_response:1; }","duration":"117.440548ms","start":"2026-07-31T22:18:07.023839Z","end":"2026-07-31T22:18:07.14128Z","steps":["trace[2054358547] 'process raft request'  (duration: 117.353155ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:08.815408Z","caller":"traceutil/trace.go:171","msg":"trace[1256327733] transaction","detail":"{read_only:false; response_revision:25873; number_of_response:1; }","duration":"147.976447ms","start":"2026-07-31T22:18:08.667411Z","end":"2026-07-31T22:18:08.815388Z","steps":["trace[1256327733] 'process raft request'  (duration: 147.837743ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:09.436613Z","caller":"traceutil/trace.go:171","msg":"trace[1083322993] linearizableReadLoop","detail":"{readStateIndex:26710; appliedIndex:26706; }","duration":"127.896992ms","start":"2026-07-31T22:18:09.308692Z","end":"2026-07-31T22:18:09.436589Z","steps":["trace[1083322993] 'read index received'  (duration: 49.5066ms)","trace[1083322993] 'applied index is now lower than readState.Index'  (duration: 78.389002ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:18:09.436897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.181541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"}
{"level":"info","ts":"2026-07-31T22:18:09.436993Z","caller":"traceutil/trace.go:171","msg":"trace[1853109110] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25881; }","duration":"128.290924ms","start":"2026-07-31T22:18:09.308657Z","end":"2026-07-31T22:18:09.436948Z","steps":["trace[1853109110] 'agreement among raft nodes before linearized reading'  (duration: 128.028766ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:09.436979Z","caller":"traceutil/trace.go:171","msg":"trace[685857004] transaction","detail":"{read_only:false; response_revision:25880; number_of_response:1; }","duration":"239.50002ms","start":"2026-07-31T22:18:09.197454Z","end":"2026-07-31T22:18:09.436954Z","steps":["trace[685857004] 'process raft request'  (duration: 239.073228ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:09.436988Z","caller":"traceutil/trace.go:171","msg":"trace[1015390229] transaction","detail":"{read_only:false; response_revision:25881; number_of_response:1; }","duration":"237.949345ms","start":"2026-07-31T22:18:09.199007Z","end":"2026-07-31T22:18:09.436957Z","steps":["trace[1015390229] 'process raft request'  (duration: 237.551664ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:09.436975Z","caller":"traceutil/trace.go:171","msg":"trace[1793912661] transaction","detail":"{read_only:false; response_revision:25878; number_of_response:1; }","duration":"240.031116ms","start":"2026-07-31T22:18:09.196905Z","end":"2026-07-31T22:18:09.436936Z","steps":["trace[1793912661] 'process raft request'  (duration: 161.364186ms)","trace[1793912661] 'compare'  (duration: 77.621669ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T22:18:09.437024Z","caller":"traceutil/trace.go:171","msg":"trace[2043669874] transaction","detail":"{read_only:false; response_revision:25879; number_of_response:1; }","duration":"239.648844ms","start":"2026-07-31T22:18:09.197343Z","end":"2026-07-31T22:18:09.436991Z","steps":["trace[2043669874] 'process raft request'  (duration: 239.136999ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T22:18:09.665934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.016487ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680221556927342687 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:4bba9fba14afa85e>","response":"size:40"}
{"level":"info","ts":"2026-07-31T22:18:09.666041Z","caller":"traceutil/trace.go:171","msg":"trace[1031419805] linearizableReadLoop","detail":"{readStateIndex:26711; appliedIndex:26710; }","duration":"100.187886ms","start":"2026-07-31T22:18:09.565834Z","end":"2026-07-31T22:18:09.666022Z","steps":["trace[1031419805] 'read index received'  (duration: 42.671µs)","trace[1031419805] 'applied index is now lower than readState.Index'  (duration: 100.143835ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:18:09.666368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.526996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:18:09.666407Z","caller":"traceutil/trace.go:171","msg":"trace[1476766181] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25881; }","duration":"100.612728ms","start":"2026-07-31T22:18:09.565784Z","end":"2026-07-31T22:18:09.666397Z","steps":["trace[1476766181] 'agreement among raft nodes before linearized reading'  (duration: 100.505265ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:09.920197Z","caller":"traceutil/trace.go:171","msg":"trace[574113810] linearizableReadLoop","detail":"{readStateIndex:26713; appliedIndex:26712; }","duration":"226.711759ms","start":"2026-07-31T22:18:09.69347Z","end":"2026-07-31T22:18:09.920182Z","steps":["trace[574113810] 'read index received'  (duration: 147.72761ms)","trace[574113810] 'applied index is now lower than readState.Index'  (duration: 78.983379ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:18:09.921228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.740768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-07-31T22:18:09.921279Z","caller":"traceutil/trace.go:171","msg":"trace[1425460032] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:25884; }","duration":"227.835931ms","start":"2026-07-31T22:18:09.693433Z","end":"2026-07-31T22:18:09.921269Z","steps":["trace[1425460032] 'agreement among raft nodes before linearized reading'  (duration: 227.653536ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:09.920911Z","caller":"traceutil/trace.go:171","msg":"trace[1933023719] transaction","detail":"{read_only:false; response_revision:25883; number_of_response:1; }","duration":"249.525142ms","start":"2026-07-31T22:18:09.671362Z","end":"2026-07-31T22:18:09.920887Z","steps":["trace[1933023719] 'process raft request'  (duration: 169.800962ms)","trace[1933023719] 'compare'  (duration: 78.540046ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T22:18:09.921812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.112557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T22:18:09.921909Z","caller":"traceutil/trace.go:171","msg":"trace[197941819] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:25884; }","duration":"151.261623ms","start":"2026-07-31T22:18:09.77063Z","end":"2026-07-31T22:18:09.921892Z","steps":["trace[197941819] 'agreement among raft nodes before linearized reading'  (duration: 151.115538ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:18:10.776496Z","caller":"traceutil/trace.go:171","msg":"trace[675764791] transaction","detail":"{read_only:false; response_revision:25885; number_of_response:1; }","duration":"112.709611ms","start":"2026-07-31T22:18:10.663761Z","end":"2026-07-31T22:18:10.77647Z","steps":["trace[675764791] 'process raft request'  (duration: 112.491595ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T22:19:06.307336Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23451}
{"level":"info","ts":"2026-07-31T22:19:06.43696Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23451,"took":"126.206903ms","hash":2882096755,"current-db-size-bytes":57171968,"current-db-size":"57 MB","current-db-size-in-use-bytes":43286528,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-07-31T22:19:06.437034Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2882096755,"revision":23451,"compact-revision":20533}
{"level":"info","ts":"2026-07-31T22:23:48.654621Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"50e03cebfd94cbba","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-31T22:23:48.660028Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-07-31T22:23:48.660162Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-07-31T22:24:06.314653Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26486}
{"level":"info","ts":"2026-07-31T22:24:06.471687Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26486,"took":"149.949848ms","hash":1487798427,"current-db-size-bytes":57171968,"current-db-size":"57 MB","current-db-size-in-use-bytes":36450304,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-07-31T22:24:06.471765Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1487798427,"revision":26486,"compact-revision":23451}
{"level":"info","ts":"2026-07-31T22:29:06.321664Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29220}
{"level":"info","ts":"2026-07-31T22:29:06.461084Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29220,"took":"136.51545ms","hash":220252415,"current-db-size-bytes":57171968,"current-db-size":"57 MB","current-db-size-in-use-bytes":31293440,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-31T22:29:06.461141Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":220252415,"revision":29220,"compact-revision":26486}
{"level":"info","ts":"2026-07-31T22:34:06.326195Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31481}
{"level":"info","ts":"2026-07-31T22:34:06.450082Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31481,"took":"120.792282ms","hash":257730978,"current-db-size-bytes":57171968,"current-db-size":"57 MB","current-db-size-in-use-bytes":31436800,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-31T22:34:06.45016Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":257730978,"revision":31481,"compact-revision":29220}
{"level":"info","ts":"2026-07-31T22:39:06.333003Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33791}
{"level":"info","ts":"2026-07-31T22:39:06.490056Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33791,"took":"151.771759ms","hash":3619917217,"current-db-size-bytes":57171968,"current-db-size":"57 MB","current-db-size-in-use-bytes":33349632,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-07-31T22:39:06.490117Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3619917217,"revision":33791,"compact-revision":31481}
{"level":"info","ts":"2026-07-31T22:44:06.341321Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":36128}
{"level":"info","ts":"2026-07-31T22:44:06.492076Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":36128,"took":"145.813947ms","hash":3639741831,"current-db-size-bytes":58544128,"current-db-size":"58 MB","current-db-size-in-use-bytes":31887360,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-07-31T22:44:06.492139Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3639741831,"revision":36128,"compact-revision":33791}
{"level":"info","ts":"2026-07-31T22:45:00.651107Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"50e03cebfd94cbba","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-31T22:45:00.656117Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-07-31T22:45:00.656189Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-07-31T22:49:06.348Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":38394}
{"level":"info","ts":"2026-07-31T22:49:06.477561Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":38394,"took":"122.25753ms","hash":83216073,"current-db-size-bytes":58544128,"current-db-size":"58 MB","current-db-size-in-use-bytes":30883840,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-31T22:49:06.477635Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":83216073,"revision":38394,"compact-revision":36128}
{"level":"info","ts":"2026-07-31T22:54:06.353987Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":40724}
{"level":"info","ts":"2026-07-31T22:54:06.4795Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":40724,"took":"120.661678ms","hash":3320651363,"current-db-size-bytes":58544128,"current-db-size":"58 MB","current-db-size-in-use-bytes":30711808,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-31T22:54:06.479547Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3320651363,"revision":40724,"compact-revision":38394}