{"level":"warn","ts":"2026-08-18T23:19:03.557788Z","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-18T23:19:03.557914Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.140:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.140:2380","--initial-cluster=instance=https://199.204.45.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.140: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-18T23:19:03.557999Z","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-18T23:19:03.55801Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.140:2380"]}
{"level":"info","ts":"2026-08-18T23:19:03.558035Z","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-18T23:19:03.558892Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"]}
{"level":"info","ts":"2026-08-18T23:19:03.559003Z","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":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.140: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-18T23:19:03.615224Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"49.501686ms"}
{"level":"info","ts":"2026-08-18T23:19:03.718246Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"35b2766da46a76bb","cluster-id":"f5fd3aeb8d9f53dc"}
{"level":"info","ts":"2026-08-18T23:19:03.718361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=()"}
{"level":"info","ts":"2026-08-18T23:19:03.718398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 0"}
{"level":"info","ts":"2026-08-18T23:19:03.718415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 35b2766da46a76bb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-18T23:19:03.71843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 1"}
{"level":"info","ts":"2026-08-18T23:19:03.718574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"}
{"level":"warn","ts":"2026-08-18T23:19:03.78037Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-18T23:19:03.783255Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-18T23:19:03.786842Z","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-18T23:19:03.794915Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"35b2766da46a76bb","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-18T23:19:03.795302Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"35b2766da46a76bb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-18T23:19:03.795372Z","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-18T23:19:03.795434Z","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-18T23:19:03.795444Z","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-18T23:19:03.799643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"}
{"level":"info","ts":"2026-08-18T23:19:03.799785Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","added-peer-id":"35b2766da46a76bb","added-peer-peer-urls":["https://199.204.45.140:2380"]}
{"level":"info","ts":"2026-08-18T23:19:03.800802Z","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-18T23:19:03.800925Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.140:2380"}
{"level":"info","ts":"2026-08-18T23:19:03.800948Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.140:2380"}
{"level":"info","ts":"2026-08-18T23:19:03.802195Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"35b2766da46a76bb","initial-advertise-peer-urls":["https://199.204.45.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-18T23:19:03.802275Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-18T23:19:04.323264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb is starting a new election at term 1"}
{"level":"info","ts":"2026-08-18T23:19:04.32333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-18T23:19:04.32341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgPreVoteResp from 35b2766da46a76bb at term 1"}
{"level":"info","ts":"2026-08-18T23:19:04.32343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became candidate at term 2"}
{"level":"info","ts":"2026-08-18T23:19:04.323442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgVoteResp from 35b2766da46a76bb at term 2"}
{"level":"info","ts":"2026-08-18T23:19:04.323457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became leader at term 2"}
{"level":"info","ts":"2026-08-18T23:19:04.323476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 35b2766da46a76bb elected leader 35b2766da46a76bb at term 2"}
{"level":"info","ts":"2026-08-18T23:19:04.33329Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-18T23:19:04.337281Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"35b2766da46a76bb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.140:2379]}","request-path":"/0/members/35b2766da46a76bb/attributes","cluster-id":"f5fd3aeb8d9f53dc","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-18T23:19:04.337326Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-18T23:19:04.337917Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-18T23:19:04.338219Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-18T23:19:04.338361Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-18T23:19:04.340681Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-18T23:19:04.348068Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.140:2379"}
{"level":"info","ts":"2026-08-18T23:19:04.349354Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-18T23:19:04.34946Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-18T23:19:04.349491Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"warn","ts":"2026-08-18T23:19:11.003169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.367513ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555607938500471941 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:250 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:4253 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-18T23:19:11.003362Z","caller":"traceutil/trace.go:171","msg":"trace[589541875] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"149.353714ms","start":"2026-08-18T23:19:10.853988Z","end":"2026-08-18T23:19:11.003342Z","steps":["trace[589541875] 'process raft request'  (duration: 149.297972ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:11.003415Z","caller":"traceutil/trace.go:171","msg":"trace[1442623790] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"164.724435ms","start":"2026-08-18T23:19:10.838642Z","end":"2026-08-18T23:19:11.003366Z","steps":["trace[1442623790] 'process raft request'  (duration: 54.591693ms)","trace[1442623790] 'compare'  (duration: 109.195667ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:19:12.204292Z","caller":"traceutil/trace.go:171","msg":"trace[1037867352] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"100.610892ms","start":"2026-08-18T23:19:12.103634Z","end":"2026-08-18T23:19:12.204245Z","steps":["trace[1037867352] 'process raft request'  (duration: 100.337412ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:14.61663Z","caller":"traceutil/trace.go:171","msg":"trace[1322185336] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"139.22385ms","start":"2026-08-18T23:19:14.477373Z","end":"2026-08-18T23:19:14.616597Z","steps":["trace[1322185336] 'process raft request'  (duration: 81.730879ms)","trace[1322185336] 'compare'  (duration: 57.349836ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:19:14.617159Z","caller":"traceutil/trace.go:171","msg":"trace[1791672844] linearizableReadLoop","detail":"{readStateIndex:323; appliedIndex:320; }","duration":"113.219518ms","start":"2026-08-18T23:19:14.503893Z","end":"2026-08-18T23:19:14.617113Z","steps":["trace[1791672844] 'read index received'  (duration: 55.205319ms)","trace[1791672844] 'applied index is now lower than readState.Index'  (duration: 58.012969ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:19:14.617558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.596321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"}
{"level":"info","ts":"2026-08-18T23:19:14.617647Z","caller":"traceutil/trace.go:171","msg":"trace[864241] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:311; }","duration":"113.753997ms","start":"2026-08-18T23:19:14.503874Z","end":"2026-08-18T23:19:14.617628Z","steps":["trace[864241] 'agreement among raft nodes before linearized reading'  (duration: 113.483697ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:14.617353Z","caller":"traceutil/trace.go:171","msg":"trace[1470762344] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"137.622683ms","start":"2026-08-18T23:19:14.479642Z","end":"2026-08-18T23:19:14.617264Z","steps":["trace[1470762344] 'process raft request'  (duration: 137.364183ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:14.61831Z","caller":"traceutil/trace.go:171","msg":"trace[1868951962] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"139.676266ms","start":"2026-08-18T23:19:14.477615Z","end":"2026-08-18T23:19:14.617292Z","steps":["trace[1868951962] 'process raft request'  (duration: 139.144707ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:14.750367Z","caller":"traceutil/trace.go:171","msg":"trace[1355372064] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"118.349702ms","start":"2026-08-18T23:19:14.631991Z","end":"2026-08-18T23:19:14.75034Z","steps":["trace[1355372064] 'process raft request'  (duration: 91.428617ms)","trace[1355372064] 'compare'  (duration: 26.685617ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:19:14.750417Z","caller":"traceutil/trace.go:171","msg":"trace[1493844559] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"116.861579ms","start":"2026-08-18T23:19:14.633522Z","end":"2026-08-18T23:19:14.750383Z","steps":["trace[1493844559] 'process raft request'  (duration: 116.791366ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:14.750519Z","caller":"traceutil/trace.go:171","msg":"trace[141039462] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"118.408224ms","start":"2026-08-18T23:19:14.632048Z","end":"2026-08-18T23:19:14.750456Z","steps":["trace[141039462] 'process raft request'  (duration: 118.217517ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:14.759598Z","caller":"traceutil/trace.go:171","msg":"trace[1348833593] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"113.758177ms","start":"2026-08-18T23:19:14.645828Z","end":"2026-08-18T23:19:14.759586Z","steps":["trace[1348833593] 'process raft request'  (duration: 113.641453ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:14.759683Z","caller":"traceutil/trace.go:171","msg":"trace[749116996] linearizableReadLoop","detail":"{readStateIndex:332; appliedIndex:327; }","duration":"106.063652ms","start":"2026-08-18T23:19:14.653611Z","end":"2026-08-18T23:19:14.759675Z","steps":["trace[749116996] 'read index received'  (duration: 69.826053ms)","trace[749116996] 'applied index is now lower than readState.Index'  (duration: 36.236669ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:19:14.759747Z","caller":"traceutil/trace.go:171","msg":"trace[1910196716] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"113.588891ms","start":"2026-08-18T23:19:14.646151Z","end":"2026-08-18T23:19:14.75974Z","steps":["trace[1910196716] 'process raft request'  (duration: 113.409264ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:19:14.759897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.284409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"}
{"level":"info","ts":"2026-08-18T23:19:14.759925Z","caller":"traceutil/trace.go:171","msg":"trace[1958354958] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:320; }","duration":"106.358172ms","start":"2026-08-18T23:19:14.65356Z","end":"2026-08-18T23:19:14.759918Z","steps":["trace[1958354958] 'agreement among raft nodes before linearized reading'  (duration: 106.280039ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.273732Z","caller":"traceutil/trace.go:171","msg":"trace[730835448] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"274.893949ms","start":"2026-08-18T23:19:41.998818Z","end":"2026-08-18T23:19:42.273712Z","steps":["trace[730835448] 'process raft request'  (duration: 274.711415ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.283696Z","caller":"traceutil/trace.go:171","msg":"trace[1565790484] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"282.999563ms","start":"2026-08-18T23:19:42.000679Z","end":"2026-08-18T23:19:42.283678Z","steps":["trace[1565790484] 'process raft request'  (duration: 282.872919ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.283882Z","caller":"traceutil/trace.go:171","msg":"trace[1527024284] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"142.728577ms","start":"2026-08-18T23:19:42.141109Z","end":"2026-08-18T23:19:42.283837Z","steps":["trace[1527024284] 'process raft request'  (duration: 142.504681ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.283937Z","caller":"traceutil/trace.go:171","msg":"trace[2071106096] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"137.074445ms","start":"2026-08-18T23:19:42.146851Z","end":"2026-08-18T23:19:42.283925Z","steps":["trace[2071106096] 'process raft request'  (duration: 136.788368ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.284016Z","caller":"traceutil/trace.go:171","msg":"trace[361730726] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"136.89455ms","start":"2026-08-18T23:19:42.147114Z","end":"2026-08-18T23:19:42.284008Z","steps":["trace[361730726] 'process raft request'  (duration: 136.749686ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.284386Z","caller":"traceutil/trace.go:171","msg":"trace[2036469453] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"134.052898ms","start":"2026-08-18T23:19:42.150325Z","end":"2026-08-18T23:19:42.284378Z","steps":["trace[2036469453] 'process raft request'  (duration: 133.783441ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.284479Z","caller":"traceutil/trace.go:171","msg":"trace[1151458217] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"131.131795ms","start":"2026-08-18T23:19:42.153271Z","end":"2026-08-18T23:19:42.284403Z","steps":["trace[1151458217] 'process raft request'  (duration: 130.907069ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.284572Z","caller":"traceutil/trace.go:171","msg":"trace[397332744] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"131.31994ms","start":"2026-08-18T23:19:42.153242Z","end":"2026-08-18T23:19:42.284562Z","steps":["trace[397332744] 'process raft request'  (duration: 130.908209ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.284652Z","caller":"traceutil/trace.go:171","msg":"trace[1990653778] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"128.695244ms","start":"2026-08-18T23:19:42.155948Z","end":"2026-08-18T23:19:42.284643Z","steps":["trace[1990653778] 'process raft request'  (duration: 128.281433ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.284659Z","caller":"traceutil/trace.go:171","msg":"trace[875549503] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"115.895772ms","start":"2026-08-18T23:19:42.168756Z","end":"2026-08-18T23:19:42.284652Z","steps":["trace[875549503] 'process raft request'  (duration: 115.504692ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.284663Z","caller":"traceutil/trace.go:171","msg":"trace[35785203] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"129.984836ms","start":"2026-08-18T23:19:42.154663Z","end":"2026-08-18T23:19:42.284648Z","steps":["trace[35785203] 'process raft request'  (duration: 129.540015ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.654687Z","caller":"traceutil/trace.go:171","msg":"trace[1406198265] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"242.179996ms","start":"2026-08-18T23:19:42.412482Z","end":"2026-08-18T23:19:42.654662Z","steps":["trace[1406198265] 'process raft request'  (duration: 242.035512ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.654854Z","caller":"traceutil/trace.go:171","msg":"trace[103106728] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"247.369766ms","start":"2026-08-18T23:19:42.407457Z","end":"2026-08-18T23:19:42.654826Z","steps":["trace[103106728] 'process raft request'  (duration: 239.308183ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.655418Z","caller":"traceutil/trace.go:171","msg":"trace[2008512575] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"206.299114ms","start":"2026-08-18T23:19:42.449109Z","end":"2026-08-18T23:19:42.655408Z","steps":["trace[2008512575] 'process raft request'  (duration: 206.16729ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.655494Z","caller":"traceutil/trace.go:171","msg":"trace[1431916742] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"214.849319ms","start":"2026-08-18T23:19:42.440638Z","end":"2026-08-18T23:19:42.655487Z","steps":["trace[1431916742] 'process raft request'  (duration: 214.592912ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:42.655533Z","caller":"traceutil/trace.go:171","msg":"trace[203995094] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"230.244746ms","start":"2026-08-18T23:19:42.425281Z","end":"2026-08-18T23:19:42.655526Z","steps":["trace[203995094] 'process raft request'  (duration: 229.877207ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:19:48.424797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.678119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-08-18T23:19:48.424904Z","caller":"traceutil/trace.go:171","msg":"trace[1857405511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"116.804852ms","start":"2026-08-18T23:19:48.308067Z","end":"2026-08-18T23:19:48.424872Z","steps":["trace[1857405511] 'range keys from in-memory index tree'  (duration: 116.543176ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:19:48.424883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.918315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-18T23:19:48.424992Z","caller":"traceutil/trace.go:171","msg":"trace[63708904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:592; }","duration":"117.041337ms","start":"2026-08-18T23:19:48.307905Z","end":"2026-08-18T23:19:48.424946Z","steps":["trace[63708904] 'range keys from in-memory index tree'  (duration: 116.777081ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:19:48.98574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.84843ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555607938500472636 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:577 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-18T23:19:48.9863Z","caller":"traceutil/trace.go:171","msg":"trace[245001244] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"558.015519ms","start":"2026-08-18T23:19:48.428253Z","end":"2026-08-18T23:19:48.986269Z","steps":["trace[245001244] 'process raft request'  (duration: 370.555305ms)","trace[245001244] 'compare'  (duration: 186.548653ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:19:48.986447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:19:48.428227Z","time spent":"558.131232ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:577 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-08-18T23:19:48.986585Z","caller":"traceutil/trace.go:171","msg":"trace[27029797] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:619; }","duration":"311.803212ms","start":"2026-08-18T23:19:48.674765Z","end":"2026-08-18T23:19:48.986568Z","steps":["trace[27029797] 'read index received'  (duration: 123.96305ms)","trace[27029797] 'applied index is now lower than readState.Index'  (duration: 187.839272ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:19:48.986659Z","caller":"traceutil/trace.go:171","msg":"trace[396121221] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"530.387183ms","start":"2026-08-18T23:19:48.456237Z","end":"2026-08-18T23:19:48.986624Z","steps":["trace[396121221] 'process raft request'  (duration: 529.81791ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:19:48.986825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:19:48.456217Z","time spent":"530.513787ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"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:587 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036205 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-08-18T23:19:48.986846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.076438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-08-18T23:19:48.98692Z","caller":"traceutil/trace.go:171","msg":"trace[1550564666] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"312.190641ms","start":"2026-08-18T23:19:48.674714Z","end":"2026-08-18T23:19:48.986905Z","steps":["trace[1550564666] 'agreement among raft nodes before linearized reading'  (duration: 311.989436ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:19:48.986955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:19:48.674695Z","time spent":"312.252352ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-18T23:19:48.98697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.489504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bs8cp\" ","response":"range_response_count:1 size:16965"}
{"level":"warn","ts":"2026-08-18T23:19:48.986853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.520721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:19:48.987031Z","caller":"traceutil/trace.go:171","msg":"trace[1260262792] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bs8cp; range_end:; response_count:1; response_revision:595; }","duration":"240.595837ms","start":"2026-08-18T23:19:48.746425Z","end":"2026-08-18T23:19:48.98702Z","steps":["trace[1260262792] 'agreement among raft nodes before linearized reading'  (duration: 240.453733ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:48.987091Z","caller":"traceutil/trace.go:171","msg":"trace[303888899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"218.759156ms","start":"2026-08-18T23:19:48.76829Z","end":"2026-08-18T23:19:48.987049Z","steps":["trace[303888899] 'agreement among raft nodes before linearized reading'  (duration: 218.513711ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:49.820235Z","caller":"traceutil/trace.go:171","msg":"trace[3006510] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"829.248259ms","start":"2026-08-18T23:19:48.990964Z","end":"2026-08-18T23:19:49.820212Z","steps":["trace[3006510] 'process raft request'  (duration: 820.462295ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:19:49.820366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:19:48.990942Z","time spent":"829.356972ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:581 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-08-18T23:19:49.8359Z","caller":"traceutil/trace.go:171","msg":"trace[1397774353] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"833.934044ms","start":"2026-08-18T23:19:49.001941Z","end":"2026-08-18T23:19:49.835875Z","steps":["trace[1397774353] 'process raft request'  (duration: 833.485314ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:19:49.836021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:19:49.001924Z","time spent":"834.040547ms","remote":"127.0.0.1:59252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-bs8cp\" mod_revision:479 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-bs8cp\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-bs8cp\" > >"}
{"level":"info","ts":"2026-08-18T23:19:49.836095Z","caller":"traceutil/trace.go:171","msg":"trace[690889263] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"800.970412ms","start":"2026-08-18T23:19:49.03511Z","end":"2026-08-18T23:19:49.83608Z","steps":["trace[690889263] 'process raft request'  (duration: 800.422409ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:19:49.836153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:19:49.035086Z","time spent":"801.040884ms","remote":"127.0.0.1:59632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"warn","ts":"2026-08-18T23:19:51.001663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.499737ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555607938500472648 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:586 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-18T23:19:51.001786Z","caller":"traceutil/trace.go:171","msg":"trace[1384804725] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"1.099813299s","start":"2026-08-18T23:19:49.901949Z","end":"2026-08-18T23:19:51.001762Z","steps":["trace[1384804725] 'process raft request'  (duration: 928.118687ms)","trace[1384804725] 'compare'  (duration: 171.19468ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:19:51.001864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:19:49.901938Z","time spent":"1.09988574s","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:586 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-08-18T23:19:51.007399Z","caller":"traceutil/trace.go:171","msg":"trace[975986926] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"751.459733ms","start":"2026-08-18T23:19:50.255916Z","end":"2026-08-18T23:19:51.007375Z","steps":["trace[975986926] 'process raft request'  (duration: 750.793338ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:19:51.007505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:19:50.255895Z","time spent":"751.555266ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"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:595 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036229 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-08-18T23:19:51.007382Z","caller":"traceutil/trace.go:171","msg":"trace[839620482] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:624; }","duration":"517.305245ms","start":"2026-08-18T23:19:50.490052Z","end":"2026-08-18T23:19:51.007357Z","steps":["trace[839620482] 'read index received'  (duration: 340.18491ms)","trace[839620482] 'applied index is now lower than readState.Index'  (duration: 177.119425ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:19:51.010348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.48479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:19:51.010419Z","caller":"traceutil/trace.go:171","msg":"trace[387712402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"243.547231ms","start":"2026-08-18T23:19:50.766835Z","end":"2026-08-18T23:19:51.010383Z","steps":["trace[387712402] 'agreement among raft nodes before linearized reading'  (duration: 243.391778ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:19:51.010878Z","caller":"traceutil/trace.go:171","msg":"trace[742275741] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"579.236849ms","start":"2026-08-18T23:19:50.431616Z","end":"2026-08-18T23:19:51.010852Z","steps":["trace[742275741] 'process raft request'  (duration: 575.680638ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:19:51.010983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:19:50.43159Z","time spent":"579.319821ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:450 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-08-18T23:19:51.011289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.239334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-18T23:19:51.011345Z","caller":"traceutil/trace.go:171","msg":"trace[1938470457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:601; }","duration":"521.316905ms","start":"2026-08-18T23:19:50.490004Z","end":"2026-08-18T23:19:51.011321Z","steps":["trace[1938470457] 'agreement among raft nodes before linearized reading'  (duration: 521.172852ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:19:51.011381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:19:50.489953Z","time spent":"521.419879ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-08-18T23:20:06.879155Z","caller":"traceutil/trace.go:171","msg":"trace[1045229745] linearizableReadLoop","detail":"{readStateIndex:792; appliedIndex:791; }","duration":"253.215733ms","start":"2026-08-18T23:20:06.625896Z","end":"2026-08-18T23:20:06.879112Z","steps":["trace[1045229745] 'read index received'  (duration: 253.03711ms)","trace[1045229745] 'applied index is now lower than readState.Index'  (duration: 177.013µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:20:06.87923Z","caller":"traceutil/trace.go:171","msg":"trace[2102153166] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"263.608621ms","start":"2026-08-18T23:20:06.61559Z","end":"2026-08-18T23:20:06.879199Z","steps":["trace[2102153166] 'process raft request'  (duration: 263.247914ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:20:06.879359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.444317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-18T23:20:06.879406Z","caller":"traceutil/trace.go:171","msg":"trace[1015367426] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:762; }","duration":"253.535379ms","start":"2026-08-18T23:20:06.625861Z","end":"2026-08-18T23:20:06.879396Z","steps":["trace[1015367426] 'agreement among raft nodes before linearized reading'  (duration: 253.393777ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:20:19.28171Z","caller":"traceutil/trace.go:171","msg":"trace[2112848717] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"123.082082ms","start":"2026-08-18T23:20:19.158608Z","end":"2026-08-18T23:20:19.28169Z","steps":["trace[2112848717] 'process raft request'  (duration: 113.565284ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:20:36.922165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.196451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:20:36.922281Z","caller":"traceutil/trace.go:171","msg":"trace[1334703804] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1161; }","duration":"155.357314ms","start":"2026-08-18T23:20:36.766901Z","end":"2026-08-18T23:20:36.922258Z","steps":["trace[1334703804] 'range keys from in-memory index tree'  (duration: 155.10766ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:21:00.515278Z","caller":"traceutil/trace.go:171","msg":"trace[525225164] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"210.921337ms","start":"2026-08-18T23:21:00.304321Z","end":"2026-08-18T23:21:00.515242Z","steps":["trace[525225164] 'process raft request'  (duration: 210.701034ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:21:24.682331Z","caller":"traceutil/trace.go:171","msg":"trace[894916843] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"139.312919ms","start":"2026-08-18T23:21:24.542967Z","end":"2026-08-18T23:21:24.68228Z","steps":["trace[894916843] 'process raft request'  (duration: 139.038536ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:25.490949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.593061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:21:25.491069Z","caller":"traceutil/trace.go:171","msg":"trace[1845131049] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1835; }","duration":"328.780942ms","start":"2026-08-18T23:21:25.16227Z","end":"2026-08-18T23:21:25.491051Z","steps":["trace[1845131049] 'count revisions from in-memory index tree'  (duration: 328.50084ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:25.491252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.70274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-587cb2e3-08ee-4b51-90c4-82ec45f9e49c\" ","response":"range_response_count:1 size:3627"}
{"level":"warn","ts":"2026-08-18T23:21:25.491304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:21:25.162249Z","time spent":"329.030225ms","remote":"127.0.0.1:50262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"info","ts":"2026-08-18T23:21:25.49137Z","caller":"traceutil/trace.go:171","msg":"trace[1598686556] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-587cb2e3-08ee-4b51-90c4-82ec45f9e49c; range_end:; response_count:1; response_revision:1835; }","duration":"282.870491ms","start":"2026-08-18T23:21:25.208468Z","end":"2026-08-18T23:21:25.491338Z","steps":["trace[1598686556] 'range keys from in-memory index tree'  (duration: 282.523568ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:25.492324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.157023ms","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-18T23:21:25.492419Z","caller":"traceutil/trace.go:171","msg":"trace[507467408] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1835; }","duration":"527.304184ms","start":"2026-08-18T23:21:24.965091Z","end":"2026-08-18T23:21:25.492395Z","steps":["trace[507467408] 'range keys from in-memory index tree'  (duration: 526.938001ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:25.492475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:21:24.965068Z","time spent":"527.396285ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-08-18T23:21:25.619152Z","caller":"traceutil/trace.go:171","msg":"trace[37229923] linearizableReadLoop","detail":"{readStateIndex:1911; appliedIndex:1910; }","duration":"107.06541ms","start":"2026-08-18T23:21:25.512062Z","end":"2026-08-18T23:21:25.619128Z","steps":["trace[37229923] 'read index received'  (duration: 98.943232ms)","trace[37229923] 'applied index is now lower than readState.Index'  (duration: 8.121008ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:21:25.619508Z","caller":"traceutil/trace.go:171","msg":"trace[1561047400] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"120.884692ms","start":"2026-08-18T23:21:25.498586Z","end":"2026-08-18T23:21:25.61947Z","steps":["trace[1561047400] 'process raft request'  (duration: 112.541892ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:25.619585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.496194ms","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-18T23:21:25.619736Z","caller":"traceutil/trace.go:171","msg":"trace[558874541] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1837; }","duration":"107.698606ms","start":"2026-08-18T23:21:25.512021Z","end":"2026-08-18T23:21:25.619719Z","steps":["trace[558874541] 'agreement among raft nodes before linearized reading'  (duration: 107.380003ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:25.619767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.582216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-08-18T23:21:25.619838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.602507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-18T23:21:25.619849Z","caller":"traceutil/trace.go:171","msg":"trace[1595483326] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1837; }","duration":"103.701578ms","start":"2026-08-18T23:21:25.516128Z","end":"2026-08-18T23:21:25.619829Z","steps":["trace[1595483326] 'agreement among raft nodes before linearized reading'  (duration: 103.360655ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:21:25.619895Z","caller":"traceutil/trace.go:171","msg":"trace[1286085647] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1837; }","duration":"102.692288ms","start":"2026-08-18T23:21:25.517192Z","end":"2026-08-18T23:21:25.619884Z","steps":["trace[1286085647] 'agreement among raft nodes before linearized reading'  (duration: 102.551357ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:26.121912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.278671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:21:26.121993Z","caller":"traceutil/trace.go:171","msg":"trace[801869708] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1841; }","duration":"354.408962ms","start":"2026-08-18T23:21:25.767568Z","end":"2026-08-18T23:21:26.121977Z","steps":["trace[801869708] 'range keys from in-memory index tree'  (duration: 354.20525ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:26.122023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:21:25.767535Z","time spent":"354.481732ms","remote":"127.0.0.1:59032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-08-18T23:21:26.122098Z","caller":"traceutil/trace.go:171","msg":"trace[1845530505] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"253.238879ms","start":"2026-08-18T23:21:25.868829Z","end":"2026-08-18T23:21:26.122068Z","steps":["trace[1845530505] 'process raft request'  (duration: 225.562464ms)","trace[1845530505] 'compare'  (duration: 27.598814ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:21:36.846369Z","caller":"traceutil/trace.go:171","msg":"trace[58223466] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"118.956452ms","start":"2026-08-18T23:21:36.72738Z","end":"2026-08-18T23:21:36.846337Z","steps":["trace[58223466] 'process raft request'  (duration: 118.75586ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:21:36.958976Z","caller":"traceutil/trace.go:171","msg":"trace[1402626725] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"108.073504ms","start":"2026-08-18T23:21:36.850862Z","end":"2026-08-18T23:21:36.958936Z","steps":["trace[1402626725] 'process raft request'  (duration: 72.635224ms)","trace[1402626725] 'compare'  (duration: 35.275068ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:21:39.969039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.002688ms","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-18T23:21:39.969128Z","caller":"traceutil/trace.go:171","msg":"trace[1654211417] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1951; }","duration":"266.130349ms","start":"2026-08-18T23:21:39.702978Z","end":"2026-08-18T23:21:39.969108Z","steps":["trace[1654211417] 'range keys from in-memory index tree'  (duration: 265.801846ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:39.969187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.108422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-7fcdcd478-vv9sb\" ","response":"range_response_count:1 size:5815"}
{"level":"info","ts":"2026-08-18T23:21:39.969261Z","caller":"traceutil/trace.go:171","msg":"trace[424420810] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-7fcdcd478-vv9sb; range_end:; response_count:1; response_revision:1951; }","duration":"131.270174ms","start":"2026-08-18T23:21:39.837972Z","end":"2026-08-18T23:21:39.969242Z","steps":["trace[424420810] 'range keys from in-memory index tree'  (duration: 130.929661ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:39.969291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.654372ms","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-18T23:21:39.969388Z","caller":"traceutil/trace.go:171","msg":"trace[1286120426] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1951; }","duration":"197.800393ms","start":"2026-08-18T23:21:39.771566Z","end":"2026-08-18T23:21:39.969366Z","steps":["trace[1286120426] 'range keys from in-memory index tree'  (duration: 197.43381ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:39.969402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.250285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-18T23:21:39.969503Z","caller":"traceutil/trace.go:171","msg":"trace[607476579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1951; }","duration":"200.392876ms","start":"2026-08-18T23:21:39.769085Z","end":"2026-08-18T23:21:39.969477Z","steps":["trace[607476579] 'range keys from in-memory index tree'  (duration: 200.081454ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:39.969605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.001711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-08-18T23:21:39.969668Z","caller":"traceutil/trace.go:171","msg":"trace[907715640] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1951; }","duration":"104.081303ms","start":"2026-08-18T23:21:39.865565Z","end":"2026-08-18T23:21:39.969646Z","steps":["trace[907715640] 'range keys from in-memory index tree'  (duration: 103.85403ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:39.969715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.08595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-08-18T23:21:39.969755Z","caller":"traceutil/trace.go:171","msg":"trace[1304698249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1951; }","duration":"203.126651ms","start":"2026-08-18T23:21:39.766618Z","end":"2026-08-18T23:21:39.969745Z","steps":["trace[1304698249] 'range keys from in-memory index tree'  (duration: 202.959589ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:39.969993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.727927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:21:39.970054Z","caller":"traceutil/trace.go:171","msg":"trace[240052407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1951; }","duration":"202.804697ms","start":"2026-08-18T23:21:39.767234Z","end":"2026-08-18T23:21:39.970038Z","steps":["trace[240052407] 'range keys from in-memory index tree'  (duration: 202.681287ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:42.483939Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8555607938500475364,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-08-18T23:21:42.977003Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.007854751s","expected-duration":"1s"}
{"level":"info","ts":"2026-08-18T23:21:42.977339Z","caller":"traceutil/trace.go:171","msg":"trace[167561118] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"1.008265495s","start":"2026-08-18T23:21:41.969048Z","end":"2026-08-18T23:21:42.977313Z","steps":["trace[167561118] 'process raft request'  (duration: 1.008127304s)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:42.977443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:21:41.969024Z","time spent":"1.008349946s","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:1922 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-08-18T23:21:42.979361Z","caller":"traceutil/trace.go:171","msg":"trace[1529545620] linearizableReadLoop","detail":"{readStateIndex:2049; appliedIndex:2046; }","duration":"995.675905ms","start":"2026-08-18T23:21:41.983672Z","end":"2026-08-18T23:21:42.979348Z","steps":["trace[1529545620] 'read index received'  (duration: 993.519846ms)","trace[1529545620] 'applied index is now lower than readState.Index'  (duration: 2.155049ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:21:42.979427Z","caller":"traceutil/trace.go:171","msg":"trace[885286531] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"793.625661ms","start":"2026-08-18T23:21:42.185794Z","end":"2026-08-18T23:21:42.97942Z","steps":["trace[885286531] 'process raft request'  (duration: 793.50811ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:21:42.97943Z","caller":"traceutil/trace.go:171","msg":"trace[1195577138] transaction","detail":"{read_only:false; response_revision:1970; number_of_response:1; }","duration":"793.702431ms","start":"2026-08-18T23:21:42.1857Z","end":"2026-08-18T23:21:42.979402Z","steps":["trace[1195577138] 'process raft request'  (duration: 793.54778ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:42.97947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:21:42.185787Z","time spent":"793.655312ms","remote":"127.0.0.1:59360","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:1959 > 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-18T23:21:42.979571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:21:42.185673Z","time spent":"793.828223ms","remote":"127.0.0.1:59360","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:1960 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-18T23:21:42.979604Z","caller":"traceutil/trace.go:171","msg":"trace[442014270] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"114.61425ms","start":"2026-08-18T23:21:42.86498Z","end":"2026-08-18T23:21:42.979594Z","steps":["trace[442014270] 'process raft request'  (duration: 114.345148ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:42.979757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"996.109908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-08-18T23:21:42.979788Z","caller":"traceutil/trace.go:171","msg":"trace[1818806332] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1972; }","duration":"996.19724ms","start":"2026-08-18T23:21:41.983581Z","end":"2026-08-18T23:21:42.979779Z","steps":["trace[1818806332] 'agreement among raft nodes before linearized reading'  (duration: 996.091779ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:42.979822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:21:41.983557Z","time spent":"996.25541ms","remote":"127.0.0.1:38556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-08-18T23:21:42.979858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.755815ms","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-18T23:21:42.979892Z","caller":"traceutil/trace.go:171","msg":"trace[696501525] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1972; }","duration":"987.820676ms","start":"2026-08-18T23:21:41.992063Z","end":"2026-08-18T23:21:42.979884Z","steps":["trace[696501525] 'agreement among raft nodes before linearized reading'  (duration: 987.720305ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:42.979915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:21:41.992048Z","time spent":"987.861786ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-08-18T23:21:42.980027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.534734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:21:42.980066Z","caller":"traceutil/trace.go:171","msg":"trace[669943058] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1972; }","duration":"212.608114ms","start":"2026-08-18T23:21:42.767448Z","end":"2026-08-18T23:21:42.980056Z","steps":["trace[669943058] 'agreement among raft nodes before linearized reading'  (duration: 212.557404ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:42.980085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.591148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-08-18T23:21:42.980102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.624794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-08-18T23:21:42.980111Z","caller":"traceutil/trace.go:171","msg":"trace[1804325128] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1972; }","duration":"983.626998ms","start":"2026-08-18T23:21:41.996477Z","end":"2026-08-18T23:21:42.980104Z","steps":["trace[1804325128] 'agreement among raft nodes before linearized reading'  (duration: 983.564918ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:21:42.980124Z","caller":"traceutil/trace.go:171","msg":"trace[271506452] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1972; }","duration":"212.682156ms","start":"2026-08-18T23:21:42.767436Z","end":"2026-08-18T23:21:42.980118Z","steps":["trace[271506452] 'agreement among raft nodes before linearized reading'  (duration: 212.624035ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:42.980177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.836191ms","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-18T23:21:42.980199Z","caller":"traceutil/trace.go:171","msg":"trace[352240803] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1972; }","duration":"983.869401ms","start":"2026-08-18T23:21:41.996325Z","end":"2026-08-18T23:21:42.980194Z","steps":["trace[352240803] 'agreement among raft nodes before linearized reading'  (duration: 983.815871ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:42.980219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:21:41.996316Z","time spent":"983.898721ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-18T23:21:42.980268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.984092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-08-18T23:21:42.98013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:21:41.996472Z","time spent":"983.653699ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-08-18T23:21:42.980291Z","caller":"traceutil/trace.go:171","msg":"trace[1797013834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1972; }","duration":"984.034842ms","start":"2026-08-18T23:21:41.996252Z","end":"2026-08-18T23:21:42.980286Z","steps":["trace[1797013834] 'agreement among raft nodes before linearized reading'  (duration: 983.981272ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:42.980311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:21:41.996232Z","time spent":"984.074453ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-08-18T23:21:42.980381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.293953ms","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-18T23:21:42.980514Z","caller":"traceutil/trace.go:171","msg":"trace[539414013] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1972; }","duration":"406.646796ms","start":"2026-08-18T23:21:42.573844Z","end":"2026-08-18T23:21:42.980491Z","steps":["trace[539414013] 'agreement among raft nodes before linearized reading'  (duration: 406.137571ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:42.980652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:21:42.573827Z","time spent":"406.808987ms","remote":"127.0.0.1:50248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"warn","ts":"2026-08-18T23:21:58.186844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.699552ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555607938500475582 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:1976 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:467 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-18T23:21:58.187633Z","caller":"traceutil/trace.go:171","msg":"trace[528535905] linearizableReadLoop","detail":"{readStateIndex:2143; appliedIndex:2142; }","duration":"142.676931ms","start":"2026-08-18T23:21:58.044932Z","end":"2026-08-18T23:21:58.187609Z","steps":["trace[528535905] 'read index received'  (duration: 20.068972ms)","trace[528535905] 'applied index is now lower than readState.Index'  (duration: 122.605929ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:21:58.187688Z","caller":"traceutil/trace.go:171","msg":"trace[225810921] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"186.074012ms","start":"2026-08-18T23:21:58.001569Z","end":"2026-08-18T23:21:58.187643Z","steps":["trace[225810921] 'process raft request'  (duration: 63.488272ms)","trace[225810921] 'compare'  (duration: 121.564901ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:21:58.18793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.983264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.140\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-08-18T23:21:58.188007Z","caller":"traceutil/trace.go:171","msg":"trace[1441262741] range","detail":"{range_begin:/registry/masterleases/199.204.45.140; range_end:; response_count:1; response_revision:2062; }","duration":"143.109606ms","start":"2026-08-18T23:21:58.044879Z","end":"2026-08-18T23:21:58.187989Z","steps":["trace[1441262741] 'agreement among raft nodes before linearized reading'  (duration: 142.888024ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:21:58.188075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.004114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-08-18T23:21:58.188141Z","caller":"traceutil/trace.go:171","msg":"trace[978429612] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2062; }","duration":"112.221466ms","start":"2026-08-18T23:21:58.075902Z","end":"2026-08-18T23:21:58.188124Z","steps":["trace[978429612] 'agreement among raft nodes before linearized reading'  (duration: 112.017954ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:03.84617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.804357ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555607938500475654 > lease_revoke:<id:76bba0172bd53a2d>","response":"size:28"}
{"level":"info","ts":"2026-08-18T23:22:03.846363Z","caller":"traceutil/trace.go:171","msg":"trace[728406313] linearizableReadLoop","detail":"{readStateIndex:2175; appliedIndex:2174; }","duration":"247.856678ms","start":"2026-08-18T23:22:03.59849Z","end":"2026-08-18T23:22:03.846347Z","steps":["trace[728406313] 'read index received'  (duration: 51.88613ms)","trace[728406313] 'applied index is now lower than readState.Index'  (duration: 195.969438ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:22:03.846431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.441555ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:22:03.846652Z","caller":"traceutil/trace.go:171","msg":"trace[2026532744] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2092; }","duration":"152.674746ms","start":"2026-08-18T23:22:03.693923Z","end":"2026-08-18T23:22:03.846598Z","steps":["trace[2026532744] 'range keys from in-memory index tree'  (duration: 152.427294ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:03.846728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.215001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"}
{"level":"info","ts":"2026-08-18T23:22:03.846799Z","caller":"traceutil/trace.go:171","msg":"trace[1277429308] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2092; }","duration":"248.337962ms","start":"2026-08-18T23:22:03.598442Z","end":"2026-08-18T23:22:03.84678Z","steps":["trace[1277429308] 'agreement among raft nodes before linearized reading'  (duration: 248.10294ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:22:03.846936Z","caller":"traceutil/trace.go:171","msg":"trace[909085428] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"173.077047ms","start":"2026-08-18T23:22:03.673837Z","end":"2026-08-18T23:22:03.846914Z","steps":["trace[909085428] 'process raft request'  (duration: 172.428282ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:03.894754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.245667ms","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-18T23:22:03.89483Z","caller":"traceutil/trace.go:171","msg":"trace[1414794250] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2093; }","duration":"193.366857ms","start":"2026-08-18T23:22:03.701441Z","end":"2026-08-18T23:22:03.894808Z","steps":["trace[1414794250] 'agreement among raft nodes before linearized reading'  (duration: 145.519469ms)","trace[1414794250] 'range keys from in-memory index tree'  (duration: 47.674037ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:22:03.894909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.461536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:22:03.894981Z","caller":"traceutil/trace.go:171","msg":"trace[1256100813] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2093; }","duration":"127.637488ms","start":"2026-08-18T23:22:03.767324Z","end":"2026-08-18T23:22:03.894961Z","steps":["trace[1256100813] 'agreement among raft nodes before linearized reading'  (duration: 79.68415ms)","trace[1256100813] 'range keys from in-memory index tree'  (duration: 47.795517ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:22:05.271172Z","caller":"traceutil/trace.go:171","msg":"trace[1893841581] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"213.489832ms","start":"2026-08-18T23:22:05.057662Z","end":"2026-08-18T23:22:05.271152Z","steps":["trace[1893841581] 'process raft request'  (duration: 213.365991ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:05.584135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.497508ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555607938500475669 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2087 > 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-18T23:22:05.584427Z","caller":"traceutil/trace.go:171","msg":"trace[1292977918] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"525.031343ms","start":"2026-08-18T23:22:05.059368Z","end":"2026-08-18T23:22:05.5844Z","steps":["trace[1292977918] 'process raft request'  (duration: 323.163292ms)","trace[1292977918] 'compare'  (duration: 201.395518ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:22:05.584453Z","caller":"traceutil/trace.go:171","msg":"trace[418582761] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"524.884962ms","start":"2026-08-18T23:22:05.059536Z","end":"2026-08-18T23:22:05.584421Z","steps":["trace[418582761] 'process raft request'  (duration: 524.694091ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:05.584558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.059522Z","time spent":"524.980913ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2086 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-18T23:22:05.584452Z","caller":"traceutil/trace.go:171","msg":"trace[1274439586] linearizableReadLoop","detail":"{readStateIndex:2180; appliedIndex:2177; }","duration":"493.554018ms","start":"2026-08-18T23:22:05.09088Z","end":"2026-08-18T23:22:05.584434Z","steps":["trace[1274439586] 'read index received'  (duration: 180.125452ms)","trace[1274439586] 'applied index is now lower than readState.Index'  (duration: 313.425656ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:22:05.584646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.059341Z","time spent":"525.156334ms","remote":"127.0.0.1:59360","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:2087 > 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-18T23:22:05.584662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.778099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-08-18T23:22:05.584739Z","caller":"traceutil/trace.go:171","msg":"trace[1919207994] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2098; }","duration":"493.85554ms","start":"2026-08-18T23:22:05.090874Z","end":"2026-08-18T23:22:05.58473Z","steps":["trace[1919207994] 'agreement among raft nodes before linearized reading'  (duration: 493.606548ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:05.584758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.103894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-08-18T23:22:05.584788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.760963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-08-18T23:22:05.584804Z","caller":"traceutil/trace.go:171","msg":"trace[385189565] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2098; }","duration":"486.797883ms","start":"2026-08-18T23:22:05.098001Z","end":"2026-08-18T23:22:05.584799Z","steps":["trace[385189565] 'agreement among raft nodes before linearized reading'  (duration: 486.758153ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:22:05.584807Z","caller":"traceutil/trace.go:171","msg":"trace[627023184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2098; }","duration":"488.169834ms","start":"2026-08-18T23:22:05.096622Z","end":"2026-08-18T23:22:05.584792Z","steps":["trace[627023184] 'agreement among raft nodes before linearized reading'  (duration: 488.036283ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:05.584823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.097994Z","time spent":"486.826105ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-08-18T23:22:05.584778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.090838Z","time spent":"493.9328ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-18T23:22:05.584747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.50624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-08-18T23:22:05.584868Z","caller":"traceutil/trace.go:171","msg":"trace[309454095] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2098; }","duration":"487.642531ms","start":"2026-08-18T23:22:05.097222Z","end":"2026-08-18T23:22:05.584864Z","steps":["trace[309454095] 'agreement among raft nodes before linearized reading'  (duration: 487.48316ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:05.58488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.0972Z","time spent":"487.676921ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-18T23:22:05.584986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.225835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-18T23:22:05.585022Z","caller":"traceutil/trace.go:171","msg":"trace[628592965] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2098; }","duration":"488.261375ms","start":"2026-08-18T23:22:05.096752Z","end":"2026-08-18T23:22:05.585013Z","steps":["trace[628592965] 'agreement among raft nodes before linearized reading'  (duration: 488.104384ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:05.585048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.096728Z","time spent":"488.314206ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-08-18T23:22:05.584839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.096612Z","time spent":"488.219605ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-08-18T23:22:05.584911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.652828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-08-18T23:22:05.585668Z","caller":"traceutil/trace.go:171","msg":"trace[1332478697] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2098; }","duration":"351.449714ms","start":"2026-08-18T23:22:05.234195Z","end":"2026-08-18T23:22:05.585645Z","steps":["trace[1332478697] 'agreement among raft nodes before linearized reading'  (duration: 350.495427ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:05.588377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.234184Z","time spent":"354.154455ms","remote":"127.0.0.1:38556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-08-18T23:22:06.052483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.334213ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555607938500475676 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2090 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-18T23:22:06.052591Z","caller":"traceutil/trace.go:171","msg":"trace[2017425582] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"463.198908ms","start":"2026-08-18T23:22:05.589372Z","end":"2026-08-18T23:22:06.052571Z","steps":["trace[2017425582] 'process raft request'  (duration: 227.682854ms)","trace[2017425582] 'compare'  (duration: 235.145761ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:22:06.052727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.589355Z","time spent":"463.278309ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2090 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-08-18T23:22:06.094234Z","caller":"traceutil/trace.go:171","msg":"trace[1916760222] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"504.037946ms","start":"2026-08-18T23:22:05.590174Z","end":"2026-08-18T23:22:06.094212Z","steps":["trace[1916760222] 'process raft request'  (duration: 503.926855ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:06.094501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.590163Z","time spent":"504.234228ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2092 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-08-18T23:22:06.094648Z","caller":"traceutil/trace.go:171","msg":"trace[542087072] linearizableReadLoop","detail":"{readStateIndex:2185; appliedIndex:2181; }","duration":"504.308358ms","start":"2026-08-18T23:22:05.590301Z","end":"2026-08-18T23:22:06.094609Z","steps":["trace[542087072] 'read index received'  (duration: 226.803896ms)","trace[542087072] 'applied index is now lower than readState.Index'  (duration: 277.503322ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:22:06.094736Z","caller":"traceutil/trace.go:171","msg":"trace[581027018] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"504.43429ms","start":"2026-08-18T23:22:05.590277Z","end":"2026-08-18T23:22:06.094711Z","steps":["trace[581027018] 'process raft request'  (duration: 503.886626ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:06.095391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.590256Z","time spent":"505.058005ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2091 > 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\" > >"}
{"level":"warn","ts":"2026-08-18T23:22:06.095462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.685092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:118251"}
{"level":"warn","ts":"2026-08-18T23:22:06.094762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.448729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"}
{"level":"info","ts":"2026-08-18T23:22:06.095517Z","caller":"traceutil/trace.go:171","msg":"trace[148437502] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2103; }","duration":"504.756982ms","start":"2026-08-18T23:22:05.590743Z","end":"2026-08-18T23:22:06.0955Z","steps":["trace[148437502] 'agreement among raft nodes before linearized reading'  (duration: 504.573281ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:06.095549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.328429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:22:06.095522Z","caller":"traceutil/trace.go:171","msg":"trace[844503594] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2103; }","duration":"505.226146ms","start":"2026-08-18T23:22:05.590284Z","end":"2026-08-18T23:22:06.09551Z","steps":["trace[844503594] 'agreement among raft nodes before linearized reading'  (duration: 504.41963ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:06.095746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.590278Z","time spent":"505.456798ms","remote":"127.0.0.1:59126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":141,"request content":"key:\"/registry/ranges/servicenodeports\" "}
{"level":"info","ts":"2026-08-18T23:22:06.095647Z","caller":"traceutil/trace.go:171","msg":"trace[540436916] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2103; }","duration":"328.479991ms","start":"2026-08-18T23:22:05.767154Z","end":"2026-08-18T23:22:06.095634Z","steps":["trace[540436916] 'agreement among raft nodes before linearized reading'  (duration: 328.33144ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:06.095561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.590738Z","time spent":"504.815062ms","remote":"127.0.0.1:59120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":118274,"request content":"key:\"/registry/ranges/serviceips\" "}
{"level":"warn","ts":"2026-08-18T23:22:06.095885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.767133Z","time spent":"328.696273ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-08-18T23:22:06.094245Z","caller":"traceutil/trace.go:171","msg":"trace[1342212795] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"504.661861ms","start":"2026-08-18T23:22:05.589539Z","end":"2026-08-18T23:22:06.094201Z","steps":["trace[1342212795] 'process raft request'  (duration: 504.428249ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:06.096269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.589528Z","time spent":"506.633917ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2088 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-08-18T23:22:06.094829Z","caller":"traceutil/trace.go:171","msg":"trace[349796222] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"504.116727ms","start":"2026-08-18T23:22:05.590682Z","end":"2026-08-18T23:22:06.094799Z","steps":["trace[349796222] 'process raft request'  (duration: 503.691553ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:22:06.096574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:22:05.590674Z","time spent":"505.80309ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2089 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-08-18T23:22:06.096588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.91877ms","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-18T23:22:06.096803Z","caller":"traceutil/trace.go:171","msg":"trace[1874350966] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2103; }","duration":"174.325973ms","start":"2026-08-18T23:22:05.922459Z","end":"2026-08-18T23:22:06.096785Z","steps":["trace[1874350966] 'agreement among raft nodes before linearized reading'  (duration: 173.006823ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:22:33.892616Z","caller":"traceutil/trace.go:171","msg":"trace[1383952079] linearizableReadLoop","detail":"{readStateIndex:2342; appliedIndex:2341; }","duration":"125.514692ms","start":"2026-08-18T23:22:33.767055Z","end":"2026-08-18T23:22:33.89257Z","steps":["trace[1383952079] 'read index received'  (duration: 113.841469ms)","trace[1383952079] 'applied index is now lower than readState.Index'  (duration: 11.672433ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:22:33.892746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.676994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:22:33.892773Z","caller":"traceutil/trace.go:171","msg":"trace[734429801] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2252; }","duration":"125.746134ms","start":"2026-08-18T23:22:33.76702Z","end":"2026-08-18T23:22:33.892766Z","steps":["trace[734429801] 'agreement among raft nodes before linearized reading'  (duration: 125.688033ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:22:33.892742Z","caller":"traceutil/trace.go:171","msg":"trace[2063737473] transaction","detail":"{read_only:false; response_revision:2252; number_of_response:1; }","duration":"156.155231ms","start":"2026-08-18T23:22:33.736556Z","end":"2026-08-18T23:22:33.892711Z","steps":["trace[2063737473] 'process raft request'  (duration: 144.403467ms)","trace[2063737473] 'compare'  (duration: 11.28246ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:22:46.775056Z","caller":"traceutil/trace.go:171","msg":"trace[1825855651] transaction","detail":"{read_only:false; response_revision:2374; number_of_response:1; }","duration":"171.239766ms","start":"2026-08-18T23:22:46.603793Z","end":"2026-08-18T23:22:46.775033Z","steps":["trace[1825855651] 'process raft request'  (duration: 171.104305ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:23:22.739815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.487604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-08-18T23:23:22.739868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.507733ms","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-18T23:23:22.739954Z","caller":"traceutil/trace.go:171","msg":"trace[1552515178] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2626; }","duration":"172.628307ms","start":"2026-08-18T23:23:22.567301Z","end":"2026-08-18T23:23:22.739929Z","steps":["trace[1552515178] 'range keys from in-memory index tree'  (duration: 172.336905ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:23:22.739897Z","caller":"traceutil/trace.go:171","msg":"trace[1054669311] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2626; }","duration":"173.619519ms","start":"2026-08-18T23:23:22.566258Z","end":"2026-08-18T23:23:22.739878Z","steps":["trace[1054669311] 'range keys from in-memory index tree'  (duration: 173.292275ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:23:28.441624Z","caller":"traceutil/trace.go:171","msg":"trace[1807523486] transaction","detail":"{read_only:false; response_revision:2654; number_of_response:1; }","duration":"201.113437ms","start":"2026-08-18T23:23:28.240486Z","end":"2026-08-18T23:23:28.4416Z","steps":["trace[1807523486] 'process raft request'  (duration: 200.836116ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:23:28.822323Z","caller":"traceutil/trace.go:171","msg":"trace[959112064] linearizableReadLoop","detail":"{readStateIndex:2758; appliedIndex:2757; }","duration":"349.345287ms","start":"2026-08-18T23:23:28.472955Z","end":"2026-08-18T23:23:28.822301Z","steps":["trace[959112064] 'read index received'  (duration: 349.076646ms)","trace[959112064] 'applied index is now lower than readState.Index'  (duration: 267.57µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:23:28.822428Z","caller":"traceutil/trace.go:171","msg":"trace[1445128657] transaction","detail":"{read_only:false; response_revision:2655; number_of_response:1; }","duration":"362.260153ms","start":"2026-08-18T23:23:28.460136Z","end":"2026-08-18T23:23:28.822396Z","steps":["trace[1445128657] 'process raft request'  (duration: 361.93467ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:23:28.822597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:23:28.46012Z","time spent":"362.389849ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2643 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-08-18T23:23:28.822653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.184733ms","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-18T23:23:28.822751Z","caller":"traceutil/trace.go:171","msg":"trace[368266869] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2655; }","duration":"241.394781ms","start":"2026-08-18T23:23:28.581332Z","end":"2026-08-18T23:23:28.822727Z","steps":["trace[368266869] 'agreement among raft nodes before linearized reading'  (duration: 241.196183ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:23:28.822775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.129473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-08-18T23:23:28.822927Z","caller":"traceutil/trace.go:171","msg":"trace[1159430673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2655; }","duration":"257.31963ms","start":"2026-08-18T23:23:28.56559Z","end":"2026-08-18T23:23:28.82291Z","steps":["trace[1159430673] 'agreement among raft nodes before linearized reading'  (duration: 256.974006ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:23:28.823002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.038454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-08-18T23:23:28.823095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.294234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18cd09c9919bb3de\" ","response":"range_response_count:1 size:779"}
{"level":"info","ts":"2026-08-18T23:23:28.823258Z","caller":"traceutil/trace.go:171","msg":"trace[993667747] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18cd09c9919bb3de; range_end:; response_count:1; response_revision:2655; }","duration":"349.564245ms","start":"2026-08-18T23:23:28.473677Z","end":"2026-08-18T23:23:28.823242Z","steps":["trace[993667747] 'agreement among raft nodes before linearized reading'  (duration: 348.835805ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:23:28.823132Z","caller":"traceutil/trace.go:171","msg":"trace[1919490974] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2655; }","duration":"350.191431ms","start":"2026-08-18T23:23:28.472925Z","end":"2026-08-18T23:23:28.823116Z","steps":["trace[1919490974] 'agreement among raft nodes before linearized reading'  (duration: 349.517553ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:23:28.823303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:23:28.473648Z","time spent":"349.646489ms","remote":"127.0.0.1:59142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":802,"request content":"key:\"/registry/events/auth-system/keycloak-0.18cd09c9919bb3de\" "}
{"level":"warn","ts":"2026-08-18T23:23:28.823356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:23:28.472913Z","time spent":"350.420141ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-08-18T23:24:23.384772Z","caller":"traceutil/trace.go:171","msg":"trace[1714693633] transaction","detail":"{read_only:false; response_revision:2941; number_of_response:1; }","duration":"218.064598ms","start":"2026-08-18T23:24:23.16668Z","end":"2026-08-18T23:24:23.384744Z","steps":["trace[1714693633] 'process raft request'  (duration: 217.898023ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:24:23.437129Z","caller":"traceutil/trace.go:171","msg":"trace[118266685] transaction","detail":"{read_only:false; response_revision:2942; number_of_response:1; }","duration":"270.380825ms","start":"2026-08-18T23:24:23.166724Z","end":"2026-08-18T23:24:23.437105Z","steps":["trace[118266685] 'process raft request'  (duration: 240.05343ms)","trace[118266685] 'compare'  (duration: 30.204221ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:24:23.458481Z","caller":"traceutil/trace.go:171","msg":"trace[503366916] linearizableReadLoop","detail":"{readStateIndex:3056; appliedIndex:3054; }","duration":"286.198912ms","start":"2026-08-18T23:24:23.172263Z","end":"2026-08-18T23:24:23.458462Z","steps":["trace[503366916] 'read index received'  (duration: 212.436567ms)","trace[503366916] 'applied index is now lower than readState.Index'  (duration: 73.761005ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:24:23.458746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.401739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"warn","ts":"2026-08-18T23:24:23.458711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.772367ms","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-18T23:24:23.45879Z","caller":"traceutil/trace.go:171","msg":"trace[1213735361] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2942; }","duration":"286.542183ms","start":"2026-08-18T23:24:23.172237Z","end":"2026-08-18T23:24:23.458779Z","steps":["trace[1213735361] 'agreement among raft nodes before linearized reading'  (duration: 286.324986ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:24:23.458803Z","caller":"traceutil/trace.go:171","msg":"trace[298531080] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2942; }","duration":"270.905661ms","start":"2026-08-18T23:24:23.187881Z","end":"2026-08-18T23:24:23.458787Z","steps":["trace[298531080] 'agreement among raft nodes before linearized reading'  (duration: 270.699245ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:24:23.458827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.112999ms","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-18T23:24:23.458933Z","caller":"traceutil/trace.go:171","msg":"trace[1603842242] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2942; }","duration":"214.270443ms","start":"2026-08-18T23:24:23.244645Z","end":"2026-08-18T23:24:23.458915Z","steps":["trace[1603842242] 'agreement among raft nodes before linearized reading'  (duration: 213.971594ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:24:23.459162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.733983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-18T23:24:23.459278Z","caller":"traceutil/trace.go:171","msg":"trace[1594729780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2942; }","duration":"250.884267ms","start":"2026-08-18T23:24:23.208367Z","end":"2026-08-18T23:24:23.459251Z","steps":["trace[1594729780] 'agreement among raft nodes before linearized reading'  (duration: 250.361291ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:24:23.565563Z","caller":"traceutil/trace.go:171","msg":"trace[2076668456] transaction","detail":"{read_only:false; response_revision:2943; number_of_response:1; }","duration":"101.621306ms","start":"2026-08-18T23:24:23.463912Z","end":"2026-08-18T23:24:23.565533Z","steps":["trace[2076668456] 'process raft request'  (duration: 101.409949ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:24:23.569231Z","caller":"traceutil/trace.go:171","msg":"trace[556451900] linearizableReadLoop","detail":"{readStateIndex:3060; appliedIndex:3057; }","duration":"103.896074ms","start":"2026-08-18T23:24:23.465315Z","end":"2026-08-18T23:24:23.569211Z","steps":["trace[556451900] 'read index received'  (duration: 99.972865ms)","trace[556451900] 'applied index is now lower than readState.Index'  (duration: 3.922039ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:24:23.569278Z","caller":"traceutil/trace.go:171","msg":"trace[1393831597] transaction","detail":"{read_only:false; response_revision:2944; number_of_response:1; }","duration":"105.261155ms","start":"2026-08-18T23:24:23.463989Z","end":"2026-08-18T23:24:23.56925Z","steps":["trace[1393831597] 'process raft request'  (duration: 105.066219ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:24:23.569592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.257724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1317"}
{"level":"info","ts":"2026-08-18T23:24:23.569663Z","caller":"traceutil/trace.go:171","msg":"trace[1006858506] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2945; }","duration":"104.368458ms","start":"2026-08-18T23:24:23.465284Z","end":"2026-08-18T23:24:23.569653Z","steps":["trace[1006858506] 'agreement among raft nodes before linearized reading'  (duration: 104.076739ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:24:23.569338Z","caller":"traceutil/trace.go:171","msg":"trace[1691338535] transaction","detail":"{read_only:false; response_revision:2945; number_of_response:1; }","duration":"104.455661ms","start":"2026-08-18T23:24:23.464872Z","end":"2026-08-18T23:24:23.569327Z","steps":["trace[1691338535] 'process raft request'  (duration: 104.299326ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:24:39.798417Z","caller":"traceutil/trace.go:171","msg":"trace[1906209690] transaction","detail":"{read_only:false; response_revision:3029; number_of_response:1; }","duration":"100.631321ms","start":"2026-08-18T23:24:39.697759Z","end":"2026-08-18T23:24:39.79839Z","steps":["trace[1906209690] 'process raft request'  (duration: 99.940581ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:24:39.7985Z","caller":"traceutil/trace.go:171","msg":"trace[159432346] transaction","detail":"{read_only:false; response_revision:3030; number_of_response:1; }","duration":"100.209459ms","start":"2026-08-18T23:24:39.698201Z","end":"2026-08-18T23:24:39.79841Z","steps":["trace[159432346] 'process raft request'  (duration: 100.096756ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:25:14.253687Z","caller":"traceutil/trace.go:171","msg":"trace[1679072226] transaction","detail":"{read_only:false; response_revision:3207; number_of_response:1; }","duration":"110.300679ms","start":"2026-08-18T23:25:14.143367Z","end":"2026-08-18T23:25:14.253668Z","steps":["trace[1679072226] 'process raft request'  (duration: 110.183506ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:25:32.755256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.401513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-client-secret\" ","response":"range_response_count:1 size:1229"}
{"level":"info","ts":"2026-08-18T23:25:32.755341Z","caller":"traceutil/trace.go:171","msg":"trace[1056981589] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-client-secret; range_end:; response_count:1; response_revision:3394; }","duration":"206.536316ms","start":"2026-08-18T23:25:32.548787Z","end":"2026-08-18T23:25:32.755324Z","steps":["trace[1056981589] 'range keys from in-memory index tree'  (duration: 206.239599ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:25:34.332736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.687104ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555607938500479082 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:3388 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-18T23:25:34.333043Z","caller":"traceutil/trace.go:171","msg":"trace[173135507] transaction","detail":"{read_only:false; response_revision:3398; number_of_response:1; }","duration":"386.813222ms","start":"2026-08-18T23:25:33.946169Z","end":"2026-08-18T23:25:34.332982Z","steps":["trace[173135507] 'process raft request'  (duration: 242.785452ms)","trace[173135507] 'compare'  (duration: 143.407487ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:25:34.333134Z","caller":"traceutil/trace.go:171","msg":"trace[744216377] linearizableReadLoop","detail":"{readStateIndex:3531; appliedIndex:3530; }","duration":"373.135354ms","start":"2026-08-18T23:25:33.959943Z","end":"2026-08-18T23:25:34.333079Z","steps":["trace[744216377] 'read index received'  (duration: 229.107884ms)","trace[744216377] 'applied index is now lower than readState.Index'  (duration: 144.02333ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:25:34.333203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:33.946137Z","time spent":"386.981986ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:3388 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-08-18T23:25:34.333464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.500802ms","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-18T23:25:34.333605Z","caller":"traceutil/trace.go:171","msg":"trace[1320828276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3398; }","duration":"373.673335ms","start":"2026-08-18T23:25:33.95991Z","end":"2026-08-18T23:25:34.333583Z","steps":["trace[1320828276] 'agreement among raft nodes before linearized reading'  (duration: 373.337338ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:25:34.333605Z","caller":"traceutil/trace.go:171","msg":"trace[759283607] transaction","detail":"{read_only:false; response_revision:3399; number_of_response:1; }","duration":"176.541007ms","start":"2026-08-18T23:25:34.157046Z","end":"2026-08-18T23:25:34.333587Z","steps":["trace[759283607] 'process raft request'  (duration: 175.937434ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:25:34.333658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:33.959894Z","time spent":"373.752187ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-08-18T23:25:34.33367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.76287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-18T23:25:34.333716Z","caller":"traceutil/trace.go:171","msg":"trace[1692786561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3399; }","duration":"181.864563ms","start":"2026-08-18T23:25:34.151839Z","end":"2026-08-18T23:25:34.333703Z","steps":["trace[1692786561] 'agreement among raft nodes before linearized reading'  (duration: 181.640708ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:25:34.333758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.071701ms","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":"warn","ts":"2026-08-18T23:25:34.333637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.855471ms","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":"warn","ts":"2026-08-18T23:25:34.333594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.414047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-client-secret\" ","response":"range_response_count:1 size:1229"}
{"level":"info","ts":"2026-08-18T23:25:34.333863Z","caller":"traceutil/trace.go:171","msg":"trace[784894059] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3399; }","duration":"181.133907ms","start":"2026-08-18T23:25:34.152706Z","end":"2026-08-18T23:25:34.33384Z","steps":["trace[784894059] 'agreement among raft nodes before linearized reading'  (duration: 180.727878ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:25:34.333923Z","caller":"traceutil/trace.go:171","msg":"trace[1659490559] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-client-secret; range_end:; response_count:1; response_revision:3399; }","duration":"293.767205ms","start":"2026-08-18T23:25:34.040137Z","end":"2026-08-18T23:25:34.333904Z","steps":["trace[1659490559] 'agreement among raft nodes before linearized reading'  (duration: 293.263564ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:25:34.333814Z","caller":"traceutil/trace.go:171","msg":"trace[1121352891] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3399; }","duration":"190.160593ms","start":"2026-08-18T23:25:34.143636Z","end":"2026-08-18T23:25:34.333797Z","steps":["trace[1121352891] 'agreement among raft nodes before linearized reading'  (duration: 190.009259ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:25:46.837043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.113091ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555607938500479307 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:3460 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-18T23:25:46.83718Z","caller":"traceutil/trace.go:171","msg":"trace[387243900] transaction","detail":"{read_only:false; response_revision:3469; number_of_response:1; }","duration":"313.650488ms","start":"2026-08-18T23:25:46.5235Z","end":"2026-08-18T23:25:46.837151Z","steps":["trace[387243900] 'process raft request'  (duration: 64.312892ms)","trace[387243900] 'compare'  (duration: 248.965829ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:25:46.837281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:46.523481Z","time spent":"313.748741ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:3460 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-18T23:25:46.841497Z","caller":"traceutil/trace.go:171","msg":"trace[35997278] linearizableReadLoop","detail":"{readStateIndex:3606; appliedIndex:3605; }","duration":"211.255797ms","start":"2026-08-18T23:25:46.630224Z","end":"2026-08-18T23:25:46.84148Z","steps":["trace[35997278] 'read index received'  (duration: 211.228876ms)","trace[35997278] 'applied index is now lower than readState.Index'  (duration: 25.791µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:25:46.841641Z","caller":"traceutil/trace.go:171","msg":"trace[1782946355] transaction","detail":"{read_only:false; response_revision:3470; number_of_response:1; }","duration":"317.755754ms","start":"2026-08-18T23:25:46.523875Z","end":"2026-08-18T23:25:46.841631Z","steps":["trace[1782946355] 'process raft request'  (duration: 317.477198ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:25:46.84175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:46.523861Z","time spent":"317.802184ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:3459 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-08-18T23:25:46.841874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.633714ms","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-18T23:25:46.841928Z","caller":"traceutil/trace.go:171","msg":"trace[1561176830] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3471; }","duration":"211.735417ms","start":"2026-08-18T23:25:46.63018Z","end":"2026-08-18T23:25:46.841915Z","steps":["trace[1561176830] 'agreement among raft nodes before linearized reading'  (duration: 211.645445ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:25:46.841833Z","caller":"traceutil/trace.go:171","msg":"trace[277909754] transaction","detail":"{read_only:false; response_revision:3471; number_of_response:1; }","duration":"278.02826ms","start":"2026-08-18T23:25:46.563733Z","end":"2026-08-18T23:25:46.841761Z","steps":["trace[277909754] 'process raft request'  (duration: 277.707994ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:26:24.939021Z","caller":"traceutil/trace.go:171","msg":"trace[1094517461] transaction","detail":"{read_only:false; response_revision:3711; number_of_response:1; }","duration":"261.052356ms","start":"2026-08-18T23:26:24.677928Z","end":"2026-08-18T23:26:24.938981Z","steps":["trace[1094517461] 'process raft request'  (duration: 200.800668ms)","trace[1094517461] 'compare'  (duration: 59.79037ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:26:24.939122Z","caller":"traceutil/trace.go:171","msg":"trace[389441473] linearizableReadLoop","detail":"{readStateIndex:3859; appliedIndex:3858; }","duration":"258.617902ms","start":"2026-08-18T23:26:24.680487Z","end":"2026-08-18T23:26:24.939105Z","steps":["trace[389441473] 'read index received'  (duration: 198.281942ms)","trace[389441473] 'applied index is now lower than readState.Index'  (duration: 60.33449ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:26:24.939214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.714144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusagents.monitoring.coreos.com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:26:24.939239Z","caller":"traceutil/trace.go:171","msg":"trace[166340511] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusagents.monitoring.coreos.com; range_end:; response_count:0; response_revision:3711; }","duration":"258.784155ms","start":"2026-08-18T23:26:24.680449Z","end":"2026-08-18T23:26:24.939233Z","steps":["trace[166340511] 'agreement among raft nodes before linearized reading'  (duration: 258.732254ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:26:24.939764Z","caller":"traceutil/trace.go:171","msg":"trace[627795831] transaction","detail":"{read_only:false; response_revision:3712; number_of_response:1; }","duration":"186.683162ms","start":"2026-08-18T23:26:24.753062Z","end":"2026-08-18T23:26:24.939746Z","steps":["trace[627795831] 'process raft request'  (duration: 185.921858ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:26:24.939858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.726296ms","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-18T23:26:24.939911Z","caller":"traceutil/trace.go:171","msg":"trace[505819922] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3713; }","duration":"138.806828ms","start":"2026-08-18T23:26:24.801087Z","end":"2026-08-18T23:26:24.939894Z","steps":["trace[505819922] 'agreement among raft nodes before linearized reading'  (duration: 138.721386ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:26:24.940135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.141608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-08-18T23:26:24.940136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.113467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:26:24.940185Z","caller":"traceutil/trace.go:171","msg":"trace[856078039] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3713; }","duration":"173.23997ms","start":"2026-08-18T23:26:24.766932Z","end":"2026-08-18T23:26:24.940172Z","steps":["trace[856078039] 'agreement among raft nodes before linearized reading'  (duration: 173.086787ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:26:24.940214Z","caller":"traceutil/trace.go:171","msg":"trace[28940876] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3713; }","duration":"173.209169ms","start":"2026-08-18T23:26:24.766988Z","end":"2026-08-18T23:26:24.940197Z","steps":["trace[28940876] 'agreement among raft nodes before linearized reading'  (duration: 173.034086ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:26:24.939765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.390456ms","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-18T23:26:24.940417Z","caller":"traceutil/trace.go:171","msg":"trace[403499770] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3713; }","duration":"193.058217ms","start":"2026-08-18T23:26:24.747328Z","end":"2026-08-18T23:26:24.940387Z","steps":["trace[403499770] 'agreement among raft nodes before linearized reading'  (duration: 192.315304ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:26:55.254556Z","caller":"traceutil/trace.go:171","msg":"trace[1976245589] transaction","detail":"{read_only:false; response_revision:3903; number_of_response:1; }","duration":"133.726826ms","start":"2026-08-18T23:26:55.120813Z","end":"2026-08-18T23:26:55.25454Z","steps":["trace[1976245589] 'process raft request'  (duration: 91.711526ms)","trace[1976245589] 'compare'  (duration: 41.911208ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:26:55.254942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.54193ms","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-18T23:26:55.255025Z","caller":"traceutil/trace.go:171","msg":"trace[443521120] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3905; }","duration":"156.631081ms","start":"2026-08-18T23:26:55.098372Z","end":"2026-08-18T23:26:55.255004Z","steps":["trace[443521120] 'agreement among raft nodes before linearized reading'  (duration: 156.441018ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:13.050125Z","caller":"traceutil/trace.go:171","msg":"trace[1695654302] transaction","detail":"{read_only:false; response_revision:4442; number_of_response:1; }","duration":"106.68779ms","start":"2026-08-18T23:27:12.943412Z","end":"2026-08-18T23:27:13.0501Z","steps":["trace[1695654302] 'process raft request'  (duration: 46.346576ms)","trace[1695654302] 'compare'  (duration: 59.998708ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:27:17.212877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.580001ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555607938500481663 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4494 > 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-18T23:27:17.212984Z","caller":"traceutil/trace.go:171","msg":"trace[949432845] linearizableReadLoop","detail":"{readStateIndex:4723; appliedIndex:4722; }","duration":"133.406363ms","start":"2026-08-18T23:27:17.079563Z","end":"2026-08-18T23:27:17.212969Z","steps":["trace[949432845] 'read index received'  (duration: 9.626258ms)","trace[949432845] 'applied index is now lower than readState.Index'  (duration: 123.778565ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:27:17.213094Z","caller":"traceutil/trace.go:171","msg":"trace[520234581] transaction","detail":"{read_only:false; response_revision:4543; number_of_response:1; }","duration":"136.087894ms","start":"2026-08-18T23:27:17.076976Z","end":"2026-08-18T23:27:17.213064Z","steps":["trace[520234581] 'process raft request'  (duration: 12.234519ms)","trace[520234581] 'compare'  (duration: 123.415258ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:27:17.213217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.89843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"}
{"level":"info","ts":"2026-08-18T23:27:17.213337Z","caller":"traceutil/trace.go:171","msg":"trace[289949089] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4543; }","duration":"134.035593ms","start":"2026-08-18T23:27:17.079278Z","end":"2026-08-18T23:27:17.213314Z","steps":["trace[289949089] 'agreement among raft nodes before linearized reading'  (duration: 133.8124ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:17.214506Z","caller":"traceutil/trace.go:171","msg":"trace[1512044121] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4544; }","duration":"134.034693ms","start":"2026-08-18T23:27:17.080449Z","end":"2026-08-18T23:27:17.214483Z","steps":["trace[1512044121] 'process raft request'  (duration: 133.586946ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:17.214758Z","caller":"traceutil/trace.go:171","msg":"trace[946611917] transaction","detail":"{read_only:false; response_revision:4545; number_of_response:1; }","duration":"128.631459ms","start":"2026-08-18T23:27:17.086102Z","end":"2026-08-18T23:27:17.214734Z","steps":["trace[946611917] 'process raft request'  (duration: 128.0403ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:17.72512Z","caller":"traceutil/trace.go:171","msg":"trace[1376283264] transaction","detail":"{read_only:false; response_revision:4556; number_of_response:1; }","duration":"205.053751ms","start":"2026-08-18T23:27:17.520031Z","end":"2026-08-18T23:27:17.725085Z","steps":["trace[1376283264] 'process raft request'  (duration: 197.041047ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:17.72831Z","caller":"traceutil/trace.go:171","msg":"trace[403829255] transaction","detail":"{read_only:false; response_revision:4557; number_of_response:1; }","duration":"206.996602ms","start":"2026-08-18T23:27:17.521228Z","end":"2026-08-18T23:27:17.728225Z","steps":["trace[403829255] 'process raft request'  (duration: 206.741758ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:17.728396Z","caller":"traceutil/trace.go:171","msg":"trace[1428830316] transaction","detail":"{read_only:false; response_revision:4558; number_of_response:1; }","duration":"207.020602ms","start":"2026-08-18T23:27:17.521362Z","end":"2026-08-18T23:27:17.728383Z","steps":["trace[1428830316] 'process raft request'  (duration: 206.782609ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:17.728628Z","caller":"traceutil/trace.go:171","msg":"trace[961272958] linearizableReadLoop","detail":"{readStateIndex:4739; appliedIndex:4735; }","duration":"180.042825ms","start":"2026-08-18T23:27:17.548576Z","end":"2026-08-18T23:27:17.728618Z","steps":["trace[961272958] 'read index received'  (duration: 168.487486ms)","trace[961272958] 'applied index is now lower than readState.Index'  (duration: 11.554679ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:27:17.728791Z","caller":"traceutil/trace.go:171","msg":"trace[169886412] transaction","detail":"{read_only:false; response_revision:4559; number_of_response:1; }","duration":"205.656901ms","start":"2026-08-18T23:27:17.523096Z","end":"2026-08-18T23:27:17.728753Z","steps":["trace[169886412] 'process raft request'  (duration: 205.225874ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:17.72924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.652294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"}
{"level":"info","ts":"2026-08-18T23:27:17.729285Z","caller":"traceutil/trace.go:171","msg":"trace[1363220684] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4559; }","duration":"180.740605ms","start":"2026-08-18T23:27:17.548535Z","end":"2026-08-18T23:27:17.729276Z","steps":["trace[1363220684] 'agreement among raft nodes before linearized reading'  (duration: 180.119936ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:23.435509Z","caller":"traceutil/trace.go:171","msg":"trace[655243906] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"202.333143ms","start":"2026-08-18T23:27:23.233155Z","end":"2026-08-18T23:27:23.435488Z","steps":["trace[655243906] 'process raft request'  (duration: 202.208471ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:23.436055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.610275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-91bd13af-508f-44d7-a39f-4106915cc538\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-08-18T23:27:23.436108Z","caller":"traceutil/trace.go:171","msg":"trace[1647724491] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-91bd13af-508f-44d7-a39f-4106915cc538; range_end:; response_count:1; response_revision:4650; }","duration":"106.717836ms","start":"2026-08-18T23:27:23.329379Z","end":"2026-08-18T23:27:23.436097Z","steps":["trace[1647724491] 'agreement among raft nodes before linearized reading'  (duration: 106.478092ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:23.435802Z","caller":"traceutil/trace.go:171","msg":"trace[2060808195] linearizableReadLoop","detail":"{readStateIndex:4832; appliedIndex:4832; }","duration":"106.311329ms","start":"2026-08-18T23:27:23.329428Z","end":"2026-08-18T23:27:23.43574Z","steps":["trace[2060808195] 'read index received'  (duration: 106.296989ms)","trace[2060808195] 'applied index is now lower than readState.Index'  (duration: 12.07µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:27:23.837458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.924058ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555607938500481975 > lease_revoke:<id:76bba0172bd5506c>","response":"size:28"}
{"level":"warn","ts":"2026-08-18T23:27:23.837786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.555646ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:27:23.837939Z","caller":"traceutil/trace.go:171","msg":"trace[877908283] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4650; }","duration":"143.727499ms","start":"2026-08-18T23:27:23.694189Z","end":"2026-08-18T23:27:23.837916Z","steps":["trace[877908283] 'range keys from in-memory index tree'  (duration: 143.528926ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:23.83877Z","caller":"traceutil/trace.go:171","msg":"trace[1637865517] linearizableReadLoop","detail":"{readStateIndex:4834; appliedIndex:4832; }","duration":"397.284703ms","start":"2026-08-18T23:27:23.441468Z","end":"2026-08-18T23:27:23.838753Z","steps":["trace[1637865517] 'read index received'  (duration: 34.861µs)","trace[1637865517] 'applied index is now lower than readState.Index'  (duration: 397.248752ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:27:23.838807Z","caller":"traceutil/trace.go:171","msg":"trace[1088377758] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"422.240872ms","start":"2026-08-18T23:27:23.416549Z","end":"2026-08-18T23:27:23.83879Z","steps":["trace[1088377758] 'process raft request'  (duration: 421.286998ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:23.839026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:23.416531Z","time spent":"422.415695ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:4578 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-18T23:27:23.839053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.489506ms","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-18T23:27:23.839266Z","caller":"traceutil/trace.go:171","msg":"trace[1803503022] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4651; }","duration":"397.654758ms","start":"2026-08-18T23:27:23.441439Z","end":"2026-08-18T23:27:23.839093Z","steps":["trace[1803503022] 'agreement among raft nodes before linearized reading'  (duration: 397.360864ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:23.839331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:23.441425Z","time spent":"397.886661ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-08-18T23:27:23.888063Z","caller":"traceutil/trace.go:171","msg":"trace[2065416687] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"446.498392ms","start":"2026-08-18T23:27:23.441544Z","end":"2026-08-18T23:27:23.888043Z","steps":["trace[2065416687] 'process raft request'  (duration: 446.282378ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:23.888112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.732787ms","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-18T23:27:23.888173Z","caller":"traceutil/trace.go:171","msg":"trace[296176958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4652; }","duration":"433.831878ms","start":"2026-08-18T23:27:23.454323Z","end":"2026-08-18T23:27:23.888155Z","steps":["trace[296176958] 'agreement among raft nodes before linearized reading'  (duration: 433.646626ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:23.888182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:23.441491Z","time spent":"446.623954ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4579 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-18T23:27:23.888217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:23.454302Z","time spent":"433.9031ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-08-18T23:27:23.888423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.873485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-08-18T23:27:23.888462Z","caller":"traceutil/trace.go:171","msg":"trace[324261565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4652; }","duration":"136.952846ms","start":"2026-08-18T23:27:23.751499Z","end":"2026-08-18T23:27:23.888452Z","steps":["trace[324261565] 'agreement among raft nodes before linearized reading'  (duration: 136.845644ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:23.888592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.855426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-08-18T23:27:23.88865Z","caller":"traceutil/trace.go:171","msg":"trace[686653307] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4652; }","duration":"142.941878ms","start":"2026-08-18T23:27:23.745692Z","end":"2026-08-18T23:27:23.888634Z","steps":["trace[686653307] 'agreement among raft nodes before linearized reading'  (duration: 142.799695ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:23.888581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.292096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-08-18T23:27:23.888777Z","caller":"traceutil/trace.go:171","msg":"trace[1317093701] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4652; }","duration":"134.53351ms","start":"2026-08-18T23:27:23.754227Z","end":"2026-08-18T23:27:23.888761Z","steps":["trace[1317093701] 'agreement among raft nodes before linearized reading'  (duration: 134.161434ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:23.888894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.597162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:27:23.888981Z","caller":"traceutil/trace.go:171","msg":"trace[1419863922] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4652; }","duration":"121.701414ms","start":"2026-08-18T23:27:23.767268Z","end":"2026-08-18T23:27:23.888969Z","steps":["trace[1419863922] 'agreement among raft nodes before linearized reading'  (duration: 121.592852ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:24.045346Z","caller":"traceutil/trace.go:171","msg":"trace[1156368012] transaction","detail":"{read_only:false; response_revision:4659; number_of_response:1; }","duration":"105.277732ms","start":"2026-08-18T23:27:23.940045Z","end":"2026-08-18T23:27:24.045323Z","steps":["trace[1156368012] 'process raft request'  (duration: 105.16134ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:24.310861Z","caller":"traceutil/trace.go:171","msg":"trace[1508556204] transaction","detail":"{read_only:false; response_revision:4660; number_of_response:1; }","duration":"156.376577ms","start":"2026-08-18T23:27:24.154441Z","end":"2026-08-18T23:27:24.310818Z","steps":["trace[1508556204] 'process raft request'  (duration: 156.201204ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:24.4496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.639499ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555607938500481995 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:4624 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-18T23:27:24.449766Z","caller":"traceutil/trace.go:171","msg":"trace[879701625] transaction","detail":"{read_only:false; response_revision:4661; number_of_response:1; }","duration":"134.86616ms","start":"2026-08-18T23:27:24.314877Z","end":"2026-08-18T23:27:24.449743Z","steps":["trace[879701625] 'compare'  (duration: 125.421086ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:32.343603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.793201ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555607938500482160 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:4729 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-18T23:27:32.343702Z","caller":"traceutil/trace.go:171","msg":"trace[1780529380] linearizableReadLoop","detail":"{readStateIndex:4924; appliedIndex:4923; }","duration":"366.361482ms","start":"2026-08-18T23:27:31.977324Z","end":"2026-08-18T23:27:32.343686Z","steps":["trace[1780529380] 'read index received'  (duration: 243.40835ms)","trace[1780529380] 'applied index is now lower than readState.Index'  (duration: 122.951582ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:27:32.343907Z","caller":"traceutil/trace.go:171","msg":"trace[942311961] transaction","detail":"{read_only:false; response_revision:4740; number_of_response:1; }","duration":"407.298053ms","start":"2026-08-18T23:27:31.936579Z","end":"2026-08-18T23:27:32.343877Z","steps":["trace[942311961] 'process raft request'  (duration: 284.138727ms)","trace[942311961] 'compare'  (duration: 122.490626ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:27:32.344038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:31.936567Z","time spent":"407.404555ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:4729 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-08-18T23:27:32.344172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.774867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-08-18T23:27:32.344256Z","caller":"traceutil/trace.go:171","msg":"trace[854001095] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4740; }","duration":"205.91807ms","start":"2026-08-18T23:27:32.138319Z","end":"2026-08-18T23:27:32.344237Z","steps":["trace[854001095] 'agreement among raft nodes before linearized reading'  (duration: 205.649376ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:32.344291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.612686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-08-18T23:27:32.344357Z","caller":"traceutil/trace.go:171","msg":"trace[1152206825] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4740; }","duration":"360.724897ms","start":"2026-08-18T23:27:31.983618Z","end":"2026-08-18T23:27:32.344343Z","steps":["trace[1152206825] 'agreement among raft nodes before linearized reading'  (duration: 360.511144ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:32.344393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:31.983602Z","time spent":"360.785159ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-08-18T23:27:32.344593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.257426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-08-18T23:27:32.344656Z","caller":"traceutil/trace.go:171","msg":"trace[1792702754] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4740; }","duration":"367.348307ms","start":"2026-08-18T23:27:31.977293Z","end":"2026-08-18T23:27:32.344642Z","steps":["trace[1792702754] 'agreement among raft nodes before linearized reading'  (duration: 366.520824ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:32.344693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:31.977282Z","time spent":"367.401607ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-08-18T23:27:32.34472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.104183ms","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-18T23:27:32.344793Z","caller":"traceutil/trace.go:171","msg":"trace[2024651689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4740; }","duration":"367.210215ms","start":"2026-08-18T23:27:31.977566Z","end":"2026-08-18T23:27:32.344776Z","steps":["trace[2024651689] 'agreement among raft nodes before linearized reading'  (duration: 366.327761ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:32.344842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:31.977561Z","time spent":"367.267765ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-08-18T23:27:32.344901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.2193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"}
{"level":"info","ts":"2026-08-18T23:27:32.344953Z","caller":"traceutil/trace.go:171","msg":"trace[160115063] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4740; }","duration":"354.285001ms","start":"2026-08-18T23:27:31.990655Z","end":"2026-08-18T23:27:32.34494Z","steps":["trace[160115063] 'agreement among raft nodes before linearized reading'  (duration: 354.125399ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:32.344984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:31.990648Z","time spent":"354.329283ms","remote":"127.0.0.1:38354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3266,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "}
{"level":"warn","ts":"2026-08-18T23:27:32.345048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.282045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-08-18T23:27:32.345105Z","caller":"traceutil/trace.go:171","msg":"trace[1240773623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4740; }","duration":"367.349666ms","start":"2026-08-18T23:27:31.97774Z","end":"2026-08-18T23:27:32.345089Z","steps":["trace[1240773623] 'agreement among raft nodes before linearized reading'  (duration: 366.453793ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:32.345151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:31.977735Z","time spent":"367.405198ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-08-18T23:27:37.804559Z","caller":"traceutil/trace.go:171","msg":"trace[1697750693] linearizableReadLoop","detail":"{readStateIndex:5006; appliedIndex:5005; }","duration":"122.112339ms","start":"2026-08-18T23:27:37.682425Z","end":"2026-08-18T23:27:37.804538Z","steps":["trace[1697750693] 'read index received'  (duration: 121.685753ms)","trace[1697750693] 'applied index is now lower than readState.Index'  (duration: 425.486µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:27:37.804656Z","caller":"traceutil/trace.go:171","msg":"trace[588044551] transaction","detail":"{read_only:false; response_revision:4818; number_of_response:1; }","duration":"239.408128ms","start":"2026-08-18T23:27:37.565211Z","end":"2026-08-18T23:27:37.80462Z","steps":["trace[588044551] 'process raft request'  (duration: 239.111763ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:37.804737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.278622ms","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-18T23:27:37.804804Z","caller":"traceutil/trace.go:171","msg":"trace[107380650] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:4818; }","duration":"122.395453ms","start":"2026-08-18T23:27:37.682394Z","end":"2026-08-18T23:27:37.804789Z","steps":["trace[107380650] 'agreement among raft nodes before linearized reading'  (duration: 122.244401ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:42.485212Z","caller":"traceutil/trace.go:171","msg":"trace[130313115] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"671.222735ms","start":"2026-08-18T23:27:41.813961Z","end":"2026-08-18T23:27:42.485184Z","steps":["trace[130313115] 'process raft request'  (duration: 671.032632ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:42.485634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:41.813938Z","time spent":"671.363156ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4828 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-18T23:27:42.630521Z","caller":"traceutil/trace.go:171","msg":"trace[2008127612] linearizableReadLoop","detail":"{readStateIndex:5033; appliedIndex:5030; }","duration":"581.959348ms","start":"2026-08-18T23:27:42.048538Z","end":"2026-08-18T23:27:42.630497Z","steps":["trace[2008127612] 'read index received'  (duration: 436.52232ms)","trace[2008127612] 'applied index is now lower than readState.Index'  (duration: 145.435858ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:27:42.630524Z","caller":"traceutil/trace.go:171","msg":"trace[238692167] transaction","detail":"{read_only:false; response_revision:4843; number_of_response:1; }","duration":"737.591679ms","start":"2026-08-18T23:27:41.892892Z","end":"2026-08-18T23:27:42.630484Z","steps":["trace[238692167] 'process raft request'  (duration: 737.193603ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:42.630647Z","caller":"traceutil/trace.go:171","msg":"trace[1594867781] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"685.032191ms","start":"2026-08-18T23:27:41.945604Z","end":"2026-08-18T23:27:42.630636Z","steps":["trace[1594867781] 'process raft request'  (duration: 684.806088ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:42.630798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:41.892874Z","time spent":"737.738821ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:4829 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-18T23:27:42.631068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.665144ms","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-18T23:27:42.631101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.316667ms","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-18T23:27:42.631143Z","caller":"traceutil/trace.go:171","msg":"trace[1481468193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4844; }","duration":"209.747835ms","start":"2026-08-18T23:27:42.421371Z","end":"2026-08-18T23:27:42.631119Z","steps":["trace[1481468193] 'agreement among raft nodes before linearized reading'  (duration: 209.585613ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:42.631172Z","caller":"traceutil/trace.go:171","msg":"trace[1789418046] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4844; }","duration":"215.414968ms","start":"2026-08-18T23:27:42.415739Z","end":"2026-08-18T23:27:42.631154Z","steps":["trace[1789418046] 'agreement among raft nodes before linearized reading'  (duration: 215.250996ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:42.631197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.948722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-08-18T23:27:42.631256Z","caller":"traceutil/trace.go:171","msg":"trace[1003124839] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4844; }","duration":"119.029314ms","start":"2026-08-18T23:27:42.51221Z","end":"2026-08-18T23:27:42.631239Z","steps":["trace[1003124839] 'agreement among raft nodes before linearized reading'  (duration: 118.862752ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:42.631284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.536746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"warn","ts":"2026-08-18T23:27:42.63132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.007275ms","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-18T23:27:42.631361Z","caller":"traceutil/trace.go:171","msg":"trace[749056234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4844; }","duration":"185.088756ms","start":"2026-08-18T23:27:42.44626Z","end":"2026-08-18T23:27:42.631349Z","steps":["trace[749056234] 'agreement among raft nodes before linearized reading'  (duration: 184.980264ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:42.63136Z","caller":"traceutil/trace.go:171","msg":"trace[1991219604] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4844; }","duration":"177.642948ms","start":"2026-08-18T23:27:42.453695Z","end":"2026-08-18T23:27:42.631338Z","steps":["trace[1991219604] 'agreement among raft nodes before linearized reading'  (duration: 177.395454ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:42.631363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.822961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"}
{"level":"info","ts":"2026-08-18T23:27:42.631409Z","caller":"traceutil/trace.go:171","msg":"trace[1995024185] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4844; }","duration":"582.868021ms","start":"2026-08-18T23:27:42.048529Z","end":"2026-08-18T23:27:42.631397Z","steps":["trace[1995024185] 'agreement among raft nodes before linearized reading'  (duration: 582.74828ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:42.631443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:42.048467Z","time spent":"582.966853ms","remote":"127.0.0.1:59252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10415,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-08-18T23:27:42.631524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.465978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"}
{"level":"info","ts":"2026-08-18T23:27:42.631551Z","caller":"traceutil/trace.go:171","msg":"trace[1229699510] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4844; }","duration":"263.491329ms","start":"2026-08-18T23:27:42.36805Z","end":"2026-08-18T23:27:42.631541Z","steps":["trace[1229699510] 'agreement among raft nodes before linearized reading'  (duration: 263.411717ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:42.630999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.233039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-08-18T23:27:42.631911Z","caller":"traceutil/trace.go:171","msg":"trace[874888241] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4844; }","duration":"184.230914ms","start":"2026-08-18T23:27:42.447661Z","end":"2026-08-18T23:27:42.631892Z","steps":["trace[874888241] 'agreement among raft nodes before linearized reading'  (duration: 183.150768ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:42.63194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:41.945566Z","time spent":"685.107002ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4830 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-18T23:27:42.632004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.681222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-08-18T23:27:42.632114Z","caller":"traceutil/trace.go:171","msg":"trace[2020183462] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4844; }","duration":"482.838384ms","start":"2026-08-18T23:27:42.149245Z","end":"2026-08-18T23:27:42.632083Z","steps":["trace[2020183462] 'agreement among raft nodes before linearized reading'  (duration: 481.550196ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:42.632144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:42.149223Z","time spent":"482.913295ms","remote":"127.0.0.1:59214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-08-18T23:27:43.163745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.570579ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555607938500482440 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" mod_revision:4595 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" value_size:829 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-18T23:27:43.163866Z","caller":"traceutil/trace.go:171","msg":"trace[158643381] transaction","detail":"{read_only:false; response_revision:4852; number_of_response:1; }","duration":"438.27645ms","start":"2026-08-18T23:27:42.72557Z","end":"2026-08-18T23:27:43.163846Z","steps":["trace[158643381] 'process raft request'  (duration: 243.523128ms)","trace[158643381] 'compare'  (duration: 194.439027ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:27:43.163931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:42.725546Z","time spent":"438.35333ms","remote":"127.0.0.1:59224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" mod_revision:4595 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" value_size:829 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" > >"}
{"level":"info","ts":"2026-08-18T23:27:43.219329Z","caller":"traceutil/trace.go:171","msg":"trace[1401304414] transaction","detail":"{read_only:false; response_revision:4853; number_of_response:1; }","duration":"493.578403ms","start":"2026-08-18T23:27:42.725728Z","end":"2026-08-18T23:27:43.219306Z","steps":["trace[1401304414] 'process raft request'  (duration: 493.334669ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:27:43.219328Z","caller":"traceutil/trace.go:171","msg":"trace[1116490300] transaction","detail":"{read_only:false; response_revision:4854; number_of_response:1; }","duration":"492.586949ms","start":"2026-08-18T23:27:42.726717Z","end":"2026-08-18T23:27:43.219304Z","steps":["trace[1116490300] 'process raft request'  (duration: 492.479317ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:43.219432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:42.72571Z","time spent":"493.672915ms","remote":"127.0.0.1:59364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-mrr8d\" mod_revision:4594 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-mrr8d\" value_size:1363 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-mrr8d\" > >"}
{"level":"warn","ts":"2026-08-18T23:27:43.219472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:42.726693Z","time spent":"492.69962ms","remote":"127.0.0.1:59364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-jxnrl\" mod_revision:4590 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-jxnrl\" value_size:1434 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-jxnrl\" > >"}
{"level":"info","ts":"2026-08-18T23:27:43.219537Z","caller":"traceutil/trace.go:171","msg":"trace[479740336] linearizableReadLoop","detail":"{readStateIndex:5044; appliedIndex:5040; }","duration":"444.250885ms","start":"2026-08-18T23:27:42.7752Z","end":"2026-08-18T23:27:43.219451Z","steps":["trace[479740336] 'read index received'  (duration: 193.863245ms)","trace[479740336] 'applied index is now lower than readState.Index'  (duration: 250.38574ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:27:43.219545Z","caller":"traceutil/trace.go:171","msg":"trace[1328731208] transaction","detail":"{read_only:false; response_revision:4855; number_of_response:1; }","duration":"492.633199ms","start":"2026-08-18T23:27:42.726886Z","end":"2026-08-18T23:27:43.219519Z","steps":["trace[1328731208] 'process raft request'  (duration: 492.355715ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:43.219668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.463968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-18T23:27:43.219678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:42.726878Z","time spent":"492.726561ms","remote":"127.0.0.1:59224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" mod_revision:4589 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" value_size:881 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" > >"}
{"level":"info","ts":"2026-08-18T23:27:43.219702Z","caller":"traceutil/trace.go:171","msg":"trace[947670003] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4855; }","duration":"444.531068ms","start":"2026-08-18T23:27:42.77516Z","end":"2026-08-18T23:27:43.219691Z","steps":["trace[947670003] 'agreement among raft nodes before linearized reading'  (duration: 444.464917ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:27:43.21972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.105706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"warn","ts":"2026-08-18T23:27:43.219735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:42.775141Z","time spent":"444.586319ms","remote":"127.0.0.1:59572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"info","ts":"2026-08-18T23:27:43.219747Z","caller":"traceutil/trace.go:171","msg":"trace[1470679766] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4855; }","duration":"142.165057ms","start":"2026-08-18T23:27:43.077573Z","end":"2026-08-18T23:27:43.219738Z","steps":["trace[1470679766] 'agreement among raft nodes before linearized reading'  (duration: 142.079996ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:28:20.994242Z","caller":"traceutil/trace.go:171","msg":"trace[166214721] transaction","detail":"{read_only:false; response_revision:5195; number_of_response:1; }","duration":"214.487676ms","start":"2026-08-18T23:28:20.779729Z","end":"2026-08-18T23:28:20.994217Z","steps":["trace[166214721] 'process raft request'  (duration: 214.357924ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:28:21.00895Z","caller":"traceutil/trace.go:171","msg":"trace[387102397] linearizableReadLoop","detail":"{readStateIndex:5394; appliedIndex:5392; }","duration":"137.023359ms","start":"2026-08-18T23:28:20.871907Z","end":"2026-08-18T23:28:21.008931Z","steps":["trace[387102397] 'read index received'  (duration: 122.24751ms)","trace[387102397] 'applied index is now lower than readState.Index'  (duration: 14.775009ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:28:21.00899Z","caller":"traceutil/trace.go:171","msg":"trace[1611806965] transaction","detail":"{read_only:false; response_revision:5196; number_of_response:1; }","duration":"221.837635ms","start":"2026-08-18T23:28:20.787131Z","end":"2026-08-18T23:28:21.008969Z","steps":["trace[1611806965] 'process raft request'  (duration: 221.696743ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:28:21.009155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.746697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"warn","ts":"2026-08-18T23:28:21.009172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.254203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-08-18T23:28:21.009228Z","caller":"traceutil/trace.go:171","msg":"trace[1078330704] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5196; }","duration":"137.325824ms","start":"2026-08-18T23:28:20.871889Z","end":"2026-08-18T23:28:21.009215Z","steps":["trace[1078330704] 'agreement among raft nodes before linearized reading'  (duration: 137.132111ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:28:21.009191Z","caller":"traceutil/trace.go:171","msg":"trace[254212745] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5196; }","duration":"119.827397ms","start":"2026-08-18T23:28:20.889353Z","end":"2026-08-18T23:28:21.00918Z","steps":["trace[254212745] 'agreement among raft nodes before linearized reading'  (duration: 119.691226ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:28:21.146217Z","caller":"traceutil/trace.go:171","msg":"trace[1456666088] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"132.526856ms","start":"2026-08-18T23:28:21.013656Z","end":"2026-08-18T23:28:21.146183Z","steps":["trace[1456666088] 'process raft request'  (duration: 132.339623ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:28:21.184624Z","caller":"traceutil/trace.go:171","msg":"trace[208979144] transaction","detail":"{read_only:false; response_revision:5199; number_of_response:1; }","duration":"170.831362ms","start":"2026-08-18T23:28:21.013693Z","end":"2026-08-18T23:28:21.184524Z","steps":["trace[208979144] 'process raft request'  (duration: 132.457945ms)","trace[208979144] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-controller-manager; req_size:487; } (duration: 38.113213ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:28:21.184634Z","caller":"traceutil/trace.go:171","msg":"trace[1804797191] transaction","detail":"{read_only:false; response_revision:5200; number_of_response:1; }","duration":"170.891993ms","start":"2026-08-18T23:28:21.013724Z","end":"2026-08-18T23:28:21.184616Z","steps":["trace[1804797191] 'process raft request'  (duration: 170.67965ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:28:21.1847Z","caller":"traceutil/trace.go:171","msg":"trace[222667017] transaction","detail":"{read_only:false; response_revision:5203; number_of_response:1; }","duration":"148.232407ms","start":"2026-08-18T23:28:21.036437Z","end":"2026-08-18T23:28:21.18467Z","steps":["trace[222667017] 'process raft request'  (duration: 148.174547ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:28:21.184777Z","caller":"traceutil/trace.go:171","msg":"trace[497249846] transaction","detail":"{read_only:false; response_revision:5202; number_of_response:1; }","duration":"169.219341ms","start":"2026-08-18T23:28:21.015547Z","end":"2026-08-18T23:28:21.184767Z","steps":["trace[497249846] 'process raft request'  (duration: 168.948157ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:28:21.184776Z","caller":"traceutil/trace.go:171","msg":"trace[822169794] transaction","detail":"{read_only:false; response_revision:5201; number_of_response:1; }","duration":"171.034074ms","start":"2026-08-18T23:28:21.013718Z","end":"2026-08-18T23:28:21.184752Z","steps":["trace[822169794] 'process raft request'  (duration: 170.743761ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:28:31.293372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.154343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-08-18T23:28:31.293459Z","caller":"traceutil/trace.go:171","msg":"trace[1446551942] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5276; }","duration":"108.290474ms","start":"2026-08-18T23:28:31.185151Z","end":"2026-08-18T23:28:31.293442Z","steps":["trace[1446551942] 'range keys from in-memory index tree'  (duration: 107.9848ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:28:35.659107Z","caller":"traceutil/trace.go:171","msg":"trace[543989224] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"147.086595ms","start":"2026-08-18T23:28:35.512006Z","end":"2026-08-18T23:28:35.659092Z","steps":["trace[543989224] 'process raft request'  (duration: 147.057895ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:28:35.659329Z","caller":"traceutil/trace.go:171","msg":"trace[172889865] transaction","detail":"{read_only:false; response_revision:5302; number_of_response:1; }","duration":"149.059561ms","start":"2026-08-18T23:28:35.510261Z","end":"2026-08-18T23:28:35.659321Z","steps":["trace[172889865] 'process raft request'  (duration: 60.902661ms)","trace[172889865] 'compare'  (duration: 87.767725ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:28:35.65943Z","caller":"traceutil/trace.go:171","msg":"trace[1161022326] transaction","detail":"{read_only:false; response_revision:5303; number_of_response:1; }","duration":"148.274281ms","start":"2026-08-18T23:28:35.511148Z","end":"2026-08-18T23:28:35.659422Z","steps":["trace[1161022326] 'process raft request'  (duration: 147.867176ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:28:35.659681Z","caller":"traceutil/trace.go:171","msg":"trace[182365488] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"148.275321ms","start":"2026-08-18T23:28:35.511363Z","end":"2026-08-18T23:28:35.659639Z","steps":["trace[182365488] 'process raft request'  (duration: 147.683143ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:29:04.3711Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2844}
{"level":"info","ts":"2026-08-18T23:29:04.462794Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2844,"took":"90.410409ms","hash":3919553296,"current-db-size-bytes":54026240,"current-db-size":"54 MB","current-db-size-in-use-bytes":29093888,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-08-18T23:29:04.462856Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3919553296,"revision":2844,"compact-revision":-1}
{"level":"info","ts":"2026-08-18T23:31:19.876871Z","caller":"traceutil/trace.go:171","msg":"trace[1500238984] transaction","detail":"{read_only:false; response_revision:6443; number_of_response:1; }","duration":"208.638662ms","start":"2026-08-18T23:31:19.668216Z","end":"2026-08-18T23:31:19.876855Z","steps":["trace[1500238984] 'process raft request'  (duration: 208.510601ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:31:20.074877Z","caller":"traceutil/trace.go:171","msg":"trace[291962591] linearizableReadLoop","detail":"{readStateIndex:6686; appliedIndex:6684; }","duration":"250.726683ms","start":"2026-08-18T23:31:19.824122Z","end":"2026-08-18T23:31:20.074849Z","steps":["trace[291962591] 'read index received'  (duration: 52.622709ms)","trace[291962591] 'applied index is now lower than readState.Index'  (duration: 198.102984ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:31:20.075268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.115897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:31:20.07536Z","caller":"traceutil/trace.go:171","msg":"trace[1178887841] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6444; }","duration":"251.255748ms","start":"2026-08-18T23:31:19.824087Z","end":"2026-08-18T23:31:20.075343Z","steps":["trace[1178887841] 'agreement among raft nodes before linearized reading'  (duration: 251.079926ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:31:20.07536Z","caller":"traceutil/trace.go:171","msg":"trace[960524502] transaction","detail":"{read_only:false; response_revision:6444; number_of_response:1; }","duration":"363.438982ms","start":"2026-08-18T23:31:19.711893Z","end":"2026-08-18T23:31:20.075332Z","steps":["trace[960524502] 'process raft request'  (duration: 332.029721ms)","trace[960524502] 'compare'  (duration: 30.801634ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:31:20.07551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:31:19.711866Z","time spent":"363.561254ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:6433 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-18T23:31:20.075508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.164769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-08-18T23:31:20.075565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.646686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4859"}
{"level":"info","ts":"2026-08-18T23:31:20.075614Z","caller":"traceutil/trace.go:171","msg":"trace[1793980351] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6444; }","duration":"201.33915ms","start":"2026-08-18T23:31:19.874256Z","end":"2026-08-18T23:31:20.075595Z","steps":["trace[1793980351] 'agreement among raft nodes before linearized reading'  (duration: 201.071787ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:31:20.075648Z","caller":"traceutil/trace.go:171","msg":"trace[610900442] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6444; }","duration":"152.759368ms","start":"2026-08-18T23:31:19.922867Z","end":"2026-08-18T23:31:20.075627Z","steps":["trace[610900442] 'agreement among raft nodes before linearized reading'  (duration: 152.542625ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:31:20.075759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.064968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4859"}
{"level":"info","ts":"2026-08-18T23:31:20.076032Z","caller":"traceutil/trace.go:171","msg":"trace[493254968] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6444; }","duration":"151.523154ms","start":"2026-08-18T23:31:19.924494Z","end":"2026-08-18T23:31:20.076017Z","steps":["trace[493254968] 'agreement among raft nodes before linearized reading'  (duration: 150.837496ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:31:20.209867Z","caller":"traceutil/trace.go:171","msg":"trace[1343546217] transaction","detail":"{read_only:false; response_revision:6445; number_of_response:1; }","duration":"129.235224ms","start":"2026-08-18T23:31:20.080575Z","end":"2026-08-18T23:31:20.20981Z","steps":["trace[1343546217] 'process raft request'  (duration: 99.435741ms)","trace[1343546217] 'compare'  (duration: 29.689262ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T23:31:20.697417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.317565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-08-18T23:31:20.69748Z","caller":"traceutil/trace.go:171","msg":"trace[32340450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6447; }","duration":"137.421426ms","start":"2026-08-18T23:31:20.560044Z","end":"2026-08-18T23:31:20.697465Z","steps":["trace[32340450] 'range keys from in-memory index tree'  (duration: 137.162523ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:31:20.697498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.199792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"warn","ts":"2026-08-18T23:31:20.697498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.965741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-08-18T23:31:20.697574Z","caller":"traceutil/trace.go:171","msg":"trace[160195856] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6447; }","duration":"170.330134ms","start":"2026-08-18T23:31:20.527228Z","end":"2026-08-18T23:31:20.697558Z","steps":["trace[160195856] 'range keys from in-memory index tree'  (duration: 170.02305ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:31:20.697595Z","caller":"traceutil/trace.go:171","msg":"trace[2141449722] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6447; }","duration":"180.108043ms","start":"2026-08-18T23:31:20.517467Z","end":"2026-08-18T23:31:20.697575Z","steps":["trace[2141449722] 'range keys from in-memory index tree'  (duration: 179.750008ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:31:20.697712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.947468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T23:31:20.697811Z","caller":"traceutil/trace.go:171","msg":"trace[1279427752] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:6447; }","duration":"101.13105ms","start":"2026-08-18T23:31:20.596647Z","end":"2026-08-18T23:31:20.697778Z","steps":["trace[1279427752] 'count revisions from in-memory index tree'  (duration: 100.847906ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:31:21.382842Z","caller":"traceutil/trace.go:171","msg":"trace[481464842] transaction","detail":"{read_only:false; response_revision:6451; number_of_response:1; }","duration":"138.380446ms","start":"2026-08-18T23:31:21.244437Z","end":"2026-08-18T23:31:21.382818Z","steps":["trace[481464842] 'process raft request'  (duration: 138.229414ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:31:22.577183Z","caller":"traceutil/trace.go:171","msg":"trace[1817942895] transaction","detail":"{read_only:false; response_revision:6460; number_of_response:1; }","duration":"137.15313ms","start":"2026-08-18T23:31:22.440006Z","end":"2026-08-18T23:31:22.577159Z","steps":["trace[1817942895] 'process raft request'  (duration: 136.565393ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:31:44.980288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.640549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-08-18T23:31:44.98055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.709137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-18T23:31:44.980653Z","caller":"traceutil/trace.go:171","msg":"trace[1243306587] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:6627; }","duration":"115.879174ms","start":"2026-08-18T23:31:44.864749Z","end":"2026-08-18T23:31:44.980629Z","steps":["trace[1243306587] 'count revisions from in-memory index tree'  (duration: 115.601052ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T23:31:44.980944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.427198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-08-18T23:31:44.980975Z","caller":"traceutil/trace.go:171","msg":"trace[1410214549] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6627; }","duration":"101.505292ms","start":"2026-08-18T23:31:44.879464Z","end":"2026-08-18T23:31:44.980969Z","steps":["trace[1410214549] 'range keys from in-memory index tree'  (duration: 101.23764ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:31:44.980485Z","caller":"traceutil/trace.go:171","msg":"trace[432317133] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6627; }","duration":"144.774794ms","start":"2026-08-18T23:31:44.835574Z","end":"2026-08-18T23:31:44.980349Z","steps":["trace[432317133] 'range keys from in-memory index tree'  (duration: 144.462501ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T23:31:59.250118Z","caller":"traceutil/trace.go:171","msg":"trace[364147726] transaction","detail":"{read_only:false; response_revision:6703; number_of_response:1; }","duration":"131.448051ms","start":"2026-08-18T23:31:59.118643Z","end":"2026-08-18T23:31:59.250091Z","steps":["trace[364147726] 'process raft request'  (duration: 72.302886ms)","trace[364147726] 'compare'  (duration: 58.843073ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T23:34:04.375919Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5508}
{"level":"info","ts":"2026-08-18T23:34:04.466343Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5508,"took":"89.287251ms","hash":919945862,"current-db-size-bytes":54026240,"current-db-size":"54 MB","current-db-size-in-use-bytes":18337792,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-08-18T23:34:04.4664Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":919945862,"revision":5508,"compact-revision":2844}