{"level":"warn","ts":"2026-04-22T00:27:34.727595Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-22T00:27:34.727676Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-04-22T00:27:34.727742Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-22T00:27:34.72775Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]}
{"level":"info","ts":"2026-04-22T00:27:34.72777Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-22T00:27:34.728459Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]}
{"level":"info","ts":"2026-04-22T00:27:34.728534Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-04-22T00:27:34.733161Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.397049ms"}
{"level":"info","ts":"2026-04-22T00:27:34.740678Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"}
{"level":"info","ts":"2026-04-22T00:27:34.740751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"}
{"level":"info","ts":"2026-04-22T00:27:34.740771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"}
{"level":"info","ts":"2026-04-22T00:27:34.740788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-22T00:27:34.740805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"}
{"level":"info","ts":"2026-04-22T00:27:34.740844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"}
{"level":"warn","ts":"2026-04-22T00:27:34.748045Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-22T00:27:34.749624Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-22T00:27:34.752416Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-04-22T00:27:34.755858Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-22T00:27:34.756102Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-22T00:27:34.756261Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-22T00:27:34.756303Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-22T00:27:34.756316Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-22T00:27:34.75733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"}
{"level":"info","ts":"2026-04-22T00:27:34.758513Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]}
{"level":"info","ts":"2026-04-22T00:27:34.760774Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-22T00:27:34.760861Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"}
{"level":"info","ts":"2026-04-22T00:27:34.760955Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"}
{"level":"info","ts":"2026-04-22T00:27:34.76102Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-22T00:27:34.76107Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-22T00:27:35.341304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"}
{"level":"info","ts":"2026-04-22T00:27:35.341424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-22T00:27:35.341495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"}
{"level":"info","ts":"2026-04-22T00:27:35.34152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"}
{"level":"info","ts":"2026-04-22T00:27:35.34154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"}
{"level":"info","ts":"2026-04-22T00:27:35.34156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"}
{"level":"info","ts":"2026-04-22T00:27:35.341578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"}
{"level":"info","ts":"2026-04-22T00:27:35.342975Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-22T00:27:35.343097Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-22T00:27:35.343189Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-22T00:27:35.343241Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T00:27:35.343471Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-22T00:27:35.343544Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-22T00:27:35.34438Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T00:27:35.344528Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T00:27:35.344591Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T00:27:35.346842Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"}
{"level":"info","ts":"2026-04-22T00:27:35.347531Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-22T00:27:54.310908Z","caller":"traceutil/trace.go:171","msg":"trace[1644961716] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"135.954852ms","start":"2026-04-22T00:27:54.174929Z","end":"2026-04-22T00:27:54.310884Z","steps":["trace[1644961716] 'process raft request'  (duration: 135.747857ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:27:54.536683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.772715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-04-22T00:27:54.53688Z","caller":"traceutil/trace.go:171","msg":"trace[1866481333] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:377; }","duration":"140.039713ms","start":"2026-04-22T00:27:54.396811Z","end":"2026-04-22T00:27:54.536851Z","steps":["trace[1866481333] 'range keys from in-memory index tree'  (duration: 139.598231ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:28:03.597935Z","caller":"traceutil/trace.go:171","msg":"trace[171856022] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"187.212937ms","start":"2026-04-22T00:28:03.410652Z","end":"2026-04-22T00:28:03.597865Z","steps":["trace[171856022] 'process raft request'  (duration: 186.872378ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:28:22.289858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.156094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:28:22.289991Z","caller":"traceutil/trace.go:171","msg":"trace[1115997990] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"212.362499ms","start":"2026-04-22T00:28:22.077605Z","end":"2026-04-22T00:28:22.289968Z","steps":["trace[1115997990] 'range keys from in-memory index tree'  (duration: 212.052031ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:28:22.572656Z","caller":"traceutil/trace.go:171","msg":"trace[280234620] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"232.158578ms","start":"2026-04-22T00:28:22.340461Z","end":"2026-04-22T00:28:22.57262Z","steps":["trace[280234620] 'process raft request'  (duration: 231.438918ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:28:23.234911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.605041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-t8wrw\" ","response":"range_response_count:1 size:16957"}
{"level":"info","ts":"2026-04-22T00:28:23.235069Z","caller":"traceutil/trace.go:171","msg":"trace[1268557004] range","detail":"{range_begin:/registry/pods/kube-system/cilium-t8wrw; range_end:; response_count:1; response_revision:601; }","duration":"354.814736ms","start":"2026-04-22T00:28:22.880221Z","end":"2026-04-22T00:28:23.235036Z","steps":["trace[1268557004] 'range keys from in-memory index tree'  (duration: 354.396465ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:28:23.235096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.025433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-04-22T00:28:23.235116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:28:22.880197Z","time spent":"354.908539ms","remote":"127.0.0.1:51796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16980,"request content":"key:\"/registry/pods/kube-system/cilium-t8wrw\" "}
{"level":"info","ts":"2026-04-22T00:28:23.235206Z","caller":"traceutil/trace.go:171","msg":"trace[487068966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:601; }","duration":"445.165547ms","start":"2026-04-22T00:28:22.790019Z","end":"2026-04-22T00:28:23.235184Z","steps":["trace[487068966] 'range keys from in-memory index tree'  (duration: 444.724614ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:28:23.235251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:28:22.789924Z","time spent":"445.31982ms","remote":"127.0.0.1:51896","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":"info","ts":"2026-04-22T00:28:23.237175Z","caller":"traceutil/trace.go:171","msg":"trace[1662049912] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"161.563518ms","start":"2026-04-22T00:28:23.075575Z","end":"2026-04-22T00:28:23.237139Z","steps":["trace[1662049912] 'read index received'  (duration: 160.548649ms)","trace[1662049912] 'applied index is now lower than readState.Index'  (duration: 1.013879ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:28:23.237269Z","caller":"traceutil/trace.go:171","msg":"trace[897232] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"163.950945ms","start":"2026-04-22T00:28:23.073295Z","end":"2026-04-22T00:28:23.237245Z","steps":["trace[897232] 'process raft request'  (duration: 163.155622ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:28:23.237306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.721892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:28:23.237348Z","caller":"traceutil/trace.go:171","msg":"trace[478831942] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"161.820876ms","start":"2026-04-22T00:28:23.075516Z","end":"2026-04-22T00:28:23.237337Z","steps":["trace[478831942] 'agreement among raft nodes before linearized reading'  (duration: 161.740183ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:28:39.515562Z","caller":"traceutil/trace.go:171","msg":"trace[169374591] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"168.517142ms","start":"2026-04-22T00:28:39.347007Z","end":"2026-04-22T00:28:39.515524Z","steps":["trace[169374591] 'process raft request'  (duration: 168.268554ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:53.258604Z","caller":"traceutil/trace.go:171","msg":"trace[1012987283] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1819; }","duration":"100.113048ms","start":"2026-04-22T00:29:53.158454Z","end":"2026-04-22T00:29:53.258567Z","steps":["trace[1012987283] 'range keys from in-memory index tree'  (duration: 99.375147ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:53.616288Z","caller":"traceutil/trace.go:171","msg":"trace[234961918] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"351.329271ms","start":"2026-04-22T00:29:53.264928Z","end":"2026-04-22T00:29:53.616257Z","steps":["trace[234961918] 'process raft request'  (duration: 351.147696ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:29:53.616872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:29:53.264901Z","time spent":"351.467475ms","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1757 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-04-22T00:29:53.656536Z","caller":"traceutil/trace.go:171","msg":"trace[1734555620] linearizableReadLoop","detail":"{readStateIndex:1887; appliedIndex:1885; }","duration":"346.902318ms","start":"2026-04-22T00:29:53.309599Z","end":"2026-04-22T00:29:53.656501Z","steps":["trace[1734555620] 'read index received'  (duration: 306.485439ms)","trace[1734555620] 'applied index is now lower than readState.Index'  (duration: 40.415739ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:29:53.656674Z","caller":"traceutil/trace.go:171","msg":"trace[982165578] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"390.99195ms","start":"2026-04-22T00:29:53.265649Z","end":"2026-04-22T00:29:53.656641Z","steps":["trace[982165578] 'process raft request'  (duration: 390.704392ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:29:53.656818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.189676ms","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-04-22T00:29:53.656835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:29:53.26563Z","time spent":"391.117223ms","remote":"127.0.0.1:51896","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:1758 > 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-04-22T00:29:53.65686Z","caller":"traceutil/trace.go:171","msg":"trace[1399254912] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1821; }","duration":"347.300079ms","start":"2026-04-22T00:29:53.309549Z","end":"2026-04-22T00:29:53.656849Z","steps":["trace[1399254912] 'agreement among raft nodes before linearized reading'  (duration: 347.104304ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:29:53.656895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:29:53.309524Z","time spent":"347.364311ms","remote":"127.0.0.1:51896","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-04-22T00:29:53.880127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.898854ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265329773339270 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1672 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T00:29:53.880321Z","caller":"traceutil/trace.go:171","msg":"trace[183015937] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"218.125438ms","start":"2026-04-22T00:29:53.662174Z","end":"2026-04-22T00:29:53.880299Z","steps":["trace[183015937] 'process raft request'  (duration: 218.066986ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:53.880463Z","caller":"traceutil/trace.go:171","msg":"trace[217893620] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"245.497733ms","start":"2026-04-22T00:29:53.634911Z","end":"2026-04-22T00:29:53.880409Z","steps":["trace[217893620] 'process raft request'  (duration: 82.005133ms)","trace[217893620] 'compare'  (duration: 162.75562ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:29:53.880553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.990839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:29:53.880636Z","caller":"traceutil/trace.go:171","msg":"trace[2076217357] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1823; }","duration":"279.147844ms","start":"2026-04-22T00:29:53.601468Z","end":"2026-04-22T00:29:53.880616Z","steps":["trace[2076217357] 'agreement among raft nodes before linearized reading'  (duration: 279.00103ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:29:53.880639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.139072ms","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":"warn","ts":"2026-04-22T00:29:53.880692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.543468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7c43b103-e00d-47f9-8303-960821c45f50\" ","response":"range_response_count:1 size:3625"}
{"level":"info","ts":"2026-04-22T00:29:53.880751Z","caller":"traceutil/trace.go:171","msg":"trace[996245860] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7c43b103-e00d-47f9-8303-960821c45f50; range_end:; response_count:1; response_revision:1823; }","duration":"390.699952ms","start":"2026-04-22T00:29:53.490038Z","end":"2026-04-22T00:29:53.880738Z","steps":["trace[996245860] 'agreement among raft nodes before linearized reading'  (duration: 390.416014ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:53.880694Z","caller":"traceutil/trace.go:171","msg":"trace[1123531186] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1823; }","duration":"436.242274ms","start":"2026-04-22T00:29:53.444434Z","end":"2026-04-22T00:29:53.880676Z","steps":["trace[1123531186] 'agreement among raft nodes before linearized reading'  (duration: 436.028698ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:29:53.880804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:29:53.490005Z","time spent":"390.789135ms","remote":"127.0.0.1:51796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7c43b103-e00d-47f9-8303-960821c45f50\" "}
{"level":"warn","ts":"2026-04-22T00:29:53.880859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:29:53.444405Z","time spent":"436.43745ms","remote":"127.0.0.1:54480","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-04-22T00:29:53.881115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.464697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7c43b103-e00d-47f9-8303-960821c45f50\" ","response":"range_response_count:1 size:3625"}
{"level":"info","ts":"2026-04-22T00:29:53.881188Z","caller":"traceutil/trace.go:171","msg":"trace[1564394845] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7c43b103-e00d-47f9-8303-960821c45f50; range_end:; response_count:1; response_revision:1823; }","duration":"492.582981ms","start":"2026-04-22T00:29:53.388585Z","end":"2026-04-22T00:29:53.881168Z","steps":["trace[1564394845] 'agreement among raft nodes before linearized reading'  (duration: 491.979623ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:29:53.881427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:29:53.388559Z","time spent":"492.857948ms","remote":"127.0.0.1:51796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7c43b103-e00d-47f9-8303-960821c45f50\" "}
{"level":"info","ts":"2026-04-22T00:29:53.881568Z","caller":"traceutil/trace.go:171","msg":"trace[1754511966] linearizableReadLoop","detail":"{readStateIndex:1888; appliedIndex:1887; }","duration":"223.796396ms","start":"2026-04-22T00:29:53.656622Z","end":"2026-04-22T00:29:53.880419Z","steps":["trace[1754511966] 'read index received'  (duration: 60.295416ms)","trace[1754511966] 'applied index is now lower than readState.Index'  (duration: 163.49769ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:29:54.308035Z","caller":"traceutil/trace.go:171","msg":"trace[18132879] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"438.461178ms","start":"2026-04-22T00:29:53.869537Z","end":"2026-04-22T00:29:54.307998Z","steps":["trace[18132879] 'process raft request'  (duration: 438.091788ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:29:54.308289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:29:53.869499Z","time spent":"438.648013ms","remote":"127.0.0.1:51896","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:1802 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-22T00:29:54.316292Z","caller":"traceutil/trace.go:171","msg":"trace[1497667113] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"428.139139ms","start":"2026-04-22T00:29:53.888125Z","end":"2026-04-22T00:29:54.316265Z","steps":["trace[1497667113] 'process raft request'  (duration: 427.904072ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:29:54.316571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:29:53.888102Z","time spent":"428.332545ms","remote":"127.0.0.1:51796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3730,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7c43b103-e00d-47f9-8303-960821c45f50\" mod_revision:1785 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7c43b103-e00d-47f9-8303-960821c45f50\" value_size:3630 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7c43b103-e00d-47f9-8303-960821c45f50\" > >"}
{"level":"info","ts":"2026-04-22T00:29:54.323716Z","caller":"traceutil/trace.go:171","msg":"trace[1023453147] linearizableReadLoop","detail":"{readStateIndex:1892; appliedIndex:1889; }","duration":"362.129753ms","start":"2026-04-22T00:29:53.961563Z","end":"2026-04-22T00:29:54.323693Z","steps":["trace[1023453147] 'read index received'  (duration: 346.177138ms)","trace[1023453147] 'applied index is now lower than readState.Index'  (duration: 15.951195ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:29:54.324001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.441133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-04-22T00:29:54.323995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.112169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:29:54.324094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.984806ms","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-04-22T00:29:54.324199Z","caller":"traceutil/trace.go:171","msg":"trace[136520756] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1825; }","duration":"202.103091ms","start":"2026-04-22T00:29:54.122048Z","end":"2026-04-22T00:29:54.324152Z","steps":["trace[136520756] 'agreement among raft nodes before linearized reading'  (duration: 201.856554ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.324101Z","caller":"traceutil/trace.go:171","msg":"trace[996442027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1825; }","duration":"247.332705ms","start":"2026-04-22T00:29:54.076746Z","end":"2026-04-22T00:29:54.324079Z","steps":["trace[996442027] 'agreement among raft nodes before linearized reading'  (duration: 247.141779ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.324035Z","caller":"traceutil/trace.go:171","msg":"trace[1916799538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1825; }","duration":"362.555616ms","start":"2026-04-22T00:29:53.961471Z","end":"2026-04-22T00:29:54.324026Z","steps":["trace[1916799538] 'agreement among raft nodes before linearized reading'  (duration: 362.364431ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:29:54.324345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:29:53.961435Z","time spent":"362.898476ms","remote":"127.0.0.1:51896","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":"info","ts":"2026-04-22T00:30:08.509953Z","caller":"traceutil/trace.go:171","msg":"trace[2052665975] linearizableReadLoop","detail":"{readStateIndex:2011; appliedIndex:2010; }","duration":"113.40627ms","start":"2026-04-22T00:30:08.396514Z","end":"2026-04-22T00:30:08.50992Z","steps":["trace[2052665975] 'read index received'  (duration: 113.226555ms)","trace[2052665975] 'applied index is now lower than readState.Index'  (duration: 177.625µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:30:08.510062Z","caller":"traceutil/trace.go:171","msg":"trace[1335521442] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"143.882423ms","start":"2026-04-22T00:30:08.366139Z","end":"2026-04-22T00:30:08.510022Z","steps":["trace[1335521442] 'process raft request'  (duration: 143.558453ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:30:08.510289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.407208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-22T00:30:08.510342Z","caller":"traceutil/trace.go:171","msg":"trace[1416269484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1941; }","duration":"109.584324ms","start":"2026-04-22T00:30:08.400744Z","end":"2026-04-22T00:30:08.510329Z","steps":["trace[1416269484] 'agreement among raft nodes before linearized reading'  (duration: 109.371898ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:30:08.510378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.829192ms","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-04-22T00:30:08.510497Z","caller":"traceutil/trace.go:171","msg":"trace[2106187302] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1941; }","duration":"114.029308ms","start":"2026-04-22T00:30:08.396442Z","end":"2026-04-22T00:30:08.510471Z","steps":["trace[2106187302] 'agreement among raft nodes before linearized reading'  (duration: 113.642708ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:30:08.510377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.563835ms","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-04-22T00:30:08.510579Z","caller":"traceutil/trace.go:171","msg":"trace[1562415616] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1941; }","duration":"103.809132ms","start":"2026-04-22T00:30:08.406742Z","end":"2026-04-22T00:30:08.510551Z","steps":["trace[1562415616] 'agreement among raft nodes before linearized reading'  (duration: 103.407901ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:30:09.459249Z","caller":"traceutil/trace.go:171","msg":"trace[1896502939] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"191.4172ms","start":"2026-04-22T00:30:09.267798Z","end":"2026-04-22T00:30:09.459215Z","steps":["trace[1896502939] 'process raft request'  (duration: 186.602496ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:30:38.057693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.071021ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265329773339960 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2107 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T00:30:38.057835Z","caller":"traceutil/trace.go:171","msg":"trace[1154656642] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"139.696279ms","start":"2026-04-22T00:30:37.918113Z","end":"2026-04-22T00:30:38.057809Z","steps":["trace[1154656642] 'process raft request'  (duration: 14.3349ms)","trace[1154656642] 'compare'  (duration: 124.909076ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:30:44.472172Z","caller":"traceutil/trace.go:171","msg":"trace[2037705376] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"201.744ms","start":"2026-04-22T00:30:44.270395Z","end":"2026-04-22T00:30:44.472139Z","steps":["trace[2037705376] 'process raft request'  (duration: 201.506183ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:30:44.907491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.226106ms","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-04-22T00:30:44.907595Z","caller":"traceutil/trace.go:171","msg":"trace[571851403] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2152; }","duration":"205.394132ms","start":"2026-04-22T00:30:44.702179Z","end":"2026-04-22T00:30:44.907573Z","steps":["trace[571851403] 'range keys from in-memory index tree'  (duration: 205.018501ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:30:44.907538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.897875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-04-22T00:30:44.907804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.310739ms","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-04-22T00:30:44.90782Z","caller":"traceutil/trace.go:171","msg":"trace[554936636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2152; }","duration":"211.169813ms","start":"2026-04-22T00:30:44.696595Z","end":"2026-04-22T00:30:44.907765Z","steps":["trace[554936636] 'range keys from in-memory index tree'  (duration: 210.784142ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:30:44.907947Z","caller":"traceutil/trace.go:171","msg":"trace[28750885] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2152; }","duration":"205.524835ms","start":"2026-04-22T00:30:44.702393Z","end":"2026-04-22T00:30:44.907917Z","steps":["trace[28750885] 'range keys from in-memory index tree'  (duration: 205.082322ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:30:44.907974Z","caller":"traceutil/trace.go:171","msg":"trace[209437018] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"102.51766ms","start":"2026-04-22T00:30:44.805435Z","end":"2026-04-22T00:30:44.907953Z","steps":["trace[209437018] 'process raft request'  (duration: 102.231822ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:30:50.517776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.427479ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265329773340136 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:2128 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T00:30:50.518017Z","caller":"traceutil/trace.go:171","msg":"trace[44224235] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"288.845241ms","start":"2026-04-22T00:30:50.22915Z","end":"2026-04-22T00:30:50.517995Z","steps":["trace[44224235] 'process raft request'  (duration: 148.096083ms)","trace[44224235] 'compare'  (duration: 139.922375ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:30:50.518266Z","caller":"traceutil/trace.go:171","msg":"trace[1535781758] linearizableReadLoop","detail":"{readStateIndex:2264; appliedIndex:2262; }","duration":"204.470026ms","start":"2026-04-22T00:30:50.313724Z","end":"2026-04-22T00:30:50.518194Z","steps":["trace[1535781758] 'read index received'  (duration: 63.610955ms)","trace[1535781758] 'applied index is now lower than readState.Index'  (duration: 140.855861ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:30:50.518271Z","caller":"traceutil/trace.go:171","msg":"trace[759692967] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"275.767225ms","start":"2026-04-22T00:30:50.242471Z","end":"2026-04-22T00:30:50.518238Z","steps":["trace[759692967] 'process raft request'  (duration: 275.442416ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:30:50.518627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.882497ms","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-04-22T00:30:50.518682Z","caller":"traceutil/trace.go:171","msg":"trace[148604261] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2184; }","duration":"204.99974ms","start":"2026-04-22T00:30:50.313664Z","end":"2026-04-22T00:30:50.518664Z","steps":["trace[148604261] 'agreement among raft nodes before linearized reading'  (duration: 204.685021ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:31:27.196316Z","caller":"traceutil/trace.go:171","msg":"trace[1723663512] transaction","detail":"{read_only:false; response_revision:2391; number_of_response:1; }","duration":"125.93025ms","start":"2026-04-22T00:31:27.070336Z","end":"2026-04-22T00:31:27.196267Z","steps":["trace[1723663512] 'process raft request'  (duration: 100.290226ms)","trace[1723663512] 'compare'  (duration: 25.168181ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:31:49.618533Z","caller":"traceutil/trace.go:171","msg":"trace[901257853] linearizableReadLoop","detail":"{readStateIndex:2770; appliedIndex:2769; }","duration":"276.253571ms","start":"2026-04-22T00:31:49.342234Z","end":"2026-04-22T00:31:49.618487Z","steps":["trace[901257853] 'read index received'  (duration: 276.030664ms)","trace[901257853] 'applied index is now lower than readState.Index'  (duration: 221.696µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:31:49.618585Z","caller":"traceutil/trace.go:171","msg":"trace[1822933456] transaction","detail":"{read_only:false; response_revision:2669; number_of_response:1; }","duration":"301.325699ms","start":"2026-04-22T00:31:49.317214Z","end":"2026-04-22T00:31:49.61854Z","steps":["trace[1822933456] 'process raft request'  (duration: 301.052741ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:49.618788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:49.317188Z","time spent":"301.499404ms","remote":"127.0.0.1:51896","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:2654 > 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-04-22T00:31:49.618815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.553459ms","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-04-22T00:31:49.618861Z","caller":"traceutil/trace.go:171","msg":"trace[1258498993] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2669; }","duration":"276.666121ms","start":"2026-04-22T00:31:49.342183Z","end":"2026-04-22T00:31:49.618849Z","steps":["trace[1258498993] 'agreement among raft nodes before linearized reading'  (duration: 276.480126ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:31:49.636409Z","caller":"traceutil/trace.go:171","msg":"trace[2023859620] transaction","detail":"{read_only:false; response_revision:2670; number_of_response:1; }","duration":"279.112259ms","start":"2026-04-22T00:31:49.357258Z","end":"2026-04-22T00:31:49.63637Z","steps":["trace[2023859620] 'process raft request'  (duration: 278.741239ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:49.636683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.818944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-22T00:31:49.636801Z","caller":"traceutil/trace.go:171","msg":"trace[2101413524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2670; }","duration":"291.979479ms","start":"2026-04-22T00:31:49.344766Z","end":"2026-04-22T00:31:49.636746Z","steps":["trace[2101413524] 'agreement among raft nodes before linearized reading'  (duration: 291.65236ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:49.636869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.394907ms","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-04-22T00:31:49.636975Z","caller":"traceutil/trace.go:171","msg":"trace[324190751] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2670; }","duration":"293.528611ms","start":"2026-04-22T00:31:49.343416Z","end":"2026-04-22T00:31:49.636945Z","steps":["trace[324190751] 'agreement among raft nodes before linearized reading'  (duration: 292.708799ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:49.972232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.240498ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265329773341208 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2655 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T00:31:49.972394Z","caller":"traceutil/trace.go:171","msg":"trace[1279586394] transaction","detail":"{read_only:false; response_revision:2671; number_of_response:1; }","duration":"349.047829ms","start":"2026-04-22T00:31:49.623309Z","end":"2026-04-22T00:31:49.972357Z","steps":["trace[1279586394] 'process raft request'  (duration: 226.596615ms)","trace[1279586394] 'compare'  (duration: 121.5941ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:31:49.972454Z","caller":"traceutil/trace.go:171","msg":"trace[1237779462] transaction","detail":"{read_only:false; response_revision:2673; number_of_response:1; }","duration":"331.674244ms","start":"2026-04-22T00:31:49.640766Z","end":"2026-04-22T00:31:49.972441Z","steps":["trace[1237779462] 'process raft request'  (duration: 331.633793ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:31:49.97247Z","caller":"traceutil/trace.go:171","msg":"trace[1393179438] linearizableReadLoop","detail":"{readStateIndex:2772; appliedIndex:2771; }","duration":"332.129577ms","start":"2026-04-22T00:31:49.640304Z","end":"2026-04-22T00:31:49.972434Z","steps":["trace[1393179438] 'read index received'  (duration: 209.721805ms)","trace[1393179438] 'applied index is now lower than readState.Index'  (duration: 122.405222ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:31:49.972562Z","caller":"traceutil/trace.go:171","msg":"trace[1554287285] transaction","detail":"{read_only:false; response_revision:2672; number_of_response:1; }","duration":"332.207069ms","start":"2026-04-22T00:31:49.640346Z","end":"2026-04-22T00:31:49.972553Z","steps":["trace[1554287285] 'process raft request'  (duration: 331.996293ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:49.972606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:49.640324Z","time spent":"332.261041ms","remote":"127.0.0.1:51896","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:2657 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-04-22T00:31:49.972739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.412405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-04-22T00:31:49.972786Z","caller":"traceutil/trace.go:171","msg":"trace[210920729] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2673; }","duration":"332.506617ms","start":"2026-04-22T00:31:49.640268Z","end":"2026-04-22T00:31:49.972774Z","steps":["trace[210920729] 'agreement among raft nodes before linearized reading'  (duration: 332.337203ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:49.972828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:49.640254Z","time spent":"332.558869ms","remote":"127.0.0.1:51796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-04-22T00:31:49.972829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.500267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-04-22T00:31:49.973033Z","caller":"traceutil/trace.go:171","msg":"trace[966564473] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2673; }","duration":"229.707663ms","start":"2026-04-22T00:31:49.743271Z","end":"2026-04-22T00:31:49.972979Z","steps":["trace[966564473] 'agreement among raft nodes before linearized reading'  (duration: 229.447876ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:49.972519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:49.640753Z","time spent":"331.731356ms","remote":"127.0.0.1:51896","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:2656 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-22T00:31:49.972498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:49.623282Z","time spent":"349.165181ms","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2655 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-22T00:32:28.386643Z","caller":"traceutil/trace.go:171","msg":"trace[1118431497] linearizableReadLoop","detail":"{readStateIndex:3007; appliedIndex:3006; }","duration":"203.222551ms","start":"2026-04-22T00:32:28.183349Z","end":"2026-04-22T00:32:28.386571Z","steps":["trace[1118431497] 'read index received'  (duration: 202.959073ms)","trace[1118431497] 'applied index is now lower than readState.Index'  (duration: 262.118µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:32:28.38686Z","caller":"traceutil/trace.go:171","msg":"trace[2080625688] transaction","detail":"{read_only:false; response_revision:2899; number_of_response:1; }","duration":"214.795454ms","start":"2026-04-22T00:32:28.172046Z","end":"2026-04-22T00:32:28.386841Z","steps":["trace[2080625688] 'process raft request'  (duration: 214.320641ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:32:28.38703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.328397ms","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-04-22T00:32:28.38711Z","caller":"traceutil/trace.go:171","msg":"trace[422979671] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2899; }","duration":"187.466301ms","start":"2026-04-22T00:32:28.199622Z","end":"2026-04-22T00:32:28.387089Z","steps":["trace[422979671] 'agreement among raft nodes before linearized reading'  (duration: 187.289176ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:32:28.387268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.9216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-22T00:32:28.38729Z","caller":"traceutil/trace.go:171","msg":"trace[136425996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2899; }","duration":"203.95732ms","start":"2026-04-22T00:32:28.183327Z","end":"2026-04-22T00:32:28.387284Z","steps":["trace[136425996] 'agreement among raft nodes before linearized reading'  (duration: 203.900219ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:36:32.897038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.664672ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265329773347276 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/namespaces/monitoring\" mod_revision:0 > success:<request_put:<key:\"/registry/namespaces/monitoring\" value_size:318 >> failure:<>>","response":"size:5"}
{"level":"info","ts":"2026-04-22T00:36:32.897176Z","caller":"traceutil/trace.go:171","msg":"trace[624809212] linearizableReadLoop","detail":"{readStateIndex:5306; appliedIndex:5305; }","duration":"222.27315ms","start":"2026-04-22T00:36:32.674881Z","end":"2026-04-22T00:36:32.897154Z","steps":["trace[624809212] 'read index received'  (duration: 106.283969ms)","trace[624809212] 'applied index is now lower than readState.Index'  (duration: 115.987261ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:36:32.897265Z","caller":"traceutil/trace.go:171","msg":"trace[531926292] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5114; }","duration":"338.913888ms","start":"2026-04-22T00:36:32.558337Z","end":"2026-04-22T00:36:32.897251Z","steps":["trace[531926292] 'process raft request'  (duration: 222.955657ms)","trace[531926292] 'compare'  (duration: 115.621701ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:36:32.897358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:36:32.558313Z","time spent":"339.011941ms","remote":"127.0.0.1:51730","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/namespaces/monitoring\" mod_revision:0 > success:<request_put:<key:\"/registry/namespaces/monitoring\" value_size:318 >> failure:<>"}
{"level":"warn","ts":"2026-04-22T00:36:32.897657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.746413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3bf27e52-7db9-431a-b55f-d31892209314\" ","response":"range_response_count:1 size:3719"}
{"level":"info","ts":"2026-04-22T00:36:32.897746Z","caller":"traceutil/trace.go:171","msg":"trace[1437116895] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3bf27e52-7db9-431a-b55f-d31892209314; range_end:; response_count:1; response_revision:5114; }","duration":"222.879547ms","start":"2026-04-22T00:36:32.674847Z","end":"2026-04-22T00:36:32.897727Z","steps":["trace[1437116895] 'agreement among raft nodes before linearized reading'  (duration: 222.687932ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:36:32.941239Z","caller":"traceutil/trace.go:171","msg":"trace[1161823956] transaction","detail":"{read_only:false; response_revision:5115; number_of_response:1; }","duration":"147.422361ms","start":"2026-04-22T00:36:32.793799Z","end":"2026-04-22T00:36:32.941222Z","steps":["trace[1161823956] 'process raft request'  (duration: 147.296108ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:36:32.95849Z","caller":"traceutil/trace.go:171","msg":"trace[1611832952] transaction","detail":"{read_only:false; response_revision:5117; number_of_response:1; }","duration":"145.131958ms","start":"2026-04-22T00:36:32.813335Z","end":"2026-04-22T00:36:32.958467Z","steps":["trace[1611832952] 'process raft request'  (duration: 144.998203ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:36:32.958552Z","caller":"traceutil/trace.go:171","msg":"trace[869859199] transaction","detail":"{read_only:false; response_revision:5116; number_of_response:1; }","duration":"145.301073ms","start":"2026-04-22T00:36:32.813232Z","end":"2026-04-22T00:36:32.958533Z","steps":["trace[869859199] 'process raft request'  (duration: 144.955522ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:36:32.958807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.505933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xckmj\" ","response":"range_response_count:1 size:6516"}
{"level":"info","ts":"2026-04-22T00:36:32.958898Z","caller":"traceutil/trace.go:171","msg":"trace[87869155] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xckmj; range_end:; response_count:1; response_revision:5117; }","duration":"117.652917ms","start":"2026-04-22T00:36:32.841227Z","end":"2026-04-22T00:36:32.95888Z","steps":["trace[87869155] 'agreement among raft nodes before linearized reading'  (duration: 117.424601ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:36:33.278718Z","caller":"traceutil/trace.go:171","msg":"trace[1268871867] transaction","detail":"{read_only:false; response_revision:5122; number_of_response:1; }","duration":"132.586975ms","start":"2026-04-22T00:36:33.146087Z","end":"2026-04-22T00:36:33.278674Z","steps":["trace[1268871867] 'process raft request'  (duration: 104.274902ms)","trace[1268871867] 'compare'  (duration: 28.044816ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:36:43.993174Z","caller":"traceutil/trace.go:171","msg":"trace[1617739376] linearizableReadLoop","detail":"{readStateIndex:5540; appliedIndex:5539; }","duration":"132.587315ms","start":"2026-04-22T00:36:43.860556Z","end":"2026-04-22T00:36:43.993143Z","steps":["trace[1617739376] 'read index received'  (duration: 132.379818ms)","trace[1617739376] 'applied index is now lower than readState.Index'  (duration: 206.387µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:36:43.993234Z","caller":"traceutil/trace.go:171","msg":"trace[595898537] transaction","detail":"{read_only:false; response_revision:5341; number_of_response:1; }","duration":"182.492126ms","start":"2026-04-22T00:36:43.810704Z","end":"2026-04-22T00:36:43.993197Z","steps":["trace[595898537] 'process raft request'  (duration: 182.216328ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:36:43.99361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.992736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-04-22T00:36:43.993764Z","caller":"traceutil/trace.go:171","msg":"trace[231854454] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5341; }","duration":"133.225983ms","start":"2026-04-22T00:36:43.860517Z","end":"2026-04-22T00:36:43.993743Z","steps":["trace[231854454] 'agreement among raft nodes before linearized reading'  (duration: 132.78884ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:36:44.116694Z","caller":"traceutil/trace.go:171","msg":"trace[1414936480] transaction","detail":"{read_only:false; response_revision:5342; number_of_response:1; }","duration":"118.741925ms","start":"2026-04-22T00:36:43.99793Z","end":"2026-04-22T00:36:44.116672Z","steps":["trace[1414936480] 'process raft request'  (duration: 118.624982ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:36:44.116973Z","caller":"traceutil/trace.go:171","msg":"trace[709308558] linearizableReadLoop","detail":"{readStateIndex:5541; appliedIndex:5540; }","duration":"123.698715ms","start":"2026-04-22T00:36:43.993267Z","end":"2026-04-22T00:36:44.116965Z","steps":["trace[709308558] 'read index received'  (duration: 85.338387ms)","trace[709308558] 'applied index is now lower than readState.Index'  (duration: 38.359497ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:36:44.117111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.479346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-22T00:36:44.11714Z","caller":"traceutil/trace.go:171","msg":"trace[62503258] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5342; }","duration":"203.585128ms","start":"2026-04-22T00:36:43.913547Z","end":"2026-04-22T00:36:44.117132Z","steps":["trace[62503258] 'agreement among raft nodes before linearized reading'  (duration: 203.452914ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:36:44.117341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.496306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-04-22T00:36:44.117368Z","caller":"traceutil/trace.go:171","msg":"trace[1268149399] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5342; }","duration":"156.577848ms","start":"2026-04-22T00:36:43.960784Z","end":"2026-04-22T00:36:44.117362Z","steps":["trace[1268149399] 'agreement among raft nodes before linearized reading'  (duration: 156.513536ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:36:44.117527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.234635ms","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-04-22T00:36:44.117567Z","caller":"traceutil/trace.go:171","msg":"trace[763904038] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5342; }","duration":"200.326587ms","start":"2026-04-22T00:36:43.917231Z","end":"2026-04-22T00:36:44.117557Z","steps":["trace[763904038] 'agreement among raft nodes before linearized reading'  (duration: 200.232204ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:36:44.11771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.919258ms","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-04-22T00:36:44.117736Z","caller":"traceutil/trace.go:171","msg":"trace[1461407466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5342; }","duration":"203.964929ms","start":"2026-04-22T00:36:43.913766Z","end":"2026-04-22T00:36:44.117731Z","steps":["trace[1461407466] 'agreement among raft nodes before linearized reading'  (duration: 203.897717ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:36:51.899243Z","caller":"traceutil/trace.go:171","msg":"trace[1907373564] transaction","detail":"{read_only:false; response_revision:5506; number_of_response:1; }","duration":"164.375838ms","start":"2026-04-22T00:36:51.734843Z","end":"2026-04-22T00:36:51.899218Z","steps":["trace[1907373564] 'process raft request'  (duration: 164.196073ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:36:52.103852Z","caller":"traceutil/trace.go:171","msg":"trace[819600022] transaction","detail":"{read_only:false; response_revision:5507; number_of_response:1; }","duration":"192.382224ms","start":"2026-04-22T00:36:51.911423Z","end":"2026-04-22T00:36:52.103805Z","steps":["trace[819600022] 'process raft request'  (duration: 192.091596ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:36:52.103795Z","caller":"traceutil/trace.go:171","msg":"trace[833646604] linearizableReadLoop","detail":"{readStateIndex:5711; appliedIndex:5710; }","duration":"126.296328ms","start":"2026-04-22T00:36:51.977471Z","end":"2026-04-22T00:36:52.103767Z","steps":["trace[833646604] 'read index received'  (duration: 125.992999ms)","trace[833646604] 'applied index is now lower than readState.Index'  (duration: 301.249µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:36:52.10501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.521011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:36:52.105099Z","caller":"traceutil/trace.go:171","msg":"trace[899483572] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:5507; }","duration":"127.668565ms","start":"2026-04-22T00:36:51.977411Z","end":"2026-04-22T00:36:52.105079Z","steps":["trace[899483572] 'agreement among raft nodes before linearized reading'  (duration: 126.508733ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:36:52.279386Z","caller":"traceutil/trace.go:171","msg":"trace[441834465] linearizableReadLoop","detail":"{readStateIndex:5712; appliedIndex:5711; }","duration":"122.539871ms","start":"2026-04-22T00:36:52.156817Z","end":"2026-04-22T00:36:52.279357Z","steps":["trace[441834465] 'read index received'  (duration: 36.892696ms)","trace[441834465] 'applied index is now lower than readState.Index'  (duration: 85.645405ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:36:52.279395Z","caller":"traceutil/trace.go:171","msg":"trace[136771797] transaction","detail":"{read_only:false; response_revision:5508; number_of_response:1; }","duration":"122.746427ms","start":"2026-04-22T00:36:52.156603Z","end":"2026-04-22T00:36:52.279349Z","steps":["trace[136771797] 'process raft request'  (duration: 37.169203ms)","trace[136771797] 'compare'  (duration: 85.169542ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:36:52.27971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.881122ms","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-04-22T00:36:52.279787Z","caller":"traceutil/trace.go:171","msg":"trace[714708268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5509; }","duration":"123.017545ms","start":"2026-04-22T00:36:52.156752Z","end":"2026-04-22T00:36:52.279769Z","steps":["trace[714708268] 'agreement among raft nodes before linearized reading'  (duration: 122.801908ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:36:52.28002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.558342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-04-22T00:36:52.280072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.0763ms","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-04-22T00:36:52.280095Z","caller":"traceutil/trace.go:171","msg":"trace[2095801559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5509; }","duration":"122.667916ms","start":"2026-04-22T00:36:52.15741Z","end":"2026-04-22T00:36:52.280078Z","steps":["trace[2095801559] 'agreement among raft nodes before linearized reading'  (duration: 122.094869ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:36:52.280182Z","caller":"traceutil/trace.go:171","msg":"trace[345301580] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5509; }","duration":"122.221423ms","start":"2026-04-22T00:36:52.157937Z","end":"2026-04-22T00:36:52.280159Z","steps":["trace[345301580] 'agreement among raft nodes before linearized reading'  (duration: 121.614425ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:37:04.483784Z","caller":"traceutil/trace.go:171","msg":"trace[1446032324] transaction","detail":"{read_only:false; response_revision:5674; number_of_response:1; }","duration":"128.453328ms","start":"2026-04-22T00:37:04.355303Z","end":"2026-04-22T00:37:04.483756Z","steps":["trace[1446032324] 'process raft request'  (duration: 82.979551ms)","trace[1446032324] 'compare'  (duration: 45.286032ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:37:04.4841Z","caller":"traceutil/trace.go:171","msg":"trace[300945015] linearizableReadLoop","detail":"{readStateIndex:5884; appliedIndex:5881; }","duration":"112.458158ms","start":"2026-04-22T00:37:04.371614Z","end":"2026-04-22T00:37:04.484072Z","steps":["trace[300945015] 'read index received'  (duration: 66.624981ms)","trace[300945015] 'applied index is now lower than readState.Index'  (duration: 45.831457ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:37:04.484136Z","caller":"traceutil/trace.go:171","msg":"trace[99098773] transaction","detail":"{read_only:false; response_revision:5675; number_of_response:1; }","duration":"125.221237ms","start":"2026-04-22T00:37:04.358883Z","end":"2026-04-22T00:37:04.484104Z","steps":["trace[99098773] 'process raft request'  (duration: 124.831416ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:37:04.484179Z","caller":"traceutil/trace.go:171","msg":"trace[550376966] transaction","detail":"{read_only:false; response_revision:5676; number_of_response:1; }","duration":"125.197646ms","start":"2026-04-22T00:37:04.358951Z","end":"2026-04-22T00:37:04.484149Z","steps":["trace[550376966] 'process raft request'  (duration: 125.024771ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:37:04.484484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.85871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-22T00:37:04.484533Z","caller":"traceutil/trace.go:171","msg":"trace[206261422] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5676; }","duration":"112.970413ms","start":"2026-04-22T00:37:04.371552Z","end":"2026-04-22T00:37:04.484522Z","steps":["trace[206261422] 'agreement among raft nodes before linearized reading'  (duration: 112.617483ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:37:35.724334Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2941}
{"level":"info","ts":"2026-04-22T00:37:35.800084Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2941,"took":"73.639508ms","hash":2639002278,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":33226752,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-04-22T00:37:35.800147Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2639002278,"revision":2941,"compact-revision":-1}
{"level":"info","ts":"2026-04-22T00:37:44.110803Z","caller":"traceutil/trace.go:171","msg":"trace[1317239463] transaction","detail":"{read_only:false; response_revision:6015; number_of_response:1; }","duration":"123.272072ms","start":"2026-04-22T00:37:43.987482Z","end":"2026-04-22T00:37:44.110754Z","steps":["trace[1317239463] 'process raft request'  (duration: 122.546132ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:42:35.734167Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5966}
{"level":"info","ts":"2026-04-22T00:42:35.820763Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5966,"took":"84.547341ms","hash":881291472,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":25993216,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-04-22T00:42:35.820847Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":881291472,"revision":5966,"compact-revision":2941}
{"level":"info","ts":"2026-04-22T00:42:50.405138Z","caller":"traceutil/trace.go:171","msg":"trace[1839417124] transaction","detail":"{read_only:false; response_revision:8305; number_of_response:1; }","duration":"110.195239ms","start":"2026-04-22T00:42:50.294922Z","end":"2026-04-22T00:42:50.405117Z","steps":["trace[1839417124] 'process raft request'  (duration: 110.062896ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:42:50.827511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.063358ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265329773355576 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8294 > 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-04-22T00:42:50.827731Z","caller":"traceutil/trace.go:171","msg":"trace[534513367] transaction","detail":"{read_only:false; response_revision:8307; number_of_response:1; }","duration":"449.631318ms","start":"2026-04-22T00:42:50.378071Z","end":"2026-04-22T00:42:50.827702Z","steps":["trace[534513367] 'process raft request'  (duration: 449.533155ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:42:50.827801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:42:50.378062Z","time spent":"449.707669ms","remote":"127.0.0.1:51896","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:8298 > 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":"info","ts":"2026-04-22T00:42:50.827917Z","caller":"traceutil/trace.go:171","msg":"trace[1480065449] transaction","detail":"{read_only:false; response_revision:8306; number_of_response:1; }","duration":"532.703556ms","start":"2026-04-22T00:42:50.295157Z","end":"2026-04-22T00:42:50.82786Z","steps":["trace[1480065449] 'process raft request'  (duration: 163.192326ms)","trace[1480065449] 'compare'  (duration: 368.873502ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:42:50.827959Z","caller":"traceutil/trace.go:171","msg":"trace[1271022345] transaction","detail":"{read_only:false; response_revision:8308; number_of_response:1; }","duration":"447.290601ms","start":"2026-04-22T00:42:50.380652Z","end":"2026-04-22T00:42:50.827942Z","steps":["trace[1271022345] 'process raft request'  (duration: 447.010123ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:42:50.828018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:42:50.380626Z","time spent":"447.363644ms","remote":"127.0.0.1:51896","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:8299 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-22T00:42:50.828076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:42:50.295147Z","time spent":"532.84634ms","remote":"127.0.0.1:51896","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:8294 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-04-22T00:42:50.82832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.593483ms","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-04-22T00:42:50.82841Z","caller":"traceutil/trace.go:171","msg":"trace[913490850] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8308; }","duration":"532.715556ms","start":"2026-04-22T00:42:50.295668Z","end":"2026-04-22T00:42:50.828383Z","steps":["trace[913490850] 'agreement among raft nodes before linearized reading'  (duration: 532.426588ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:42:50.828462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:42:50.295657Z","time spent":"532.795598ms","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-04-22T00:42:50.828472Z","caller":"traceutil/trace.go:171","msg":"trace[158833519] linearizableReadLoop","detail":"{readStateIndex:8599; appliedIndex:8597; }","duration":"532.157931ms","start":"2026-04-22T00:42:50.2957Z","end":"2026-04-22T00:42:50.827858Z","steps":["trace[158833519] 'read index received'  (duration: 109.340326ms)","trace[158833519] 'applied index is now lower than readState.Index'  (duration: 422.815445ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:42:50.828641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.779509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:42:50.828682Z","caller":"traceutil/trace.go:171","msg":"trace[744588631] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:8308; }","duration":"154.854071ms","start":"2026-04-22T00:42:50.673816Z","end":"2026-04-22T00:42:50.82867Z","steps":["trace[744588631] 'agreement among raft nodes before linearized reading'  (duration: 154.79422ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:42:50.828745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.033946ms","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-04-22T00:42:50.828801Z","caller":"traceutil/trace.go:171","msg":"trace[356129739] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8308; }","duration":"466.115039ms","start":"2026-04-22T00:42:50.362673Z","end":"2026-04-22T00:42:50.828788Z","steps":["trace[356129739] 'agreement among raft nodes before linearized reading'  (duration: 465.938874ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:42:50.828843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:42:50.36266Z","time spent":"466.17258ms","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-22T00:42:50.829045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.913319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-22T00:42:50.8291Z","caller":"traceutil/trace.go:171","msg":"trace[126273646] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8308; }","duration":"442.012952ms","start":"2026-04-22T00:42:50.387075Z","end":"2026-04-22T00:42:50.829087Z","steps":["trace[126273646] 'agreement among raft nodes before linearized reading'  (duration: 441.864568ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:42:50.829215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:42:50.387063Z","time spent":"442.061534ms","remote":"127.0.0.1:51896","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":"info","ts":"2026-04-22T00:43:03.245621Z","caller":"traceutil/trace.go:171","msg":"trace[1709687296] linearizableReadLoop","detail":"{readStateIndex:8665; appliedIndex:8664; }","duration":"366.075394ms","start":"2026-04-22T00:43:02.879514Z","end":"2026-04-22T00:43:03.24559Z","steps":["trace[1709687296] 'read index received'  (duration: 353.389828ms)","trace[1709687296] 'applied index is now lower than readState.Index'  (duration: 12.684066ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:43:03.245932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.411653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-22T00:43:03.245985Z","caller":"traceutil/trace.go:171","msg":"trace[112289232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8369; }","duration":"366.473405ms","start":"2026-04-22T00:43:02.8795Z","end":"2026-04-22T00:43:03.245973Z","steps":["trace[112289232] 'agreement among raft nodes before linearized reading'  (duration: 366.28307ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:43:03.246011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:43:02.879489Z","time spent":"366.516526ms","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-22T00:43:03.246153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.960712ms","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-04-22T00:43:03.246202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.519405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:43:03.246215Z","caller":"traceutil/trace.go:171","msg":"trace[698639912] transaction","detail":"{read_only:false; response_revision:8369; number_of_response:1; }","duration":"375.91093ms","start":"2026-04-22T00:43:02.870267Z","end":"2026-04-22T00:43:03.246178Z","steps":["trace[698639912] 'process raft request'  (duration: 362.595156ms)","trace[698639912] 'compare'  (duration: 12.234934ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:43:03.246227Z","caller":"traceutil/trace.go:171","msg":"trace[818063429] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8369; }","duration":"365.103487ms","start":"2026-04-22T00:43:02.881108Z","end":"2026-04-22T00:43:03.246211Z","steps":["trace[818063429] 'agreement among raft nodes before linearized reading'  (duration: 364.884941ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:43:03.24625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.500988ms","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-04-22T00:43:03.246272Z","caller":"traceutil/trace.go:171","msg":"trace[537150105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8369; }","duration":"168.629898ms","start":"2026-04-22T00:43:03.077622Z","end":"2026-04-22T00:43:03.246252Z","steps":["trace[537150105] 'agreement among raft nodes before linearized reading'  (duration: 168.493734ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:43:03.246282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:43:02.881082Z","time spent":"365.187328ms","remote":"127.0.0.1:51896","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-04-22T00:43:03.246284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.776207ms","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-04-22T00:43:03.246316Z","caller":"traceutil/trace.go:171","msg":"trace[945332086] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8369; }","duration":"360.59016ms","start":"2026-04-22T00:43:02.885705Z","end":"2026-04-22T00:43:03.246295Z","steps":["trace[945332086] 'agreement among raft nodes before linearized reading'  (duration: 360.432826ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:43:03.246344Z","caller":"traceutil/trace.go:171","msg":"trace[1515671495] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8369; }","duration":"364.85434ms","start":"2026-04-22T00:43:02.881469Z","end":"2026-04-22T00:43:03.246323Z","steps":["trace[1515671495] 'agreement among raft nodes before linearized reading'  (duration: 364.668925ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:43:03.246366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:43:02.870257Z","time spent":"376.012442ms","remote":"127.0.0.1:51896","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:8359 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-22T00:43:03.246387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:43:02.881459Z","time spent":"364.915571ms","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-22T00:43:03.246385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:43:02.885681Z","time spent":"360.688313ms","remote":"127.0.0.1:51896","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-04-22T00:43:04.203635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.977518ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265329773355770 > lease_revoke:<id:4f3d9db295cc2220>","response":"size:28"}
{"level":"info","ts":"2026-04-22T00:43:04.203747Z","caller":"traceutil/trace.go:171","msg":"trace[312259522] linearizableReadLoop","detail":"{readStateIndex:8672; appliedIndex:8671; }","duration":"240.962665ms","start":"2026-04-22T00:43:03.962765Z","end":"2026-04-22T00:43:04.203728Z","steps":["trace[312259522] 'read index received'  (duration: 103.343µs)","trace[312259522] 'applied index is now lower than readState.Index'  (duration: 240.853392ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:43:04.203941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.213193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:43:04.204021Z","caller":"traceutil/trace.go:171","msg":"trace[1299915151] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:8375; }","duration":"241.341746ms","start":"2026-04-22T00:43:03.962662Z","end":"2026-04-22T00:43:04.204004Z","steps":["trace[1299915151] 'agreement among raft nodes before linearized reading'  (duration: 241.181942ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:43:05.44536Z","caller":"traceutil/trace.go:171","msg":"trace[2123683103] transaction","detail":"{read_only:false; response_revision:8381; number_of_response:1; }","duration":"133.591086ms","start":"2026-04-22T00:43:05.311746Z","end":"2026-04-22T00:43:05.445337Z","steps":["trace[2123683103] 'process raft request'  (duration: 133.410361ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:43:05.446727Z","caller":"traceutil/trace.go:171","msg":"trace[1515432298] linearizableReadLoop","detail":"{readStateIndex:8680; appliedIndex:8677; }","duration":"133.958155ms","start":"2026-04-22T00:43:05.312747Z","end":"2026-04-22T00:43:05.446705Z","steps":["trace[1515432298] 'read index received'  (duration: 132.490644ms)","trace[1515432298] 'applied index is now lower than readState.Index'  (duration: 1.466241ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:43:05.446777Z","caller":"traceutil/trace.go:171","msg":"trace[1819210273] transaction","detail":"{read_only:false; response_revision:8382; number_of_response:1; }","duration":"134.346126ms","start":"2026-04-22T00:43:05.312403Z","end":"2026-04-22T00:43:05.446749Z","steps":["trace[1819210273] 'process raft request'  (duration: 134.149561ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:43:05.446821Z","caller":"traceutil/trace.go:171","msg":"trace[941046940] transaction","detail":"{read_only:false; response_revision:8383; number_of_response:1; }","duration":"134.156671ms","start":"2026-04-22T00:43:05.312634Z","end":"2026-04-22T00:43:05.446791Z","steps":["trace[941046940] 'process raft request'  (duration: 134.032667ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:43:05.446918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.151161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xckmj\" ","response":"range_response_count:1 size:6516"}
{"level":"info","ts":"2026-04-22T00:43:05.446954Z","caller":"traceutil/trace.go:171","msg":"trace[726181163] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xckmj; range_end:; response_count:1; response_revision:8383; }","duration":"134.227264ms","start":"2026-04-22T00:43:05.312718Z","end":"2026-04-22T00:43:05.446945Z","steps":["trace[726181163] 'agreement among raft nodes before linearized reading'  (duration: 134.065758ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:43:32.688152Z","caller":"traceutil/trace.go:171","msg":"trace[1416557284] linearizableReadLoop","detail":"{readStateIndex:8886; appliedIndex:8885; }","duration":"188.232537ms","start":"2026-04-22T00:43:32.499897Z","end":"2026-04-22T00:43:32.68813Z","steps":["trace[1416557284] 'read index received'  (duration: 166.391955ms)","trace[1416557284] 'applied index is now lower than readState.Index'  (duration: 21.839642ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:43:32.688329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.437003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:43:32.688481Z","caller":"traceutil/trace.go:171","msg":"trace[222236010] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:8582; }","duration":"188.598899ms","start":"2026-04-22T00:43:32.499834Z","end":"2026-04-22T00:43:32.688433Z","steps":["trace[222236010] 'agreement among raft nodes before linearized reading'  (duration: 188.383063ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:43:32.689075Z","caller":"traceutil/trace.go:171","msg":"trace[1509605042] transaction","detail":"{read_only:false; response_revision:8582; number_of_response:1; }","duration":"246.324896ms","start":"2026-04-22T00:43:32.442664Z","end":"2026-04-22T00:43:32.688989Z","steps":["trace[1509605042] 'process raft request'  (duration: 223.677361ms)","trace[1509605042] 'compare'  (duration: 21.636557ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:43:36.113522Z","caller":"traceutil/trace.go:171","msg":"trace[1107605311] transaction","detail":"{read_only:false; response_revision:8601; number_of_response:1; }","duration":"189.078301ms","start":"2026-04-22T00:43:35.924407Z","end":"2026-04-22T00:43:36.113486Z","steps":["trace[1107605311] 'process raft request'  (duration: 188.799203ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:43:45.983032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.539352ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265329773356818 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:8673 > 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-04-22T00:43:45.983312Z","caller":"traceutil/trace.go:171","msg":"trace[919153170] linearizableReadLoop","detail":"{readStateIndex:9008; appliedIndex:9006; }","duration":"281.72856ms","start":"2026-04-22T00:43:45.701562Z","end":"2026-04-22T00:43:45.983291Z","steps":["trace[919153170] 'read index received'  (duration: 34.745664ms)","trace[919153170] 'applied index is now lower than readState.Index'  (duration: 246.981506ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:43:45.983485Z","caller":"traceutil/trace.go:171","msg":"trace[148705359] transaction","detail":"{read_only:false; response_revision:8695; number_of_response:1; }","duration":"282.645734ms","start":"2026-04-22T00:43:45.700808Z","end":"2026-04-22T00:43:45.983454Z","steps":["trace[148705359] 'process raft request'  (duration: 35.568396ms)","trace[148705359] 'compare'  (duration: 246.342007ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:43:45.983499Z","caller":"traceutil/trace.go:171","msg":"trace[497857871] transaction","detail":"{read_only:false; response_revision:8696; number_of_response:1; }","duration":"282.018888ms","start":"2026-04-22T00:43:45.701417Z","end":"2026-04-22T00:43:45.983436Z","steps":["trace[497857871] 'process raft request'  (duration: 281.75759ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:43:45.983758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.196312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228442"}
{"level":"info","ts":"2026-04-22T00:43:45.9838Z","caller":"traceutil/trace.go:171","msg":"trace[362899271] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8696; }","duration":"282.273944ms","start":"2026-04-22T00:43:45.701515Z","end":"2026-04-22T00:43:45.983789Z","steps":["trace[362899271] 'agreement among raft nodes before linearized reading'  (duration: 281.851373ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:44:02.192739Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023d4.wal"}
{"level":"info","ts":"2026-04-22T00:45:32.888825Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"597401b06ce1cf3d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-22T00:45:32.89484Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-22T00:45:32.894923Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"warn","ts":"2026-04-22T00:45:50.578254Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265329773359748,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:45:51.079079Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265329773359748,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:45:51.580262Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265329773359748,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:45:52.06136Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.037893035s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-22T00:45:52.061842Z","caller":"traceutil/trace.go:171","msg":"trace[822037671] transaction","detail":"{read_only:false; response_revision:9785; number_of_response:1; }","duration":"2.038490282s","start":"2026-04-22T00:45:50.023321Z","end":"2026-04-22T00:45:52.061811Z","steps":["trace[822037671] 'process raft request'  (duration: 2.038247805s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.062069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.023285Z","time spent":"2.038655116s","remote":"127.0.0.1:51896","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:9773 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-22T00:45:52.077487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000230869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-04-22T00:45:52.077611Z","caller":"traceutil/trace.go:171","msg":"trace[1223854878] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000385864s","start":"2026-04-22T00:45:50.077203Z","end":"2026-04-22T00:45:52.077589Z","steps":["trace[1223854878] 'agreement among raft nodes before linearized reading'  (duration: 2.00025366s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.077662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.077187Z","time spent":"2.000462196s","remote":"127.0.0.1:51634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/04/22 00:45:52 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"info","ts":"2026-04-22T00:45:53.224038Z","caller":"traceutil/trace.go:171","msg":"trace[1303073419] linearizableReadLoop","detail":"{readStateIndex:10129; appliedIndex:10126; }","duration":"3.146739482s","start":"2026-04-22T00:45:50.077243Z","end":"2026-04-22T00:45:53.223983Z","steps":["trace[1303073419] 'read index received'  (duration: 1.984327753s)","trace[1303073419] 'applied index is now lower than readState.Index'  (duration: 1.162410539s)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:45:53.224533Z","caller":"traceutil/trace.go:171","msg":"trace[861806571] transaction","detail":"{read_only:false; response_revision:9787; number_of_response:1; }","duration":"1.687231286s","start":"2026-04-22T00:45:51.53715Z","end":"2026-04-22T00:45:53.224382Z","steps":["trace[861806571] 'process raft request'  (duration: 1.686772943s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.224593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.054963966s","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-04-22T00:45:53.22468Z","caller":"traceutil/trace.go:171","msg":"trace[525183687] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9787; }","duration":"3.05509993s","start":"2026-04-22T00:45:50.169561Z","end":"2026-04-22T00:45:53.224661Z","steps":["trace[525183687] 'agreement among raft nodes before linearized reading'  (duration: 3.054862853s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.224721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.169545Z","time spent":"3.055169941s","remote":"127.0.0.1:51896","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-04-22T00:45:53.224685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.69874952s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:45:53.224565Z","caller":"traceutil/trace.go:171","msg":"trace[1986285786] transaction","detail":"{read_only:false; response_revision:9786; number_of_response:1; }","duration":"2.517076392s","start":"2026-04-22T00:45:50.707414Z","end":"2026-04-22T00:45:53.224491Z","steps":["trace[1986285786] 'process raft request'  (duration: 2.51627775s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.224735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:51.537117Z","time spent":"1.687502844s","remote":"127.0.0.1:51896","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:9783 > 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-04-22T00:45:53.224783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.538655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:45:53.224932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.838800421s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-22T00:45:53.224959Z","caller":"traceutil/trace.go:171","msg":"trace[1245469133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9787; }","duration":"2.838827012s","start":"2026-04-22T00:45:50.386126Z","end":"2026-04-22T00:45:53.224953Z","steps":["trace[1245469133] 'agreement among raft nodes before linearized reading'  (duration: 2.83875675s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.224977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.386056Z","time spent":"2.838916694s","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-22T00:45:53.224962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.564201155s","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-04-22T00:45:53.225041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.595107213s","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-04-22T00:45:53.225071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.932076169s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:45:53.224917Z","caller":"traceutil/trace.go:171","msg":"trace[1111394840] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9787; }","duration":"609.708559ms","start":"2026-04-22T00:45:52.615196Z","end":"2026-04-22T00:45:53.224904Z","steps":["trace[1111394840] 'agreement among raft nodes before linearized reading'  (duration: 609.560775ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:53.225091Z","caller":"traceutil/trace.go:171","msg":"trace[419797891] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:9787; }","duration":"2.93213676s","start":"2026-04-22T00:45:50.292948Z","end":"2026-04-22T00:45:53.225085Z","steps":["trace[419797891] 'agreement among raft nodes before linearized reading'  (duration: 2.932095629s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:53.225086Z","caller":"traceutil/trace.go:171","msg":"trace[1896824140] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9787; }","duration":"2.595251047s","start":"2026-04-22T00:45:50.629822Z","end":"2026-04-22T00:45:53.225073Z","steps":["trace[1896824140] 'agreement among raft nodes before linearized reading'  (duration: 2.59498848s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.225113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.292937Z","time spent":"2.932170621s","remote":"127.0.0.1:51908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":4,"response size":30,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "}
{"level":"info","ts":"2026-04-22T00:45:53.225115Z","caller":"traceutil/trace.go:171","msg":"trace[980704824] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9787; }","duration":"2.564428832s","start":"2026-04-22T00:45:50.660637Z","end":"2026-04-22T00:45:53.225065Z","steps":["trace[980704824] 'agreement among raft nodes before linearized reading'  (duration: 2.564004959s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.225224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.014308973s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:45:53.225128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.629787Z","time spent":"2.595331379s","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-22T00:45:53.225286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.145130204s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:45:53.225259Z","caller":"traceutil/trace.go:171","msg":"trace[857402289] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:9787; }","duration":"1.014389145s","start":"2026-04-22T00:45:52.210861Z","end":"2026-04-22T00:45:53.22525Z","steps":["trace[857402289] 'agreement among raft nodes before linearized reading'  (duration: 1.014314163s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:53.225347Z","caller":"traceutil/trace.go:171","msg":"trace[661766674] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9787; }","duration":"1.145182175s","start":"2026-04-22T00:45:52.08015Z","end":"2026-04-22T00:45:53.225332Z","steps":["trace[661766674] 'agreement among raft nodes before linearized reading'  (duration: 1.145119054s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.224722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.363703508s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xckmj\" ","response":"range_response_count:1 size:6516"}
{"level":"warn","ts":"2026-04-22T00:45:53.22541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.683341327s","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-04-22T00:45:53.225443Z","caller":"traceutil/trace.go:171","msg":"trace[846627959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9787; }","duration":"1.683403329s","start":"2026-04-22T00:45:51.542033Z","end":"2026-04-22T00:45:53.225436Z","steps":["trace[846627959] 'agreement among raft nodes before linearized reading'  (duration: 1.683336527s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.225466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:51.542022Z","time spent":"1.68344072s","remote":"127.0.0.1:51896","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":"warn","ts":"2026-04-22T00:45:53.225493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.125232207s","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-04-22T00:45:53.225441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:52.210836Z","time spent":"1.01454272s","remote":"127.0.0.1:56586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "}
{"level":"info","ts":"2026-04-22T00:45:53.225531Z","caller":"traceutil/trace.go:171","msg":"trace[1141853536] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9787; }","duration":"2.125328791s","start":"2026-04-22T00:45:51.100193Z","end":"2026-04-22T00:45:53.225522Z","steps":["trace[1141853536] 'agreement among raft nodes before linearized reading'  (duration: 2.125230958s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.225566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:51.100161Z","time spent":"2.125398212s","remote":"127.0.0.1:51896","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":"warn","ts":"2026-04-22T00:45:53.225235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.707392Z","time spent":"2.517478154s","remote":"127.0.0.1:51896","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:9779 > 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-04-22T00:45:53.225222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.660597Z","time spent":"2.564610017s","remote":"127.0.0.1:51896","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-04-22T00:45:53.225117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:52.615163Z","time spent":"609.945136ms","remote":"127.0.0.1:51634","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-04-22T00:45:53.224783Z","caller":"traceutil/trace.go:171","msg":"trace[1647825709] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:9787; }","duration":"2.698932406s","start":"2026-04-22T00:45:50.525826Z","end":"2026-04-22T00:45:53.224758Z","steps":["trace[1647825709] 'agreement among raft nodes before linearized reading'  (duration: 2.698756921s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.225864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.525794Z","time spent":"2.700041167s","remote":"127.0.0.1:51096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:45:53.225233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.950795054s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:45:53.22525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.371772654s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-04-22T00:45:53.225935Z","caller":"traceutil/trace.go:171","msg":"trace[1964020968] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9787; }","duration":"1.372501945s","start":"2026-04-22T00:45:51.853421Z","end":"2026-04-22T00:45:53.225923Z","steps":["trace[1964020968] 'agreement among raft nodes before linearized reading'  (duration: 1.371761834s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:53.225957Z","caller":"traceutil/trace.go:171","msg":"trace[1396989085] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:9787; }","duration":"2.951538634s","start":"2026-04-22T00:45:50.274376Z","end":"2026-04-22T00:45:53.225914Z","steps":["trace[1396989085] 'agreement among raft nodes before linearized reading'  (duration: 2.950830995s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.225984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:51.853394Z","time spent":"1.372577536s","remote":"127.0.0.1:51796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-04-22T00:45:53.226063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.274346Z","time spent":"2.951648618s","remote":"127.0.0.1:56756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "}
{"level":"info","ts":"2026-04-22T00:45:53.225514Z","caller":"traceutil/trace.go:171","msg":"trace[2009474765] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xckmj; range_end:; response_count:1; response_revision:9787; }","duration":"2.364491711s","start":"2026-04-22T00:45:50.860966Z","end":"2026-04-22T00:45:53.225458Z","steps":["trace[2009474765] 'agreement among raft nodes before linearized reading'  (duration: 2.363592665s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.2254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:52.08009Z","time spent":"1.145297429s","remote":"127.0.0.1:51624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-22T00:45:53.226175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.860945Z","time spent":"2.365218351s","remote":"127.0.0.1:51796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6539,"request content":"key:\"/registry/pods/openstack/keepalived-xckmj\" "}
{"level":"info","ts":"2026-04-22T00:45:53.336032Z","caller":"traceutil/trace.go:171","msg":"trace[1311889982] transaction","detail":"{read_only:false; response_revision:9790; number_of_response:1; }","duration":"104.382638ms","start":"2026-04-22T00:45:53.231623Z","end":"2026-04-22T00:45:53.336006Z","steps":["trace[1311889982] 'process raft request'  (duration: 104.295386ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:53.336118Z","caller":"traceutil/trace.go:171","msg":"trace[187597294] transaction","detail":"{read_only:false; response_revision:9789; number_of_response:1; }","duration":"104.446951ms","start":"2026-04-22T00:45:53.231616Z","end":"2026-04-22T00:45:53.336063Z","steps":["trace[187597294] 'process raft request'  (duration: 104.116372ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:53.336493Z","caller":"traceutil/trace.go:171","msg":"trace[1127242446] transaction","detail":"{read_only:false; response_revision:9791; number_of_response:1; }","duration":"104.79073ms","start":"2026-04-22T00:45:53.231685Z","end":"2026-04-22T00:45:53.336475Z","steps":["trace[1127242446] 'process raft request'  (duration: 104.283266ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:53.336596Z","caller":"traceutil/trace.go:171","msg":"trace[127409145] transaction","detail":"{read_only:false; response_revision:9792; number_of_response:1; }","duration":"103.602137ms","start":"2026-04-22T00:45:53.232956Z","end":"2026-04-22T00:45:53.336558Z","steps":["trace[127409145] 'process raft request'  (duration: 103.35757ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:53.336673Z","caller":"traceutil/trace.go:171","msg":"trace[269536249] transaction","detail":"{read_only:false; response_revision:9793; number_of_response:1; }","duration":"103.698779ms","start":"2026-04-22T00:45:53.232956Z","end":"2026-04-22T00:45:53.336655Z","steps":["trace[269536249] 'process raft request'  (duration: 103.539375ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:53.336881Z","caller":"traceutil/trace.go:171","msg":"trace[407976761] linearizableReadLoop","detail":"{readStateIndex:10136; appliedIndex:10129; }","duration":"103.667909ms","start":"2026-04-22T00:45:53.233184Z","end":"2026-04-22T00:45:53.336852Z","steps":["trace[407976761] 'read index received'  (duration: 40.99388ms)","trace[407976761] 'applied index is now lower than readState.Index'  (duration: 62.670949ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:45:53.336929Z","caller":"traceutil/trace.go:171","msg":"trace[216438428] transaction","detail":"{read_only:false; response_revision:9794; number_of_response:1; }","duration":"103.791203ms","start":"2026-04-22T00:45:53.233115Z","end":"2026-04-22T00:45:53.336907Z","steps":["trace[216438428] 'process raft request'  (duration: 103.493324ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.337114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.912155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-04-22T00:45:53.337142Z","caller":"traceutil/trace.go:171","msg":"trace[1114091700] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9794; }","duration":"103.986239ms","start":"2026-04-22T00:45:53.233146Z","end":"2026-04-22T00:45:53.337133Z","steps":["trace[1114091700] 'agreement among raft nodes before linearized reading'  (duration: 103.831574ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.337132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.190856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:45:53.337203Z","caller":"traceutil/trace.go:171","msg":"trace[92201058] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9794; }","duration":"103.272368ms","start":"2026-04-22T00:45:53.233918Z","end":"2026-04-22T00:45:53.33719Z","steps":["trace[92201058] 'agreement among raft nodes before linearized reading'  (duration: 103.128174ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.337296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.610712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"}
{"level":"info","ts":"2026-04-22T00:45:53.337413Z","caller":"traceutil/trace.go:171","msg":"trace[248450851] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:9794; }","duration":"101.765846ms","start":"2026-04-22T00:45:53.235629Z","end":"2026-04-22T00:45:53.337395Z","steps":["trace[248450851] 'agreement among raft nodes before linearized reading'  (duration: 101.433817ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:53.521501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.731487ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265329773359764 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:9749 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T00:45:53.521609Z","caller":"traceutil/trace.go:171","msg":"trace[220415878] linearizableReadLoop","detail":"{readStateIndex:10137; appliedIndex:10136; }","duration":"111.645872ms","start":"2026-04-22T00:45:53.409947Z","end":"2026-04-22T00:45:53.521593Z","steps":["trace[220415878] 'read index received'  (duration: 10.661738ms)","trace[220415878] 'applied index is now lower than readState.Index'  (duration: 100.982634ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:45:53.521686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.746554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:45:53.521666Z","caller":"traceutil/trace.go:171","msg":"trace[130747784] transaction","detail":"{read_only:false; response_revision:9795; number_of_response:1; }","duration":"139.027661ms","start":"2026-04-22T00:45:53.382597Z","end":"2026-04-22T00:45:53.521624Z","steps":["trace[130747784] 'process raft request'  (duration: 38.078108ms)","trace[130747784] 'compare'  (duration: 100.446389ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:45:53.521718Z","caller":"traceutil/trace.go:171","msg":"trace[1601452258] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:9795; }","duration":"111.806467ms","start":"2026-04-22T00:45:53.409902Z","end":"2026-04-22T00:45:53.521709Z","steps":["trace[1601452258] 'agreement among raft nodes before linearized reading'  (duration: 111.734614ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.294213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.842622ms","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-04-22T00:46:12.294317Z","caller":"traceutil/trace.go:171","msg":"trace[2115783051] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9909; }","duration":"852.956725ms","start":"2026-04-22T00:46:11.441337Z","end":"2026-04-22T00:46:12.294294Z","steps":["trace[2115783051] 'range keys from in-memory index tree'  (duration: 852.634307ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.294371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:11.441248Z","time spent":"853.10879ms","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-22T00:46:12.295034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.5034ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265329773360056 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:9900 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T00:46:12.295136Z","caller":"traceutil/trace.go:171","msg":"trace[1980365326] transaction","detail":"{read_only:false; response_revision:9910; number_of_response:1; }","duration":"853.590013ms","start":"2026-04-22T00:46:11.441522Z","end":"2026-04-22T00:46:12.295112Z","steps":["trace[1980365326] 'process raft request'  (duration: 25.892077ms)","trace[1980365326] 'compare'  (duration: 827.015527ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:12.295229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:11.4415Z","time spent":"853.684896ms","remote":"127.0.0.1:51896","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:9900 > 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":"info","ts":"2026-04-22T00:46:12.295258Z","caller":"traceutil/trace.go:171","msg":"trace[1476068258] linearizableReadLoop","detail":"{readStateIndex:10256; appliedIndex:10255; }","duration":"853.344866ms","start":"2026-04-22T00:46:11.441856Z","end":"2026-04-22T00:46:12.295201Z","steps":["trace[1476068258] 'read index received'  (duration: 25.498465ms)","trace[1476068258] 'applied index is now lower than readState.Index'  (duration: 827.840671ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:12.29563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.993333ms","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-04-22T00:46:12.295653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.111407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:46:12.295626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.739818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-22T00:46:12.295713Z","caller":"traceutil/trace.go:171","msg":"trace[1817637770] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9911; }","duration":"849.116057ms","start":"2026-04-22T00:46:11.446577Z","end":"2026-04-22T00:46:12.295693Z","steps":["trace[1817637770] 'agreement among raft nodes before linearized reading'  (duration: 848.88061ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.295722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.395403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-04-22T00:46:12.295724Z","caller":"traceutil/trace.go:171","msg":"trace[1464019550] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:9911; }","duration":"601.22481ms","start":"2026-04-22T00:46:11.69448Z","end":"2026-04-22T00:46:12.295705Z","steps":["trace[1464019550] 'agreement among raft nodes before linearized reading'  (duration: 601.112427ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.295734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.094717ms","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-04-22T00:46:12.29575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:11.446565Z","time spent":"849.179449ms","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-04-22T00:46:12.295764Z","caller":"traceutil/trace.go:171","msg":"trace[1621513980] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9911; }","duration":"845.459505ms","start":"2026-04-22T00:46:11.450293Z","end":"2026-04-22T00:46:12.295753Z","steps":["trace[1621513980] 'agreement among raft nodes before linearized reading'  (duration: 845.339001ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:12.295759Z","caller":"traceutil/trace.go:171","msg":"trace[567809951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9911; }","duration":"853.939583ms","start":"2026-04-22T00:46:11.441788Z","end":"2026-04-22T00:46:12.295728Z","steps":["trace[567809951] 'agreement among raft nodes before linearized reading'  (duration: 853.519621ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:12.295783Z","caller":"traceutil/trace.go:171","msg":"trace[825318853] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9911; }","duration":"849.164148ms","start":"2026-04-22T00:46:11.446606Z","end":"2026-04-22T00:46:12.29577Z","steps":["trace[825318853] 'agreement among raft nodes before linearized reading'  (duration: 849.028694ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.295784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:11.694453Z","time spent":"601.315743ms","remote":"127.0.0.1:52002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:12.295779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.107544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xckmj\" ","response":"range_response_count:1 size:6516"}
{"level":"warn","ts":"2026-04-22T00:46:12.295799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:11.450281Z","time spent":"845.511857ms","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-22T00:46:12.295819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:11.446591Z","time spent":"849.22014ms","remote":"127.0.0.1:51896","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-04-22T00:46:12.295822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:11.441766Z","time spent":"854.045016ms","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-04-22T00:46:12.29584Z","caller":"traceutil/trace.go:171","msg":"trace[947782803] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xckmj; range_end:; response_count:1; response_revision:9911; }","duration":"845.208887ms","start":"2026-04-22T00:46:11.450617Z","end":"2026-04-22T00:46:12.295826Z","steps":["trace[947782803] 'agreement among raft nodes before linearized reading'  (duration: 844.859077ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.295826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.960091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-6c8689d955-dq8xq.18a8871158d102a8\" ","response":"range_response_count:1 size:1133"}
{"level":"info","ts":"2026-04-22T00:46:12.295924Z","caller":"traceutil/trace.go:171","msg":"trace[1392787679] range","detail":"{range_begin:/registry/events/openstack/barbican-api-6c8689d955-dq8xq.18a8871158d102a8; range_end:; response_count:1; response_revision:9911; }","duration":"721.102705ms","start":"2026-04-22T00:46:11.574804Z","end":"2026-04-22T00:46:12.295907Z","steps":["trace[1392787679] 'agreement among raft nodes before linearized reading'  (duration: 720.871658ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.295926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:11.450612Z","time spent":"845.304319ms","remote":"127.0.0.1:51796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6539,"request content":"key:\"/registry/pods/openstack/keepalived-xckmj\" "}
{"level":"warn","ts":"2026-04-22T00:46:12.295954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:11.57478Z","time spent":"721.167826ms","remote":"127.0.0.1:51692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1156,"request content":"key:\"/registry/events/openstack/barbican-api-6c8689d955-dq8xq.18a8871158d102a8\" "}
{"level":"warn","ts":"2026-04-22T00:46:13.212599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.372122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:46:13.21273Z","caller":"traceutil/trace.go:171","msg":"trace[801031607] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:9917; }","duration":"546.574528ms","start":"2026-04-22T00:46:12.66613Z","end":"2026-04-22T00:46:13.212705Z","steps":["trace[801031607] 'count revisions from in-memory index tree'  (duration: 546.28796ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:13.212792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:12.666116Z","time spent":"546.660251ms","remote":"127.0.0.1:52068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":12,"response size":30,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:26.859716Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265329773360299,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:27.360718Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265329773360299,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:27.861577Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265329773360299,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:28.362376Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265329773360299,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:28.863173Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265329773360299,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:29.363343Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265329773360299,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:29.864272Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265329773360299,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:30.077946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00050826s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-04-22T00:46:30.078084Z","caller":"traceutil/trace.go:171","msg":"trace[981371830] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000686335s","start":"2026-04-22T00:46:28.077371Z","end":"2026-04-22T00:46:30.078058Z","steps":["trace[981371830] 'agreement among raft nodes before linearized reading'  (duration: 2.000547071s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:30.07814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:28.077351Z","time spent":"2.000777407s","remote":"127.0.0.1:51634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/04/22 00:46:30 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-22T00:46:30.364839Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265329773360299,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:30.865407Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265329773360299,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:31.337066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:26.340287Z","time spent":"4.996771992s","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-04-22T00:46:31.366295Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265329773360299,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:31.372593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999435908s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-04-22T00:46:31.372645Z","caller":"traceutil/trace.go:171","msg":"trace[1065713607] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999537431s","start":"2026-04-22T00:46:26.373092Z","end":"2026-04-22T00:46:31.37263Z","steps":["trace[1065713607] 'agreement among raft nodes before linearized reading'  (duration: 4.999464159s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:31.37268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:26.373078Z","time spent":"4.999594513s","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
2026/04/22 00:46:31 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-22T00:46:31.396647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.000099416s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-04-22T00:46:31.39678Z","caller":"traceutil/trace.go:171","msg":"trace[1852007762] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"5.000268151s","start":"2026-04-22T00:46:26.396488Z","end":"2026-04-22T00:46:31.396756Z","steps":["trace[1852007762] 'agreement among raft nodes before linearized reading'  (duration: 5.000118257s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:31.396829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:26.396476Z","time spent":"5.000342283s","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
2026/04/22 00:46:31 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-22T00:46:31.397667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999790788s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-04-22T00:46:31.39776Z","caller":"traceutil/trace.go:171","msg":"trace[659332858] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999919982s","start":"2026-04-22T00:46:26.397818Z","end":"2026-04-22T00:46:31.397738Z","steps":["trace[659332858] 'agreement among raft nodes before linearized reading'  (duration: 4.999807478s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:31.397826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:26.397803Z","time spent":"5.000008034s","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
2026/04/22 00:46:31 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-22T00:46:31.866896Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265329773360299,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:32.078153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.9998146s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-04-22T00:46:32.07829Z","caller":"traceutil/trace.go:171","msg":"trace[493560919] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999992805s","start":"2026-04-22T00:46:30.078278Z","end":"2026-04-22T00:46:32.078271Z","steps":["trace[493560919] 'agreement among raft nodes before linearized reading'  (duration: 1.999834041s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.078339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:30.078266Z","time spent":"2.000063317s","remote":"127.0.0.1:51624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/04/22 00:46:32 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-22T00:46:32.114294Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"5.773834276s","expected-duration":"1s"}
{"level":"warn","ts":"2026-04-22T00:46:32.425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.426138Z","time spent":"4.998854982s","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/04/22 00:46:32 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"info","ts":"2026-04-22T00:46:32.468709Z","caller":"traceutil/trace.go:171","msg":"trace[933000665] linearizableReadLoop","detail":"{readStateIndex:10357; appliedIndex:10353; }","duration":"6.110073582s","start":"2026-04-22T00:46:26.35859Z","end":"2026-04-22T00:46:32.468664Z","steps":["trace[933000665] 'read index received'  (duration: 5.756012935s)","trace[933000665] 'applied index is now lower than readState.Index'  (duration: 354.059697ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:32.468809Z","caller":"traceutil/trace.go:171","msg":"trace[1183845101] transaction","detail":"{read_only:false; response_revision:10006; number_of_response:1; }","duration":"5.033612429s","start":"2026-04-22T00:46:27.435142Z","end":"2026-04-22T00:46:32.468755Z","steps":["trace[1183845101] 'process raft request'  (duration: 5.033376973s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.468845Z","caller":"traceutil/trace.go:171","msg":"trace[343084437] transaction","detail":"{read_only:false; response_revision:10007; number_of_response:1; }","duration":"3.036218597s","start":"2026-04-22T00:46:29.432554Z","end":"2026-04-22T00:46:32.468773Z","steps":["trace[343084437] 'process raft request'  (duration: 3.036068443s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.468971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.105857443s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-04-22T00:46:32.468985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.11038755s","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-04-22T00:46:32.468966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.435117Z","time spent":"5.033755603s","remote":"127.0.0.1:51896","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:10001 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-22T00:46:32.469024Z","caller":"traceutil/trace.go:171","msg":"trace[367338901] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:10007; }","duration":"6.110437222s","start":"2026-04-22T00:46:26.358577Z","end":"2026-04-22T00:46:32.469014Z","steps":["trace[367338901] 'agreement among raft nodes before linearized reading'  (duration: 6.110231516s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.469008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.059421529s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-22T00:46:32.469051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:29.432537Z","time spent":"3.036412203s","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:9950 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-04-22T00:46:32.469081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.642821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:46:32.469125Z","caller":"traceutil/trace.go:171","msg":"trace[1765153295] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:10007; }","duration":"904.724643ms","start":"2026-04-22T00:46:31.564387Z","end":"2026-04-22T00:46:32.469112Z","steps":["trace[1765153295] 'agreement among raft nodes before linearized reading'  (duration: 904.660242ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.469014Z","caller":"traceutil/trace.go:171","msg":"trace[480152720] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:10007; }","duration":"6.105935225s","start":"2026-04-22T00:46:26.363066Z","end":"2026-04-22T00:46:32.469001Z","steps":["trace[480152720] 'agreement among raft nodes before linearized reading'  (duration: 6.105785881s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.46916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.130225685s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"}
{"level":"warn","ts":"2026-04-22T00:46:32.469253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.464212236s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:46:32.469289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.762054199s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:1 size:131"}
{"level":"warn","ts":"2026-04-22T00:46:32.469294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.01569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:46:32.469308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.56613182s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:46:32.46905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.694498605s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"info","ts":"2026-04-22T00:46:32.469322Z","caller":"traceutil/trace.go:171","msg":"trace[1019270896] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:1; response_revision:10007; }","duration":"3.762125901s","start":"2026-04-22T00:46:28.707188Z","end":"2026-04-22T00:46:32.469314Z","steps":["trace[1019270896] 'agreement among raft nodes before linearized reading'  (duration: 3.762036189s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.469325Z","caller":"traceutil/trace.go:171","msg":"trace[254179696] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:10007; }","duration":"4.464305238s","start":"2026-04-22T00:46:28.004994Z","end":"2026-04-22T00:46:32.4693Z","steps":["trace[254179696] 'agreement among raft nodes before linearized reading'  (duration: 4.464204465s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.469346Z","caller":"traceutil/trace.go:171","msg":"trace[1585942770] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:10007; }","duration":"3.566207062s","start":"2026-04-22T00:46:28.903127Z","end":"2026-04-22T00:46:32.469334Z","steps":["trace[1585942770] 'agreement among raft nodes before linearized reading'  (duration: 3.56615989s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.469352Z","caller":"traceutil/trace.go:171","msg":"trace[879475355] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:10007; }","duration":"1.694850735s","start":"2026-04-22T00:46:30.774485Z","end":"2026-04-22T00:46:32.469336Z","steps":["trace[879475355] 'agreement among raft nodes before linearized reading'  (duration: 1.694384772s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.469361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:28.707169Z","time spent":"3.762181582s","remote":"127.0.0.1:51652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.3\" "}
{"level":"info","ts":"2026-04-22T00:46:32.469298Z","caller":"traceutil/trace.go:171","msg":"trace[901145616] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:10007; }","duration":"1.130380619s","start":"2026-04-22T00:46:31.338899Z","end":"2026-04-22T00:46:32.46928Z","steps":["trace[901145616] 'agreement among raft nodes before linearized reading'  (duration: 1.130197914s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.469371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.062993217s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xckmj\" ","response":"range_response_count:1 size:6516"}
{"level":"warn","ts":"2026-04-22T00:46:32.469376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:28.004979Z","time spent":"4.46438638s","remote":"127.0.0.1:54360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:32.469395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:28.903106Z","time spent":"3.566264163s","remote":"127.0.0.1:56508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:32.46926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.621070853s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:46:32.469409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:31.338887Z","time spent":"1.130508223s","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":549,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "}
{"level":"info","ts":"2026-04-22T00:46:32.469442Z","caller":"traceutil/trace.go:171","msg":"trace[718721699] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:10007; }","duration":"3.62125188s","start":"2026-04-22T00:46:28.848179Z","end":"2026-04-22T00:46:32.469431Z","steps":["trace[718721699] 'agreement among raft nodes before linearized reading'  (duration: 3.621037753s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.46946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.071445687s","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-04-22T00:46:32.469294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.864031482s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:46:32.469056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.977541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a8873df86ba618\" ","response":"range_response_count:1 size:774"}
{"level":"warn","ts":"2026-04-22T00:46:32.469483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:28.848089Z","time spent":"3.621383723s","remote":"127.0.0.1:56794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "}
{"level":"info","ts":"2026-04-22T00:46:32.469491Z","caller":"traceutil/trace.go:171","msg":"trace[1982301558] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:10007; }","duration":"6.071506709s","start":"2026-04-22T00:46:26.397971Z","end":"2026-04-22T00:46:32.469478Z","steps":["trace[1982301558] 'agreement among raft nodes before linearized reading'  (duration: 6.071444767s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.469164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:31.564365Z","time spent":"904.790716ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "}
{"level":"info","ts":"2026-04-22T00:46:32.469505Z","caller":"traceutil/trace.go:171","msg":"trace[1162591350] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:10007; }","duration":"5.86427685s","start":"2026-04-22T00:46:26.605217Z","end":"2026-04-22T00:46:32.469494Z","steps":["trace[1162591350] 'agreement among raft nodes before linearized reading'  (duration: 5.864057413s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.469524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:26.397948Z","time spent":"6.07156908s","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-04-22T00:46:32.469351Z","caller":"traceutil/trace.go:171","msg":"trace[1054671165] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10007; }","duration":"384.106863ms","start":"2026-04-22T00:46:32.085226Z","end":"2026-04-22T00:46:32.469332Z","steps":["trace[1054671165] 'agreement among raft nodes before linearized reading'  (duration: 384.02141ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.469601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:32.085207Z","time spent":"384.388011ms","remote":"127.0.0.1:51634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-22T00:46:32.469644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.842175078s","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":"warn","ts":"2026-04-22T00:46:32.469057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:26.358515Z","time spent":"6.110531355s","remote":"127.0.0.1:51896","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-04-22T00:46:32.469398Z","caller":"traceutil/trace.go:171","msg":"trace[298651218] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xckmj; range_end:; response_count:1; response_revision:10007; }","duration":"6.063037149s","start":"2026-04-22T00:46:26.406353Z","end":"2026-04-22T00:46:32.46939Z","steps":["trace[298651218] 'agreement among raft nodes before linearized reading'  (duration: 6.062957427s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.469554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:26.605193Z","time spent":"5.864348242s","remote":"127.0.0.1:59746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:32.469255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.44633253s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:46:32.469735Z","caller":"traceutil/trace.go:171","msg":"trace[715006243] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:10007; }","duration":"3.446852445s","start":"2026-04-22T00:46:29.022869Z","end":"2026-04-22T00:46:32.469721Z","steps":["trace[715006243] 'agreement among raft nodes before linearized reading'  (duration: 3.446315289s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.469182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:26.363057Z","time spent":"6.10611041s","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-04-22T00:46:32.469515Z","caller":"traceutil/trace.go:171","msg":"trace[1562795298] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18a8873df86ba618; range_end:; response_count:1; response_revision:10007; }","duration":"388.503466ms","start":"2026-04-22T00:46:32.081Z","end":"2026-04-22T00:46:32.469503Z","steps":["trace[1562795298] 'agreement among raft nodes before linearized reading'  (duration: 387.867158ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.469786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:29.022848Z","time spent":"3.446915648s","remote":"127.0.0.1:51674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":92,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:32.469695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:26.406341Z","time spent":"6.063344328s","remote":"127.0.0.1:51796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6539,"request content":"key:\"/registry/pods/openstack/keepalived-xckmj\" "}
{"level":"info","ts":"2026-04-22T00:46:32.469816Z","caller":"traceutil/trace.go:171","msg":"trace[72723834] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:10007; }","duration":"1.8422443s","start":"2026-04-22T00:46:30.627417Z","end":"2026-04-22T00:46:32.469661Z","steps":["trace[72723834] 'agreement among raft nodes before linearized reading'  (duration: 1.842165597s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.469399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:30.774468Z","time spent":"1.694916856s","remote":"127.0.0.1:51770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1804,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" "}
{"level":"warn","ts":"2026-04-22T00:46:32.46986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:30.627395Z","time spent":"1.842454626s","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"warn","ts":"2026-04-22T00:46:32.469167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.310833729s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"warn","ts":"2026-04-22T00:46:32.469811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:32.080977Z","time spent":"388.815615ms","remote":"127.0.0.1:51692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a8873df86ba618\" "}
{"level":"info","ts":"2026-04-22T00:46:32.469933Z","caller":"traceutil/trace.go:171","msg":"trace[1853489632] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:10007; }","duration":"3.311633022s","start":"2026-04-22T00:46:29.158287Z","end":"2026-04-22T00:46:32.46992Z","steps":["trace[1853489632] 'agreement among raft nodes before linearized reading'  (duration: 3.310796628s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.470211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.834438523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-04-22T00:46:32.470237Z","caller":"traceutil/trace.go:171","msg":"trace[120428139] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:10007; }","duration":"2.834464393s","start":"2026-04-22T00:46:29.635765Z","end":"2026-04-22T00:46:32.47023Z","steps":["trace[120428139] 'agreement among raft nodes before linearized reading'  (duration: 2.834400862s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.470255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:29.635738Z","time spent":"2.834512775s","remote":"127.0.0.1:51896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "}
{"level":"warn","ts":"2026-04-22T00:46:32.469061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.162139748s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:46:32.470417Z","caller":"traceutil/trace.go:171","msg":"trace[1732308366] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:10007; }","duration":"3.163522447s","start":"2026-04-22T00:46:29.306874Z","end":"2026-04-22T00:46:32.470397Z","steps":["trace[1732308366] 'agreement among raft nodes before linearized reading'  (duration: 3.162159628s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.470485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:29.306853Z","time spent":"3.163608299s","remote":"127.0.0.1:60828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true "}
{"level":"info","ts":"2026-04-22T00:46:32.470728Z","caller":"traceutil/trace.go:171","msg":"trace[1139260113] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:10007; }","duration":"3.059601694s","start":"2026-04-22T00:46:29.409495Z","end":"2026-04-22T00:46:32.469096Z","steps":["trace[1139260113] 'agreement among raft nodes before linearized reading'  (duration: 3.059363307s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.470798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:29.409468Z","time spent":"3.061311853s","remote":"127.0.0.1:60860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":29,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:32.469975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:29.158268Z","time spent":"3.311694344s","remote":"127.0.0.1:51796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-04-22T00:46:32.617112Z","caller":"traceutil/trace.go:171","msg":"trace[218097889] transaction","detail":"{read_only:false; response_revision:10014; number_of_response:1; }","duration":"121.872017ms","start":"2026-04-22T00:46:32.495173Z","end":"2026-04-22T00:46:32.617045Z","steps":["trace[218097889] 'process raft request'  (duration: 76.003357ms)","trace[218097889] 'compare'  (duration: 45.695735ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:32.617233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.424962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:46:32.617312Z","caller":"traceutil/trace.go:171","msg":"trace[2121871165] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:10014; }","duration":"112.544435ms","start":"2026-04-22T00:46:32.504744Z","end":"2026-04-22T00:46:32.617289Z","steps":["trace[2121871165] 'agreement among raft nodes before linearized reading'  (duration: 112.321118ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:48.811483Z","caller":"traceutil/trace.go:171","msg":"trace[311321205] linearizableReadLoop","detail":"{readStateIndex:10486; appliedIndex:10485; }","duration":"101.810063ms","start":"2026-04-22T00:46:48.709647Z","end":"2026-04-22T00:46:48.811457Z","steps":["trace[311321205] 'read index received'  (duration: 93.8972ms)","trace[311321205] 'applied index is now lower than readState.Index'  (duration: 7.911943ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:48.811501Z","caller":"traceutil/trace.go:171","msg":"trace[2014030692] transaction","detail":"{read_only:false; response_revision:10132; number_of_response:1; }","duration":"123.653727ms","start":"2026-04-22T00:46:48.687819Z","end":"2026-04-22T00:46:48.811473Z","steps":["trace[2014030692] 'process raft request'  (duration: 115.708804ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:48.811802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.975119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/glance-storage-init-lgzn4\" ","response":"range_response_count:1 size:9661"}
{"level":"info","ts":"2026-04-22T00:46:48.81197Z","caller":"traceutil/trace.go:171","msg":"trace[1765001111] range","detail":"{range_begin:/registry/pods/openstack/glance-storage-init-lgzn4; range_end:; response_count:1; response_revision:10132; }","duration":"122.185395ms","start":"2026-04-22T00:46:48.689757Z","end":"2026-04-22T00:46:48.811943Z","steps":["trace[1765001111] 'agreement among raft nodes before linearized reading'  (duration: 121.830925ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:48.81277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.004254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:1 size:131"}
{"level":"info","ts":"2026-04-22T00:46:48.812825Z","caller":"traceutil/trace.go:171","msg":"trace[164366581] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:1; response_revision:10132; }","duration":"105.083605ms","start":"2026-04-22T00:46:48.707729Z","end":"2026-04-22T00:46:48.812813Z","steps":["trace[164366581] 'agreement among raft nodes before linearized reading'  (duration: 104.94047ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:48.82835Z","caller":"traceutil/trace.go:171","msg":"trace[281105238] transaction","detail":"{read_only:false; response_revision:10133; number_of_response:1; }","duration":"114.384307ms","start":"2026-04-22T00:46:48.713939Z","end":"2026-04-22T00:46:48.828323Z","steps":["trace[281105238] 'process raft request'  (duration: 114.229713ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:48.828432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.869947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xckmj\" ","response":"range_response_count:1 size:6516"}
{"level":"warn","ts":"2026-04-22T00:46:48.82844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.655652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:46:48.828486Z","caller":"traceutil/trace.go:171","msg":"trace[135301644] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xckmj; range_end:; response_count:1; response_revision:10133; }","duration":"116.955269ms","start":"2026-04-22T00:46:48.711517Z","end":"2026-04-22T00:46:48.828472Z","steps":["trace[135301644] 'agreement among raft nodes before linearized reading'  (duration: 116.760794ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:48.828498Z","caller":"traceutil/trace.go:171","msg":"trace[890078266] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:10133; }","duration":"110.724624ms","start":"2026-04-22T00:46:48.717759Z","end":"2026-04-22T00:46:48.828484Z","steps":["trace[890078266] 'agreement among raft nodes before linearized reading'  (duration: 110.61056ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:49.048403Z","caller":"traceutil/trace.go:171","msg":"trace[1740970490] linearizableReadLoop","detail":"{readStateIndex:10489; appliedIndex:10487; }","duration":"215.578312ms","start":"2026-04-22T00:46:48.832803Z","end":"2026-04-22T00:46:49.048381Z","steps":["trace[1740970490] 'read index received'  (duration: 118.716638ms)","trace[1740970490] 'applied index is now lower than readState.Index'  (duration: 96.860884ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:49.048729Z","caller":"traceutil/trace.go:171","msg":"trace[1741995395] transaction","detail":"{read_only:false; response_revision:10134; number_of_response:1; }","duration":"225.087841ms","start":"2026-04-22T00:46:48.823607Z","end":"2026-04-22T00:46:49.048695Z","steps":["trace[1741995395] 'process raft request'  (duration: 224.654059ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:49.048783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.971204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:37 size:347232"}
{"level":"info","ts":"2026-04-22T00:46:49.048812Z","caller":"traceutil/trace.go:171","msg":"trace[1798172882] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:37; response_revision:10134; }","duration":"216.014295ms","start":"2026-04-22T00:46:48.83279Z","end":"2026-04-22T00:46:49.048804Z","steps":["trace[1798172882] 'agreement among raft nodes before linearized reading'  (duration: 215.674496ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:49.710255Z","caller":"traceutil/trace.go:171","msg":"trace[1927383134] transaction","detail":"{read_only:false; response_revision:10137; number_of_response:1; }","duration":"183.740828ms","start":"2026-04-22T00:46:49.526488Z","end":"2026-04-22T00:46:49.710229Z","steps":["trace[1927383134] 'process raft request'  (duration: 182.840693ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:49.727777Z","caller":"traceutil/trace.go:171","msg":"trace[1529908128] transaction","detail":"{read_only:false; response_revision:10138; number_of_response:1; }","duration":"201.225189ms","start":"2026-04-22T00:46:49.526535Z","end":"2026-04-22T00:46:49.72776Z","steps":["trace[1529908128] 'process raft request'  (duration: 201.094785ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:50.238102Z","caller":"traceutil/trace.go:171","msg":"trace[1544805010] transaction","detail":"{read_only:false; response_revision:10139; number_of_response:1; }","duration":"178.430737ms","start":"2026-04-22T00:46:50.059612Z","end":"2026-04-22T00:46:50.238042Z","steps":["trace[1544805010] 'process raft request'  (duration: 178.18487ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:50.755794Z","caller":"traceutil/trace.go:171","msg":"trace[992620050] transaction","detail":"{read_only:false; response_revision:10141; number_of_response:1; }","duration":"140.952053ms","start":"2026-04-22T00:46:50.614811Z","end":"2026-04-22T00:46:50.755763Z","steps":["trace[992620050] 'process raft request'  (duration: 124.610483ms)","trace[992620050] 'compare'  (duration: 16.207046ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:51.107969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.336851ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265329773360628 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:10129 > 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-04-22T00:46:51.108107Z","caller":"traceutil/trace.go:171","msg":"trace[5227136] linearizableReadLoop","detail":"{readStateIndex:10497; appliedIndex:10495; }","duration":"420.446964ms","start":"2026-04-22T00:46:50.687643Z","end":"2026-04-22T00:46:51.10809Z","steps":["trace[5227136] 'read index received'  (duration: 51.793946ms)","trace[5227136] 'applied index is now lower than readState.Index'  (duration: 368.651538ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:51.108207Z","caller":"traceutil/trace.go:171","msg":"trace[894970267] transaction","detail":"{read_only:false; response_revision:10142; number_of_response:1; }","duration":"438.878123ms","start":"2026-04-22T00:46:50.669317Z","end":"2026-04-22T00:46:51.108195Z","steps":["trace[894970267] 'process raft request'  (duration: 230.979956ms)","trace[894970267] 'compare'  (duration: 207.214608ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:51.10827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:50.669292Z","time spent":"438.948105ms","remote":"127.0.0.1:51896","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:10129 > 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-04-22T00:46:51.108508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.870606ms","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-04-22T00:46:51.108549Z","caller":"traceutil/trace.go:171","msg":"trace[2055940160] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:10142; }","duration":"420.944178ms","start":"2026-04-22T00:46:50.687592Z","end":"2026-04-22T00:46:51.108537Z","steps":["trace[2055940160] 'agreement among raft nodes before linearized reading'  (duration: 420.829035ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:51.108577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:50.687572Z","time spent":"420.998019ms","remote":"127.0.0.1:51896","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-04-22T00:46:51.109005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.788262ms","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-04-22T00:46:51.109042Z","caller":"traceutil/trace.go:171","msg":"trace[672249567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:10142; }","duration":"293.874855ms","start":"2026-04-22T00:46:50.815159Z","end":"2026-04-22T00:46:51.109033Z","steps":["trace[672249567] 'agreement among raft nodes before linearized reading'  (duration: 293.773312ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:51.109057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.683939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-22T00:46:51.109103Z","caller":"traceutil/trace.go:171","msg":"trace[916823043] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:10142; }","duration":"277.769112ms","start":"2026-04-22T00:46:50.831322Z","end":"2026-04-22T00:46:51.109092Z","steps":["trace[916823043] 'agreement among raft nodes before linearized reading'  (duration: 277.659098ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:51.313322Z","caller":"traceutil/trace.go:171","msg":"trace[1594642749] linearizableReadLoop","detail":"{readStateIndex:10500; appliedIndex:10497; }","duration":"200.103867ms","start":"2026-04-22T00:46:51.113192Z","end":"2026-04-22T00:46:51.313296Z","steps":["trace[1594642749] 'read index received'  (duration: 58.888947ms)","trace[1594642749] 'applied index is now lower than readState.Index'  (duration: 141.21332ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:51.313373Z","caller":"traceutil/trace.go:171","msg":"trace[102249604] transaction","detail":"{read_only:false; response_revision:10145; number_of_response:1; }","duration":"200.925481ms","start":"2026-04-22T00:46:51.112426Z","end":"2026-04-22T00:46:51.313352Z","steps":["trace[102249604] 'process raft request'  (duration: 200.743646ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:51.313399Z","caller":"traceutil/trace.go:171","msg":"trace[1917768120] transaction","detail":"{read_only:false; response_revision:10144; number_of_response:1; }","duration":"200.91471ms","start":"2026-04-22T00:46:51.112441Z","end":"2026-04-22T00:46:51.313355Z","steps":["trace[1917768120] 'process raft request'  (duration: 183.234333ms)","trace[1917768120] 'compare'  (duration: 17.05923ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:51.313946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.735185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:37 size:347232"}
{"level":"info","ts":"2026-04-22T00:46:51.314006Z","caller":"traceutil/trace.go:171","msg":"trace[441949722] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:37; response_revision:10145; }","duration":"200.831817ms","start":"2026-04-22T00:46:51.113162Z","end":"2026-04-22T00:46:51.313994Z","steps":["trace[441949722] 'agreement among raft nodes before linearized reading'  (duration: 200.23646ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:52.915179Z","caller":"traceutil/trace.go:171","msg":"trace[1496128064] transaction","detail":"{read_only:false; response_revision:10150; number_of_response:1; }","duration":"151.680485ms","start":"2026-04-22T00:46:52.763467Z","end":"2026-04-22T00:46:52.915148Z","steps":["trace[1496128064] 'process raft request'  (duration: 151.49952ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:53.248601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.780426ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265329773360653 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:10142 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T00:46:53.248831Z","caller":"traceutil/trace.go:171","msg":"trace[2005605768] transaction","detail":"{read_only:false; response_revision:10152; number_of_response:1; }","duration":"134.857762ms","start":"2026-04-22T00:46:53.113943Z","end":"2026-04-22T00:46:53.2488Z","steps":["trace[2005605768] 'process raft request'  (duration: 29.775868ms)","trace[2005605768] 'compare'  (duration: 104.683183ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:53.539401Z","caller":"traceutil/trace.go:171","msg":"trace[870579613] linearizableReadLoop","detail":"{readStateIndex:10510; appliedIndex:10508; }","duration":"218.33416ms","start":"2026-04-22T00:46:53.321042Z","end":"2026-04-22T00:46:53.539376Z","steps":["trace[870579613] 'read index received'  (duration: 19.253802ms)","trace[870579613] 'applied index is now lower than readState.Index'  (duration: 199.079478ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:53.539475Z","caller":"traceutil/trace.go:171","msg":"trace[1519936052] transaction","detail":"{read_only:false; response_revision:10155; number_of_response:1; }","duration":"218.450144ms","start":"2026-04-22T00:46:53.320986Z","end":"2026-04-22T00:46:53.539436Z","steps":["trace[1519936052] 'process raft request'  (duration: 218.216057ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:53.539614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.543096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xckmj\" ","response":"range_response_count:1 size:6516"}
{"level":"info","ts":"2026-04-22T00:46:53.539659Z","caller":"traceutil/trace.go:171","msg":"trace[1157548638] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xckmj; range_end:; response_count:1; response_revision:10155; }","duration":"218.624799ms","start":"2026-04-22T00:46:53.321024Z","end":"2026-04-22T00:46:53.539648Z","steps":["trace[1157548638] 'agreement among raft nodes before linearized reading'  (duration: 218.451824ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:54.184333Z","caller":"traceutil/trace.go:171","msg":"trace[314642781] linearizableReadLoop","detail":"{readStateIndex:10514; appliedIndex:10513; }","duration":"107.118682ms","start":"2026-04-22T00:46:54.077186Z","end":"2026-04-22T00:46:54.184305Z","steps":["trace[314642781] 'read index received'  (duration: 29.745386ms)","trace[314642781] 'applied index is now lower than readState.Index'  (duration: 77.371646ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:54.18449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.278447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:46:54.184574Z","caller":"traceutil/trace.go:171","msg":"trace[70467118] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10158; }","duration":"107.40974ms","start":"2026-04-22T00:46:54.077145Z","end":"2026-04-22T00:46:54.184555Z","steps":["trace[70467118] 'agreement among raft nodes before linearized reading'  (duration: 107.253596ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:54.838474Z","caller":"traceutil/trace.go:171","msg":"trace[1198373200] transaction","detail":"{read_only:false; response_revision:10160; number_of_response:1; }","duration":"134.642947ms","start":"2026-04-22T00:46:54.703806Z","end":"2026-04-22T00:46:54.838449Z","steps":["trace[1198373200] 'process raft request'  (duration: 134.489703ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:47:35.74294Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8090}
{"level":"info","ts":"2026-04-22T00:47:35.805358Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8090,"took":"59.786211ms","hash":2199047650,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":28123136,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-04-22T00:47:35.80541Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2199047650,"revision":8090,"compact-revision":5966}
{"level":"info","ts":"2026-04-22T00:52:35.749948Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10413}
{"level":"info","ts":"2026-04-22T00:52:35.840584Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10413,"took":"88.055896ms","hash":3617587764,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":21196800,"current-db-size-in-use":"21 MB"}
{"level":"info","ts":"2026-04-22T00:52:35.840674Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3617587764,"revision":10413,"compact-revision":8090}