{"level":"warn","ts":"2026-08-05T11:08:17.116303Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-05T11:08:17.116391Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.102:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.102:2380","--initial-cluster=instance=https://199.19.213.102:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.102:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.102: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-08-05T11:08:17.116448Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-05T11:08:17.116457Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.102:2380"]}
{"level":"info","ts":"2026-08-05T11:08:17.116475Z","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-08-05T11:08:17.117093Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.102:2379"]}
{"level":"info","ts":"2026-08-05T11:08:17.117162Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.102:2380"],"listen-peer-urls":["https://199.19.213.102:2380"],"advertise-client-urls":["https://199.19.213.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.102: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-08-05T11:08:17.121387Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.020699ms"}
{"level":"info","ts":"2026-08-05T11:08:17.130748Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1ee87564e61d159f","cluster-id":"92a92aec402e97c3"}
{"level":"info","ts":"2026-08-05T11:08:17.130824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f switched to configuration voters=()"}
{"level":"info","ts":"2026-08-05T11:08:17.130857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became follower at term 0"}
{"level":"info","ts":"2026-08-05T11:08:17.130871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1ee87564e61d159f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-05T11:08:17.13088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became follower at term 1"}
{"level":"info","ts":"2026-08-05T11:08:17.130921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f switched to configuration voters=(2227159091952555423)"}
{"level":"warn","ts":"2026-08-05T11:08:17.139121Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-05T11:08:17.143086Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-05T11:08:17.145265Z","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-08-05T11:08:17.147642Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1ee87564e61d159f","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-05T11:08:17.148104Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1ee87564e61d159f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-05T11:08:17.148152Z","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-08-05T11:08:17.148248Z","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-08-05T11:08:17.148264Z","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-08-05T11:08:17.150065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f switched to configuration voters=(2227159091952555423)"}
{"level":"info","ts":"2026-08-05T11:08:17.150362Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"92a92aec402e97c3","local-member-id":"1ee87564e61d159f","added-peer-id":"1ee87564e61d159f","added-peer-peer-urls":["https://199.19.213.102:2380"]}
{"level":"info","ts":"2026-08-05T11:08:17.152596Z","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-08-05T11:08:17.152697Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.102:2380"}
{"level":"info","ts":"2026-08-05T11:08:17.153363Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.102:2380"}
{"level":"info","ts":"2026-08-05T11:08:17.153603Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1ee87564e61d159f","initial-advertise-peer-urls":["https://199.19.213.102:2380"],"listen-peer-urls":["https://199.19.213.102:2380"],"advertise-client-urls":["https://199.19.213.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-05T11:08:17.153652Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-05T11:08:17.231785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f is starting a new election at term 1"}
{"level":"info","ts":"2026-08-05T11:08:17.231894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-05T11:08:17.23192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f received MsgPreVoteResp from 1ee87564e61d159f at term 1"}
{"level":"info","ts":"2026-08-05T11:08:17.231945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became candidate at term 2"}
{"level":"info","ts":"2026-08-05T11:08:17.231983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f received MsgVoteResp from 1ee87564e61d159f at term 2"}
{"level":"info","ts":"2026-08-05T11:08:17.232004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became leader at term 2"}
{"level":"info","ts":"2026-08-05T11:08:17.232022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1ee87564e61d159f elected leader 1ee87564e61d159f at term 2"}
{"level":"info","ts":"2026-08-05T11:08:17.233042Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-05T11:08:17.234072Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1ee87564e61d159f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.102:2379]}","request-path":"/0/members/1ee87564e61d159f/attributes","cluster-id":"92a92aec402e97c3","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-05T11:08:17.234144Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-05T11:08:17.234158Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-05T11:08:17.234384Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-05T11:08:17.234493Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-05T11:08:17.234608Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"92a92aec402e97c3","local-member-id":"1ee87564e61d159f","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-05T11:08:17.234741Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-05T11:08:17.234776Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-05T11:08:17.237475Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.102:2379"}
{"level":"info","ts":"2026-08-05T11:08:17.239811Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-05T11:08:59.380048Z","caller":"traceutil/trace.go:171","msg":"trace[720856262] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"129.921294ms","start":"2026-08-05T11:08:59.250087Z","end":"2026-08-05T11:08:59.380009Z","steps":["trace[720856262] 'process raft request'  (duration: 129.72587ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:09:00.139983Z","caller":"traceutil/trace.go:171","msg":"trace[2118270927] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"175.407932ms","start":"2026-08-05T11:08:59.964527Z","end":"2026-08-05T11:09:00.139935Z","steps":["trace[2118270927] 'read index received'  (duration: 170.402744ms)","trace[2118270927] 'applied index is now lower than readState.Index'  (duration: 5.004298ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:09:00.140061Z","caller":"traceutil/trace.go:171","msg":"trace[583355543] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"328.353342ms","start":"2026-08-05T11:08:59.811673Z","end":"2026-08-05T11:09:00.140026Z","steps":["trace[583355543] 'process raft request'  (duration: 326.167629ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:09:00.140207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.630446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4zpjf\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-08-05T11:09:00.140287Z","caller":"traceutil/trace.go:171","msg":"trace[1667165347] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4zpjf; range_end:; response_count:1; response_revision:632; }","duration":"175.791229ms","start":"2026-08-05T11:08:59.964479Z","end":"2026-08-05T11:09:00.14027Z","steps":["trace[1667165347] 'agreement among raft nodes before linearized reading'  (duration: 175.561795ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:09:00.140661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:08:59.811643Z","time spent":"328.484024ms","remote":"127.0.0.1:46236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:628 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036209 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-08-05T11:09:00.275075Z","caller":"traceutil/trace.go:171","msg":"trace[2022769044] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"104.043955ms","start":"2026-08-05T11:09:00.171003Z","end":"2026-08-05T11:09:00.275047Z","steps":["trace[2022769044] 'process raft request'  (duration: 103.84989ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:09:48.295896Z","caller":"traceutil/trace.go:171","msg":"trace[1397834670] linearizableReadLoop","detail":"{readStateIndex:1252; appliedIndex:1251; }","duration":"130.699666ms","start":"2026-08-05T11:09:48.165152Z","end":"2026-08-05T11:09:48.295852Z","steps":["trace[1397834670] 'read index received'  (duration: 50.995937ms)","trace[1397834670] 'applied index is now lower than readState.Index'  (duration: 79.702679ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:09:48.296048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.877151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:09:48.296081Z","caller":"traceutil/trace.go:171","msg":"trace[1379112410] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1216; }","duration":"130.959502ms","start":"2026-08-05T11:09:48.165111Z","end":"2026-08-05T11:09:48.296071Z","steps":["trace[1379112410] 'agreement among raft nodes before linearized reading'  (duration: 130.8743ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:09:48.296189Z","caller":"traceutil/trace.go:171","msg":"trace[637315310] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"180.173204ms","start":"2026-08-05T11:09:48.115982Z","end":"2026-08-05T11:09:48.296155Z","steps":["trace[637315310] 'process raft request'  (duration: 100.270971ms)","trace[637315310] 'compare'  (duration: 79.444724ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:10:33.279061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.850029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:10:33.279257Z","caller":"traceutil/trace.go:171","msg":"trace[145781700] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1865; }","duration":"107.069383ms","start":"2026-08-05T11:10:33.172123Z","end":"2026-08-05T11:10:33.279192Z","steps":["trace[145781700] 'count revisions from in-memory index tree'  (duration: 106.678326ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:11:17.905816Z","caller":"traceutil/trace.go:171","msg":"trace[463729246] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"105.783808ms","start":"2026-08-05T11:11:17.800008Z","end":"2026-08-05T11:11:17.905791Z","steps":["trace[463729246] 'process raft request'  (duration: 105.615835ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:11:17.950847Z","caller":"traceutil/trace.go:171","msg":"trace[1906396512] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"149.49053ms","start":"2026-08-05T11:11:17.801322Z","end":"2026-08-05T11:11:17.950812Z","steps":["trace[1906396512] 'process raft request'  (duration: 125.706657ms)","trace[1906396512] 'compare'  (duration: 23.66802ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:11:18.688849Z","caller":"traceutil/trace.go:171","msg":"trace[337690321] linearizableReadLoop","detail":"{readStateIndex:2249; appliedIndex:2248; }","duration":"200.585005ms","start":"2026-08-05T11:11:18.488228Z","end":"2026-08-05T11:11:18.688813Z","steps":["trace[337690321] 'read index received'  (duration: 200.432512ms)","trace[337690321] 'applied index is now lower than readState.Index'  (duration: 136.463µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:11:18.688951Z","caller":"traceutil/trace.go:171","msg":"trace[948779747] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"219.287868ms","start":"2026-08-05T11:11:18.469626Z","end":"2026-08-05T11:11:18.688913Z","steps":["trace[948779747] 'process raft request'  (duration: 218.993442ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:11:18.689163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.911231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-08-05T11:11:18.689239Z","caller":"traceutil/trace.go:171","msg":"trace[1181308672] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2167; }","duration":"201.017953ms","start":"2026-08-05T11:11:18.488196Z","end":"2026-08-05T11:11:18.689214Z","steps":["trace[1181308672] 'agreement among raft nodes before linearized reading'  (duration: 200.811689ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:11:18.68922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.05061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:11:18.689339Z","caller":"traceutil/trace.go:171","msg":"trace[681846139] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:2167; }","duration":"169.231273ms","start":"2026-08-05T11:11:18.520084Z","end":"2026-08-05T11:11:18.689315Z","steps":["trace[681846139] 'agreement among raft nodes before linearized reading'  (duration: 169.000999ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:11:23.875813Z","caller":"traceutil/trace.go:171","msg":"trace[1431047320] linearizableReadLoop","detail":"{readStateIndex:2278; appliedIndex:2277; }","duration":"151.50724ms","start":"2026-08-05T11:11:23.724279Z","end":"2026-08-05T11:11:23.875786Z","steps":["trace[1431047320] 'read index received'  (duration: 151.383107ms)","trace[1431047320] 'applied index is now lower than readState.Index'  (duration: 122.843µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:11:23.875966Z","caller":"traceutil/trace.go:171","msg":"trace[911269435] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"180.669047ms","start":"2026-08-05T11:11:23.695246Z","end":"2026-08-05T11:11:23.875915Z","steps":["trace[911269435] 'process raft request'  (duration: 180.3429ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:11:23.876042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.741674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-05T11:11:23.876123Z","caller":"traceutil/trace.go:171","msg":"trace[1662748736] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2195; }","duration":"151.887877ms","start":"2026-08-05T11:11:23.724223Z","end":"2026-08-05T11:11:23.876111Z","steps":["trace[1662748736] 'agreement among raft nodes before linearized reading'  (duration: 151.664623ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:12:46.495485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.538763ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1558139718709641959 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2824 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-05T11:12:46.495728Z","caller":"traceutil/trace.go:171","msg":"trace[1793710235] transaction","detail":"{read_only:false; response_revision:2836; number_of_response:1; }","duration":"200.446729ms","start":"2026-08-05T11:12:46.295259Z","end":"2026-08-05T11:12:46.495706Z","steps":["trace[1793710235] 'process raft request'  (duration: 55.351966ms)","trace[1793710235] 'compare'  (duration: 144.254517ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:15:18.558093Z","caller":"traceutil/trace.go:171","msg":"trace[1431774987] transaction","detail":"{read_only:false; response_revision:3837; number_of_response:1; }","duration":"109.219928ms","start":"2026-08-05T11:15:18.448844Z","end":"2026-08-05T11:15:18.558064Z","steps":["trace[1431774987] 'process raft request'  (duration: 109.034964ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:15:18.747895Z","caller":"traceutil/trace.go:171","msg":"trace[1603148766] transaction","detail":"{read_only:false; response_revision:3838; number_of_response:1; }","duration":"298.898761ms","start":"2026-08-05T11:15:18.448965Z","end":"2026-08-05T11:15:18.747864Z","steps":["trace[1603148766] 'process raft request'  (duration: 249.559363ms)","trace[1603148766] 'compare'  (duration: 49.141824ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:16:42.644857Z","caller":"traceutil/trace.go:171","msg":"trace[335041179] transaction","detail":"{read_only:false; response_revision:4999; number_of_response:1; }","duration":"126.763425ms","start":"2026-08-05T11:16:42.518068Z","end":"2026-08-05T11:16:42.644831Z","steps":["trace[335041179] 'process raft request'  (duration: 126.629892ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:16:44.521184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.957201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:16:44.521267Z","caller":"traceutil/trace.go:171","msg":"trace[392153230] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5036; }","duration":"109.064674ms","start":"2026-08-05T11:16:44.412184Z","end":"2026-08-05T11:16:44.521249Z","steps":["trace[392153230] 'range keys from in-memory index tree'  (duration: 108.915681ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:16:44.521257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.650474ms","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-08-05T11:16:44.521318Z","caller":"traceutil/trace.go:171","msg":"trace[313111397] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5036; }","duration":"125.711935ms","start":"2026-08-05T11:16:44.395587Z","end":"2026-08-05T11:16:44.521299Z","steps":["trace[313111397] 'range keys from in-memory index tree'  (duration: 125.464461ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:16:48.322752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.229048ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1558139718709647483 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5074 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-05T11:16:48.322858Z","caller":"traceutil/trace.go:171","msg":"trace[1212347275] linearizableReadLoop","detail":"{readStateIndex:5300; appliedIndex:5299; }","duration":"223.732406ms","start":"2026-08-05T11:16:48.099109Z","end":"2026-08-05T11:16:48.322841Z","steps":["trace[1212347275] 'read index received'  (duration: 88.304224ms)","trace[1212347275] 'applied index is now lower than readState.Index'  (duration: 135.427252ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:16:48.322953Z","caller":"traceutil/trace.go:171","msg":"trace[490896504] transaction","detail":"{read_only:false; response_revision:5107; number_of_response:1; }","duration":"233.33573ms","start":"2026-08-05T11:16:48.089535Z","end":"2026-08-05T11:16:48.32287Z","steps":["trace[490896504] 'process raft request'  (duration: 97.901468ms)","trace[490896504] 'compare'  (duration: 135.051265ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:16:48.323047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.935549ms","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-08-05T11:16:48.323079Z","caller":"traceutil/trace.go:171","msg":"trace[1174251974] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5107; }","duration":"223.995491ms","start":"2026-08-05T11:16:48.099072Z","end":"2026-08-05T11:16:48.323068Z","steps":["trace[1174251974] 'agreement among raft nodes before linearized reading'  (duration: 223.862798ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:16:48.323159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.737012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:16:48.323225Z","caller":"traceutil/trace.go:171","msg":"trace[898608098] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5107; }","duration":"157.842495ms","start":"2026-08-05T11:16:48.165364Z","end":"2026-08-05T11:16:48.323206Z","steps":["trace[898608098] 'agreement among raft nodes before linearized reading'  (duration: 157.652901ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:16:48.565451Z","caller":"traceutil/trace.go:171","msg":"trace[467592696] linearizableReadLoop","detail":"{readStateIndex:5305; appliedIndex:5302; }","duration":"190.437804ms","start":"2026-08-05T11:16:48.374982Z","end":"2026-08-05T11:16:48.56542Z","steps":["trace[467592696] 'read index received'  (duration: 4.247142ms)","trace[467592696] 'applied index is now lower than readState.Index'  (duration: 186.189622ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:16:48.565563Z","caller":"traceutil/trace.go:171","msg":"trace[927424479] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5111; }","duration":"197.551522ms","start":"2026-08-05T11:16:48.367972Z","end":"2026-08-05T11:16:48.565524Z","steps":["trace[927424479] 'process raft request'  (duration: 197.411479ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:16:48.565503Z","caller":"traceutil/trace.go:171","msg":"trace[43131303] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"202.598159ms","start":"2026-08-05T11:16:48.362872Z","end":"2026-08-05T11:16:48.56547Z","steps":["trace[43131303] 'process raft request'  (duration: 202.333964ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:16:48.565787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.7808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"warn","ts":"2026-08-05T11:16:48.565883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.176454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:16:48.565891Z","caller":"traceutil/trace.go:171","msg":"trace[1803669988] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5111; }","duration":"190.928963ms","start":"2026-08-05T11:16:48.374935Z","end":"2026-08-05T11:16:48.565864Z","steps":["trace[1803669988] 'agreement among raft nodes before linearized reading'  (duration: 190.639038ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:16:48.565931Z","caller":"traceutil/trace.go:171","msg":"trace[921664975] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5111; }","duration":"154.236165ms","start":"2026-08-05T11:16:48.41168Z","end":"2026-08-05T11:16:48.565917Z","steps":["trace[921664975] 'agreement among raft nodes before linearized reading'  (duration: 154.130753ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:16:48.791362Z","caller":"traceutil/trace.go:171","msg":"trace[423822522] transaction","detail":"{read_only:false; response_revision:5113; number_of_response:1; }","duration":"219.488823ms","start":"2026-08-05T11:16:48.571818Z","end":"2026-08-05T11:16:48.791306Z","steps":["trace[423822522] 'process raft request'  (duration: 218.851541ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:16:48.791625Z","caller":"traceutil/trace.go:171","msg":"trace[742432787] transaction","detail":"{read_only:false; response_revision:5114; number_of_response:1; }","duration":"218.536186ms","start":"2026-08-05T11:16:48.57305Z","end":"2026-08-05T11:16:48.791586Z","steps":["trace[742432787] 'process raft request'  (duration: 217.839893ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:16:48.791692Z","caller":"traceutil/trace.go:171","msg":"trace[1525895508] linearizableReadLoop","detail":"{readStateIndex:5307; appliedIndex:5305; }","duration":"218.687268ms","start":"2026-08-05T11:16:48.57298Z","end":"2026-08-05T11:16:48.791667Z","steps":["trace[1525895508] 'read index received'  (duration: 34.262451ms)","trace[1525895508] 'applied index is now lower than readState.Index'  (duration: 184.423627ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:16:48.791805Z","caller":"traceutil/trace.go:171","msg":"trace[1803325083] transaction","detail":"{read_only:false; response_revision:5116; number_of_response:1; }","duration":"218.037307ms","start":"2026-08-05T11:16:48.573755Z","end":"2026-08-05T11:16:48.791792Z","steps":["trace[1803325083] 'process raft request'  (duration: 217.769841ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:16:48.791961Z","caller":"traceutil/trace.go:171","msg":"trace[592617671] transaction","detail":"{read_only:false; response_revision:5117; number_of_response:1; }","duration":"208.997612ms","start":"2026-08-05T11:16:48.582944Z","end":"2026-08-05T11:16:48.791942Z","steps":["trace[592617671] 'process raft request'  (duration: 208.663695ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:16:48.792019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.004746ms","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:1935"}
{"level":"info","ts":"2026-08-05T11:16:48.79207Z","caller":"traceutil/trace.go:171","msg":"trace[817135484] transaction","detail":"{read_only:false; response_revision:5115; number_of_response:1; }","duration":"219.003206ms","start":"2026-08-05T11:16:48.573053Z","end":"2026-08-05T11:16:48.792056Z","steps":["trace[817135484] 'process raft request'  (duration: 218.330312ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:16:48.792114Z","caller":"traceutil/trace.go:171","msg":"trace[791831289] 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:5117; }","duration":"219.143708ms","start":"2026-08-05T11:16:48.572947Z","end":"2026-08-05T11:16:48.79209Z","steps":["trace[791831289] 'agreement among raft nodes before linearized reading'  (duration: 218.879593ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:16:48.79215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.992519ms","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-08-05T11:16:48.792216Z","caller":"traceutil/trace.go:171","msg":"trace[1406823474] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5117; }","duration":"186.06894ms","start":"2026-08-05T11:16:48.606128Z","end":"2026-08-05T11:16:48.792197Z","steps":["trace[1406823474] 'agreement among raft nodes before linearized reading'  (duration: 185.869147ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:17:03.532386Z","caller":"traceutil/trace.go:171","msg":"trace[1658289354] linearizableReadLoop","detail":"{readStateIndex:5589; appliedIndex:5588; }","duration":"129.077695ms","start":"2026-08-05T11:17:03.403284Z","end":"2026-08-05T11:17:03.532362Z","steps":["trace[1658289354] 'read index received'  (duration: 57.402286ms)","trace[1658289354] 'applied index is now lower than readState.Index'  (duration: 71.673819ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:17:03.532422Z","caller":"traceutil/trace.go:171","msg":"trace[1045297965] transaction","detail":"{read_only:false; response_revision:5390; number_of_response:1; }","duration":"135.184853ms","start":"2026-08-05T11:17:03.397212Z","end":"2026-08-05T11:17:03.532397Z","steps":["trace[1045297965] 'process raft request'  (duration: 63.484713ms)","trace[1045297965] 'compare'  (duration: 71.437985ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:17:03.532572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.278291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9573"}
{"level":"info","ts":"2026-08-05T11:17:03.532603Z","caller":"traceutil/trace.go:171","msg":"trace[671779746] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5390; }","duration":"129.348302ms","start":"2026-08-05T11:17:03.403246Z","end":"2026-08-05T11:17:03.532594Z","steps":["trace[671779746] 'agreement among raft nodes before linearized reading'  (duration: 129.224489ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:17:03.533086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.90678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:17:03.533126Z","caller":"traceutil/trace.go:171","msg":"trace[1066863573] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5391; }","duration":"118.968082ms","start":"2026-08-05T11:17:03.414148Z","end":"2026-08-05T11:17:03.533116Z","steps":["trace[1066863573] 'agreement among raft nodes before linearized reading'  (duration: 118.88584ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:17:04.649922Z","caller":"traceutil/trace.go:171","msg":"trace[999313205] transaction","detail":"{read_only:false; response_revision:5410; number_of_response:1; }","duration":"123.734383ms","start":"2026-08-05T11:17:04.52615Z","end":"2026-08-05T11:17:04.649885Z","steps":["trace[999313205] 'process raft request'  (duration: 123.475988ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:17:04.935467Z","caller":"traceutil/trace.go:171","msg":"trace[1983465498] linearizableReadLoop","detail":"{readStateIndex:5610; appliedIndex:5609; }","duration":"277.243219ms","start":"2026-08-05T11:17:04.658198Z","end":"2026-08-05T11:17:04.935441Z","steps":["trace[1983465498] 'read index received'  (duration: 276.989224ms)","trace[1983465498] 'applied index is now lower than readState.Index'  (duration: 252.625µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:17:04.935654Z","caller":"traceutil/trace.go:171","msg":"trace[510353334] transaction","detail":"{read_only:false; response_revision:5411; number_of_response:1; }","duration":"280.306018ms","start":"2026-08-05T11:17:04.655315Z","end":"2026-08-05T11:17:04.935621Z","steps":["trace[510353334] 'process raft request'  (duration: 279.979052ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:17:04.935718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.495273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-05T11:17:04.935779Z","caller":"traceutil/trace.go:171","msg":"trace[454648993] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5411; }","duration":"277.579205ms","start":"2026-08-05T11:17:04.658185Z","end":"2026-08-05T11:17:04.935765Z","steps":["trace[454648993] 'agreement among raft nodes before linearized reading'  (duration: 277.415032ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:18:17.870225Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3008}
{"level":"info","ts":"2026-08-05T11:18:17.960467Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3008,"took":"88.542657ms","hash":708624531,"current-db-size-bytes":59011072,"current-db-size":"59 MB","current-db-size-in-use-bytes":31944704,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-05T11:18:17.960536Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":708624531,"revision":3008,"compact-revision":-1}
{"level":"info","ts":"2026-08-05T11:22:55.270053Z","caller":"traceutil/trace.go:171","msg":"trace[1646076474] transaction","detail":"{read_only:false; response_revision:8189; number_of_response:1; }","duration":"282.595974ms","start":"2026-08-05T11:22:54.987423Z","end":"2026-08-05T11:22:55.270019Z","steps":["trace[1646076474] 'process raft request'  (duration: 282.39978ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:23:07.15069Z","caller":"traceutil/trace.go:171","msg":"trace[1001420135] linearizableReadLoop","detail":"{readStateIndex:8538; appliedIndex:8537; }","duration":"200.35264ms","start":"2026-08-05T11:23:06.950309Z","end":"2026-08-05T11:23:07.150662Z","steps":["trace[1001420135] 'read index received'  (duration: 200.132326ms)","trace[1001420135] 'applied index is now lower than readState.Index'  (duration: 218.884µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:23:07.151031Z","caller":"traceutil/trace.go:171","msg":"trace[1747508404] transaction","detail":"{read_only:false; response_revision:8249; number_of_response:1; }","duration":"279.470614ms","start":"2026-08-05T11:23:06.871516Z","end":"2026-08-05T11:23:07.150986Z","steps":["trace[1747508404] 'process raft request'  (duration: 278.929954ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:23:07.151062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.718667ms","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-08-05T11:23:07.151341Z","caller":"traceutil/trace.go:171","msg":"trace[696673894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8249; }","duration":"201.048864ms","start":"2026-08-05T11:23:06.950272Z","end":"2026-08-05T11:23:07.151321Z","steps":["trace[696673894] 'agreement among raft nodes before linearized reading'  (duration: 200.554764ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:23:07.993475Z","caller":"traceutil/trace.go:171","msg":"trace[1130472102] transaction","detail":"{read_only:false; response_revision:8252; number_of_response:1; }","duration":"231.103083ms","start":"2026-08-05T11:23:07.76234Z","end":"2026-08-05T11:23:07.993443Z","steps":["trace[1130472102] 'process raft request'  (duration: 230.92107ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:23:08.025528Z","caller":"traceutil/trace.go:171","msg":"trace[1087473170] transaction","detail":"{read_only:false; response_revision:8254; number_of_response:1; }","duration":"187.282278ms","start":"2026-08-05T11:23:07.838208Z","end":"2026-08-05T11:23:08.025491Z","steps":["trace[1087473170] 'process raft request'  (duration: 187.210536ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:23:08.025866Z","caller":"traceutil/trace.go:171","msg":"trace[1718748046] transaction","detail":"{read_only:false; response_revision:8253; number_of_response:1; }","duration":"205.5954ms","start":"2026-08-05T11:23:07.820253Z","end":"2026-08-05T11:23:08.025848Z","steps":["trace[1718748046] 'process raft request'  (duration: 183.70169ms)","trace[1718748046] 'compare'  (duration: 21.282739ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:23:17.877076Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6120}
{"level":"info","ts":"2026-08-05T11:23:17.98003Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6120,"took":"100.817373ms","hash":1852063749,"current-db-size-bytes":59011072,"current-db-size":"59 MB","current-db-size-in-use-bytes":23420928,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-08-05T11:23:17.980117Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1852063749,"revision":6120,"compact-revision":3008}
{"level":"info","ts":"2026-08-05T11:23:32.948511Z","caller":"traceutil/trace.go:171","msg":"trace[2084623845] transaction","detail":"{read_only:false; response_revision:8445; number_of_response:1; }","duration":"132.515682ms","start":"2026-08-05T11:23:32.815948Z","end":"2026-08-05T11:23:32.948464Z","steps":["trace[2084623845] 'process raft request'  (duration: 128.239949ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:23:36.363884Z","caller":"traceutil/trace.go:171","msg":"trace[1808075068] linearizableReadLoop","detail":"{readStateIndex:8758; appliedIndex:8757; }","duration":"240.167286ms","start":"2026-08-05T11:23:36.123689Z","end":"2026-08-05T11:23:36.363856Z","steps":["trace[1808075068] 'read index received'  (duration: 239.911931ms)","trace[1808075068] 'applied index is now lower than readState.Index'  (duration: 254.155µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:23:36.363942Z","caller":"traceutil/trace.go:171","msg":"trace[1122903052] transaction","detail":"{read_only:false; response_revision:8461; number_of_response:1; }","duration":"245.535619ms","start":"2026-08-05T11:23:36.118371Z","end":"2026-08-05T11:23:36.363907Z","steps":["trace[1122903052] 'process raft request'  (duration: 245.306685ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:23:36.364129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.418232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-08-05T11:23:36.36417Z","caller":"traceutil/trace.go:171","msg":"trace[277966171] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8461; }","duration":"240.509543ms","start":"2026-08-05T11:23:36.12365Z","end":"2026-08-05T11:23:36.36416Z","steps":["trace[277966171] 'agreement among raft nodes before linearized reading'  (duration: 240.34067ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:23:36.48635Z","caller":"traceutil/trace.go:171","msg":"trace[939796817] linearizableReadLoop","detail":"{readStateIndex:8759; appliedIndex:8758; }","duration":"122.351808ms","start":"2026-08-05T11:23:36.363962Z","end":"2026-08-05T11:23:36.486314Z","steps":["trace[939796817] 'read index received'  (duration: 72.750372ms)","trace[939796817] 'applied index is now lower than readState.Index'  (duration: 49.595276ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:23:36.486409Z","caller":"traceutil/trace.go:171","msg":"trace[989887894] transaction","detail":"{read_only:false; response_revision:8462; number_of_response:1; }","duration":"115.952954ms","start":"2026-08-05T11:23:36.370428Z","end":"2026-08-05T11:23:36.486381Z","steps":["trace[989887894] 'process raft request'  (duration: 115.794501ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:23:36.486559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.037031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-05T11:23:36.486647Z","caller":"traceutil/trace.go:171","msg":"trace[9614821] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:8462; }","duration":"341.200354ms","start":"2026-08-05T11:23:36.145426Z","end":"2026-08-05T11:23:36.486627Z","steps":["trace[9614821] 'agreement among raft nodes before linearized reading'  (duration: 340.977539ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:23:36.486847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:23:36.145403Z","time spent":"341.427347ms","remote":"127.0.0.1:46538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":11,"response size":30,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"info","ts":"2026-08-05T11:23:49.076425Z","caller":"traceutil/trace.go:171","msg":"trace[466479776] transaction","detail":"{read_only:false; response_revision:8570; number_of_response:1; }","duration":"184.999974ms","start":"2026-08-05T11:23:48.891394Z","end":"2026-08-05T11:23:49.076394Z","steps":["trace[466479776] 'process raft request'  (duration: 90.059655ms)","trace[466479776] 'compare'  (duration: 94.751656ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:23:49.07672Z","caller":"traceutil/trace.go:171","msg":"trace[1059701786] linearizableReadLoop","detail":"{readStateIndex:8872; appliedIndex:8871; }","duration":"179.402756ms","start":"2026-08-05T11:23:48.897275Z","end":"2026-08-05T11:23:49.076678Z","steps":["trace[1059701786] 'read index received'  (duration: 84.11939ms)","trace[1059701786] 'applied index is now lower than readState.Index'  (duration: 95.279826ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:23:49.076893Z","caller":"traceutil/trace.go:171","msg":"trace[1589304359] transaction","detail":"{read_only:false; response_revision:8571; number_of_response:1; }","duration":"179.038809ms","start":"2026-08-05T11:23:48.897834Z","end":"2026-08-05T11:23:49.076873Z","steps":["trace[1589304359] 'process raft request'  (duration: 178.53802ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:23:49.077095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.819534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-tbrtx\" ","response":"range_response_count:1 size:4645"}
{"level":"info","ts":"2026-08-05T11:23:49.077177Z","caller":"traceutil/trace.go:171","msg":"trace[1188079690] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-tbrtx; range_end:; response_count:1; response_revision:8571; }","duration":"179.913866ms","start":"2026-08-05T11:23:48.89724Z","end":"2026-08-05T11:23:49.077154Z","steps":["trace[1188079690] 'agreement among raft nodes before linearized reading'  (duration: 179.568939ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:23:49.930711Z","caller":"traceutil/trace.go:171","msg":"trace[1703395106] linearizableReadLoop","detail":"{readStateIndex:8879; appliedIndex:8878; }","duration":"159.908271ms","start":"2026-08-05T11:23:49.770766Z","end":"2026-08-05T11:23:49.930675Z","steps":["trace[1703395106] 'read index received'  (duration: 159.719507ms)","trace[1703395106] 'applied index is now lower than readState.Index'  (duration: 187.484µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:23:49.930808Z","caller":"traceutil/trace.go:171","msg":"trace[2044826261] transaction","detail":"{read_only:false; response_revision:8577; number_of_response:1; }","duration":"187.313598ms","start":"2026-08-05T11:23:49.74346Z","end":"2026-08-05T11:23:49.930773Z","steps":["trace[2044826261] 'process raft request'  (duration: 187.024233ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:23:49.930952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.160845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-krjd5\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-08-05T11:23:49.931028Z","caller":"traceutil/trace.go:171","msg":"trace[313367321] range","detail":"{range_begin:/registry/pods/openstack/keepalived-krjd5; range_end:; response_count:1; response_revision:8577; }","duration":"160.283318ms","start":"2026-08-05T11:23:49.770714Z","end":"2026-08-05T11:23:49.930997Z","steps":["trace[313367321] 'agreement among raft nodes before linearized reading'  (duration: 160.072494ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:23:50.740107Z","caller":"traceutil/trace.go:171","msg":"trace[793209888] linearizableReadLoop","detail":"{readStateIndex:8886; appliedIndex:8885; }","duration":"102.453084ms","start":"2026-08-05T11:23:50.637626Z","end":"2026-08-05T11:23:50.740079Z","steps":["trace[793209888] 'read index received'  (duration: 93.632695ms)","trace[793209888] 'applied index is now lower than readState.Index'  (duration: 8.819159ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:23:50.740202Z","caller":"traceutil/trace.go:171","msg":"trace[586998527] transaction","detail":"{read_only:false; response_revision:8584; number_of_response:1; }","duration":"105.192866ms","start":"2026-08-05T11:23:50.634985Z","end":"2026-08-05T11:23:50.740177Z","steps":["trace[586998527] 'process raft request'  (duration: 96.314115ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:23:50.74039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.73568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"}
{"level":"info","ts":"2026-08-05T11:23:50.74043Z","caller":"traceutil/trace.go:171","msg":"trace[1975671672] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:8584; }","duration":"102.807111ms","start":"2026-08-05T11:23:50.63761Z","end":"2026-08-05T11:23:50.740417Z","steps":["trace[1975671672] 'agreement among raft nodes before linearized reading'  (duration: 102.616877ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:23:50.904776Z","caller":"traceutil/trace.go:171","msg":"trace[261800595] transaction","detail":"{read_only:false; response_revision:8586; number_of_response:1; }","duration":"143.27031ms","start":"2026-08-05T11:23:50.761483Z","end":"2026-08-05T11:23:50.904753Z","steps":["trace[261800595] 'process raft request'  (duration: 142.620018ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:24:04.787873Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000237c.wal"}
{"level":"info","ts":"2026-08-05T11:25:00.75833Z","caller":"traceutil/trace.go:171","msg":"trace[970598096] transaction","detail":"{read_only:false; response_revision:9294; number_of_response:1; }","duration":"110.491906ms","start":"2026-08-05T11:25:00.647797Z","end":"2026-08-05T11:25:00.758289Z","steps":["trace[970598096] 'process raft request'  (duration: 35.672537ms)","trace[970598096] 'compare'  (duration: 74.668766ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:25:00.791505Z","caller":"traceutil/trace.go:171","msg":"trace[910001744] linearizableReadLoop","detail":"{readStateIndex:9617; appliedIndex:9615; }","duration":"123.577849ms","start":"2026-08-05T11:25:00.667889Z","end":"2026-08-05T11:25:00.791467Z","steps":["trace[910001744] 'read index received'  (duration: 15.578731ms)","trace[910001744] 'applied index is now lower than readState.Index'  (duration: 107.997658ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:25:00.791648Z","caller":"traceutil/trace.go:171","msg":"trace[398221515] transaction","detail":"{read_only:false; response_revision:9295; number_of_response:1; }","duration":"129.012123ms","start":"2026-08-05T11:25:00.662596Z","end":"2026-08-05T11:25:00.791608Z","steps":["trace[398221515] 'process raft request'  (duration: 128.673876ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:25:00.791734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.809763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-05T11:25:00.791835Z","caller":"traceutil/trace.go:171","msg":"trace[1919015534] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:9295; }","duration":"123.965276ms","start":"2026-08-05T11:25:00.667842Z","end":"2026-08-05T11:25:00.791808Z","steps":["trace[1919015534] 'agreement among raft nodes before linearized reading'  (duration: 123.778373ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:25:50.175118Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1ee87564e61d159f","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-05T11:25:50.180825Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-05T11:25:50.180953Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-05T11:28:17.884399Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8313}
{"level":"info","ts":"2026-08-05T11:28:17.972286Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8313,"took":"85.612897ms","hash":527882231,"current-db-size-bytes":59011072,"current-db-size":"59 MB","current-db-size-in-use-bytes":26533888,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-05T11:28:17.972355Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":527882231,"revision":8313,"compact-revision":6120}
{"level":"info","ts":"2026-08-05T11:28:27.085751Z","caller":"traceutil/trace.go:171","msg":"trace[514895482] transaction","detail":"{read_only:false; response_revision:11046; number_of_response:1; }","duration":"143.188734ms","start":"2026-08-05T11:28:26.942508Z","end":"2026-08-05T11:28:27.085697Z","steps":["trace[514895482] 'process raft request'  (duration: 142.646394ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:28:41.132058Z","caller":"traceutil/trace.go:171","msg":"trace[960567331] linearizableReadLoop","detail":"{readStateIndex:11501; appliedIndex:11500; }","duration":"116.581932ms","start":"2026-08-05T11:28:41.015452Z","end":"2026-08-05T11:28:41.132034Z","steps":["trace[960567331] 'read index received'  (duration: 69.797342ms)","trace[960567331] 'applied index is now lower than readState.Index'  (duration: 46.78334ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:28:41.132227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.762556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-05T11:28:41.132263Z","caller":"traceutil/trace.go:171","msg":"trace[1051598816] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:11123; }","duration":"116.870388ms","start":"2026-08-05T11:28:41.015382Z","end":"2026-08-05T11:28:41.132253Z","steps":["trace[1051598816] 'agreement among raft nodes before linearized reading'  (duration: 116.738116ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:28:41.345194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.498274ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1558139718709663683 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:11116 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-05T11:28:41.34532Z","caller":"traceutil/trace.go:171","msg":"trace[45801725] transaction","detail":"{read_only:false; response_revision:11125; number_of_response:1; }","duration":"143.53277ms","start":"2026-08-05T11:28:41.201765Z","end":"2026-08-05T11:28:41.345298Z","steps":["trace[45801725] 'process raft request'  (duration: 32.831742ms)","trace[45801725] 'compare'  (duration: 110.375782ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:28:41.374285Z","caller":"traceutil/trace.go:171","msg":"trace[518314292] transaction","detail":"{read_only:false; response_revision:11126; number_of_response:1; }","duration":"172.391665ms","start":"2026-08-05T11:28:41.20187Z","end":"2026-08-05T11:28:41.374261Z","steps":["trace[518314292] 'process raft request'  (duration: 172.085439ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:28:41.3745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.5713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-05T11:28:41.374605Z","caller":"traceutil/trace.go:171","msg":"trace[2070685340] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:11126; }","duration":"171.702783ms","start":"2026-08-05T11:28:41.202878Z","end":"2026-08-05T11:28:41.37458Z","steps":["trace[2070685340] 'agreement among raft nodes before linearized reading'  (duration: 171.459077ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:28:41.374191Z","caller":"traceutil/trace.go:171","msg":"trace[536660812] linearizableReadLoop","detail":"{readStateIndex:11504; appliedIndex:11502; }","duration":"171.243953ms","start":"2026-08-05T11:28:41.202911Z","end":"2026-08-05T11:28:41.374155Z","steps":["trace[536660812] 'read index received'  (duration: 31.849653ms)","trace[536660812] 'applied index is now lower than readState.Index'  (duration: 139.39274ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:33:17.890649Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10972}
{"level":"info","ts":"2026-08-05T11:33:17.975523Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10972,"took":"82.150047ms","hash":3257564266,"current-db-size-bytes":59011072,"current-db-size":"59 MB","current-db-size-in-use-bytes":28065792,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-05T11:33:17.975604Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3257564266,"revision":10972,"compact-revision":8313}
{"level":"info","ts":"2026-08-05T11:34:55.460757Z","caller":"traceutil/trace.go:171","msg":"trace[2020339350] transaction","detail":"{read_only:false; response_revision:13645; number_of_response:1; }","duration":"101.394215ms","start":"2026-08-05T11:34:55.359328Z","end":"2026-08-05T11:34:55.460722Z","steps":["trace[2020339350] 'process raft request'  (duration: 81.057365ms)","trace[2020339350] 'compare'  (duration: 20.183707ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:35:06.219237Z","caller":"traceutil/trace.go:171","msg":"trace[188207243] linearizableReadLoop","detail":"{readStateIndex:14185; appliedIndex:14184; }","duration":"111.090831ms","start":"2026-08-05T11:35:06.108106Z","end":"2026-08-05T11:35:06.219196Z","steps":["trace[188207243] 'read index received'  (duration: 49.493959ms)","trace[188207243] 'applied index is now lower than readState.Index'  (duration: 61.594922ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:35:06.219587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.430887ms","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-08-05T11:35:06.219697Z","caller":"traceutil/trace.go:171","msg":"trace[694184086] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13715; }","duration":"111.657553ms","start":"2026-08-05T11:35:06.108006Z","end":"2026-08-05T11:35:06.219663Z","steps":["trace[694184086] 'agreement among raft nodes before linearized reading'  (duration: 111.344047ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:13.424401Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558139718709671258,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-08-05T11:35:13.515197Z","caller":"traceutil/trace.go:171","msg":"trace[2036288644] transaction","detail":"{read_only:false; response_revision:13753; number_of_response:1; }","duration":"655.14994ms","start":"2026-08-05T11:35:12.860006Z","end":"2026-08-05T11:35:13.515156Z","steps":["trace[2036288644] 'process raft request'  (duration: 654.877825ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:13.515534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:35:12.859969Z","time spent":"655.337234ms","remote":"127.0.0.1:46324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12713,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/openvswitch-zzbsd\" mod_revision:13708 > success:<request_put:<key:\"/registry/pods/openstack/openvswitch-zzbsd\" value_size:12663 >> failure:<request_range:<key:\"/registry/pods/openstack/openvswitch-zzbsd\" > >"}
{"level":"info","ts":"2026-08-05T11:35:13.516499Z","caller":"traceutil/trace.go:171","msg":"trace[323620478] linearizableReadLoop","detail":"{readStateIndex:14225; appliedIndex:14223; }","duration":"592.696672ms","start":"2026-08-05T11:35:12.923776Z","end":"2026-08-05T11:35:13.516473Z","steps":["trace[323620478] 'read index received'  (duration: 591.05599ms)","trace[323620478] 'applied index is now lower than readState.Index'  (duration: 1.636292ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:35:13.516625Z","caller":"traceutil/trace.go:171","msg":"trace[374904480] transaction","detail":"{read_only:false; response_revision:13754; number_of_response:1; }","duration":"492.630293ms","start":"2026-08-05T11:35:13.023985Z","end":"2026-08-05T11:35:13.516616Z","steps":["trace[374904480] 'process raft request'  (duration: 492.328747ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:13.516735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:35:13.023957Z","time spent":"492.689584ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:13740 > 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-08-05T11:35:13.516775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.120442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-05T11:35:13.51685Z","caller":"traceutil/trace.go:171","msg":"trace[1478691235] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:13754; }","duration":"590.276196ms","start":"2026-08-05T11:35:12.926556Z","end":"2026-08-05T11:35:13.516832Z","steps":["trace[1478691235] 'agreement among raft nodes before linearized reading'  (duration: 590.146044ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:13.516918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:35:12.926523Z","time spent":"590.381498ms","remote":"127.0.0.1:46370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":3,"response size":30,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "}
{"level":"warn","ts":"2026-08-05T11:35:13.517136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.926912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:35:13.517179Z","caller":"traceutil/trace.go:171","msg":"trace[1132310306] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:13754; }","duration":"106.008294ms","start":"2026-08-05T11:35:13.411157Z","end":"2026-08-05T11:35:13.517165Z","steps":["trace[1132310306] 'agreement among raft nodes before linearized reading'  (duration: 105.943913ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:13.51728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.484678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-08-05T11:35:13.517364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.817993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-08-05T11:35:13.517384Z","caller":"traceutil/trace.go:171","msg":"trace[1903204028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13754; }","duration":"593.62862ms","start":"2026-08-05T11:35:12.923729Z","end":"2026-08-05T11:35:13.517358Z","steps":["trace[1903204028] 'agreement among raft nodes before linearized reading'  (duration: 593.348855ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:35:13.517408Z","caller":"traceutil/trace.go:171","msg":"trace[569398965] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:13754; }","duration":"458.914575ms","start":"2026-08-05T11:35:13.058481Z","end":"2026-08-05T11:35:13.517395Z","steps":["trace[569398965] 'agreement among raft nodes before linearized reading'  (duration: 458.67596ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:13.517469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:35:12.923713Z","time spent":"593.740003ms","remote":"127.0.0.1:46382","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-08-05T11:35:13.517535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:35:13.058458Z","time spent":"459.067097ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"warn","ts":"2026-08-05T11:35:13.517639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.057789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-krjd5\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-08-05T11:35:13.517815Z","caller":"traceutil/trace.go:171","msg":"trace[560308114] range","detail":"{range_begin:/registry/pods/openstack/keepalived-krjd5; range_end:; response_count:1; response_revision:13754; }","duration":"311.252513ms","start":"2026-08-05T11:35:13.206481Z","end":"2026-08-05T11:35:13.517734Z","steps":["trace[560308114] 'agreement among raft nodes before linearized reading'  (duration: 310.688641ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:13.518075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:35:13.20645Z","time spent":"311.605419ms","remote":"127.0.0.1:46324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-krjd5\" "}
{"level":"warn","ts":"2026-08-05T11:35:13.518786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.369491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:35:13.518858Z","caller":"traceutil/trace.go:171","msg":"trace[3096918] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13754; }","duration":"106.494293ms","start":"2026-08-05T11:35:13.412347Z","end":"2026-08-05T11:35:13.518841Z","steps":["trace[3096918] 'agreement among raft nodes before linearized reading'  (duration: 104.653587ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:36:56.245074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.481521ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1558139718709674931 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:14827 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-05T11:36:56.24518Z","caller":"traceutil/trace.go:171","msg":"trace[234625562] linearizableReadLoop","detail":"{readStateIndex:15346; appliedIndex:15345; }","duration":"251.550007ms","start":"2026-08-05T11:36:55.993613Z","end":"2026-08-05T11:36:56.245163Z","steps":["trace[234625562] 'read index received'  (duration: 68.852291ms)","trace[234625562] 'applied index is now lower than readState.Index'  (duration: 182.696116ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:36:56.245346Z","caller":"traceutil/trace.go:171","msg":"trace[805642177] transaction","detail":"{read_only:false; response_revision:14838; number_of_response:1; }","duration":"302.514025ms","start":"2026-08-05T11:36:55.942671Z","end":"2026-08-05T11:36:56.245186Z","steps":["trace[805642177] 'process raft request'  (duration: 119.84339ms)","trace[805642177] 'compare'  (duration: 181.649946ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:36:56.245433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.806362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-klxnr\" ","response":"range_response_count:1 size:22132"}
{"level":"info","ts":"2026-08-05T11:36:56.245496Z","caller":"traceutil/trace.go:171","msg":"trace[459264853] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-klxnr; range_end:; response_count:1; response_revision:14838; }","duration":"251.933545ms","start":"2026-08-05T11:36:55.993544Z","end":"2026-08-05T11:36:56.245477Z","steps":["trace[459264853] 'agreement among raft nodes before linearized reading'  (duration: 251.660829ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:36:56.245809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:36:55.942648Z","time spent":"303.040195ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:14827 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-05T11:36:56.300993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.992561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:36:56.301111Z","caller":"traceutil/trace.go:171","msg":"trace[27486494] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:14839; }","duration":"257.191324ms","start":"2026-08-05T11:36:56.043888Z","end":"2026-08-05T11:36:56.301079Z","steps":["trace[27486494] 'agreement among raft nodes before linearized reading'  (duration: 256.990081ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:36:56.301162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.024307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"warn","ts":"2026-08-05T11:36:56.30121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.641189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-klxnr\" ","response":"range_response_count:1 size:22132"}
{"level":"info","ts":"2026-08-05T11:36:56.301233Z","caller":"traceutil/trace.go:171","msg":"trace[1613075853] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14839; }","duration":"128.128799ms","start":"2026-08-05T11:36:56.173088Z","end":"2026-08-05T11:36:56.301216Z","steps":["trace[1613075853] 'agreement among raft nodes before linearized reading'  (duration: 127.942985ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:36:56.301299Z","caller":"traceutil/trace.go:171","msg":"trace[2015465018] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-klxnr; range_end:; response_count:1; response_revision:14839; }","duration":"238.854873ms","start":"2026-08-05T11:36:56.062423Z","end":"2026-08-05T11:36:56.301278Z","steps":["trace[2015465018] 'agreement among raft nodes before linearized reading'  (duration: 238.582598ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:36:56.301188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.901163ms","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-08-05T11:36:56.301452Z","caller":"traceutil/trace.go:171","msg":"trace[1425263385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14839; }","duration":"166.173818ms","start":"2026-08-05T11:36:56.135249Z","end":"2026-08-05T11:36:56.301423Z","steps":["trace[1425263385] 'agreement among raft nodes before linearized reading'  (duration: 165.846862ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:36:56.301541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.03222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-08-05T11:36:56.301513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.929392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-t479p\" ","response":"range_response_count:1 size:20660"}
{"level":"warn","ts":"2026-08-05T11:36:56.301357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.30389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-08-05T11:36:56.301626Z","caller":"traceutil/trace.go:171","msg":"trace[1470592648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14839; }","duration":"173.151782ms","start":"2026-08-05T11:36:56.12845Z","end":"2026-08-05T11:36:56.301602Z","steps":["trace[1470592648] 'agreement among raft nodes before linearized reading'  (duration: 172.378658ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:36:56.301679Z","caller":"traceutil/trace.go:171","msg":"trace[1171825073] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-t479p; range_end:; response_count:1; response_revision:14839; }","duration":"218.117286ms","start":"2026-08-05T11:36:56.083508Z","end":"2026-08-05T11:36:56.301625Z","steps":["trace[1171825073] 'agreement among raft nodes before linearized reading'  (duration: 217.457333ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:36:56.301688Z","caller":"traceutil/trace.go:171","msg":"trace[1977667947] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14839; }","duration":"166.778059ms","start":"2026-08-05T11:36:56.134871Z","end":"2026-08-05T11:36:56.301649Z","steps":["trace[1977667947] 'agreement among raft nodes before linearized reading'  (duration: 165.933093ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:36:56.504036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.085796ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1558139718709674937 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:14830 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:462 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-05T11:36:56.504229Z","caller":"traceutil/trace.go:171","msg":"trace[297263573] linearizableReadLoop","detail":"{readStateIndex:15351; appliedIndex:15348; }","duration":"195.013503ms","start":"2026-08-05T11:36:56.309198Z","end":"2026-08-05T11:36:56.504211Z","steps":["trace[297263573] 'read index received'  (duration: 64.769173ms)","trace[297263573] 'applied index is now lower than readState.Index'  (duration: 130.24355ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:36:56.504376Z","caller":"traceutil/trace.go:171","msg":"trace[375272963] transaction","detail":"{read_only:false; response_revision:14840; number_of_response:1; }","duration":"197.874148ms","start":"2026-08-05T11:36:56.30648Z","end":"2026-08-05T11:36:56.504354Z","steps":["trace[375272963] 'process raft request'  (duration: 67.374793ms)","trace[375272963] 'compare'  (duration: 129.955233ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:36:56.504551Z","caller":"traceutil/trace.go:171","msg":"trace[647555167] transaction","detail":"{read_only:false; response_revision:14842; number_of_response:1; }","duration":"196.326457ms","start":"2026-08-05T11:36:56.308181Z","end":"2026-08-05T11:36:56.504507Z","steps":["trace[647555167] 'process raft request'  (duration: 196.001571ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:36:56.505027Z","caller":"traceutil/trace.go:171","msg":"trace[954359984] transaction","detail":"{read_only:false; response_revision:14841; number_of_response:1; }","duration":"197.400689ms","start":"2026-08-05T11:36:56.307609Z","end":"2026-08-05T11:36:56.50501Z","steps":["trace[954359984] 'process raft request'  (duration: 196.536042ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:36:56.505382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.710275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:737321"}
{"level":"info","ts":"2026-08-05T11:36:56.505461Z","caller":"traceutil/trace.go:171","msg":"trace[422263954] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:14842; }","duration":"195.818398ms","start":"2026-08-05T11:36:56.309627Z","end":"2026-08-05T11:36:56.505445Z","steps":["trace[422263954] 'agreement among raft nodes before linearized reading'  (duration: 194.990552ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:36:56.505598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.390198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:737321"}
{"level":"info","ts":"2026-08-05T11:36:56.505685Z","caller":"traceutil/trace.go:171","msg":"trace[1430744150] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:14842; }","duration":"196.513861ms","start":"2026-08-05T11:36:56.309153Z","end":"2026-08-05T11:36:56.505667Z","steps":["trace[1430744150] 'agreement among raft nodes before linearized reading'  (duration: 195.720716ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:36:56.505769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.635584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:22 size:198747"}
{"level":"info","ts":"2026-08-05T11:36:56.505809Z","caller":"traceutil/trace.go:171","msg":"trace[602829132] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:22; response_revision:14842; }","duration":"183.781717ms","start":"2026-08-05T11:36:56.322016Z","end":"2026-08-05T11:36:56.505798Z","steps":["trace[602829132] 'agreement among raft nodes before linearized reading'  (duration: 183.218436ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:38:17.897388Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13009}
{"level":"info","ts":"2026-08-05T11:38:17.978002Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13009,"took":"77.522128ms","hash":2771530509,"current-db-size-bytes":59011072,"current-db-size":"59 MB","current-db-size-in-use-bytes":30511104,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-05T11:38:17.978097Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2771530509,"revision":13009,"compact-revision":10972}
{"level":"info","ts":"2026-08-05T11:42:30.48971Z","caller":"traceutil/trace.go:171","msg":"trace[1723107318] transaction","detail":"{read_only:false; response_revision:17351; number_of_response:1; }","duration":"109.854987ms","start":"2026-08-05T11:42:30.379798Z","end":"2026-08-05T11:42:30.489653Z","steps":["trace[1723107318] 'process raft request'  (duration: 107.322048ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:42:30.489753Z","caller":"traceutil/trace.go:171","msg":"trace[854091473] transaction","detail":"{read_only:false; response_revision:17352; number_of_response:1; }","duration":"109.030961ms","start":"2026-08-05T11:42:30.380684Z","end":"2026-08-05T11:42:30.489715Z","steps":["trace[854091473] 'process raft request'  (duration: 108.697485ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:42:36.708655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.784614ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1558139718709685080 > lease_revoke:<id:159f9fd19c1e2a21>","response":"size:29"}
{"level":"info","ts":"2026-08-05T11:42:36.708782Z","caller":"traceutil/trace.go:171","msg":"trace[1230459063] linearizableReadLoop","detail":"{readStateIndex:17978; appliedIndex:17977; }","duration":"417.935456ms","start":"2026-08-05T11:42:36.290822Z","end":"2026-08-05T11:42:36.708758Z","steps":["trace[1230459063] 'read index received'  (duration: 280.932158ms)","trace[1230459063] 'applied index is now lower than readState.Index'  (duration: 137.001428ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:42:36.709402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.558188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-05T11:42:36.709455Z","caller":"traceutil/trace.go:171","msg":"trace[1222151765] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:17385; }","duration":"418.621959ms","start":"2026-08-05T11:42:36.290816Z","end":"2026-08-05T11:42:36.709438Z","steps":["trace[1222151765] 'agreement among raft nodes before linearized reading'  (duration: 418.384555ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:42:36.7095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:42:36.290775Z","time spent":"418.71147ms","remote":"127.0.0.1:37230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":118,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "}
{"level":"warn","ts":"2026-08-05T11:42:36.709493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.794047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-05T11:42:36.709557Z","caller":"traceutil/trace.go:171","msg":"trace[1281205399] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:17385; }","duration":"352.911329ms","start":"2026-08-05T11:42:36.356626Z","end":"2026-08-05T11:42:36.709538Z","steps":["trace[1281205399] 'agreement among raft nodes before linearized reading'  (duration: 352.738846ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:42:36.709602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:42:36.356598Z","time spent":"352.989781ms","remote":"127.0.0.1:46308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":74,"response size":31,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "}
{"level":"warn","ts":"2026-08-05T11:42:36.710182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.814651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-05T11:42:36.710244Z","caller":"traceutil/trace.go:171","msg":"trace[631402963] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17385; }","duration":"190.926663ms","start":"2026-08-05T11:42:36.519302Z","end":"2026-08-05T11:42:36.710229Z","steps":["trace[631402963] 'agreement among raft nodes before linearized reading'  (duration: 190.776049ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:42:36.710735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.34821ms","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-08-05T11:42:36.710832Z","caller":"traceutil/trace.go:171","msg":"trace[906619725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17385; }","duration":"191.470563ms","start":"2026-08-05T11:42:36.519346Z","end":"2026-08-05T11:42:36.710816Z","steps":["trace[906619725] 'agreement among raft nodes before linearized reading'  (duration: 191.29876ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:42:36.710192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.163582ms","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-08-05T11:42:36.711163Z","caller":"traceutil/trace.go:171","msg":"trace[1985348751] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17385; }","duration":"332.168691ms","start":"2026-08-05T11:42:36.378976Z","end":"2026-08-05T11:42:36.711145Z","steps":["trace[1985348751] 'agreement among raft nodes before linearized reading'  (duration: 331.121412ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:42:36.711228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:42:36.378953Z","time spent":"332.256914ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-08-05T11:42:46.91109Z","caller":"traceutil/trace.go:171","msg":"trace[1138950444] transaction","detail":"{read_only:false; response_revision:17559; number_of_response:1; }","duration":"134.754775ms","start":"2026-08-05T11:42:46.776301Z","end":"2026-08-05T11:42:46.911055Z","steps":["trace[1138950444] 'process raft request'  (duration: 78.400814ms)","trace[1138950444] 'compare'  (duration: 56.225399ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:42:46.917609Z","caller":"traceutil/trace.go:171","msg":"trace[1110348565] linearizableReadLoop","detail":"{readStateIndex:18161; appliedIndex:18159; }","duration":"100.922766ms","start":"2026-08-05T11:42:46.816662Z","end":"2026-08-05T11:42:46.917585Z","steps":["trace[1110348565] 'read index received'  (duration: 38.056371ms)","trace[1110348565] 'applied index is now lower than readState.Index'  (duration: 62.864775ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:42:46.917883Z","caller":"traceutil/trace.go:171","msg":"trace[215268510] transaction","detail":"{read_only:false; response_revision:17560; number_of_response:1; }","duration":"109.206375ms","start":"2026-08-05T11:42:46.80863Z","end":"2026-08-05T11:42:46.917836Z","steps":["trace[215268510] 'process raft request'  (duration: 108.611914ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:42:46.918003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.318143ms","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-08-05T11:42:46.919419Z","caller":"traceutil/trace.go:171","msg":"trace[1605085287] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17560; }","duration":"102.794802ms","start":"2026-08-05T11:42:46.816604Z","end":"2026-08-05T11:42:46.919398Z","steps":["trace[1605085287] 'agreement among raft nodes before linearized reading'  (duration: 101.217481ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:42:46.932197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.530823ms","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-08-05T11:42:46.932403Z","caller":"traceutil/trace.go:171","msg":"trace[1271157727] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17561; }","duration":"107.782808ms","start":"2026-08-05T11:42:46.82461Z","end":"2026-08-05T11:42:46.932392Z","steps":["trace[1271157727] 'agreement among raft nodes before linearized reading'  (duration: 107.464861ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:42:46.93224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.916771ms","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":"warn","ts":"2026-08-05T11:42:46.932331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.222928ms","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-08-05T11:42:46.932567Z","caller":"traceutil/trace.go:171","msg":"trace[217426657] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17561; }","duration":"107.245258ms","start":"2026-08-05T11:42:46.825281Z","end":"2026-08-05T11:42:46.932526Z","steps":["trace[217426657] 'agreement among raft nodes before linearized reading'  (duration: 106.85722ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:42:46.932648Z","caller":"traceutil/trace.go:171","msg":"trace[1374817217] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17561; }","duration":"106.548083ms","start":"2026-08-05T11:42:46.826084Z","end":"2026-08-05T11:42:46.932632Z","steps":["trace[1374817217] 'agreement among raft nodes before linearized reading'  (duration: 106.198357ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:42:46.932339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.466942ms","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-08-05T11:42:46.932805Z","caller":"traceutil/trace.go:171","msg":"trace[215830666] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17561; }","duration":"107.945312ms","start":"2026-08-05T11:42:46.824852Z","end":"2026-08-05T11:42:46.932797Z","steps":["trace[215830666] 'agreement among raft nodes before linearized reading'  (duration: 107.441122ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:43:17.903004Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15388}
{"level":"info","ts":"2026-08-05T11:43:18.001001Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15388,"took":"95.078424ms","hash":2995613758,"current-db-size-bytes":59011072,"current-db-size":"59 MB","current-db-size-in-use-bytes":32538624,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-05T11:43:18.001076Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2995613758,"revision":15388,"compact-revision":13009}
{"level":"info","ts":"2026-08-05T11:46:28.139887Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1ee87564e61d159f","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-05T11:46:28.144808Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-05T11:46:28.144939Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"warn","ts":"2026-08-05T11:48:06.403894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.529569ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1558139718709692504 > lease_revoke:<id:159f9fd19c1e4791>","response":"size:29"}
{"level":"info","ts":"2026-08-05T11:48:06.513003Z","caller":"traceutil/trace.go:171","msg":"trace[1321964392] transaction","detail":"{read_only:false; response_revision:19972; number_of_response:1; }","duration":"104.149426ms","start":"2026-08-05T11:48:06.40883Z","end":"2026-08-05T11:48:06.512979Z","steps":["trace[1321964392] 'process raft request'  (duration: 103.954972ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:48:06.731614Z","caller":"traceutil/trace.go:171","msg":"trace[2045747611] transaction","detail":"{read_only:false; response_revision:19973; number_of_response:1; }","duration":"235.645136ms","start":"2026-08-05T11:48:06.49588Z","end":"2026-08-05T11:48:06.731525Z","steps":["trace[2045747611] 'process raft request'  (duration: 173.277151ms)","trace[2045747611] 'compare'  (duration: 62.226793ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:48:06.885187Z","caller":"traceutil/trace.go:171","msg":"trace[1591401488] linearizableReadLoop","detail":"{readStateIndex:20652; appliedIndex:20651; }","duration":"132.640213ms","start":"2026-08-05T11:48:06.752508Z","end":"2026-08-05T11:48:06.885149Z","steps":["trace[1591401488] 'read index received'  (duration: 117.462221ms)","trace[1591401488] 'applied index is now lower than readState.Index'  (duration: 15.176792ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:48:06.885338Z","caller":"traceutil/trace.go:171","msg":"trace[1544305665] transaction","detail":"{read_only:false; response_revision:19974; number_of_response:1; }","duration":"136.347473ms","start":"2026-08-05T11:48:06.748975Z","end":"2026-08-05T11:48:06.885322Z","steps":["trace[1544305665] 'process raft request'  (duration: 121.06608ms)","trace[1544305665] 'compare'  (duration: 14.901496ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:48:06.88566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.658775ms","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-08-05T11:48:06.88578Z","caller":"traceutil/trace.go:171","msg":"trace[782240889] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19974; }","duration":"130.791687ms","start":"2026-08-05T11:48:06.75496Z","end":"2026-08-05T11:48:06.885751Z","steps":["trace[782240889] 'agreement among raft nodes before linearized reading'  (duration: 130.426941ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:48:06.885886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.908902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-08-05T11:48:06.885926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.704856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-05T11:48:06.885972Z","caller":"traceutil/trace.go:171","msg":"trace[880594279] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19974; }","duration":"117.816958ms","start":"2026-08-05T11:48:06.76814Z","end":"2026-08-05T11:48:06.885957Z","steps":["trace[880594279] 'agreement among raft nodes before linearized reading'  (duration: 117.657385ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:48:06.885977Z","caller":"traceutil/trace.go:171","msg":"trace[214513172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19974; }","duration":"115.051925ms","start":"2026-08-05T11:48:06.770899Z","end":"2026-08-05T11:48:06.885951Z","steps":["trace[214513172] 'agreement among raft nodes before linearized reading'  (duration: 114.79632ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:48:06.886099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.956818ms","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-08-05T11:48:06.886193Z","caller":"traceutil/trace.go:171","msg":"trace[1117664060] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:19974; }","duration":"109.090211ms","start":"2026-08-05T11:48:06.777077Z","end":"2026-08-05T11:48:06.886167Z","steps":["trace[1117664060] 'agreement among raft nodes before linearized reading'  (duration: 108.564531ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:48:06.886087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.56302ms","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-08-05T11:48:06.886265Z","caller":"traceutil/trace.go:171","msg":"trace[907175327] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19974; }","duration":"133.793205ms","start":"2026-08-05T11:48:06.752448Z","end":"2026-08-05T11:48:06.886241Z","steps":["trace[907175327] 'agreement among raft nodes before linearized reading'  (duration: 133.318966ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:48:07.10115Z","caller":"traceutil/trace.go:171","msg":"trace[320608993] transaction","detail":"{read_only:false; response_revision:19975; number_of_response:1; }","duration":"211.234709ms","start":"2026-08-05T11:48:06.889873Z","end":"2026-08-05T11:48:07.101107Z","steps":["trace[320608993] 'process raft request'  (duration: 152.381061ms)","trace[320608993] 'compare'  (duration: 58.665394ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:48:07.124451Z","caller":"traceutil/trace.go:171","msg":"trace[884951026] transaction","detail":"{read_only:false; response_revision:19976; number_of_response:1; }","duration":"233.891543ms","start":"2026-08-05T11:48:06.890537Z","end":"2026-08-05T11:48:07.124428Z","steps":["trace[884951026] 'process raft request'  (duration: 233.535386ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:48:07.124797Z","caller":"traceutil/trace.go:171","msg":"trace[1708172554] transaction","detail":"{read_only:false; response_revision:19977; number_of_response:1; }","duration":"233.950114ms","start":"2026-08-05T11:48:06.8908Z","end":"2026-08-05T11:48:07.12475Z","steps":["trace[1708172554] 'process raft request'  (duration: 233.538676ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:48:07.124876Z","caller":"traceutil/trace.go:171","msg":"trace[1760831786] transaction","detail":"{read_only:false; response_revision:19978; number_of_response:1; }","duration":"233.976074ms","start":"2026-08-05T11:48:06.890854Z","end":"2026-08-05T11:48:07.12483Z","steps":["trace[1760831786] 'process raft request'  (duration: 233.78203ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:48:07.125271Z","caller":"traceutil/trace.go:171","msg":"trace[2001328551] transaction","detail":"{read_only:false; response_revision:19979; number_of_response:1; }","duration":"233.939964ms","start":"2026-08-05T11:48:06.89129Z","end":"2026-08-05T11:48:07.12523Z","steps":["trace[2001328551] 'process raft request'  (duration: 233.477985ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:48:07.12541Z","caller":"traceutil/trace.go:171","msg":"trace[286377898] transaction","detail":"{read_only:false; response_revision:19980; number_of_response:1; }","duration":"160.147461ms","start":"2026-08-05T11:48:06.965241Z","end":"2026-08-05T11:48:07.125389Z","steps":["trace[286377898] 'process raft request'  (duration: 159.906405ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:48:07.125554Z","caller":"traceutil/trace.go:171","msg":"trace[977905159] linearizableReadLoop","detail":"{readStateIndex:20657; appliedIndex:20652; }","duration":"208.810393ms","start":"2026-08-05T11:48:06.916652Z","end":"2026-08-05T11:48:07.125463Z","steps":["trace[977905159] 'read index received'  (duration: 125.583197ms)","trace[977905159] 'applied index is now lower than readState.Index'  (duration: 83.225926ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:48:07.125635Z","caller":"traceutil/trace.go:171","msg":"trace[1529295929] transaction","detail":"{read_only:false; response_revision:19981; number_of_response:1; }","duration":"151.062575ms","start":"2026-08-05T11:48:06.974551Z","end":"2026-08-05T11:48:07.125613Z","steps":["trace[1529295929] 'process raft request'  (duration: 150.739439ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:48:07.125983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.323842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"}
{"level":"warn","ts":"2026-08-05T11:48:07.12734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.446996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-05T11:48:07.127373Z","caller":"traceutil/trace.go:171","msg":"trace[371111856] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:19981; }","duration":"210.752019ms","start":"2026-08-05T11:48:06.916595Z","end":"2026-08-05T11:48:07.127347Z","steps":["trace[371111856] 'agreement among raft nodes before linearized reading'  (duration: 209.289042ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:48:07.127398Z","caller":"traceutil/trace.go:171","msg":"trace[1819737171] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:19981; }","duration":"195.557978ms","start":"2026-08-05T11:48:06.931819Z","end":"2026-08-05T11:48:07.127377Z","steps":["trace[1819737171] 'agreement among raft nodes before linearized reading'  (duration: 195.420325ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:48:17.913444Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17774}
{"level":"info","ts":"2026-08-05T11:48:18.014108Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17774,"took":"96.681223ms","hash":564011060,"current-db-size-bytes":59011072,"current-db-size":"59 MB","current-db-size-in-use-bytes":32866304,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-08-05T11:48:18.014185Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":564011060,"revision":17774,"compact-revision":15388}
{"level":"info","ts":"2026-08-05T11:48:39.43457Z","caller":"traceutil/trace.go:171","msg":"trace[1732084742] transaction","detail":"{read_only:false; response_revision:20228; number_of_response:1; }","duration":"111.748982ms","start":"2026-08-05T11:48:39.322776Z","end":"2026-08-05T11:48:39.434525Z","steps":["trace[1732084742] 'process raft request'  (duration: 18.905723ms)","trace[1732084742] 'compare'  (duration: 92.707846ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:48:39.452505Z","caller":"traceutil/trace.go:171","msg":"trace[566934602] linearizableReadLoop","detail":"{readStateIndex:20923; appliedIndex:20922; }","duration":"109.703203ms","start":"2026-08-05T11:48:39.342776Z","end":"2026-08-05T11:48:39.452479Z","steps":["trace[566934602] 'read index received'  (duration: 109.499459ms)","trace[566934602] 'applied index is now lower than readState.Index'  (duration: 202.594µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:48:39.452582Z","caller":"traceutil/trace.go:171","msg":"trace[468504172] transaction","detail":"{read_only:false; response_revision:20229; number_of_response:1; }","duration":"128.236537ms","start":"2026-08-05T11:48:39.324307Z","end":"2026-08-05T11:48:39.452543Z","steps":["trace[468504172] 'process raft request'  (duration: 128.033623ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:48:39.452873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.976228ms","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-08-05T11:48:39.452932Z","caller":"traceutil/trace.go:171","msg":"trace[1888657784] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20229; }","duration":"110.176801ms","start":"2026-08-05T11:48:39.342737Z","end":"2026-08-05T11:48:39.452914Z","steps":["trace[1888657784] 'agreement among raft nodes before linearized reading'  (duration: 109.890165ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:48:39.452929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.10463ms","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-08-05T11:48:39.452986Z","caller":"traceutil/trace.go:171","msg":"trace[1942929958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20229; }","duration":"110.233513ms","start":"2026-08-05T11:48:39.342738Z","end":"2026-08-05T11:48:39.452971Z","steps":["trace[1942929958] 'agreement among raft nodes before linearized reading'  (duration: 110.044208ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:52:03.742481Z","caller":"traceutil/trace.go:171","msg":"trace[1546757607] transaction","detail":"{read_only:false; response_revision:22381; number_of_response:1; }","duration":"125.173305ms","start":"2026-08-05T11:52:03.617258Z","end":"2026-08-05T11:52:03.742431Z","steps":["trace[1546757607] 'process raft request'  (duration: 106.09457ms)","trace[1546757607] 'compare'  (duration: 18.678527ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:52:11.616811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.250437ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1558139718709699955 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:22450 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:451 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-05T11:52:11.617287Z","caller":"traceutil/trace.go:171","msg":"trace[1672861219] transaction","detail":"{read_only:false; response_revision:22480; number_of_response:1; }","duration":"321.101673ms","start":"2026-08-05T11:52:11.296141Z","end":"2026-08-05T11:52:11.617243Z","steps":["trace[1672861219] 'process raft request'  (duration: 220.293185ms)","trace[1672861219] 'compare'  (duration: 99.745317ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:52:11.617393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:52:11.296098Z","time spent":"321.245046ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:22450 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:451 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-08-05T11:52:11.617963Z","caller":"traceutil/trace.go:171","msg":"trace[1243305144] linearizableReadLoop","detail":"{readStateIndex:23238; appliedIndex:23236; }","duration":"204.274187ms","start":"2026-08-05T11:52:11.413676Z","end":"2026-08-05T11:52:11.617951Z","steps":["trace[1243305144] 'read index received'  (duration: 102.805736ms)","trace[1243305144] 'applied index is now lower than readState.Index'  (duration: 101.467261ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:52:11.618168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.495332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-05T11:52:11.618208Z","caller":"traceutil/trace.go:171","msg":"trace[617196655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22481; }","duration":"204.580213ms","start":"2026-08-05T11:52:11.413617Z","end":"2026-08-05T11:52:11.618197Z","steps":["trace[617196655] 'agreement among raft nodes before linearized reading'  (duration: 204.384319ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:52:11.61844Z","caller":"traceutil/trace.go:171","msg":"trace[1101594422] transaction","detail":"{read_only:false; response_revision:22481; number_of_response:1; }","duration":"274.105724ms","start":"2026-08-05T11:52:11.344254Z","end":"2026-08-05T11:52:11.61836Z","steps":["trace[1101594422] 'process raft request'  (duration: 272.696437ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:53:17.920747Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20033}
{"level":"info","ts":"2026-08-05T11:53:18.03377Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20033,"took":"107.811492ms","hash":2861708326,"current-db-size-bytes":59011072,"current-db-size":"59 MB","current-db-size-in-use-bytes":42942464,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-08-05T11:53:18.033847Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2861708326,"revision":20033,"compact-revision":17774}
{"level":"info","ts":"2026-08-05T11:53:19.676986Z","caller":"traceutil/trace.go:171","msg":"trace[478054005] transaction","detail":"{read_only:false; response_revision:23227; number_of_response:1; }","duration":"101.476501ms","start":"2026-08-05T11:53:19.575464Z","end":"2026-08-05T11:53:19.67694Z","steps":["trace[478054005] 'process raft request'  (duration: 100.966761ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:53:32.972077Z","caller":"traceutil/trace.go:171","msg":"trace[13312909] transaction","detail":"{read_only:false; response_revision:23353; number_of_response:1; }","duration":"113.988821ms","start":"2026-08-05T11:53:32.858062Z","end":"2026-08-05T11:53:32.97205Z","steps":["trace[13312909] 'process raft request'  (duration: 113.760427ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:58:17.928079Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23212}
{"level":"info","ts":"2026-08-05T11:58:18.080041Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23212,"took":"146.875559ms","hash":2231007505,"current-db-size-bytes":59011072,"current-db-size":"59 MB","current-db-size-in-use-bytes":31072256,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-05T11:58:18.080242Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2231007505,"revision":23212,"compact-revision":20033}