{"level":"warn","ts":"2026-09-10T11:06:33.213887Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-10T11:06:33.214353Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.135: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://162.253.55.135:2380","--initial-cluster=instance=https://162.253.55.135:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.135:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.135: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-09-10T11:06:33.214437Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-10T11:06:33.214454Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.135:2380"]}
{"level":"info","ts":"2026-09-10T11:06:33.214481Z","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-09-10T11:06:33.215062Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.135:2379"]}
{"level":"info","ts":"2026-09-10T11:06:33.215162Z","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://162.253.55.135:2380"],"listen-peer-urls":["https://162.253.55.135:2380"],"advertise-client-urls":["https://162.253.55.135:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.135:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.135: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-09-10T11:06:33.220552Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.127869ms"}
{"level":"info","ts":"2026-09-10T11:06:33.235558Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"36725369a67988c9","cluster-id":"458f7f83a0fed211"}
{"level":"info","ts":"2026-09-10T11:06:33.235743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 switched to configuration voters=()"}
{"level":"info","ts":"2026-09-10T11:06:33.235775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became follower at term 0"}
{"level":"info","ts":"2026-09-10T11:06:33.235791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 36725369a67988c9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-10T11:06:33.235808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became follower at term 1"}
{"level":"info","ts":"2026-09-10T11:06:33.235853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 switched to configuration voters=(3923289938622777545)"}
{"level":"warn","ts":"2026-09-10T11:06:33.244379Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-10T11:06:33.250889Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-10T11:06:33.252943Z","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-09-10T11:06:33.25622Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"36725369a67988c9","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-10T11:06:33.256418Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"36725369a67988c9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-10T11:06:33.256552Z","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-09-10T11:06:33.256694Z","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-09-10T11:06:33.256706Z","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-09-10T11:06:33.258357Z","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-09-10T11:06:33.258482Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.135:2380"}
{"level":"info","ts":"2026-09-10T11:06:33.258558Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.135:2380"}
{"level":"info","ts":"2026-09-10T11:06:33.258604Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"36725369a67988c9","initial-advertise-peer-urls":["https://162.253.55.135:2380"],"listen-peer-urls":["https://162.253.55.135:2380"],"advertise-client-urls":["https://162.253.55.135:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.135:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-10T11:06:33.258647Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-10T11:06:33.259623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 switched to configuration voters=(3923289938622777545)"}
{"level":"info","ts":"2026-09-10T11:06:33.259762Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"458f7f83a0fed211","local-member-id":"36725369a67988c9","added-peer-id":"36725369a67988c9","added-peer-peer-urls":["https://162.253.55.135:2380"]}
{"level":"info","ts":"2026-09-10T11:06:33.736308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 is starting a new election at term 1"}
{"level":"info","ts":"2026-09-10T11:06:33.736423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-10T11:06:33.736461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 received MsgPreVoteResp from 36725369a67988c9 at term 1"}
{"level":"info","ts":"2026-09-10T11:06:33.736481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became candidate at term 2"}
{"level":"info","ts":"2026-09-10T11:06:33.736488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 received MsgVoteResp from 36725369a67988c9 at term 2"}
{"level":"info","ts":"2026-09-10T11:06:33.736501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became leader at term 2"}
{"level":"info","ts":"2026-09-10T11:06:33.736513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 36725369a67988c9 elected leader 36725369a67988c9 at term 2"}
{"level":"info","ts":"2026-09-10T11:06:33.738037Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"36725369a67988c9","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.135:2379]}","request-path":"/0/members/36725369a67988c9/attributes","cluster-id":"458f7f83a0fed211","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-10T11:06:33.738159Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-10T11:06:33.738257Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-10T11:06:33.738327Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-10T11:06:33.738434Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-10T11:06:33.738477Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-10T11:06:33.741136Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.135:2379"}
{"level":"info","ts":"2026-09-10T11:06:33.741272Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-10T11:06:33.741543Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"458f7f83a0fed211","local-member-id":"36725369a67988c9","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-10T11:06:33.741697Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-10T11:06:33.741736Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-10T11:06:35.419042Z","caller":"traceutil/trace.go:171","msg":"trace[1075692195] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"123.976431ms","start":"2026-09-10T11:06:35.295028Z","end":"2026-09-10T11:06:35.419004Z","steps":["trace[1075692195] 'process raft request'  (duration: 120.24784ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:06:35.419375Z","caller":"traceutil/trace.go:171","msg":"trace[1585459491] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"109.716183ms","start":"2026-09-10T11:06:35.309618Z","end":"2026-09-10T11:06:35.419334Z","steps":["trace[1585459491] 'process raft request'  (duration: 109.354303ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:06:35.41935Z","caller":"traceutil/trace.go:171","msg":"trace[1995091099] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"122.278275ms","start":"2026-09-10T11:06:35.296988Z","end":"2026-09-10T11:06:35.419266Z","steps":["trace[1995091099] 'process raft request'  (duration: 121.947346ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:06:52.137214Z","caller":"traceutil/trace.go:171","msg":"trace[1555332450] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"128.240156ms","start":"2026-09-10T11:06:52.008956Z","end":"2026-09-10T11:06:52.137196Z","steps":["trace[1555332450] 'process raft request'  (duration: 128.076942ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:06:52.375073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.438399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-09-10T11:06:52.375228Z","caller":"traceutil/trace.go:171","msg":"trace[476023926] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:375; }","duration":"122.702626ms","start":"2026-09-10T11:06:52.252498Z","end":"2026-09-10T11:06:52.375201Z","steps":["trace[476023926] 'range keys from in-memory index tree'  (duration: 122.253984ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:06:52.524867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.628103ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9856585778328999803 > lease_revoke:<id:08c9a08aff7795ec>","response":"size:27"}
{"level":"info","ts":"2026-09-10T11:06:52.769463Z","caller":"traceutil/trace.go:171","msg":"trace[102605518] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"388.837042ms","start":"2026-09-10T11:06:52.380569Z","end":"2026-09-10T11:06:52.769406Z","steps":["trace[102605518] 'process raft request'  (duration: 388.630577ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:06:52.770264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:06:52.380536Z","time spent":"389.13093ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:370 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-09-10T11:07:06.274718Z","caller":"traceutil/trace.go:171","msg":"trace[28777541] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"101.588492ms","start":"2026-09-10T11:07:06.173099Z","end":"2026-09-10T11:07:06.274688Z","steps":["trace[28777541] 'process raft request'  (duration: 101.410427ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:07:14.911919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.033921ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9856585778329000148 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoypatchpolicies.gateway.envoyproxy.io\" mod_revision:571 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoypatchpolicies.gateway.envoyproxy.io\" value_size:20744 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoypatchpolicies.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T11:07:14.912064Z","caller":"traceutil/trace.go:171","msg":"trace[1370492664] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"293.430288ms","start":"2026-09-10T11:07:14.618608Z","end":"2026-09-10T11:07:14.912038Z","steps":["trace[1370492664] 'process raft request'  (duration: 165.1487ms)","trace[1370492664] 'compare'  (duration: 127.905118ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:07:14.932961Z","caller":"traceutil/trace.go:171","msg":"trace[2054875280] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:600; }","duration":"228.219995ms","start":"2026-09-10T11:07:14.704714Z","end":"2026-09-10T11:07:14.932934Z","steps":["trace[2054875280] 'read index received'  (duration: 79.07652ms)","trace[2054875280] 'applied index is now lower than readState.Index'  (duration: 149.142415ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:07:14.933089Z","caller":"traceutil/trace.go:171","msg":"trace[275524808] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"253.286196ms","start":"2026-09-10T11:07:14.679755Z","end":"2026-09-10T11:07:14.933041Z","steps":["trace[275524808] 'process raft request'  (duration: 252.522486ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:07:14.933289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.560014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:07:14.933358Z","caller":"traceutil/trace.go:171","msg":"trace[964547493] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:575; }","duration":"228.694858ms","start":"2026-09-10T11:07:14.704643Z","end":"2026-09-10T11:07:14.933337Z","steps":["trace[964547493] 'agreement among raft nodes before linearized reading'  (duration: 228.417171ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:07:14.937619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.200337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-75wnr\" ","response":"range_response_count:1 size:4683"}
{"level":"info","ts":"2026-09-10T11:07:14.937667Z","caller":"traceutil/trace.go:171","msg":"trace[331177359] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-75wnr; range_end:; response_count:1; response_revision:576; }","duration":"188.29405ms","start":"2026-09-10T11:07:14.749359Z","end":"2026-09-10T11:07:14.937653Z","steps":["trace[331177359] 'agreement among raft nodes before linearized reading'  (duration: 188.122375ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:07:14.938058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.779676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:07:14.93816Z","caller":"traceutil/trace.go:171","msg":"trace[106960558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:576; }","duration":"112.888209ms","start":"2026-09-10T11:07:14.825221Z","end":"2026-09-10T11:07:14.938109Z","steps":["trace[106960558] 'agreement among raft nodes before linearized reading'  (duration: 112.787006ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:07:21.916821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.432535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wvcwt\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-09-10T11:07:21.916953Z","caller":"traceutil/trace.go:171","msg":"trace[2013764938] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wvcwt; range_end:; response_count:1; response_revision:655; }","duration":"147.62159ms","start":"2026-09-10T11:07:21.769304Z","end":"2026-09-10T11:07:21.916926Z","steps":["trace[2013764938] 'range keys from in-memory index tree'  (duration: 147.293992ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:07:22.673567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.038735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-09-10T11:07:22.673655Z","caller":"traceutil/trace.go:171","msg":"trace[1512559556] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:657; }","duration":"517.181689ms","start":"2026-09-10T11:07:22.156455Z","end":"2026-09-10T11:07:22.673637Z","steps":["trace[1512559556] 'range keys from in-memory index tree'  (duration: 516.875001ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:07:22.673715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:07:22.156438Z","time spent":"517.267881ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-09-10T11:07:22.759402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.759106ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9856585778329000346 > lease_revoke:<id:08c9a08aff7797fb>","response":"size:27"}
{"level":"info","ts":"2026-09-10T11:07:22.759647Z","caller":"traceutil/trace.go:171","msg":"trace[469239455] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:685; }","duration":"394.636616ms","start":"2026-09-10T11:07:22.364968Z","end":"2026-09-10T11:07:22.759605Z","steps":["trace[469239455] 'read index received'  (duration: 173.703095ms)","trace[469239455] 'applied index is now lower than readState.Index'  (duration: 220.930281ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:07:22.759985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.001986ms","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-09-10T11:07:22.760063Z","caller":"traceutil/trace.go:171","msg":"trace[2076746835] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:658; }","duration":"395.125979ms","start":"2026-09-10T11:07:22.364914Z","end":"2026-09-10T11:07:22.76004Z","steps":["trace[2076746835] 'agreement among raft nodes before linearized reading'  (duration: 394.900013ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:07:22.760108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:07:22.364889Z","time spent":"395.210532ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-09-10T11:07:40.223833Z","caller":"traceutil/trace.go:171","msg":"trace[461137430] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"342.24498ms","start":"2026-09-10T11:07:39.881558Z","end":"2026-09-10T11:07:40.223803Z","steps":["trace[461137430] 'process raft request'  (duration: 342.072456ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:07:40.224041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:07:39.881532Z","time spent":"342.401865ms","remote":"127.0.0.1:56504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nhbjk\" mod_revision:729 > success:<request_put:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nhbjk\" value_size:3941 >> failure:<request_range:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nhbjk\" > >"}
{"level":"info","ts":"2026-09-10T11:07:40.28537Z","caller":"traceutil/trace.go:171","msg":"trace[1123885807] linearizableReadLoop","detail":"{readStateIndex:812; appliedIndex:810; }","duration":"218.973929ms","start":"2026-09-10T11:07:40.066362Z","end":"2026-09-10T11:07:40.285336Z","steps":["trace[1123885807] 'read index received'  (duration: 157.343893ms)","trace[1123885807] 'applied index is now lower than readState.Index'  (duration: 61.628776ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:07:40.285396Z","caller":"traceutil/trace.go:171","msg":"trace[1598206087] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"281.387636ms","start":"2026-09-10T11:07:40.003986Z","end":"2026-09-10T11:07:40.285374Z","steps":["trace[1598206087] 'process raft request'  (duration: 278.123007ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:07:40.285864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.484743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-09-10T11:07:40.285908Z","caller":"traceutil/trace.go:171","msg":"trace[638115186] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:778; }","duration":"219.589606ms","start":"2026-09-10T11:07:40.066307Z","end":"2026-09-10T11:07:40.285897Z","steps":["trace[638115186] 'agreement among raft nodes before linearized reading'  (duration: 219.149094ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:08:09.148995Z","caller":"traceutil/trace.go:171","msg":"trace[24651335] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"149.82597ms","start":"2026-09-10T11:08:08.99914Z","end":"2026-09-10T11:08:09.148966Z","steps":["trace[24651335] 'process raft request'  (duration: 149.650285ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:08:09.167439Z","caller":"traceutil/trace.go:171","msg":"trace[2054238231] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"168.161075ms","start":"2026-09-10T11:08:08.99925Z","end":"2026-09-10T11:08:09.167411Z","steps":["trace[2054238231] 'process raft request'  (duration: 167.908138ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:08:29.388594Z","caller":"traceutil/trace.go:171","msg":"trace[2106138693] linearizableReadLoop","detail":"{readStateIndex:1471; appliedIndex:1470; }","duration":"139.696896ms","start":"2026-09-10T11:08:29.248871Z","end":"2026-09-10T11:08:29.388568Z","steps":["trace[2106138693] 'read index received'  (duration: 139.514411ms)","trace[2106138693] 'applied index is now lower than readState.Index'  (duration: 181.725µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:08:29.388691Z","caller":"traceutil/trace.go:171","msg":"trace[1969314566] transaction","detail":"{read_only:false; response_revision:1420; number_of_response:1; }","duration":"148.110493ms","start":"2026-09-10T11:08:29.240557Z","end":"2026-09-10T11:08:29.388667Z","steps":["trace[1969314566] 'process raft request'  (duration: 147.859546ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:08:29.388817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.944072ms","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-09-10T11:08:29.388838Z","caller":"traceutil/trace.go:171","msg":"trace[1080383019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1420; }","duration":"140.041995ms","start":"2026-09-10T11:08:29.24879Z","end":"2026-09-10T11:08:29.388832Z","steps":["trace[1080383019] 'agreement among raft nodes before linearized reading'  (duration: 139.904392ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:08:29.389109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.114974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-09-10T11:08:29.389307Z","caller":"traceutil/trace.go:171","msg":"trace[292819662] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1420; }","duration":"121.383751ms","start":"2026-09-10T11:08:29.267903Z","end":"2026-09-10T11:08:29.389287Z","steps":["trace[292819662] 'agreement among raft nodes before linearized reading'  (duration: 120.860816ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:08:55.680306Z","caller":"traceutil/trace.go:171","msg":"trace[1266667385] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"396.658481ms","start":"2026-09-10T11:08:55.283618Z","end":"2026-09-10T11:08:55.680276Z","steps":["trace[1266667385] 'process raft request'  (duration: 396.464056ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:08:55.680571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:08:55.283585Z","time spent":"396.889197ms","remote":"127.0.0.1:56504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2609008d-15a0-4f36-835c-37c78dc1f2a5\" mod_revision:1790 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2609008d-15a0-4f36-835c-37c78dc1f2a5\" value_size:3632 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2609008d-15a0-4f36-835c-37c78dc1f2a5\" > >"}
{"level":"info","ts":"2026-09-10T11:08:55.686056Z","caller":"traceutil/trace.go:171","msg":"trace[271658026] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"282.224298ms","start":"2026-09-10T11:08:55.403808Z","end":"2026-09-10T11:08:55.686032Z","steps":["trace[271658026] 'process raft request'  (duration: 281.993682ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:08:55.686259Z","caller":"traceutil/trace.go:171","msg":"trace[1712589881] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"137.185937ms","start":"2026-09-10T11:08:55.549005Z","end":"2026-09-10T11:08:55.686191Z","steps":["trace[1712589881] 'process raft request'  (duration: 136.90613ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:08:55.822497Z","caller":"traceutil/trace.go:171","msg":"trace[1138247951] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"130.930449ms","start":"2026-09-10T11:08:55.691526Z","end":"2026-09-10T11:08:55.822457Z","steps":["trace[1138247951] 'process raft request'  (duration: 98.152143ms)","trace[1138247951] 'compare'  (duration: 32.595311ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:08:56.158482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.904978ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9856585778329002711 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1814 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T11:08:56.158731Z","caller":"traceutil/trace.go:171","msg":"trace[1875318349] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"466.895078ms","start":"2026-09-10T11:08:55.691816Z","end":"2026-09-10T11:08:56.158712Z","steps":["trace[1875318349] 'process raft request'  (duration: 234.672013ms)","trace[1875318349] 'compare'  (duration: 231.427334ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:08:56.158779Z","caller":"traceutil/trace.go:171","msg":"trace[1286376365] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1913; }","duration":"332.007023ms","start":"2026-09-10T11:08:55.826762Z","end":"2026-09-10T11:08:56.158769Z","steps":["trace[1286376365] 'read index received'  (duration: 99.658294ms)","trace[1286376365] 'applied index is now lower than readState.Index'  (duration: 232.347379ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:08:56.158794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:08:55.691803Z","time spent":"466.960191ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1814 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-09-10T11:08:56.158964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.212659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:08:56.159Z","caller":"traceutil/trace.go:171","msg":"trace[82026812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1837; }","duration":"332.287981ms","start":"2026-09-10T11:08:55.826704Z","end":"2026-09-10T11:08:56.158992Z","steps":["trace[82026812] 'agreement among raft nodes before linearized reading'  (duration: 332.23307ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:08:56.159024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:08:55.82668Z","time spent":"332.337822ms","remote":"127.0.0.1:56328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-09-10T11:08:56.159036Z","caller":"traceutil/trace.go:171","msg":"trace[1294799923] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"466.774176ms","start":"2026-09-10T11:08:55.692249Z","end":"2026-09-10T11:08:56.159024Z","steps":["trace[1294799923] 'process raft request'  (duration: 466.338764ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:08:56.158897Z","caller":"traceutil/trace.go:171","msg":"trace[1899860150] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"458.985385ms","start":"2026-09-10T11:08:55.699879Z","end":"2026-09-10T11:08:56.158864Z","steps":["trace[1899860150] 'process raft request'  (duration: 458.82359ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:08:56.159157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:08:55.699865Z","time spent":"459.268453ms","remote":"127.0.0.1:56504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10932,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" mod_revision:1785 > success:<request_put:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" value_size:10875 >> failure:<request_range:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" > >"}
{"level":"warn","ts":"2026-09-10T11:08:56.159173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.23789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-09-10T11:08:56.159314Z","caller":"traceutil/trace.go:171","msg":"trace[1275657139] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1837; }","duration":"150.438205ms","start":"2026-09-10T11:08:56.008846Z","end":"2026-09-10T11:08:56.159284Z","steps":["trace[1275657139] 'agreement among raft nodes before linearized reading'  (duration: 150.104076ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:08:56.159324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:08:55.692208Z","time spent":"466.905159ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1812 > 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-09-10T11:09:08.346054Z","caller":"traceutil/trace.go:171","msg":"trace[152023993] linearizableReadLoop","detail":"{readStateIndex:2025; appliedIndex:2023; }","duration":"114.736112ms","start":"2026-09-10T11:09:08.231213Z","end":"2026-09-10T11:09:08.345949Z","steps":["trace[152023993] 'read index received'  (duration: 95.604075ms)","trace[152023993] 'applied index is now lower than readState.Index'  (duration: 19.130377ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:09:08.346339Z","caller":"traceutil/trace.go:171","msg":"trace[1414801178] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"118.538444ms","start":"2026-09-10T11:09:08.227482Z","end":"2026-09-10T11:09:08.34602Z","steps":["trace[1414801178] 'process raft request'  (duration: 118.313828ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:09:08.346484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.232975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-09-10T11:09:08.346523Z","caller":"traceutil/trace.go:171","msg":"trace[1456189568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1943; }","duration":"115.316367ms","start":"2026-09-10T11:09:08.231194Z","end":"2026-09-10T11:09:08.346511Z","steps":["trace[1456189568] 'agreement among raft nodes before linearized reading'  (duration: 114.931377ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:09:08.520212Z","caller":"traceutil/trace.go:171","msg":"trace[1796993453] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"110.776084ms","start":"2026-09-10T11:09:08.409393Z","end":"2026-09-10T11:09:08.520169Z","steps":["trace[1796993453] 'process raft request'  (duration: 110.326102ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:09:45.294363Z","caller":"traceutil/trace.go:171","msg":"trace[1369698637] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"192.320888ms","start":"2026-09-10T11:09:45.101998Z","end":"2026-09-10T11:09:45.294318Z","steps":["trace[1369698637] 'process raft request'  (duration: 191.907147ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:10:24.907576Z","caller":"traceutil/trace.go:171","msg":"trace[256943201] transaction","detail":"{read_only:false; response_revision:2547; number_of_response:1; }","duration":"115.707288ms","start":"2026-09-10T11:10:24.791844Z","end":"2026-09-10T11:10:24.907551Z","steps":["trace[256943201] 'process raft request'  (duration: 63.397884ms)","trace[256943201] 'compare'  (duration: 52.151729ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:10:25.245878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.233638ms","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-09-10T11:10:25.245973Z","caller":"traceutil/trace.go:171","msg":"trace[905353275] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2548; }","duration":"181.386442ms","start":"2026-09-10T11:10:25.064565Z","end":"2026-09-10T11:10:25.245951Z","steps":["trace[905353275] 'range keys from in-memory index tree'  (duration: 181.032303ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:10:59.769804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.955155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:10:59.769896Z","caller":"traceutil/trace.go:171","msg":"trace[1837248293] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2755; }","duration":"236.106149ms","start":"2026-09-10T11:10:59.533773Z","end":"2026-09-10T11:10:59.769879Z","steps":["trace[1837248293] 'range keys from in-memory index tree'  (duration: 235.76825ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:10:59.924022Z","caller":"traceutil/trace.go:171","msg":"trace[1591770701] transaction","detail":"{read_only:false; response_revision:2756; number_of_response:1; }","duration":"150.859925ms","start":"2026-09-10T11:10:59.773127Z","end":"2026-09-10T11:10:59.923987Z","steps":["trace[1591770701] 'process raft request'  (duration: 150.67096ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:14:06.351591Z","caller":"traceutil/trace.go:171","msg":"trace[1002938738] transaction","detail":"{read_only:false; response_revision:3941; number_of_response:1; }","duration":"231.708411ms","start":"2026-09-10T11:14:06.119853Z","end":"2026-09-10T11:14:06.351561Z","steps":["trace[1002938738] 'process raft request'  (duration: 231.562097ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:14:06.499967Z","caller":"traceutil/trace.go:171","msg":"trace[830677318] transaction","detail":"{read_only:false; response_revision:3942; number_of_response:1; }","duration":"380.038027ms","start":"2026-09-10T11:14:06.119904Z","end":"2026-09-10T11:14:06.499942Z","steps":["trace[830677318] 'process raft request'  (duration: 328.045836ms)","trace[830677318] 'compare'  (duration: 51.819666ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:14:06.500117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:14:06.119885Z","time spent":"380.154421ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:3932 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-09-10T11:14:06.500187Z","caller":"traceutil/trace.go:171","msg":"trace[1424405676] linearizableReadLoop","detail":"{readStateIndex:4100; appliedIndex:4098; }","duration":"125.098846ms","start":"2026-09-10T11:14:06.375062Z","end":"2026-09-10T11:14:06.500161Z","steps":["trace[1424405676] 'read index received'  (duration: 72.856898ms)","trace[1424405676] 'applied index is now lower than readState.Index'  (duration: 52.239898ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:14:06.500315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.228439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-10T11:14:06.500376Z","caller":"traceutil/trace.go:171","msg":"trace[2021925820] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:3943; }","duration":"125.353954ms","start":"2026-09-10T11:14:06.375011Z","end":"2026-09-10T11:14:06.500365Z","steps":["trace[2021925820] 'agreement among raft nodes before linearized reading'  (duration: 125.239731ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:14:06.50051Z","caller":"traceutil/trace.go:171","msg":"trace[754411101] transaction","detail":"{read_only:false; response_revision:3943; number_of_response:1; }","duration":"379.655738ms","start":"2026-09-10T11:14:06.12078Z","end":"2026-09-10T11:14:06.500436Z","steps":["trace[754411101] 'process raft request'  (duration: 379.124463ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:14:06.500854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:14:06.120769Z","time spent":"379.985066ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:3933 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-09-10T11:15:31.548475Z","caller":"traceutil/trace.go:171","msg":"trace[1568218577] linearizableReadLoop","detail":"{readStateIndex:5123; appliedIndex:5122; }","duration":"137.891753ms","start":"2026-09-10T11:15:31.410546Z","end":"2026-09-10T11:15:31.548438Z","steps":["trace[1568218577] 'read index received'  (duration: 130.862132ms)","trace[1568218577] 'applied index is now lower than readState.Index'  (duration: 7.028361ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:15:31.548579Z","caller":"traceutil/trace.go:171","msg":"trace[1251806223] transaction","detail":"{read_only:false; response_revision:4924; number_of_response:1; }","duration":"140.873235ms","start":"2026-09-10T11:15:31.40766Z","end":"2026-09-10T11:15:31.548533Z","steps":["trace[1251806223] 'process raft request'  (duration: 133.871535ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:15:31.548718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.32559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-09-10T11:15:31.548726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.15367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"}
{"level":"info","ts":"2026-09-10T11:15:31.548773Z","caller":"traceutil/trace.go:171","msg":"trace[2024189855] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4924; }","duration":"138.234873ms","start":"2026-09-10T11:15:31.410526Z","end":"2026-09-10T11:15:31.548761Z","steps":["trace[2024189855] 'agreement among raft nodes before linearized reading'  (duration: 138.065428ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:15:31.548768Z","caller":"traceutil/trace.go:171","msg":"trace[2019522986] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4924; }","duration":"126.445203ms","start":"2026-09-10T11:15:31.42231Z","end":"2026-09-10T11:15:31.548755Z","steps":["trace[2019522986] 'agreement among raft nodes before linearized reading'  (duration: 126.32037ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:15:31.548894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.633844ms","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-09-10T11:15:31.548998Z","caller":"traceutil/trace.go:171","msg":"trace[950615903] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4924; }","duration":"106.804699ms","start":"2026-09-10T11:15:31.442175Z","end":"2026-09-10T11:15:31.548979Z","steps":["trace[950615903] 'agreement among raft nodes before linearized reading'  (duration: 106.522401ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:15:37.333037Z","caller":"traceutil/trace.go:171","msg":"trace[235555718] linearizableReadLoop","detail":"{readStateIndex:5363; appliedIndex:5362; }","duration":"170.92592ms","start":"2026-09-10T11:15:37.162092Z","end":"2026-09-10T11:15:37.333018Z","steps":["trace[235555718] 'read index received'  (duration: 170.711624ms)","trace[235555718] 'applied index is now lower than readState.Index'  (duration: 213.776µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:15:37.333563Z","caller":"traceutil/trace.go:171","msg":"trace[1929362929] transaction","detail":"{read_only:false; response_revision:5156; number_of_response:1; }","duration":"216.170219ms","start":"2026-09-10T11:15:37.117353Z","end":"2026-09-10T11:15:37.333523Z","steps":["trace[1929362929] 'process raft request'  (duration: 215.509641ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:15:37.333926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.809795ms","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-09-10T11:15:37.33397Z","caller":"traceutil/trace.go:171","msg":"trace[1267504073] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5156; }","duration":"171.908437ms","start":"2026-09-10T11:15:37.16205Z","end":"2026-09-10T11:15:37.333958Z","steps":["trace[1267504073] 'agreement among raft nodes before linearized reading'  (duration: 171.785484ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:15:37.509439Z","caller":"traceutil/trace.go:171","msg":"trace[1412021467] transaction","detail":"{read_only:false; response_revision:5157; number_of_response:1; }","duration":"169.797979ms","start":"2026-09-10T11:15:37.339563Z","end":"2026-09-10T11:15:37.509361Z","steps":["trace[1412021467] 'process raft request'  (duration: 151.699058ms)","trace[1412021467] 'compare'  (duration: 17.762692ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:15:37.518801Z","caller":"traceutil/trace.go:171","msg":"trace[1501571286] transaction","detail":"{read_only:false; response_revision:5158; number_of_response:1; }","duration":"177.023146ms","start":"2026-09-10T11:15:37.341756Z","end":"2026-09-10T11:15:37.518779Z","steps":["trace[1501571286] 'process raft request'  (duration: 176.480932ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:15:37.518998Z","caller":"traceutil/trace.go:171","msg":"trace[1900406429] transaction","detail":"{read_only:false; response_revision:5159; number_of_response:1; }","duration":"152.726656ms","start":"2026-09-10T11:15:37.366262Z","end":"2026-09-10T11:15:37.518988Z","steps":["trace[1900406429] 'process raft request'  (duration: 152.067418ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:15:49.984875Z","caller":"traceutil/trace.go:171","msg":"trace[362849879] linearizableReadLoop","detail":"{readStateIndex:5600; appliedIndex:5599; }","duration":"160.658182ms","start":"2026-09-10T11:15:49.824189Z","end":"2026-09-10T11:15:49.984848Z","steps":["trace[362849879] 'read index received'  (duration: 160.347764ms)","trace[362849879] 'applied index is now lower than readState.Index'  (duration: 308.778µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:15:49.984934Z","caller":"traceutil/trace.go:171","msg":"trace[1810673735] transaction","detail":"{read_only:false; response_revision:5386; number_of_response:1; }","duration":"222.297815ms","start":"2026-09-10T11:15:49.76259Z","end":"2026-09-10T11:15:49.984888Z","steps":["trace[1810673735] 'process raft request'  (duration: 222.006367ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:15:49.986426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.193423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:15:49.986537Z","caller":"traceutil/trace.go:171","msg":"trace[1456223614] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5386; }","duration":"162.380939ms","start":"2026-09-10T11:15:49.824125Z","end":"2026-09-10T11:15:49.986506Z","steps":["trace[1456223614] 'agreement among raft nodes before linearized reading'  (duration: 162.195274ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:16:00.558291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.675454ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9856585778329011781 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5494 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T11:16:00.558421Z","caller":"traceutil/trace.go:171","msg":"trace[352431269] linearizableReadLoop","detail":"{readStateIndex:5778; appliedIndex:5776; }","duration":"259.114752ms","start":"2026-09-10T11:16:00.29929Z","end":"2026-09-10T11:16:00.558405Z","steps":["trace[352431269] 'read index received'  (duration: 48.590658ms)","trace[352431269] 'applied index is now lower than readState.Index'  (duration: 210.498223ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:16:00.558568Z","caller":"traceutil/trace.go:171","msg":"trace[703979014] transaction","detail":"{read_only:false; response_revision:5562; number_of_response:1; }","duration":"260.720245ms","start":"2026-09-10T11:16:00.297782Z","end":"2026-09-10T11:16:00.558502Z","steps":["trace[703979014] 'process raft request'  (duration: 156.741484ms)","trace[703979014] 'compare'  (duration: 103.529699ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:16:00.558596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.312488ms","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-09-10T11:16:00.558619Z","caller":"traceutil/trace.go:171","msg":"trace[555558526] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5562; }","duration":"259.41033ms","start":"2026-09-10T11:16:00.299201Z","end":"2026-09-10T11:16:00.558612Z","steps":["trace[555558526] 'agreement among raft nodes before linearized reading'  (duration: 259.303657ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:16:00.755953Z","caller":"traceutil/trace.go:171","msg":"trace[1110093718] transaction","detail":"{read_only:false; response_revision:5563; number_of_response:1; }","duration":"191.878404ms","start":"2026-09-10T11:16:00.564044Z","end":"2026-09-10T11:16:00.755923Z","steps":["trace[1110093718] 'process raft request'  (duration: 104.852416ms)","trace[1110093718] 'compare'  (duration: 86.838043ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:16:33.833326Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2945}
{"level":"info","ts":"2026-09-10T11:16:33.912677Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2945,"took":"77.712545ms","hash":4012481488,"current-db-size-bytes":56799232,"current-db-size":"57 MB","current-db-size-in-use-bytes":32288768,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-10T11:16:33.912747Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4012481488,"revision":2945,"compact-revision":-1}
{"level":"warn","ts":"2026-09-10T11:16:42.044606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.107416ms","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-09-10T11:16:42.044731Z","caller":"traceutil/trace.go:171","msg":"trace[612548211] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:6010; }","duration":"104.308421ms","start":"2026-09-10T11:16:41.940394Z","end":"2026-09-10T11:16:42.044703Z","steps":["trace[612548211] 'count revisions from in-memory index tree'  (duration: 104.034453ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:16:51.767507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.0641ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9856585778329013155 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" mod_revision:5985 > success:<request_put:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" value_size:7343 >> failure:<request_range:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T11:16:51.767659Z","caller":"traceutil/trace.go:171","msg":"trace[1873238839] transaction","detail":"{read_only:false; response_revision:6068; number_of_response:1; }","duration":"188.856192ms","start":"2026-09-10T11:16:51.578769Z","end":"2026-09-10T11:16:51.767625Z","steps":["trace[1873238839] 'process raft request'  (duration: 60.529534ms)","trace[1873238839] 'compare'  (duration: 127.936217ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:21:33.840003Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5872}
{"level":"info","ts":"2026-09-10T11:21:33.941991Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5872,"took":"99.536891ms","hash":1194084782,"current-db-size-bytes":56799232,"current-db-size":"57 MB","current-db-size-in-use-bytes":26058752,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-10T11:21:33.942051Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1194084782,"revision":5872,"compact-revision":2945}
{"level":"warn","ts":"2026-09-10T11:22:14.024855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.544029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-10T11:22:14.024915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.395577ms","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":"info","ts":"2026-09-10T11:22:14.025001Z","caller":"traceutil/trace.go:171","msg":"trace[354273161] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8431; }","duration":"197.744414ms","start":"2026-09-10T11:22:13.827219Z","end":"2026-09-10T11:22:14.024963Z","steps":["trace[354273161] 'range keys from in-memory index tree'  (duration: 197.414595ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:22:14.025043Z","caller":"traceutil/trace.go:171","msg":"trace[1472791075] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:8431; }","duration":"294.598493ms","start":"2026-09-10T11:22:13.730417Z","end":"2026-09-10T11:22:14.025016Z","steps":["trace[1472791075] 'count revisions from in-memory index tree'  (duration: 294.254153ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:22:14.02534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.402758ms","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-09-10T11:22:14.025413Z","caller":"traceutil/trace.go:171","msg":"trace[2062455645] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8431; }","duration":"425.530621ms","start":"2026-09-10T11:22:13.599867Z","end":"2026-09-10T11:22:14.025398Z","steps":["trace[2062455645] 'range keys from in-memory index tree'  (duration: 425.202252ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:22:14.025444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:22:13.599844Z","time spent":"425.594913ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-09-10T11:22:14.031472Z","caller":"traceutil/trace.go:171","msg":"trace[1094878477] transaction","detail":"{read_only:false; response_revision:8432; number_of_response:1; }","duration":"152.118341ms","start":"2026-09-10T11:22:13.879314Z","end":"2026-09-10T11:22:14.031433Z","steps":["trace[1094878477] 'process raft request'  (duration: 151.794913ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:22:16.325346Z","caller":"traceutil/trace.go:171","msg":"trace[1836917667] transaction","detail":"{read_only:false; response_revision:8444; number_of_response:1; }","duration":"103.063136ms","start":"2026-09-10T11:22:16.222257Z","end":"2026-09-10T11:22:16.32532Z","steps":["trace[1836917667] 'process raft request'  (duration: 102.913391ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:22:25.598769Z","caller":"traceutil/trace.go:171","msg":"trace[668794871] transaction","detail":"{read_only:false; response_revision:8493; number_of_response:1; }","duration":"124.10547ms","start":"2026-09-10T11:22:25.47463Z","end":"2026-09-10T11:22:25.598735Z","steps":["trace[668794871] 'process raft request'  (duration: 62.927144ms)","trace[668794871] 'compare'  (duration: 60.866158ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:22:26.405869Z","caller":"traceutil/trace.go:171","msg":"trace[1673613353] linearizableReadLoop","detail":"{readStateIndex:8809; appliedIndex:8808; }","duration":"288.223064ms","start":"2026-09-10T11:22:26.117616Z","end":"2026-09-10T11:22:26.405839Z","steps":["trace[1673613353] 'read index received'  (duration: 288.0748ms)","trace[1673613353] 'applied index is now lower than readState.Index'  (duration: 147.084µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:22:26.405911Z","caller":"traceutil/trace.go:171","msg":"trace[315674510] transaction","detail":"{read_only:false; response_revision:8494; number_of_response:1; }","duration":"329.005938ms","start":"2026-09-10T11:22:26.076871Z","end":"2026-09-10T11:22:26.405877Z","steps":["trace[315674510] 'process raft request'  (duration: 328.827273ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:22:26.406054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:22:26.076844Z","time spent":"329.138802ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8485 > 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-09-10T11:22:26.406084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.43925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-09-10T11:22:26.406138Z","caller":"traceutil/trace.go:171","msg":"trace[659365096] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8494; }","duration":"288.556913ms","start":"2026-09-10T11:22:26.117571Z","end":"2026-09-10T11:22:26.406128Z","steps":["trace[659365096] 'agreement among raft nodes before linearized reading'  (duration: 288.395048ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:22:26.415817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.616818ms","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-09-10T11:22:26.415871Z","caller":"traceutil/trace.go:171","msg":"trace[1205679163] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8495; }","duration":"191.712861ms","start":"2026-09-10T11:22:26.224145Z","end":"2026-09-10T11:22:26.415858Z","steps":["trace[1205679163] 'agreement among raft nodes before linearized reading'  (duration: 191.563767ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:22:27.221333Z","caller":"traceutil/trace.go:171","msg":"trace[1206415414] linearizableReadLoop","detail":"{readStateIndex:8815; appliedIndex:8814; }","duration":"195.865453ms","start":"2026-09-10T11:22:27.02543Z","end":"2026-09-10T11:22:27.221295Z","steps":["trace[1206415414] 'read index received'  (duration: 195.558055ms)","trace[1206415414] 'applied index is now lower than readState.Index'  (duration: 305.538µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:22:27.221632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.124959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:22:27.221679Z","caller":"traceutil/trace.go:171","msg":"trace[1779764165] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:8499; }","duration":"145.240472ms","start":"2026-09-10T11:22:27.076427Z","end":"2026-09-10T11:22:27.221667Z","steps":["trace[1779764165] 'agreement among raft nodes before linearized reading'  (duration: 145.101309ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:22:27.2217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.005127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jww54\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-09-10T11:22:27.221786Z","caller":"traceutil/trace.go:171","msg":"trace[229711795] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jww54; range_end:; response_count:1; response_revision:8499; }","duration":"179.144981ms","start":"2026-09-10T11:22:27.042622Z","end":"2026-09-10T11:22:27.221767Z","steps":["trace[229711795] 'agreement among raft nodes before linearized reading'  (duration: 178.862843ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:22:27.222049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.733955ms","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-09-10T11:22:27.222093Z","caller":"traceutil/trace.go:171","msg":"trace[1828235279] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:8499; }","duration":"176.801628ms","start":"2026-09-10T11:22:27.045281Z","end":"2026-09-10T11:22:27.222083Z","steps":["trace[1828235279] 'agreement among raft nodes before linearized reading'  (duration: 176.727216ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:22:27.222147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.650154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-09-10T11:22:27.222255Z","caller":"traceutil/trace.go:171","msg":"trace[1874283808] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8499; }","duration":"196.8246ms","start":"2026-09-10T11:22:27.025403Z","end":"2026-09-10T11:22:27.222228Z","steps":["trace[1874283808] 'agreement among raft nodes before linearized reading'  (duration: 196.050669ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:22:27.717603Z","caller":"traceutil/trace.go:171","msg":"trace[1318672770] transaction","detail":"{read_only:false; response_revision:8504; number_of_response:1; }","duration":"111.543099ms","start":"2026-09-10T11:22:27.605968Z","end":"2026-09-10T11:22:27.717512Z","steps":["trace[1318672770] 'process raft request'  (duration: 111.243841ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:22:54.675182Z","caller":"traceutil/trace.go:171","msg":"trace[1114313848] transaction","detail":"{read_only:false; response_revision:8700; number_of_response:1; }","duration":"153.959479ms","start":"2026-09-10T11:22:54.521196Z","end":"2026-09-10T11:22:54.675156Z","steps":["trace[1114313848] 'process raft request'  (duration: 153.794174ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:22:54.884152Z","caller":"traceutil/trace.go:171","msg":"trace[499335589] linearizableReadLoop","detail":"{readStateIndex:9024; appliedIndex:9023; }","duration":"283.547608ms","start":"2026-09-10T11:22:54.600579Z","end":"2026-09-10T11:22:54.884126Z","steps":["trace[499335589] 'read index received'  (duration: 75.196867ms)","trace[499335589] 'applied index is now lower than readState.Index'  (duration: 208.349901ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:22:54.884353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.755573ms","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-09-10T11:22:54.884423Z","caller":"traceutil/trace.go:171","msg":"trace[431229522] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8701; }","duration":"283.873876ms","start":"2026-09-10T11:22:54.600531Z","end":"2026-09-10T11:22:54.884405Z","steps":["trace[431229522] 'agreement among raft nodes before linearized reading'  (duration: 283.712972ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:22:54.884437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.732248ms","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-09-10T11:22:54.884469Z","caller":"traceutil/trace.go:171","msg":"trace[312852153] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8701; }","duration":"230.81026ms","start":"2026-09-10T11:22:54.653651Z","end":"2026-09-10T11:22:54.884461Z","steps":["trace[312852153] 'agreement among raft nodes before linearized reading'  (duration: 230.703927ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:22:54.884424Z","caller":"traceutil/trace.go:171","msg":"trace[1146966922] transaction","detail":"{read_only:false; response_revision:8701; number_of_response:1; }","duration":"361.321554ms","start":"2026-09-10T11:22:54.52303Z","end":"2026-09-10T11:22:54.884352Z","steps":["trace[1146966922] 'process raft request'  (duration: 336.171073ms)","trace[1146966922] 'compare'  (duration: 24.818502ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:22:54.884617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.540144ms","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-09-10T11:22:54.884654Z","caller":"traceutil/trace.go:171","msg":"trace[502834206] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8701; }","duration":"274.606456ms","start":"2026-09-10T11:22:54.610037Z","end":"2026-09-10T11:22:54.884643Z","steps":["trace[502834206] 'agreement among raft nodes before linearized reading'  (duration: 274.213295ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:22:54.884666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:22:54.523022Z","time spent":"361.55346ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8691 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-10T11:23:01.802093Z","caller":"traceutil/trace.go:171","msg":"trace[1396188423] transaction","detail":"{read_only:false; response_revision:8739; number_of_response:1; }","duration":"122.005193ms","start":"2026-09-10T11:23:01.680064Z","end":"2026-09-10T11:23:01.802069Z","steps":["trace[1396188423] 'process raft request'  (duration: 121.778287ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:23:02.785689Z","caller":"traceutil/trace.go:171","msg":"trace[1545579243] linearizableReadLoop","detail":"{readStateIndex:9069; appliedIndex:9068; }","duration":"131.378027ms","start":"2026-09-10T11:23:02.654249Z","end":"2026-09-10T11:23:02.785627Z","steps":["trace[1545579243] 'read index received'  (duration: 131.260644ms)","trace[1545579243] 'applied index is now lower than readState.Index'  (duration: 116.353µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:23:02.785758Z","caller":"traceutil/trace.go:171","msg":"trace[1766526249] transaction","detail":"{read_only:false; response_revision:8743; number_of_response:1; }","duration":"230.83018ms","start":"2026-09-10T11:23:02.554908Z","end":"2026-09-10T11:23:02.785738Z","steps":["trace[1766526249] 'process raft request'  (duration: 230.525222ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:23:02.786011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.738867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-09-10T11:23:02.786135Z","caller":"traceutil/trace.go:171","msg":"trace[464725474] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:8743; }","duration":"131.904151ms","start":"2026-09-10T11:23:02.654183Z","end":"2026-09-10T11:23:02.786088Z","steps":["trace[464725474] 'agreement among raft nodes before linearized reading'  (duration: 131.606283ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:23:02.81966Z","caller":"traceutil/trace.go:171","msg":"trace[97960443] transaction","detail":"{read_only:false; response_revision:8744; number_of_response:1; }","duration":"115.308962ms","start":"2026-09-10T11:23:02.704308Z","end":"2026-09-10T11:23:02.819617Z","steps":["trace[97960443] 'process raft request'  (duration: 114.976573ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:23:08.212279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.521272ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9856585778329020549 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/ingress/openstack/rook-ceph-cluster\" mod_revision:0 > success:<request_put:<key:\"/registry/ingress/openstack/rook-ceph-cluster\" value_size:888 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-10T11:23:08.212398Z","caller":"traceutil/trace.go:171","msg":"trace[873980745] linearizableReadLoop","detail":"{readStateIndex:9114; appliedIndex:9113; }","duration":"113.774491ms","start":"2026-09-10T11:23:08.098611Z","end":"2026-09-10T11:23:08.212385Z","steps":["trace[873980745] 'read index received'  (duration: 40.631µs)","trace[873980745] 'applied index is now lower than readState.Index'  (duration: 113.73262ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:23:08.212569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.948645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-58cbc48f87-cg4hh.18d3f1ca484d6885\" ","response":"range_response_count:1 size:1135"}
{"level":"info","ts":"2026-09-10T11:23:08.212595Z","caller":"traceutil/trace.go:171","msg":"trace[589668348] range","detail":"{range_begin:/registry/events/openstack/barbican-api-58cbc48f87-cg4hh.18d3f1ca484d6885; range_end:; response_count:1; response_revision:8787; }","duration":"114.067478ms","start":"2026-09-10T11:23:08.098517Z","end":"2026-09-10T11:23:08.212584Z","steps":["trace[589668348] 'agreement among raft nodes before linearized reading'  (duration: 113.900424ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:23:08.212614Z","caller":"traceutil/trace.go:171","msg":"trace[1352720295] transaction","detail":"{read_only:false; response_revision:8787; number_of_response:1; }","duration":"228.880337ms","start":"2026-09-10T11:23:07.983694Z","end":"2026-09-10T11:23:08.212574Z","steps":["trace[1352720295] 'process raft request'  (duration: 76.999985ms)","trace[1352720295] 'compare'  (duration: 151.319717ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:23:08.767838Z","caller":"traceutil/trace.go:171","msg":"trace[1111063511] linearizableReadLoop","detail":"{readStateIndex:9117; appliedIndex:9115; }","duration":"197.740704ms","start":"2026-09-10T11:23:08.570068Z","end":"2026-09-10T11:23:08.767809Z","steps":["trace[1111063511] 'read index received'  (duration: 197.539168ms)","trace[1111063511] 'applied index is now lower than readState.Index'  (duration: 200.506µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:23:08.767981Z","caller":"traceutil/trace.go:171","msg":"trace[1150291289] transaction","detail":"{read_only:false; response_revision:8790; number_of_response:1; }","duration":"546.21259ms","start":"2026-09-10T11:23:08.221751Z","end":"2026-09-10T11:23:08.767964Z","steps":["trace[1150291289] 'process raft request'  (duration: 546.004384ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:23:08.767983Z","caller":"traceutil/trace.go:171","msg":"trace[290782237] transaction","detail":"{read_only:false; response_revision:8789; number_of_response:1; }","duration":"549.780446ms","start":"2026-09-10T11:23:08.218184Z","end":"2026-09-10T11:23:08.767965Z","steps":["trace[290782237] 'process raft request'  (duration: 549.387375ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:23:08.768087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:23:08.218152Z","time spent":"549.873179ms","remote":"127.0.0.1:56394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":682,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-cluster.18d3f1d847b0e121\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-cluster.18d3f1d847b0e121\" value_size:603 lease:633213741474244556 >> failure:<>"}
{"level":"warn","ts":"2026-09-10T11:23:08.768084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:23:08.221729Z","time spent":"546.282111ms","remote":"127.0.0.1:55050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1211,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/cert-manager.io/certificates/openstack/rook-ceph-rgw-ceph-certs\" mod_revision:0 > success:<request_put:<key:\"/registry/cert-manager.io/certificates/openstack/rook-ceph-rgw-ceph-certs\" value_size:1130 >> failure:<>"}
{"level":"warn","ts":"2026-09-10T11:23:08.768374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.267109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/ingress-nginx/ingress-nginx-controller-rwr5m.18d3f10c7aaa831a\" ","response":"range_response_count:1 size:765"}
{"level":"info","ts":"2026-09-10T11:23:08.768495Z","caller":"traceutil/trace.go:171","msg":"trace[1177987660] range","detail":"{range_begin:/registry/events/ingress-nginx/ingress-nginx-controller-rwr5m.18d3f10c7aaa831a; range_end:; response_count:1; response_revision:8790; }","duration":"198.441943ms","start":"2026-09-10T11:23:08.57002Z","end":"2026-09-10T11:23:08.768462Z","steps":["trace[1177987660] 'agreement among raft nodes before linearized reading'  (duration: 198.034912ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:23:08.831715Z","caller":"traceutil/trace.go:171","msg":"trace[640059211] transaction","detail":"{read_only:false; response_revision:8791; number_of_response:1; }","duration":"255.9449ms","start":"2026-09-10T11:23:08.575746Z","end":"2026-09-10T11:23:08.831691Z","steps":["trace[640059211] 'process raft request'  (duration: 252.161188ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:23:08.83212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.09958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"info","ts":"2026-09-10T11:23:08.832189Z","caller":"traceutil/trace.go:171","msg":"trace[1092451645] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8792; }","duration":"254.203352ms","start":"2026-09-10T11:23:08.577971Z","end":"2026-09-10T11:23:08.832174Z","steps":["trace[1092451645] 'agreement among raft nodes before linearized reading'  (duration: 253.950476ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:23:08.832371Z","caller":"traceutil/trace.go:171","msg":"trace[2009672500] transaction","detail":"{read_only:false; response_revision:8792; number_of_response:1; }","duration":"249.914226ms","start":"2026-09-10T11:23:08.582442Z","end":"2026-09-10T11:23:08.832356Z","steps":["trace[2009672500] 'process raft request'  (duration: 249.098544ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:23:08.832768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.985228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-lq24q\" ","response":"range_response_count:1 size:4653"}
{"level":"info","ts":"2026-09-10T11:23:08.832824Z","caller":"traceutil/trace.go:171","msg":"trace[321026085] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-lq24q; range_end:; response_count:1; response_revision:8792; }","duration":"257.104522ms","start":"2026-09-10T11:23:08.575708Z","end":"2026-09-10T11:23:08.832813Z","steps":["trace[321026085] 'agreement among raft nodes before linearized reading'  (duration: 256.228088ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:23:28.799436Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000246c.wal"}
{"level":"warn","ts":"2026-09-10T11:24:29.665854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.588038ms","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-09-10T11:24:29.666004Z","caller":"traceutil/trace.go:171","msg":"trace[510233747] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9565; }","duration":"136.819684ms","start":"2026-09-10T11:24:29.52915Z","end":"2026-09-10T11:24:29.665969Z","steps":["trace[510233747] 'range keys from in-memory index tree'  (duration: 136.170387ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:24:29.948501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.985063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:24:29.948676Z","caller":"traceutil/trace.go:171","msg":"trace[434432033] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9566; }","duration":"122.149357ms","start":"2026-09-10T11:24:29.826477Z","end":"2026-09-10T11:24:29.948627Z","steps":["trace[434432033] 'range keys from in-memory index tree'  (duration: 121.841778ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:24:30.264973Z","caller":"traceutil/trace.go:171","msg":"trace[740117684] transaction","detail":"{read_only:false; response_revision:9568; number_of_response:1; }","duration":"110.498642ms","start":"2026-09-10T11:24:30.154432Z","end":"2026-09-10T11:24:30.26493Z","steps":["trace[740117684] 'process raft request'  (duration: 110.240135ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:24:37.029907Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"36725369a67988c9","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-10T11:24:37.03676Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-09-10T11:24:37.036846Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-09-10T11:26:33.847496Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8042}
{"level":"info","ts":"2026-09-10T11:26:33.926366Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8042,"took":"76.001368ms","hash":3422371576,"current-db-size-bytes":56799232,"current-db-size":"57 MB","current-db-size-in-use-bytes":29016064,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-09-10T11:26:33.926462Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3422371576,"revision":8042,"compact-revision":5872}
{"level":"info","ts":"2026-09-10T11:28:14.465298Z","caller":"traceutil/trace.go:171","msg":"trace[1703296079] transaction","detail":"{read_only:false; response_revision:11478; number_of_response:1; }","duration":"176.469278ms","start":"2026-09-10T11:28:14.288808Z","end":"2026-09-10T11:28:14.465277Z","steps":["trace[1703296079] 'process raft request'  (duration: 83.804799ms)","trace[1703296079] 'compare'  (duration: 92.486644ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:28:14.465448Z","caller":"traceutil/trace.go:171","msg":"trace[1042769446] transaction","detail":"{read_only:false; response_revision:11479; number_of_response:1; }","duration":"126.561666ms","start":"2026-09-10T11:28:14.338878Z","end":"2026-09-10T11:28:14.46544Z","steps":["trace[1042769446] 'process raft request'  (duration: 126.32462ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:28:14.882829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.233288ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9856585778329027900 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:11470 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T11:28:14.882955Z","caller":"traceutil/trace.go:171","msg":"trace[1215270965] linearizableReadLoop","detail":"{readStateIndex:11889; appliedIndex:11888; }","duration":"413.997919ms","start":"2026-09-10T11:28:14.468937Z","end":"2026-09-10T11:28:14.882935Z","steps":["trace[1215270965] 'read index received'  (duration: 171.498404ms)","trace[1215270965] 'applied index is now lower than readState.Index'  (duration: 242.498185ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:28:14.883123Z","caller":"traceutil/trace.go:171","msg":"trace[2054072774] transaction","detail":"{read_only:false; response_revision:11480; number_of_response:1; }","duration":"488.164008ms","start":"2026-09-10T11:28:14.394928Z","end":"2026-09-10T11:28:14.883092Z","steps":["trace[2054072774] 'process raft request'  (duration: 245.549739ms)","trace[2054072774] 'compare'  (duration: 242.075364ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:28:14.883234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:28:14.394897Z","time spent":"488.281621ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:11470 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-10T11:28:14.883447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.489563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/cinder-volume-79d49dcdbf-rzgr9.18d3f2182518d477\" ","response":"range_response_count:1 size:804"}
{"level":"info","ts":"2026-09-10T11:28:14.88353Z","caller":"traceutil/trace.go:171","msg":"trace[1694009951] range","detail":"{range_begin:/registry/events/openstack/cinder-volume-79d49dcdbf-rzgr9.18d3f2182518d477; range_end:; response_count:1; response_revision:11480; }","duration":"414.573855ms","start":"2026-09-10T11:28:14.468931Z","end":"2026-09-10T11:28:14.883505Z","steps":["trace[1694009951] 'agreement among raft nodes before linearized reading'  (duration: 414.204205ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:28:14.883567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:28:14.468917Z","time spent":"414.642726ms","remote":"127.0.0.1:56394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":826,"request content":"key:\"/registry/events/openstack/cinder-volume-79d49dcdbf-rzgr9.18d3f2182518d477\" "}
{"level":"warn","ts":"2026-09-10T11:28:14.970907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.274957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:28:14.97098Z","caller":"traceutil/trace.go:171","msg":"trace[624390716] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11481; }","duration":"144.39347ms","start":"2026-09-10T11:28:14.826571Z","end":"2026-09-10T11:28:14.970964Z","steps":["trace[624390716] 'agreement among raft nodes before linearized reading'  (duration: 144.269957ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:28:14.970998Z","caller":"traceutil/trace.go:171","msg":"trace[2069560461] transaction","detail":"{read_only:false; response_revision:11481; number_of_response:1; }","duration":"278.825989ms","start":"2026-09-10T11:28:14.692149Z","end":"2026-09-10T11:28:14.970975Z","steps":["trace[2069560461] 'process raft request'  (duration: 278.553832ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:28:15.050718Z","caller":"traceutil/trace.go:171","msg":"trace[882400630] transaction","detail":"{read_only:false; response_revision:11482; number_of_response:1; }","duration":"164.70583ms","start":"2026-09-10T11:28:14.88598Z","end":"2026-09-10T11:28:15.050686Z","steps":["trace[882400630] 'process raft request'  (duration: 108.186299ms)","trace[882400630] 'compare'  (duration: 55.905694ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:31:33.858054Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10519}
{"level":"info","ts":"2026-09-10T11:31:33.957832Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10519,"took":"97.525436ms","hash":3608254680,"current-db-size-bytes":56799232,"current-db-size":"57 MB","current-db-size-in-use-bytes":27377664,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-09-10T11:31:33.957931Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3608254680,"revision":10519,"compact-revision":8042}
{"level":"info","ts":"2026-09-10T11:34:15.027467Z","caller":"traceutil/trace.go:171","msg":"trace[1033118815] transaction","detail":"{read_only:false; response_revision:13927; number_of_response:1; }","duration":"115.481184ms","start":"2026-09-10T11:34:14.911944Z","end":"2026-09-10T11:34:15.027425Z","steps":["trace[1033118815] 'process raft request'  (duration: 115.296809ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:34:36.037965Z","caller":"traceutil/trace.go:171","msg":"trace[1403729819] transaction","detail":"{read_only:false; response_revision:14038; number_of_response:1; }","duration":"187.556449ms","start":"2026-09-10T11:34:35.850373Z","end":"2026-09-10T11:34:36.03793Z","steps":["trace[1403729819] 'process raft request'  (duration: 187.387515ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:34:43.66805Z","caller":"traceutil/trace.go:171","msg":"trace[231191849] linearizableReadLoop","detail":"{readStateIndex:14576; appliedIndex:14575; }","duration":"102.765329ms","start":"2026-09-10T11:34:43.565249Z","end":"2026-09-10T11:34:43.668014Z","steps":["trace[231191849] 'read index received'  (duration: 65.811146ms)","trace[231191849] 'applied index is now lower than readState.Index'  (duration: 36.952513ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:34:43.668348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.079437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jww54\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-09-10T11:34:43.668618Z","caller":"traceutil/trace.go:171","msg":"trace[266757055] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jww54; range_end:; response_count:1; response_revision:14077; }","duration":"103.407086ms","start":"2026-09-10T11:34:43.565192Z","end":"2026-09-10T11:34:43.668599Z","steps":["trace[266757055] 'agreement among raft nodes before linearized reading'  (duration: 102.965674ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:34:43.669218Z","caller":"traceutil/trace.go:171","msg":"trace[315317773] transaction","detail":"{read_only:false; response_revision:14077; number_of_response:1; }","duration":"126.843492ms","start":"2026-09-10T11:34:43.542213Z","end":"2026-09-10T11:34:43.669057Z","steps":["trace[315317773] 'process raft request'  (duration: 88.838441ms)","trace[315317773] 'compare'  (duration: 36.790968ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:34:43.927829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.60941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:34:43.92792Z","caller":"traceutil/trace.go:171","msg":"trace[1011175514] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14077; }","duration":"100.768454ms","start":"2026-09-10T11:34:43.82713Z","end":"2026-09-10T11:34:43.927898Z","steps":["trace[1011175514] 'range keys from in-memory index tree'  (duration: 100.500317ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:34:52.009716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.70984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:34:52.009854Z","caller":"traceutil/trace.go:171","msg":"trace[916312054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14133; }","duration":"185.905735ms","start":"2026-09-10T11:34:51.823925Z","end":"2026-09-10T11:34:52.009831Z","steps":["trace[916312054] 'range keys from in-memory index tree'  (duration: 185.604376ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:34:52.78657Z","caller":"traceutil/trace.go:171","msg":"trace[818876056] transaction","detail":"{read_only:false; response_revision:14139; number_of_response:1; }","duration":"124.21097ms","start":"2026-09-10T11:34:52.662325Z","end":"2026-09-10T11:34:52.786536Z","steps":["trace[818876056] 'process raft request'  (duration: 124.020125ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:34:53.050835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.662497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-10T11:34:53.050937Z","caller":"traceutil/trace.go:171","msg":"trace[1183088010] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:14139; }","duration":"161.79787ms","start":"2026-09-10T11:34:52.889115Z","end":"2026-09-10T11:34:53.050913Z","steps":["trace[1183088010] 'count revisions from in-memory index tree'  (duration: 161.506752ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:35:00.023294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.444824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:35:00.023366Z","caller":"traceutil/trace.go:171","msg":"trace[1855116930] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14187; }","duration":"195.567997ms","start":"2026-09-10T11:34:59.827785Z","end":"2026-09-10T11:35:00.023353Z","steps":["trace[1855116930] 'range keys from in-memory index tree'  (duration: 195.356132ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:35:00.023551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.505813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jww54\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-09-10T11:35:00.023624Z","caller":"traceutil/trace.go:171","msg":"trace[174276] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jww54; range_end:; response_count:1; response_revision:14187; }","duration":"189.612915ms","start":"2026-09-10T11:34:59.833995Z","end":"2026-09-10T11:35:00.023608Z","steps":["trace[174276] 'range keys from in-memory index tree'  (duration: 189.278346ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:35:00.023609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.0229ms","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-09-10T11:35:00.023701Z","caller":"traceutil/trace.go:171","msg":"trace[1487882483] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14187; }","duration":"276.150083ms","start":"2026-09-10T11:34:59.747531Z","end":"2026-09-10T11:35:00.023682Z","steps":["trace[1487882483] 'range keys from in-memory index tree'  (duration: 275.835995ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:35:00.023859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.4365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:35:00.023892Z","caller":"traceutil/trace.go:171","msg":"trace[134741242] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:14187; }","duration":"130.507361ms","start":"2026-09-10T11:34:59.893374Z","end":"2026-09-10T11:35:00.023881Z","steps":["trace[134741242] 'count revisions from in-memory index tree'  (duration: 130.332946ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:35:00.023915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.906862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"info","ts":"2026-09-10T11:35:00.023998Z","caller":"traceutil/trace.go:171","msg":"trace[385450638] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14187; }","duration":"250.018384ms","start":"2026-09-10T11:34:59.773953Z","end":"2026-09-10T11:35:00.023971Z","steps":["trace[385450638] 'range keys from in-memory index tree'  (duration: 249.710656ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:35:00.024107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.952649ms","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-09-10T11:35:00.024178Z","caller":"traceutil/trace.go:171","msg":"trace[622647842] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14187; }","duration":"356.050822ms","start":"2026-09-10T11:34:59.668106Z","end":"2026-09-10T11:35:00.024157Z","steps":["trace[622647842] 'range keys from in-memory index tree'  (duration: 355.793485ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:35:00.024225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:34:59.668087Z","time spent":"356.126753ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-09-10T11:35:00.02427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.425448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-09-10T11:35:00.024303Z","caller":"traceutil/trace.go:171","msg":"trace[117833217] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:14187; }","duration":"319.494759ms","start":"2026-09-10T11:34:59.704795Z","end":"2026-09-10T11:35:00.02429Z","steps":["trace[117833217] 'range keys from in-memory index tree'  (duration: 319.283664ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:35:00.024327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:34:59.704773Z","time spent":"319.544781ms","remote":"127.0.0.1:56480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2104,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "}
{"level":"info","ts":"2026-09-10T11:35:00.182298Z","caller":"traceutil/trace.go:171","msg":"trace[1509380722] transaction","detail":"{read_only:false; response_revision:14188; number_of_response:1; }","duration":"151.630605ms","start":"2026-09-10T11:35:00.030651Z","end":"2026-09-10T11:35:00.182282Z","steps":["trace[1509380722] 'process raft request'  (duration: 151.245354ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:35:00.193511Z","caller":"traceutil/trace.go:171","msg":"trace[209462335] transaction","detail":"{read_only:false; response_revision:14189; number_of_response:1; }","duration":"161.591185ms","start":"2026-09-10T11:35:00.031893Z","end":"2026-09-10T11:35:00.193484Z","steps":["trace[209462335] 'process raft request'  (duration: 161.007079ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:36:10.757795Z","caller":"traceutil/trace.go:171","msg":"trace[1560860995] linearizableReadLoop","detail":"{readStateIndex:15744; appliedIndex:15743; }","duration":"137.834371ms","start":"2026-09-10T11:36:10.619928Z","end":"2026-09-10T11:36:10.757763Z","steps":["trace[1560860995] 'read index received'  (duration: 137.624145ms)","trace[1560860995] 'applied index is now lower than readState.Index'  (duration: 209.136µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:36:10.757859Z","caller":"traceutil/trace.go:171","msg":"trace[740131393] transaction","detail":"{read_only:false; response_revision:15213; number_of_response:1; }","duration":"160.185959ms","start":"2026-09-10T11:36:10.597628Z","end":"2026-09-10T11:36:10.757814Z","steps":["trace[740131393] 'process raft request'  (duration: 159.903991ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:36:10.758097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.137629ms","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-09-10T11:36:10.758215Z","caller":"traceutil/trace.go:171","msg":"trace[1177605026] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15213; }","duration":"138.315953ms","start":"2026-09-10T11:36:10.619877Z","end":"2026-09-10T11:36:10.758193Z","steps":["trace[1177605026] 'agreement among raft nodes before linearized reading'  (duration: 138.024445ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:36:10.758375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.800028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-09-10T11:36:10.758463Z","caller":"traceutil/trace.go:171","msg":"trace[2016993182] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:15213; }","duration":"122.915412ms","start":"2026-09-10T11:36:10.635522Z","end":"2026-09-10T11:36:10.758438Z","steps":["trace[2016993182] 'agreement among raft nodes before linearized reading'  (duration: 122.695306ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:36:10.758166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.177656ms","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-09-10T11:36:10.75889Z","caller":"traceutil/trace.go:171","msg":"trace[2079272431] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15213; }","duration":"130.967467ms","start":"2026-09-10T11:36:10.627889Z","end":"2026-09-10T11:36:10.758857Z","steps":["trace[2079272431] 'agreement among raft nodes before linearized reading'  (duration: 130.079113ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:36:33.865873Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12774}
{"level":"info","ts":"2026-09-10T11:36:33.965224Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12774,"took":"96.237257ms","hash":64490173,"current-db-size-bytes":56799232,"current-db-size":"57 MB","current-db-size-in-use-bytes":30416896,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-10T11:36:33.965341Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":64490173,"revision":12774,"compact-revision":10519}
{"level":"info","ts":"2026-09-10T11:36:45.03485Z","caller":"traceutil/trace.go:171","msg":"trace[1137503954] linearizableReadLoop","detail":"{readStateIndex:15931; appliedIndex:15930; }","duration":"117.423754ms","start":"2026-09-10T11:36:44.917396Z","end":"2026-09-10T11:36:45.034819Z","steps":["trace[1137503954] 'read index received'  (duration: 117.122426ms)","trace[1137503954] 'applied index is now lower than readState.Index'  (duration: 300.118µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:36:45.03501Z","caller":"traceutil/trace.go:171","msg":"trace[987827125] transaction","detail":"{read_only:false; response_revision:15392; number_of_response:1; }","duration":"157.837307ms","start":"2026-09-10T11:36:44.87716Z","end":"2026-09-10T11:36:45.034998Z","steps":["trace[987827125] 'process raft request'  (duration: 157.447756ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:36:45.035248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.696902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:36:45.035361Z","caller":"traceutil/trace.go:171","msg":"trace[752859411] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15392; }","duration":"117.853866ms","start":"2026-09-10T11:36:44.917487Z","end":"2026-09-10T11:36:45.035341Z","steps":["trace[752859411] 'agreement among raft nodes before linearized reading'  (duration: 117.62211ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:36:45.035444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.025431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:36:45.035485Z","caller":"traceutil/trace.go:171","msg":"trace[1480265275] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15392; }","duration":"118.143903ms","start":"2026-09-10T11:36:44.91733Z","end":"2026-09-10T11:36:45.035474Z","steps":["trace[1480265275] 'agreement among raft nodes before linearized reading'  (duration: 118.069681ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:36:45.318816Z","caller":"traceutil/trace.go:171","msg":"trace[1752727404] transaction","detail":"{read_only:false; response_revision:15394; number_of_response:1; }","duration":"275.927628ms","start":"2026-09-10T11:36:45.042858Z","end":"2026-09-10T11:36:45.318786Z","steps":["trace[1752727404] 'process raft request'  (duration: 275.678312ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:36:45.319147Z","caller":"traceutil/trace.go:171","msg":"trace[1996221138] transaction","detail":"{read_only:false; response_revision:15395; number_of_response:1; }","duration":"276.183735ms","start":"2026-09-10T11:36:45.042952Z","end":"2026-09-10T11:36:45.319136Z","steps":["trace[1996221138] 'process raft request'  (duration: 275.787924ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:36:45.319329Z","caller":"traceutil/trace.go:171","msg":"trace[637806612] transaction","detail":"{read_only:false; response_revision:15396; number_of_response:1; }","duration":"276.214955ms","start":"2026-09-10T11:36:45.043058Z","end":"2026-09-10T11:36:45.319273Z","steps":["trace[637806612] 'process raft request'  (duration: 275.930538ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:36:45.319745Z","caller":"traceutil/trace.go:171","msg":"trace[444935616] linearizableReadLoop","detail":"{readStateIndex:15936; appliedIndex:15932; }","duration":"214.044051ms","start":"2026-09-10T11:36:45.105684Z","end":"2026-09-10T11:36:45.319728Z","steps":["trace[444935616] 'read index received'  (duration: 212.763926ms)","trace[444935616] 'applied index is now lower than readState.Index'  (duration: 1.279055ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:36:45.319947Z","caller":"traceutil/trace.go:171","msg":"trace[1175577695] transaction","detail":"{read_only:false; response_revision:15397; number_of_response:1; }","duration":"268.5074ms","start":"2026-09-10T11:36:45.051423Z","end":"2026-09-10T11:36:45.31993Z","steps":["trace[1175577695] 'process raft request'  (duration: 267.75736ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:36:45.320144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.441512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T11:36:45.320177Z","caller":"traceutil/trace.go:171","msg":"trace[615368174] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15397; }","duration":"214.530604ms","start":"2026-09-10T11:36:45.105635Z","end":"2026-09-10T11:36:45.320166Z","steps":["trace[615368174] 'agreement among raft nodes before linearized reading'  (duration: 214.452062ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:36:45.320408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.92699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"info","ts":"2026-09-10T11:36:45.320431Z","caller":"traceutil/trace.go:171","msg":"trace[1907573667] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15397; }","duration":"200.983501ms","start":"2026-09-10T11:36:45.119441Z","end":"2026-09-10T11:36:45.320425Z","steps":["trace[1907573667] 'agreement among raft nodes before linearized reading'  (duration: 200.859478ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:36:45.320815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.825341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"info","ts":"2026-09-10T11:36:45.320843Z","caller":"traceutil/trace.go:171","msg":"trace[1051310115] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15397; }","duration":"106.901942ms","start":"2026-09-10T11:36:45.21393Z","end":"2026-09-10T11:36:45.320832Z","steps":["trace[1051310115] 'agreement among raft nodes before linearized reading'  (duration: 106.81342ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:36:45.320986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.364394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"info","ts":"2026-09-10T11:36:45.321006Z","caller":"traceutil/trace.go:171","msg":"trace[966336072] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15397; }","duration":"194.412216ms","start":"2026-09-10T11:36:45.126588Z","end":"2026-09-10T11:36:45.321Z","steps":["trace[966336072] 'agreement among raft nodes before linearized reading'  (duration: 194.342544ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:36:45.527094Z","caller":"traceutil/trace.go:171","msg":"trace[153023736] transaction","detail":"{read_only:false; response_revision:15398; number_of_response:1; }","duration":"190.362327ms","start":"2026-09-10T11:36:45.336693Z","end":"2026-09-10T11:36:45.527055Z","steps":["trace[153023736] 'process raft request'  (duration: 169.091207ms)","trace[153023736] 'compare'  (duration: 20.986812ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:36:45.796002Z","caller":"traceutil/trace.go:171","msg":"trace[2096772918] transaction","detail":"{read_only:false; response_revision:15400; number_of_response:1; }","duration":"128.027678ms","start":"2026-09-10T11:36:45.66794Z","end":"2026-09-10T11:36:45.795968Z","steps":["trace[2096772918] 'process raft request'  (duration: 40.101724ms)","trace[2096772918] 'compare'  (duration: 87.243986ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:41:33.873171Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15339}
{"level":"info","ts":"2026-09-10T11:41:33.997105Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15339,"took":"120.590968ms","hash":2348064143,"current-db-size-bytes":56799232,"current-db-size":"57 MB","current-db-size-in-use-bytes":31563776,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-10T11:41:33.997185Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2348064143,"revision":15339,"compact-revision":12774}
{"level":"warn","ts":"2026-09-10T11:42:19.143631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.654028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-10T11:42:19.143749Z","caller":"traceutil/trace.go:171","msg":"trace[565611566] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:17800; }","duration":"144.839743ms","start":"2026-09-10T11:42:18.998885Z","end":"2026-09-10T11:42:19.143724Z","steps":["trace[565611566] 'count revisions from in-memory index tree'  (duration: 144.497084ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:42:24.425628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.115884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-10T11:42:24.42576Z","caller":"traceutil/trace.go:171","msg":"trace[846762710] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:17830; }","duration":"274.31993ms","start":"2026-09-10T11:42:24.151417Z","end":"2026-09-10T11:42:24.425737Z","steps":["trace[846762710] 'count revisions from in-memory index tree'  (duration: 273.983451ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:42:24.426147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.426961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-spznw\" ","response":"range_response_count:1 size:9797"}
{"level":"info","ts":"2026-09-10T11:42:24.426377Z","caller":"traceutil/trace.go:171","msg":"trace[76063459] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-spznw; range_end:; response_count:1; response_revision:17830; }","duration":"247.797872ms","start":"2026-09-10T11:42:24.178393Z","end":"2026-09-10T11:42:24.426191Z","steps":["trace[76063459] 'range keys from in-memory index tree'  (duration: 247.215816ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:42:24.747504Z","caller":"traceutil/trace.go:171","msg":"trace[2111924695] transaction","detail":"{read_only:false; response_revision:17832; number_of_response:1; }","duration":"106.793502ms","start":"2026-09-10T11:42:24.640684Z","end":"2026-09-10T11:42:24.747477Z","steps":["trace[2111924695] 'process raft request'  (duration: 106.619837ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:42:25.470082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:42:24.93337Z","time spent":"536.697947ms","remote":"127.0.0.1:43272","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-09-10T11:42:25.470243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.334362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"}
{"level":"info","ts":"2026-09-10T11:42:25.470379Z","caller":"traceutil/trace.go:171","msg":"trace[698526488] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17832; }","duration":"311.495387ms","start":"2026-09-10T11:42:25.158814Z","end":"2026-09-10T11:42:25.470309Z","steps":["trace[698526488] 'range keys from in-memory index tree'  (duration: 311.084265ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:42:25.470458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:42:25.158783Z","time spent":"311.659862ms","remote":"127.0.0.1:56490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":724,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-09-10T11:42:25.47053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.39465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-7l7mk\" ","response":"range_response_count:1 size:20755"}
{"level":"info","ts":"2026-09-10T11:42:25.470619Z","caller":"traceutil/trace.go:171","msg":"trace[896343624] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-7l7mk; range_end:; response_count:1; response_revision:17832; }","duration":"597.587236ms","start":"2026-09-10T11:42:24.873011Z","end":"2026-09-10T11:42:25.470598Z","steps":["trace[896343624] 'range keys from in-memory index tree'  (duration: 596.991429ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:42:25.470705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:42:24.872978Z","time spent":"597.7163ms","remote":"127.0.0.1:56504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20777,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-7l7mk\" "}
{"level":"info","ts":"2026-09-10T11:42:25.470995Z","caller":"traceutil/trace.go:171","msg":"trace[498708667] linearizableReadLoop","detail":"{readStateIndex:18457; appliedIndex:18456; }","duration":"208.340062ms","start":"2026-09-10T11:42:25.26264Z","end":"2026-09-10T11:42:25.47098Z","steps":["trace[498708667] 'read index received'  (duration: 157.897636ms)","trace[498708667] 'applied index is now lower than readState.Index'  (duration: 50.441736ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:42:25.471133Z","caller":"traceutil/trace.go:171","msg":"trace[132933448] transaction","detail":"{read_only:false; response_revision:17833; number_of_response:1; }","duration":"245.725995ms","start":"2026-09-10T11:42:25.2254Z","end":"2026-09-10T11:42:25.471126Z","steps":["trace[132933448] 'process raft request'  (duration: 195.142395ms)","trace[132933448] 'compare'  (duration: 50.318333ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:42:25.471336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.685222ms","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-09-10T11:42:25.471425Z","caller":"traceutil/trace.go:171","msg":"trace[1612269974] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17833; }","duration":"208.821746ms","start":"2026-09-10T11:42:25.262586Z","end":"2026-09-10T11:42:25.471408Z","steps":["trace[1612269974] 'agreement among raft nodes before linearized reading'  (duration: 208.563849ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:42:25.495055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.699489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-10T11:42:25.495157Z","caller":"traceutil/trace.go:171","msg":"trace[1453159408] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:17834; }","duration":"185.856053ms","start":"2026-09-10T11:42:25.309279Z","end":"2026-09-10T11:42:25.495135Z","steps":["trace[1453159408] 'agreement among raft nodes before linearized reading'  (duration: 185.71606ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:42:25.614Z","caller":"traceutil/trace.go:171","msg":"trace[462047640] transaction","detail":"{read_only:false; response_revision:17835; number_of_response:1; }","duration":"136.762205ms","start":"2026-09-10T11:42:25.477147Z","end":"2026-09-10T11:42:25.613909Z","steps":["trace[462047640] 'process raft request'  (duration: 121.229644ms)","trace[462047640] 'compare'  (duration: 15.176371ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:42:25.622568Z","caller":"traceutil/trace.go:171","msg":"trace[1322051949] transaction","detail":"{read_only:false; response_revision:17836; number_of_response:1; }","duration":"125.52659ms","start":"2026-09-10T11:42:25.497Z","end":"2026-09-10T11:42:25.622527Z","steps":["trace[1322051949] 'process raft request'  (duration: 125.084538ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:42:33.501284Z","caller":"traceutil/trace.go:171","msg":"trace[1520043747] transaction","detail":"{read_only:false; response_revision:17919; number_of_response:1; }","duration":"108.704474ms","start":"2026-09-10T11:42:33.392556Z","end":"2026-09-10T11:42:33.501261Z","steps":["trace[1520043747] 'process raft request'  (duration: 108.564681ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:42:33.512563Z","caller":"traceutil/trace.go:171","msg":"trace[868467002] linearizableReadLoop","detail":"{readStateIndex:18549; appliedIndex:18547; }","duration":"111.924212ms","start":"2026-09-10T11:42:33.400608Z","end":"2026-09-10T11:42:33.512532Z","steps":["trace[868467002] 'read index received'  (duration: 100.578364ms)","trace[868467002] 'applied index is now lower than readState.Index'  (duration: 11.344428ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:42:33.513025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.392054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1344"}
{"level":"info","ts":"2026-09-10T11:42:33.513214Z","caller":"traceutil/trace.go:171","msg":"trace[1874435381] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:17920; }","duration":"112.509927ms","start":"2026-09-10T11:42:33.400561Z","end":"2026-09-10T11:42:33.513071Z","steps":["trace[1874435381] 'agreement among raft nodes before linearized reading'  (duration: 112.123857ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:42:33.513592Z","caller":"traceutil/trace.go:171","msg":"trace[854771367] transaction","detail":"{read_only:false; response_revision:17920; number_of_response:1; }","duration":"115.672333ms","start":"2026-09-10T11:42:33.397904Z","end":"2026-09-10T11:42:33.513576Z","steps":["trace[854771367] 'process raft request'  (duration: 114.46692ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:43:23.26881Z","caller":"traceutil/trace.go:171","msg":"trace[979406428] transaction","detail":"{read_only:false; response_revision:18517; number_of_response:1; }","duration":"155.502521ms","start":"2026-09-10T11:43:23.113247Z","end":"2026-09-10T11:43:23.268749Z","steps":["trace[979406428] 'process raft request'  (duration: 155.204933ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:45:17.044015Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"36725369a67988c9","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-10T11:45:17.052966Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-09-10T11:45:17.053057Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-09-10T11:46:33.880529Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17487}
{"level":"info","ts":"2026-09-10T11:46:34.00478Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17487,"took":"120.807842ms","hash":711317592,"current-db-size-bytes":56799232,"current-db-size":"57 MB","current-db-size-in-use-bytes":33697792,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-09-10T11:46:34.004863Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":711317592,"revision":17487,"compact-revision":15339}
{"level":"info","ts":"2026-09-10T11:48:29.307807Z","caller":"traceutil/trace.go:171","msg":"trace[686052761] transaction","detail":"{read_only:false; response_revision:20624; number_of_response:1; }","duration":"168.655301ms","start":"2026-09-10T11:48:29.139115Z","end":"2026-09-10T11:48:29.30777Z","steps":["trace[686052761] 'process raft request'  (duration: 168.447235ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:48:29.496374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.948232ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9856585778329057009 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:20613 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-10T11:48:29.496519Z","caller":"traceutil/trace.go:171","msg":"trace[2127726160] transaction","detail":"{read_only:false; response_revision:20625; number_of_response:1; }","duration":"325.616486ms","start":"2026-09-10T11:48:29.170876Z","end":"2026-09-10T11:48:29.496493Z","steps":["trace[2127726160] 'process raft request'  (duration: 140.413227ms)","trace[2127726160] 'compare'  (duration: 184.829499ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:48:29.496604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:48:29.170838Z","time spent":"325.723799ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:20613 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-10T11:48:30.071789Z","caller":"traceutil/trace.go:171","msg":"trace[2021403644] linearizableReadLoop","detail":"{readStateIndex:21341; appliedIndex:21340; }","duration":"245.281923ms","start":"2026-09-10T11:48:29.826481Z","end":"2026-09-10T11:48:30.071763Z","steps":["trace[2021403644] 'read index received'  (duration: 245.088948ms)","trace[2021403644] 'applied index is now lower than readState.Index'  (duration: 191.915µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:48:30.071936Z","caller":"traceutil/trace.go:171","msg":"trace[925826480] transaction","detail":"{read_only:false; response_revision:20626; number_of_response:1; }","duration":"285.812479ms","start":"2026-09-10T11:48:29.786093Z","end":"2026-09-10T11:48:30.071906Z","steps":["trace[925826480] 'process raft request'  (duration: 285.47514ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:48:30.072018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.497699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-10T11:48:30.072067Z","caller":"traceutil/trace.go:171","msg":"trace[1663912850] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20626; }","duration":"245.623152ms","start":"2026-09-10T11:48:29.826429Z","end":"2026-09-10T11:48:30.072052Z","steps":["trace[1663912850] 'agreement among raft nodes before linearized reading'  (duration: 245.506149ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:48:30.124521Z","caller":"traceutil/trace.go:171","msg":"trace[1895594359] transaction","detail":"{read_only:false; response_revision:20627; number_of_response:1; }","duration":"219.880236ms","start":"2026-09-10T11:48:29.904612Z","end":"2026-09-10T11:48:30.124492Z","steps":["trace[1895594359] 'process raft request'  (duration: 219.459355ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:48:30.125471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.380305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:19221"}
{"level":"warn","ts":"2026-09-10T11:48:30.125463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.620371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-09-10T11:48:30.125516Z","caller":"traceutil/trace.go:171","msg":"trace[61021450] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:20627; }","duration":"191.474108ms","start":"2026-09-10T11:48:29.934031Z","end":"2026-09-10T11:48:30.125505Z","steps":["trace[61021450] 'agreement among raft nodes before linearized reading'  (duration: 191.338994ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:48:30.125558Z","caller":"traceutil/trace.go:171","msg":"trace[1422665240] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20627; }","duration":"188.771654ms","start":"2026-09-10T11:48:29.936758Z","end":"2026-09-10T11:48:30.12553Z","steps":["trace[1422665240] 'agreement among raft nodes before linearized reading'  (duration: 188.546328ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:48:30.125746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.164532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-09-10T11:48:30.125774Z","caller":"traceutil/trace.go:171","msg":"trace[751601810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20627; }","duration":"190.215004ms","start":"2026-09-10T11:48:29.93555Z","end":"2026-09-10T11:48:30.125765Z","steps":["trace[751601810] 'agreement among raft nodes before linearized reading'  (duration: 190.103911ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:48:30.426391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.894013ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9856585778329057017 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:20616 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-10T11:48:30.42678Z","caller":"traceutil/trace.go:171","msg":"trace[1443675653] linearizableReadLoop","detail":"{readStateIndex:21345; appliedIndex:21342; }","duration":"294.019951ms","start":"2026-09-10T11:48:30.132744Z","end":"2026-09-10T11:48:30.426764Z","steps":["trace[1443675653] 'read index received'  (duration: 153.485801ms)","trace[1443675653] 'applied index is now lower than readState.Index'  (duration: 140.53313ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:48:30.42677Z","caller":"traceutil/trace.go:171","msg":"trace[665794291] transaction","detail":"{read_only:false; response_revision:20628; number_of_response:1; }","duration":"295.632886ms","start":"2026-09-10T11:48:30.131065Z","end":"2026-09-10T11:48:30.426698Z","steps":["trace[665794291] 'process raft request'  (duration: 155.29668ms)","trace[665794291] 'compare'  (duration: 139.517424ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:48:30.426881Z","caller":"traceutil/trace.go:171","msg":"trace[2026026312] transaction","detail":"{read_only:false; response_revision:20629; number_of_response:1; }","duration":"295.739178ms","start":"2026-09-10T11:48:30.131116Z","end":"2026-09-10T11:48:30.426855Z","steps":["trace[2026026312] 'process raft request'  (duration: 295.468161ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:48:30.427Z","caller":"traceutil/trace.go:171","msg":"trace[766779085] transaction","detail":"{read_only:false; response_revision:20630; number_of_response:1; }","duration":"295.865331ms","start":"2026-09-10T11:48:30.131123Z","end":"2026-09-10T11:48:30.426988Z","steps":["trace[766779085] 'process raft request'  (duration: 295.565683ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:48:30.427126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.376802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19221"}
{"level":"info","ts":"2026-09-10T11:48:30.427171Z","caller":"traceutil/trace.go:171","msg":"trace[1570171822] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20630; }","duration":"294.488424ms","start":"2026-09-10T11:48:30.13267Z","end":"2026-09-10T11:48:30.427159Z","steps":["trace[1570171822] 'agreement among raft nodes before linearized reading'  (duration: 294.32063ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:48:30.58832Z","caller":"traceutil/trace.go:171","msg":"trace[435941607] linearizableReadLoop","detail":"{readStateIndex:21346; appliedIndex:21345; }","duration":"161.466456ms","start":"2026-09-10T11:48:30.426812Z","end":"2026-09-10T11:48:30.588279Z","steps":["trace[435941607] 'read index received'  (duration: 105.698098ms)","trace[435941607] 'applied index is now lower than readState.Index'  (duration: 55.766828ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:48:30.588357Z","caller":"traceutil/trace.go:171","msg":"trace[1280117966] transaction","detail":"{read_only:false; response_revision:20631; number_of_response:1; }","duration":"203.465382ms","start":"2026-09-10T11:48:30.384859Z","end":"2026-09-10T11:48:30.588324Z","steps":["trace[1280117966] 'process raft request'  (duration: 147.754626ms)","trace[1280117966] 'compare'  (duration: 55.200433ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:48:30.588567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.799133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-10T11:48:30.588788Z","caller":"traceutil/trace.go:171","msg":"trace[945112942] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:20631; }","duration":"234.016529ms","start":"2026-09-10T11:48:30.354665Z","end":"2026-09-10T11:48:30.588681Z","steps":["trace[945112942] 'agreement among raft nodes before linearized reading'  (duration: 233.700321ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:48:30.5889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.088938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/kube-prometheus-stack-kubelet\" ","response":"range_response_count:1 size:1137"}
{"level":"info","ts":"2026-09-10T11:48:30.588995Z","caller":"traceutil/trace.go:171","msg":"trace[622934383] range","detail":"{range_begin:/registry/services/specs/kube-system/kube-prometheus-stack-kubelet; range_end:; response_count:1; response_revision:20631; }","duration":"455.221701ms","start":"2026-09-10T11:48:30.133747Z","end":"2026-09-10T11:48:30.588969Z","steps":["trace[622934383] 'agreement among raft nodes before linearized reading'  (duration: 454.910292ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:48:30.589033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:48:30.133737Z","time spent":"455.290042ms","remote":"127.0.0.1:56510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":1159,"request content":"key:\"/registry/services/specs/kube-system/kube-prometheus-stack-kubelet\" "}
{"level":"warn","ts":"2026-09-10T11:48:30.58908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.721478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-09-10T11:48:30.58922Z","caller":"traceutil/trace.go:171","msg":"trace[969146010] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20631; }","duration":"340.101688ms","start":"2026-09-10T11:48:30.249098Z","end":"2026-09-10T11:48:30.589199Z","steps":["trace[969146010] 'agreement among raft nodes before linearized reading'  (duration: 339.362218ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:48:30.589258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:48:30.249061Z","time spent":"340.18308ms","remote":"127.0.0.1:56588","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-09-10T11:48:51.060131Z","caller":"traceutil/trace.go:171","msg":"trace[519774863] transaction","detail":"{read_only:false; response_revision:20736; number_of_response:1; }","duration":"134.135878ms","start":"2026-09-10T11:48:50.925955Z","end":"2026-09-10T11:48:51.060091Z","steps":["trace[519774863] 'process raft request'  (duration: 129.41232ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:48:51.060394Z","caller":"traceutil/trace.go:171","msg":"trace[2128344739] transaction","detail":"{read_only:false; response_revision:20737; number_of_response:1; }","duration":"134.243201ms","start":"2026-09-10T11:48:50.926112Z","end":"2026-09-10T11:48:51.060355Z","steps":["trace[2128344739] 'process raft request'  (duration: 133.928402ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:48:52.477357Z","caller":"traceutil/trace.go:171","msg":"trace[1796605545] transaction","detail":"{read_only:false; response_revision:20741; number_of_response:1; }","duration":"150.380337ms","start":"2026-09-10T11:48:52.326949Z","end":"2026-09-10T11:48:52.477329Z","steps":["trace[1796605545] 'process raft request'  (duration: 150.172242ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:51:33.901576Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19907}
{"level":"info","ts":"2026-09-10T11:51:34.049553Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19907,"took":"143.001098ms","hash":3510557143,"current-db-size-bytes":56799232,"current-db-size":"57 MB","current-db-size-in-use-bytes":29876224,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-10T11:51:34.049616Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3510557143,"revision":19907,"compact-revision":17487}
{"level":"info","ts":"2026-09-10T11:52:37.017149Z","caller":"traceutil/trace.go:171","msg":"trace[1283838047] transaction","detail":"{read_only:false; response_revision:23148; number_of_response:1; }","duration":"460.097064ms","start":"2026-09-10T11:52:36.557031Z","end":"2026-09-10T11:52:37.017128Z","steps":["trace[1283838047] 'process raft request'  (duration: 373.209211ms)","trace[1283838047] 'compare'  (duration: 86.74637ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T11:52:37.017283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:52:36.557006Z","time spent":"460.205688ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:23094 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-10T11:52:37.017517Z","caller":"traceutil/trace.go:171","msg":"trace[2027459480] transaction","detail":"{read_only:false; response_revision:23149; number_of_response:1; }","duration":"459.107918ms","start":"2026-09-10T11:52:36.558396Z","end":"2026-09-10T11:52:37.017503Z","steps":["trace[2027459480] 'process raft request'  (duration: 458.706648ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:52:37.017563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:52:36.558345Z","time spent":"459.19156ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:23095 > 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-09-10T11:52:37.017586Z","caller":"traceutil/trace.go:171","msg":"trace[1587923288] linearizableReadLoop","detail":"{readStateIndex:23942; appliedIndex:23939; }","duration":"417.756837ms","start":"2026-09-10T11:52:36.59978Z","end":"2026-09-10T11:52:37.017537Z","steps":["trace[1587923288] 'read index received'  (duration: 330.472233ms)","trace[1587923288] 'applied index is now lower than readState.Index'  (duration: 87.283734ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:52:37.017779Z","caller":"traceutil/trace.go:171","msg":"trace[1844287768] transaction","detail":"{read_only:false; response_revision:23150; number_of_response:1; }","duration":"448.412771ms","start":"2026-09-10T11:52:36.569311Z","end":"2026-09-10T11:52:37.017724Z","steps":["trace[1844287768] 'process raft request'  (duration: 448.076432ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:52:37.017853Z","caller":"traceutil/trace.go:171","msg":"trace[780480689] transaction","detail":"{read_only:false; response_revision:23151; number_of_response:1; }","duration":"221.877188ms","start":"2026-09-10T11:52:36.795952Z","end":"2026-09-10T11:52:37.017829Z","steps":["trace[780480689] 'process raft request'  (duration: 221.518139ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:52:37.017919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:52:36.569284Z","time spent":"448.522574ms","remote":"127.0.0.1:56588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:23096 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-09-10T11:52:37.018106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.555041ms","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:6"}
{"level":"info","ts":"2026-09-10T11:52:37.018208Z","caller":"traceutil/trace.go:171","msg":"trace[1555340327] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:23152; }","duration":"211.693915ms","start":"2026-09-10T11:52:36.806497Z","end":"2026-09-10T11:52:37.018191Z","steps":["trace[1555340327] 'agreement among raft nodes before linearized reading'  (duration: 211.551011ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:52:37.018143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.359184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-09-10T11:52:37.018374Z","caller":"traceutil/trace.go:171","msg":"trace[1186775456] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23152; }","duration":"418.638952ms","start":"2026-09-10T11:52:36.599696Z","end":"2026-09-10T11:52:37.018335Z","steps":["trace[1186775456] 'agreement among raft nodes before linearized reading'  (duration: 418.093177ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:52:37.01837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.993902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"warn","ts":"2026-09-10T11:52:37.018438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:52:36.599678Z","time spent":"418.734794ms","remote":"127.0.0.1:56588","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-09-10T11:52:37.018469Z","caller":"traceutil/trace.go:171","msg":"trace[966136659] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:23152; }","duration":"368.166426ms","start":"2026-09-10T11:52:36.650287Z","end":"2026-09-10T11:52:37.018454Z","steps":["trace[966136659] 'agreement among raft nodes before linearized reading'  (duration: 367.738704ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:52:37.018538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T11:52:36.650269Z","time spent":"368.259129ms","remote":"127.0.0.1:56504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-09-10T11:56:33.910148Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22054}
{"level":"info","ts":"2026-09-10T11:56:34.046519Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22054,"took":"130.72399ms","hash":4280804246,"current-db-size-bytes":57643008,"current-db-size":"58 MB","current-db-size-in-use-bytes":42246144,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-09-10T11:56:34.04663Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4280804246,"revision":22054,"compact-revision":19907}
{"level":"warn","ts":"2026-09-10T11:59:53.079699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.034595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:204"}
{"level":"warn","ts":"2026-09-10T11:59:53.079804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.562193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:1 size:208"}
{"level":"info","ts":"2026-09-10T11:59:53.079838Z","caller":"traceutil/trace.go:171","msg":"trace[1806618632] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:26669; }","duration":"175.21235ms","start":"2026-09-10T11:59:52.904599Z","end":"2026-09-10T11:59:53.079811Z","steps":["trace[1806618632] 'range keys from in-memory index tree'  (duration: 174.851741ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:59:53.079538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.419543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-10T11:59:53.07997Z","caller":"traceutil/trace.go:171","msg":"trace[1100987774] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:1; response_revision:26669; }","duration":"174.699917ms","start":"2026-09-10T11:59:52.90516Z","end":"2026-09-10T11:59:53.07986Z","steps":["trace[1100987774] 'range keys from in-memory index tree'  (duration: 174.411539ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:59:53.080094Z","caller":"traceutil/trace.go:171","msg":"trace[898569213] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:26669; }","duration":"157.0455ms","start":"2026-09-10T11:59:52.923023Z","end":"2026-09-10T11:59:53.080069Z","steps":["trace[898569213] 'count revisions from in-memory index tree'  (duration: 156.321031ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:59:53.080101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.743513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-09-10T11:59:53.080181Z","caller":"traceutil/trace.go:171","msg":"trace[1101153562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26669; }","duration":"109.856726ms","start":"2026-09-10T11:59:52.9703Z","end":"2026-09-10T11:59:53.080156Z","steps":["trace[1101153562] 'range keys from in-memory index tree'  (duration: 109.572509ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:59:53.292834Z","caller":"traceutil/trace.go:171","msg":"trace[1775447970] linearizableReadLoop","detail":"{readStateIndex:27559; appliedIndex:27558; }","duration":"174.09281ms","start":"2026-09-10T11:59:53.118716Z","end":"2026-09-10T11:59:53.292808Z","steps":["trace[1775447970] 'read index received'  (duration: 173.980197ms)","trace[1775447970] 'applied index is now lower than readState.Index'  (duration: 111.623µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T11:59:53.292889Z","caller":"traceutil/trace.go:171","msg":"trace[450554933] transaction","detail":"{read_only:false; response_revision:26671; number_of_response:1; }","duration":"208.1162ms","start":"2026-09-10T11:59:53.08474Z","end":"2026-09-10T11:59:53.292856Z","steps":["trace[450554933] 'process raft request'  (duration: 207.921644ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:59:53.293246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.116196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:4 size:329957"}
{"level":"info","ts":"2026-09-10T11:59:53.293286Z","caller":"traceutil/trace.go:171","msg":"trace[200487630] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:26671; }","duration":"209.207239ms","start":"2026-09-10T11:59:53.084066Z","end":"2026-09-10T11:59:53.293273Z","steps":["trace[200487630] 'agreement among raft nodes before linearized reading'  (duration: 208.841359ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T11:59:53.293489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.034654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:4 size:329957"}
{"level":"info","ts":"2026-09-10T11:59:53.293621Z","caller":"traceutil/trace.go:171","msg":"trace[986390520] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:26671; }","duration":"209.204028ms","start":"2026-09-10T11:59:53.084378Z","end":"2026-09-10T11:59:53.293582Z","steps":["trace[986390520] 'agreement among raft nodes before linearized reading'  (duration: 208.53985ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:59:53.30564Z","caller":"traceutil/trace.go:171","msg":"trace[422359275] transaction","detail":"{read_only:false; response_revision:26673; number_of_response:1; }","duration":"121.48358ms","start":"2026-09-10T11:59:53.184123Z","end":"2026-09-10T11:59:53.305606Z","steps":["trace[422359275] 'process raft request'  (duration: 121.095199ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T11:59:53.305836Z","caller":"traceutil/trace.go:171","msg":"trace[1005527377] transaction","detail":"{read_only:false; response_revision:26672; number_of_response:1; }","duration":"178.922691ms","start":"2026-09-10T11:59:53.126899Z","end":"2026-09-10T11:59:53.305822Z","steps":["trace[1005527377] 'process raft request'  (duration: 178.16273ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T12:00:03.503239Z","caller":"traceutil/trace.go:171","msg":"trace[1114877245] transaction","detail":"{read_only:false; response_revision:26805; number_of_response:1; }","duration":"166.578908ms","start":"2026-09-10T12:00:03.336628Z","end":"2026-09-10T12:00:03.503206Z","steps":["trace[1114877245] 'process raft request'  (duration: 166.378672ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T12:00:03.612941Z","caller":"traceutil/trace.go:171","msg":"trace[1485436408] linearizableReadLoop","detail":"{readStateIndex:27696; appliedIndex:27695; }","duration":"262.525758ms","start":"2026-09-10T12:00:03.350386Z","end":"2026-09-10T12:00:03.612912Z","steps":["trace[1485436408] 'read index received'  (duration: 153.150315ms)","trace[1485436408] 'applied index is now lower than readState.Index'  (duration: 109.374343ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T12:00:03.613208Z","caller":"traceutil/trace.go:171","msg":"trace[1066745851] transaction","detail":"{read_only:false; response_revision:26808; number_of_response:1; }","duration":"237.203144ms","start":"2026-09-10T12:00:03.375938Z","end":"2026-09-10T12:00:03.613141Z","steps":["trace[1066745851] 'process raft request'  (duration: 236.914036ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T12:00:03.61337Z","caller":"traceutil/trace.go:171","msg":"trace[342709551] transaction","detail":"{read_only:false; response_revision:26807; number_of_response:1; }","duration":"242.671481ms","start":"2026-09-10T12:00:03.370562Z","end":"2026-09-10T12:00:03.613233Z","steps":["trace[342709551] 'process raft request'  (duration: 242.175938ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T12:00:03.613622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.00425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:17457"}
{"level":"info","ts":"2026-09-10T12:00:03.613703Z","caller":"traceutil/trace.go:171","msg":"trace[774259841] range","detail":"{range_begin:/registry/configmaps/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:26808; }","duration":"263.36057ms","start":"2026-09-10T12:00:03.350332Z","end":"2026-09-10T12:00:03.613693Z","steps":["trace[774259841] 'agreement among raft nodes before linearized reading'  (duration: 262.858516ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T12:00:03.613653Z","caller":"traceutil/trace.go:171","msg":"trace[685776713] transaction","detail":"{read_only:false; response_revision:26806; number_of_response:1; }","duration":"270.651736ms","start":"2026-09-10T12:00:03.342621Z","end":"2026-09-10T12:00:03.613273Z","steps":["trace[685776713] 'process raft request'  (duration: 208.145189ms)","trace[685776713] 'compare'  (duration: 61.725626ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T12:00:03.613833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.165844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/monitoring/node-feature-discovery-gc\" ","response":"range_response_count:1 size:3559"}
{"level":"info","ts":"2026-09-10T12:00:03.614423Z","caller":"traceutil/trace.go:171","msg":"trace[2143193540] range","detail":"{range_begin:/registry/deployments/monitoring/node-feature-discovery-gc; range_end:; response_count:1; response_revision:26808; }","duration":"240.562364ms","start":"2026-09-10T12:00:03.373471Z","end":"2026-09-10T12:00:03.614033Z","steps":["trace[2143193540] 'agreement among raft nodes before linearized reading'  (duration: 239.726931ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T12:01:33.932806Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25218}
{"level":"info","ts":"2026-09-10T12:01:34.129023Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25218,"took":"193.024865ms","hash":1065442820,"current-db-size-bytes":57643008,"current-db-size":"58 MB","current-db-size-in-use-bytes":29880320,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-10T12:01:34.129078Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1065442820,"revision":25218,"compact-revision":22054}